{"level":"warn","ts":"2026-04-12T20:48:14.422788Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-12T20:48:14.422883Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.38:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.38:2380","--initial-cluster=instance=https://199.204.45.38:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.38:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.38:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-12T20:48:14.422952Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-12T20:48:14.422965Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.38:2380"]} {"level":"info","ts":"2026-04-12T20:48:14.422983Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-12T20:48:14.42363Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"]} {"level":"info","ts":"2026-04-12T20:48:14.423701Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.38:2380"],"listen-peer-urls":["https://199.204.45.38:2380"],"advertise-client-urls":["https://199.204.45.38:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.38:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-12T20:48:14.426951Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.021836ms"} {"level":"info","ts":"2026-04-12T20:48:14.43287Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"331455d6226d3423","cluster-id":"25c7803fb83a1455"} {"level":"info","ts":"2026-04-12T20:48:14.432936Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=()"} {"level":"info","ts":"2026-04-12T20:48:14.432954Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became follower at term 0"} {"level":"info","ts":"2026-04-12T20:48:14.432969Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 331455d6226d3423 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-12T20:48:14.43299Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became follower at term 1"} {"level":"info","ts":"2026-04-12T20:48:14.433032Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=(3680661173657482275)"} {"level":"warn","ts":"2026-04-12T20:48:14.439075Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-12T20:48:14.44045Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-12T20:48:14.441617Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-12T20:48:14.44371Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"331455d6226d3423","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-12T20:48:14.443858Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"331455d6226d3423","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-12T20:48:14.44412Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-12T20:48:14.444305Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-12T20:48:14.444328Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-12T20:48:14.445361Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=(3680661173657482275)"} {"level":"info","ts":"2026-04-12T20:48:14.446148Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"25c7803fb83a1455","local-member-id":"331455d6226d3423","added-peer-id":"331455d6226d3423","added-peer-peer-urls":["https://199.204.45.38:2380"]} {"level":"info","ts":"2026-04-12T20:48:14.448987Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-12T20:48:14.449117Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.38:2380"} {"level":"info","ts":"2026-04-12T20:48:14.449176Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.38:2380"} {"level":"info","ts":"2026-04-12T20:48:14.44934Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"331455d6226d3423","initial-advertise-peer-urls":["https://199.204.45.38:2380"],"listen-peer-urls":["https://199.204.45.38:2380"],"advertise-client-urls":["https://199.204.45.38:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-12T20:48:14.449388Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-12T20:48:14.83423Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 is starting a new election at term 1"} {"level":"info","ts":"2026-04-12T20:48:14.834292Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-12T20:48:14.834327Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 received MsgPreVoteResp from 331455d6226d3423 at term 1"} {"level":"info","ts":"2026-04-12T20:48:14.834348Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became candidate at term 2"} {"level":"info","ts":"2026-04-12T20:48:14.834358Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 received MsgVoteResp from 331455d6226d3423 at term 2"} {"level":"info","ts":"2026-04-12T20:48:14.834379Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became leader at term 2"} {"level":"info","ts":"2026-04-12T20:48:14.834393Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 331455d6226d3423 elected leader 331455d6226d3423 at term 2"} {"level":"info","ts":"2026-04-12T20:48:14.835328Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-12T20:48:14.836382Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-12T20:48:14.836392Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"331455d6226d3423","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.38:2379]}","request-path":"/0/members/331455d6226d3423/attributes","cluster-id":"25c7803fb83a1455","publish-timeout":"7s"} {"level":"info","ts":"2026-04-12T20:48:14.836534Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-12T20:48:14.836726Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-12T20:48:14.836821Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-12T20:48:14.837005Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"25c7803fb83a1455","local-member-id":"331455d6226d3423","cluster-version":"3.5"} {"level":"info","ts":"2026-04-12T20:48:14.837129Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-12T20:48:14.837179Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-12T20:48:14.838247Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-12T20:48:14.840288Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.38:2379"} {"level":"info","ts":"2026-04-12T20:48:38.329788Z","caller":"traceutil/trace.go:171","msg":"trace[497539517] transaction","detail":"{read_only:false; response_revision:420; number_of_response:1; }","duration":"165.974184ms","start":"2026-04-12T20:48:38.163789Z","end":"2026-04-12T20:48:38.329763Z","steps":["trace[497539517] 'process raft request' (duration: 165.82742ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T20:48:45.174261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.052009ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-12T20:48:45.174388Z","caller":"traceutil/trace.go:171","msg":"trace[34369772] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"184.766197ms","start":"2026-04-12T20:48:44.989604Z","end":"2026-04-12T20:48:45.17437Z","steps":["trace[34369772] 'compare' (duration: 175.886345ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T20:48:45.180881Z","caller":"traceutil/trace.go:171","msg":"trace[1049120603] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"173.415527ms","start":"2026-04-12T20:48:45.007445Z","end":"2026-04-12T20:48:45.18086Z","steps":["trace[1049120603] 'process raft request' (duration: 173.209862ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T20:48:45.184987Z","caller":"traceutil/trace.go:171","msg":"trace[540343206] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"175.565016ms","start":"2026-04-12T20:48:45.009381Z","end":"2026-04-12T20:48:45.184946Z","steps":["trace[540343206] 'process raft request' (duration: 175.324129ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T20:48:51.682011Z","caller":"traceutil/trace.go:171","msg":"trace[1019469920] linearizableReadLoop","detail":"{readStateIndex:596; appliedIndex:595; }","duration":"103.186599ms","start":"2026-04-12T20:48:51.578797Z","end":"2026-04-12T20:48:51.681984Z","steps":["trace[1019469920] 'read index received' (duration: 102.383517ms)","trace[1019469920] 'applied index is now lower than readState.Index' (duration: 802.142µs)"],"step_count":2} {"level":"info","ts":"2026-04-12T20:48:51.682088Z","caller":"traceutil/trace.go:171","msg":"trace[960747177] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"298.127733ms","start":"2026-04-12T20:48:51.383925Z","end":"2026-04-12T20:48:51.682052Z","steps":["trace[960747177] 'process raft request' (duration: 297.528567ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T20:48:51.682281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.459796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-12T20:48:51.682322Z","caller":"traceutil/trace.go:171","msg":"trace[635616697] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:579; }","duration":"103.571089ms","start":"2026-04-12T20:48:51.578738Z","end":"2026-04-12T20:48:51.682309Z","steps":["trace[635616697] 'agreement among raft nodes before linearized reading' (duration: 103.405635ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T20:48:52.169719Z","caller":"traceutil/trace.go:171","msg":"trace[825928968] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"423.511528ms","start":"2026-04-12T20:48:51.746182Z","end":"2026-04-12T20:48:52.169693Z","steps":["trace[825928968] 'process raft request' (duration: 423.267991ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T20:48:52.169698Z","caller":"traceutil/trace.go:171","msg":"trace[917794808] linearizableReadLoop","detail":"{readStateIndex:598; appliedIndex:597; }","duration":"319.416174ms","start":"2026-04-12T20:48:51.850209Z","end":"2026-04-12T20:48:52.169625Z","steps":["trace[917794808] 'read index received' (duration: 319.169988ms)","trace[917794808] 'applied index is now lower than readState.Index' (duration: 244.966µs)"],"step_count":2} {"level":"warn","ts":"2026-04-12T20:48:52.1699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.646721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-12T20:48:52.169846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T20:48:51.746153Z","time spent":"423.634442ms","remote":"127.0.0.1:47696","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-12T20:48:52.169978Z","caller":"traceutil/trace.go:171","msg":"trace[448602184] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:581; }","duration":"319.810615ms","start":"2026-04-12T20:48:51.850148Z","end":"2026-04-12T20:48:52.169959Z","steps":["trace[448602184] 'agreement among raft nodes before linearized reading' (duration: 319.6229ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T20:48:52.170031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T20:48:51.850131Z","time spent":"319.887527ms","remote":"127.0.0.1:47460","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-12T20:48:52.170086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.334435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-b9r9m\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-04-12T20:48:52.170152Z","caller":"traceutil/trace.go:171","msg":"trace[285334439] range","detail":"{range_begin:/registry/pods/kube-system/cilium-b9r9m; range_end:; response_count:1; response_revision:581; }","duration":"266.466768ms","start":"2026-04-12T20:48:51.903668Z","end":"2026-04-12T20:48:52.170135Z","steps":["trace[285334439] 'agreement among raft nodes before linearized reading' (duration: 266.330844ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T20:49:08.692174Z","caller":"traceutil/trace.go:171","msg":"trace[1005519299] transaction","detail":"{read_only:false; response_revision:747; number_of_response:1; }","duration":"107.310811ms","start":"2026-04-12T20:49:08.584836Z","end":"2026-04-12T20:49:08.692147Z","steps":["trace[1005519299] 'process raft request' (duration: 107.161747ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T20:49:35.888342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.893849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-12T20:49:35.888468Z","caller":"traceutil/trace.go:171","msg":"trace[1825060740] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1137; }","duration":"111.132636ms","start":"2026-04-12T20:49:35.777308Z","end":"2026-04-12T20:49:35.888441Z","steps":["trace[1825060740] 'count revisions from in-memory index tree' (duration: 110.732694ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T20:49:35.888952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.865444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-12T20:49:35.889089Z","caller":"traceutil/trace.go:171","msg":"trace[583419682] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:1137; }","duration":"176.067139ms","start":"2026-04-12T20:49:35.712985Z","end":"2026-04-12T20:49:35.889052Z","steps":["trace[583419682] 'count revisions from in-memory index tree' (duration: 175.761902ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T20:50:21.310704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.003259ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-12T20:50:21.310813Z","caller":"traceutil/trace.go:171","msg":"trace[160395043] linearizableReadLoop","detail":"{readStateIndex:1866; appliedIndex:1865; }","duration":"325.016424ms","start":"2026-04-12T20:50:20.985781Z","end":"2026-04-12T20:50:21.310797Z","steps":["trace[160395043] 'read index received' (duration: 49.629595ms)","trace[160395043] 'applied index is now lower than readState.Index' (duration: 275.385439ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T20:50:21.310897Z","caller":"traceutil/trace.go:171","msg":"trace[1962774902] transaction","detail":"{read_only:false; response_revision:1802; number_of_response:1; }","duration":"357.971814ms","start":"2026-04-12T20:50:20.952897Z","end":"2026-04-12T20:50:21.310869Z","steps":["trace[1962774902] 'process raft request' (duration: 82.559765ms)","trace[1962774902] 'compare' (duration: 274.781892ms)"],"step_count":2} {"level":"warn","ts":"2026-04-12T20:50:21.310991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.179978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-12T20:50:21.311103Z","caller":"traceutil/trace.go:171","msg":"trace[1277771930] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:1802; }","duration":"325.348873ms","start":"2026-04-12T20:50:20.985733Z","end":"2026-04-12T20:50:21.311082Z","steps":["trace[1277771930] 'agreement among raft nodes before linearized reading' (duration: 325.136977ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T20:50:21.311112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T20:50:20.952868Z","time spent":"358.100318ms","remote":"127.0.0.1:47726","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-12T20:50:21.31116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T20:50:20.985715Z","time spent":"325.433466ms","remote":"127.0.0.1:42372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":13,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true "} {"level":"warn","ts":"2026-04-12T20:50:21.330219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.653279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-12T20:50:21.330278Z","caller":"traceutil/trace.go:171","msg":"trace[2017038557] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:1803; }","duration":"122.764202ms","start":"2026-04-12T20:50:21.207499Z","end":"2026-04-12T20:50:21.330263Z","steps":["trace[2017038557] 'agreement among raft nodes before linearized reading' (duration: 122.656739ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T20:50:21.330586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.19143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-12T20:50:21.330617Z","caller":"traceutil/trace.go:171","msg":"trace[783510518] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1803; }","duration":"291.257412ms","start":"2026-04-12T20:50:21.039352Z","end":"2026-04-12T20:50:21.330609Z","steps":["trace[783510518] 'agreement among raft nodes before linearized reading' (duration: 290.663016ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T20:50:21.47547Z","caller":"traceutil/trace.go:171","msg":"trace[1896882308] transaction","detail":"{read_only:false; response_revision:1806; number_of_response:1; }","duration":"112.926783ms","start":"2026-04-12T20:50:21.362497Z","end":"2026-04-12T20:50:21.475424Z","steps":["trace[1896882308] 'process raft request' (duration: 69.993661ms)","trace[1896882308] 'compare' (duration: 42.748997ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T20:51:11.646664Z","caller":"traceutil/trace.go:171","msg":"trace[19686365] transaction","detail":"{read_only:false; response_revision:2133; number_of_response:1; }","duration":"106.340668ms","start":"2026-04-12T20:51:11.540283Z","end":"2026-04-12T20:51:11.646624Z","steps":["trace[19686365] 'process raft request' (duration: 106.171034ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T20:51:11.715082Z","caller":"traceutil/trace.go:171","msg":"trace[149544078] linearizableReadLoop","detail":"{readStateIndex:2209; appliedIndex:2207; }","duration":"128.722134ms","start":"2026-04-12T20:51:11.586335Z","end":"2026-04-12T20:51:11.715057Z","steps":["trace[149544078] 'read index received' (duration: 60.095107ms)","trace[149544078] 'applied index is now lower than readState.Index' (duration: 68.625717ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T20:51:11.71518Z","caller":"traceutil/trace.go:171","msg":"trace[234242627] transaction","detail":"{read_only:false; response_revision:2134; number_of_response:1; }","duration":"169.726484ms","start":"2026-04-12T20:51:11.545437Z","end":"2026-04-12T20:51:11.715164Z","steps":["trace[234242627] 'process raft request' (duration: 169.485488ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T20:51:11.715362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.013952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-12T20:51:11.715427Z","caller":"traceutil/trace.go:171","msg":"trace[497142555] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2134; }","duration":"129.153786ms","start":"2026-04-12T20:51:11.586258Z","end":"2026-04-12T20:51:11.715412Z","steps":["trace[497142555] 'agreement among raft nodes before linearized reading' (duration: 128.93877ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T20:51:12.301297Z","caller":"traceutil/trace.go:171","msg":"trace[1959139664] linearizableReadLoop","detail":"{readStateIndex:2213; appliedIndex:2212; }","duration":"152.179338ms","start":"2026-04-12T20:51:12.149087Z","end":"2026-04-12T20:51:12.301266Z","steps":["trace[1959139664] 'read index received' (duration: 128.518948ms)","trace[1959139664] 'applied index is now lower than readState.Index' (duration: 23.65916ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T20:51:12.301397Z","caller":"traceutil/trace.go:171","msg":"trace[599854332] transaction","detail":"{read_only:false; response_revision:2138; number_of_response:1; }","duration":"166.65825ms","start":"2026-04-12T20:51:12.134715Z","end":"2026-04-12T20:51:12.301373Z","steps":["trace[599854332] 'process raft request' (duration: 142.880226ms)","trace[599854332] 'compare' (duration: 23.077425ms)"],"step_count":2} {"level":"warn","ts":"2026-04-12T20:51:12.301496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.387865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-12T20:51:12.301542Z","caller":"traceutil/trace.go:171","msg":"trace[1601136347] range","detail":"{range_begin:/registry/rabbitmq.com/federations/; range_end:/registry/rabbitmq.com/federations0; response_count:0; response_revision:2138; }","duration":"152.475517ms","start":"2026-04-12T20:51:12.149052Z","end":"2026-04-12T20:51:12.301527Z","steps":["trace[1601136347] 'agreement among raft nodes before linearized reading' (duration: 152.345303ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T20:51:12.302642Z","caller":"traceutil/trace.go:171","msg":"trace[1620117890] transaction","detail":"{read_only:false; response_revision:2139; number_of_response:1; }","duration":"139.470375ms","start":"2026-04-12T20:51:12.163123Z","end":"2026-04-12T20:51:12.302594Z","steps":["trace[1620117890] 'process raft request' (duration: 139.314951ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T20:51:12.302658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.355301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-12T20:51:12.302977Z","caller":"traceutil/trace.go:171","msg":"trace[1250286213] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:2139; }","duration":"112.68361ms","start":"2026-04-12T20:51:12.190218Z","end":"2026-04-12T20:51:12.302902Z","steps":["trace[1250286213] 'agreement among raft nodes before linearized reading' (duration: 112.32558ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T20:52:41.796607Z","caller":"traceutil/trace.go:171","msg":"trace[610769983] transaction","detail":"{read_only:false; response_revision:2811; number_of_response:1; }","duration":"178.751338ms","start":"2026-04-12T20:52:41.617819Z","end":"2026-04-12T20:52:41.796571Z","steps":["trace[610769983] 'process raft request' (duration: 178.531142ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T20:55:07.102372Z","caller":"traceutil/trace.go:171","msg":"trace[1476865155] transaction","detail":"{read_only:false; response_revision:3781; number_of_response:1; }","duration":"248.160978ms","start":"2026-04-12T20:55:06.854178Z","end":"2026-04-12T20:55:07.102339Z","steps":["trace[1476865155] 'process raft request' (duration: 187.46026ms)","trace[1476865155] 'compare' (duration: 60.498552ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T20:55:07.102582Z","caller":"traceutil/trace.go:171","msg":"trace[994128857] transaction","detail":"{read_only:false; response_revision:3782; number_of_response:1; }","duration":"114.828624ms","start":"2026-04-12T20:55:06.98772Z","end":"2026-04-12T20:55:07.102548Z","steps":["trace[994128857] 'process raft request' (duration: 114.577447ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T20:56:26.441348Z","caller":"traceutil/trace.go:171","msg":"trace[484107509] transaction","detail":"{read_only:false; response_revision:4757; number_of_response:1; }","duration":"183.837262ms","start":"2026-04-12T20:56:26.257474Z","end":"2026-04-12T20:56:26.441311Z","steps":["trace[484107509] 'process raft request' (duration: 146.360596ms)","trace[484107509] 'compare' (duration: 37.316622ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T20:56:26.442622Z","caller":"traceutil/trace.go:171","msg":"trace[2034363394] transaction","detail":"{read_only:false; response_revision:4759; number_of_response:1; }","duration":"124.06941ms","start":"2026-04-12T20:56:26.318513Z","end":"2026-04-12T20:56:26.442582Z","steps":["trace[2034363394] 'process raft request' (duration: 123.995408ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T20:56:26.442668Z","caller":"traceutil/trace.go:171","msg":"trace[287793658] transaction","detail":"{read_only:false; response_revision:4758; number_of_response:1; }","duration":"184.711176ms","start":"2026-04-12T20:56:26.257918Z","end":"2026-04-12T20:56:26.442629Z","steps":["trace[287793658] 'process raft request' (duration: 184.430839ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T20:56:32.466425Z","caller":"traceutil/trace.go:171","msg":"trace[830812327] linearizableReadLoop","detail":"{readStateIndex:5179; appliedIndex:5176; }","duration":"113.429356ms","start":"2026-04-12T20:56:32.35296Z","end":"2026-04-12T20:56:32.466389Z","steps":["trace[830812327] 'read index received' (duration: 30.530694ms)","trace[830812327] 'applied index is now lower than readState.Index' (duration: 82.896862ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T20:56:32.466796Z","caller":"traceutil/trace.go:171","msg":"trace[1789716235] transaction","detail":"{read_only:false; response_revision:4998; number_of_response:1; }","duration":"156.489316ms","start":"2026-04-12T20:56:32.310278Z","end":"2026-04-12T20:56:32.466767Z","steps":["trace[1789716235] 'process raft request' (duration: 156.046494ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T20:56:32.466936Z","caller":"traceutil/trace.go:171","msg":"trace[253946066] transaction","detail":"{read_only:false; response_revision:4996; number_of_response:1; }","duration":"158.158673ms","start":"2026-04-12T20:56:32.308735Z","end":"2026-04-12T20:56:32.466894Z","steps":["trace[253946066] 'process raft request' (duration: 74.758857ms)","trace[253946066] 'compare' (duration: 82.543612ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T20:56:32.46688Z","caller":"traceutil/trace.go:171","msg":"trace[499215565] transaction","detail":"{read_only:false; response_revision:4997; number_of_response:1; }","duration":"157.540046ms","start":"2026-04-12T20:56:32.309296Z","end":"2026-04-12T20:56:32.466836Z","steps":["trace[499215565] 'process raft request' (duration: 156.95865ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T20:56:32.467699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.720331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:26 size:787898"} {"level":"info","ts":"2026-04-12T20:56:32.467762Z","caller":"traceutil/trace.go:171","msg":"trace[292454226] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:26; response_revision:4998; }","duration":"114.848806ms","start":"2026-04-12T20:56:32.352898Z","end":"2026-04-12T20:56:32.467747Z","steps":["trace[292454226] 'agreement among raft nodes before linearized reading' (duration: 113.971411ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T20:56:41.250037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.627355ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-12T20:56:41.250233Z","caller":"traceutil/trace.go:171","msg":"trace[644710001] transaction","detail":"{read_only:false; response_revision:5170; number_of_response:1; }","duration":"155.415587ms","start":"2026-04-12T20:56:41.094799Z","end":"2026-04-12T20:56:41.250214Z","steps":["trace[644710001] 'process raft request' (duration: 155.346235ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T20:56:41.250842Z","caller":"traceutil/trace.go:171","msg":"trace[981294761] transaction","detail":"{read_only:false; response_revision:5169; number_of_response:1; }","duration":"155.681054ms","start":"2026-04-12T20:56:41.094531Z","end":"2026-04-12T20:56:41.250212Z","steps":["trace[981294761] 'process raft request' (duration: 17.794652ms)","trace[981294761] 'compare' (duration: 137.485611ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T20:56:49.100257Z","caller":"traceutil/trace.go:171","msg":"trace[1944134983] transaction","detail":"{read_only:false; response_revision:5323; number_of_response:1; }","duration":"138.705794ms","start":"2026-04-12T20:56:48.961528Z","end":"2026-04-12T20:56:49.100234Z","steps":["trace[1944134983] 'process raft request' (duration: 127.992518ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T20:56:49.172534Z","caller":"traceutil/trace.go:171","msg":"trace[134497541] transaction","detail":"{read_only:false; response_revision:5324; number_of_response:1; }","duration":"183.939056ms","start":"2026-04-12T20:56:48.988578Z","end":"2026-04-12T20:56:49.172517Z","steps":["trace[134497541] 'process raft request' (duration: 183.794802ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T20:56:49.172671Z","caller":"traceutil/trace.go:171","msg":"trace[440624973] linearizableReadLoop","detail":"{readStateIndex:5514; appliedIndex:5511; }","duration":"158.470771ms","start":"2026-04-12T20:56:49.014189Z","end":"2026-04-12T20:56:49.17266Z","steps":["trace[440624973] 'read index received' (duration: 75.25815ms)","trace[440624973] 'applied index is now lower than readState.Index' (duration: 83.211411ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T20:56:49.172789Z","caller":"traceutil/trace.go:171","msg":"trace[813287431] transaction","detail":"{read_only:false; response_revision:5325; number_of_response:1; }","duration":"182.398193ms","start":"2026-04-12T20:56:48.990349Z","end":"2026-04-12T20:56:49.172747Z","steps":["trace[813287431] 'process raft request' (duration: 182.131166ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T20:56:49.172921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.710498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-12T20:56:49.172994Z","caller":"traceutil/trace.go:171","msg":"trace[1764430933] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5325; }","duration":"158.838452ms","start":"2026-04-12T20:56:49.014144Z","end":"2026-04-12T20:56:49.172982Z","steps":["trace[1764430933] 'agreement among raft nodes before linearized reading' (duration: 158.593815ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T20:56:51.7408Z","caller":"traceutil/trace.go:171","msg":"trace[198332697] linearizableReadLoop","detail":"{readStateIndex:5541; appliedIndex:5540; }","duration":"207.435635ms","start":"2026-04-12T20:56:51.533339Z","end":"2026-04-12T20:56:51.740774Z","steps":["trace[198332697] 'read index received' (duration: 201.495851ms)","trace[198332697] 'applied index is now lower than readState.Index' (duration: 5.933884ms)"],"step_count":2} {"level":"warn","ts":"2026-04-12T20:56:51.741347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.73351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-04-12T20:56:51.741362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.869617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-12T20:56:51.741389Z","caller":"traceutil/trace.go:171","msg":"trace[1204425885] transaction","detail":"{read_only:false; response_revision:5352; number_of_response:1; }","duration":"220.426644ms","start":"2026-04-12T20:56:51.520907Z","end":"2026-04-12T20:56:51.741333Z","steps":["trace[1204425885] 'process raft request' (duration: 214.055218ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T20:56:51.741482Z","caller":"traceutil/trace.go:171","msg":"trace[510334449] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/; range_end:/registry/rabbitmq.com/rabbitmqclusters0; response_count:0; response_revision:5352; }","duration":"208.143255ms","start":"2026-04-12T20:56:51.533311Z","end":"2026-04-12T20:56:51.741455Z","steps":["trace[510334449] 'agreement among raft nodes before linearized reading' (duration: 207.838496ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T20:56:51.741406Z","caller":"traceutil/trace.go:171","msg":"trace[113899006] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5352; }","duration":"166.852293ms","start":"2026-04-12T20:56:51.57454Z","end":"2026-04-12T20:56:51.741393Z","steps":["trace[113899006] 'agreement among raft nodes before linearized reading' (duration: 166.652048ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T20:58:14.866057Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2996} {"level":"info","ts":"2026-04-12T20:58:14.940617Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2996,"took":"72.931537ms","hash":2947908247,"current-db-size-bytes":58884096,"current-db-size":"59 MB","current-db-size-in-use-bytes":33812480,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-04-12T20:58:14.940687Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2947908247,"revision":2996,"compact-revision":-1} {"level":"info","ts":"2026-04-12T21:02:08.460725Z","caller":"traceutil/trace.go:171","msg":"trace[1935207322] transaction","detail":"{read_only:false; response_revision:7748; number_of_response:1; }","duration":"156.489554ms","start":"2026-04-12T21:02:08.304211Z","end":"2026-04-12T21:02:08.4607Z","steps":["trace[1935207322] 'process raft request' (duration: 156.316179ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T21:02:08.461654Z","caller":"traceutil/trace.go:171","msg":"trace[1323866076] transaction","detail":"{read_only:false; response_revision:7749; number_of_response:1; }","duration":"143.271541ms","start":"2026-04-12T21:02:08.318364Z","end":"2026-04-12T21:02:08.461636Z","steps":["trace[1323866076] 'process raft request' (duration: 143.177389ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T21:03:00.780283Z","caller":"traceutil/trace.go:171","msg":"trace[835973094] transaction","detail":"{read_only:false; response_revision:8207; number_of_response:1; }","duration":"115.472523ms","start":"2026-04-12T21:03:00.664779Z","end":"2026-04-12T21:03:00.780251Z","steps":["trace[835973094] 'process raft request' (duration: 115.240437ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T21:03:00.784938Z","caller":"traceutil/trace.go:171","msg":"trace[202191617] transaction","detail":"{read_only:false; response_revision:8208; number_of_response:1; }","duration":"113.427036ms","start":"2026-04-12T21:03:00.671483Z","end":"2026-04-12T21:03:00.78491Z","steps":["trace[202191617] 'process raft request' (duration: 113.232221ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T21:03:14.871851Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6116} {"level":"info","ts":"2026-04-12T21:03:14.971698Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6116,"took":"96.715506ms","hash":3063511189,"current-db-size-bytes":58884096,"current-db-size":"59 MB","current-db-size-in-use-bytes":23072768,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-04-12T21:03:14.971779Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3063511189,"revision":6116,"compact-revision":2996} {"level":"info","ts":"2026-04-12T21:03:29.147042Z","caller":"traceutil/trace.go:171","msg":"trace[1272760563] linearizableReadLoop","detail":"{readStateIndex:8701; appliedIndex:8698; }","duration":"127.585617ms","start":"2026-04-12T21:03:29.019433Z","end":"2026-04-12T21:03:29.147019Z","steps":["trace[1272760563] 'read index received' (duration: 127.305979ms)","trace[1272760563] 'applied index is now lower than readState.Index' (duration: 278.278µs)"],"step_count":2} {"level":"warn","ts":"2026-04-12T21:03:29.14726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.809373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:529"} {"level":"info","ts":"2026-04-12T21:03:29.14729Z","caller":"traceutil/trace.go:171","msg":"trace[1816852931] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:8412; }","duration":"127.904175ms","start":"2026-04-12T21:03:29.019378Z","end":"2026-04-12T21:03:29.147282Z","steps":["trace[1816852931] 'agreement among raft nodes before linearized reading' (duration: 127.735511ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T21:03:29.147359Z","caller":"traceutil/trace.go:171","msg":"trace[1120072916] transaction","detail":"{read_only:false; response_revision:8410; number_of_response:1; }","duration":"238.635108ms","start":"2026-04-12T21:03:28.908684Z","end":"2026-04-12T21:03:29.147319Z","steps":["trace[1120072916] 'process raft request' (duration: 238.131174ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T21:03:29.147399Z","caller":"traceutil/trace.go:171","msg":"trace[226001276] transaction","detail":"{read_only:false; response_revision:8411; number_of_response:1; }","duration":"221.65883ms","start":"2026-04-12T21:03:28.925687Z","end":"2026-04-12T21:03:29.147346Z","steps":["trace[226001276] 'process raft request' (duration: 221.267869ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T21:03:29.147459Z","caller":"traceutil/trace.go:171","msg":"trace[1764458025] transaction","detail":"{read_only:false; response_revision:8412; number_of_response:1; }","duration":"221.697321ms","start":"2026-04-12T21:03:28.925752Z","end":"2026-04-12T21:03:29.14745Z","steps":["trace[1764458025] 'process raft request' (duration: 221.234578ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T21:03:33.437129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.562558ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-04-12T21:03:33.437522Z","caller":"traceutil/trace.go:171","msg":"trace[31243885] transaction","detail":"{read_only:false; response_revision:8432; number_of_response:1; }","duration":"278.340612ms","start":"2026-04-12T21:03:33.159155Z","end":"2026-04-12T21:03:33.437496Z","steps":["trace[31243885] 'process raft request' (duration: 278.051124ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T21:03:33.517841Z","caller":"traceutil/trace.go:171","msg":"trace[677011629] linearizableReadLoop","detail":"{readStateIndex:8724; appliedIndex:8720; }","duration":"232.92513ms","start":"2026-04-12T21:03:33.284889Z","end":"2026-04-12T21:03:33.517814Z","steps":["trace[677011629] 'read index received' (duration: 78.00299ms)","trace[677011629] 'applied index is now lower than readState.Index' (duration: 154.92112ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T21:03:33.517903Z","caller":"traceutil/trace.go:171","msg":"trace[589531363] transaction","detail":"{read_only:false; response_revision:8433; number_of_response:1; }","duration":"357.012111ms","start":"2026-04-12T21:03:33.16085Z","end":"2026-04-12T21:03:33.517862Z","steps":["trace[589531363] 'process raft request' (duration: 276.632385ms)","trace[589531363] 'compare' (duration: 80.126859ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T21:03:33.517961Z","caller":"traceutil/trace.go:171","msg":"trace[1505095483] transaction","detail":"{read_only:false; response_revision:8434; number_of_response:1; }","duration":"354.912523ms","start":"2026-04-12T21:03:33.162986Z","end":"2026-04-12T21:03:33.517899Z","steps":["trace[1505095483] 'process raft request' (duration: 354.773289ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T21:03:33.518057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T21:03:33.160826Z","time spent":"357.147335ms","remote":"127.0.0.1:47726","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-12T21:03:33.518004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.104316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-12T21:03:33.518151Z","caller":"traceutil/trace.go:171","msg":"trace[132937343] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8434; }","duration":"233.29256ms","start":"2026-04-12T21:03:33.284844Z","end":"2026-04-12T21:03:33.518136Z","steps":["trace[132937343] 'agreement among raft nodes before linearized reading' (duration: 233.057604ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T21:03:33.518161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T21:03:33.162964Z","time spent":"355.099498ms","remote":"127.0.0.1:47726","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-12T21:03:33.913332Z","caller":"traceutil/trace.go:171","msg":"trace[1569030440] linearizableReadLoop","detail":"{readStateIndex:8727; appliedIndex:8726; }","duration":"157.416919ms","start":"2026-04-12T21:03:33.755894Z","end":"2026-04-12T21:03:33.913311Z","steps":["trace[1569030440] 'read index received' (duration: 157.168672ms)","trace[1569030440] 'applied index is now lower than readState.Index' (duration: 247.257µs)"],"step_count":2} {"level":"info","ts":"2026-04-12T21:03:33.913378Z","caller":"traceutil/trace.go:171","msg":"trace[1775854366] transaction","detail":"{read_only:false; response_revision:8437; number_of_response:1; }","duration":"191.954071ms","start":"2026-04-12T21:03:33.7214Z","end":"2026-04-12T21:03:33.913354Z","steps":["trace[1775854366] 'process raft request' (duration: 191.754996ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T21:03:33.913512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.598404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-12T21:03:33.913644Z","caller":"traceutil/trace.go:171","msg":"trace[162677695] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:8437; }","duration":"157.784819ms","start":"2026-04-12T21:03:33.755849Z","end":"2026-04-12T21:03:33.913634Z","steps":["trace[162677695] 'agreement among raft nodes before linearized reading' (duration: 157.583093ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T21:03:41.673595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.540138ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-12T21:03:41.67373Z","caller":"traceutil/trace.go:171","msg":"trace[2059606949] transaction","detail":"{read_only:false; response_revision:8516; number_of_response:1; }","duration":"201.902816ms","start":"2026-04-12T21:03:41.4718Z","end":"2026-04-12T21:03:41.673703Z","steps":["trace[2059606949] 'process raft request' (duration: 87.081041ms)","trace[2059606949] 'compare' (duration: 114.417334ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T21:03:41.678451Z","caller":"traceutil/trace.go:171","msg":"trace[341097442] transaction","detail":"{read_only:false; response_revision:8517; number_of_response:1; }","duration":"132.630306ms","start":"2026-04-12T21:03:41.545806Z","end":"2026-04-12T21:03:41.678436Z","steps":["trace[341097442] 'process raft request' (duration: 132.502403ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T21:03:41.678588Z","caller":"traceutil/trace.go:171","msg":"trace[492457845] linearizableReadLoop","detail":"{readStateIndex:8812; appliedIndex:8810; }","duration":"118.474385ms","start":"2026-04-12T21:03:41.560082Z","end":"2026-04-12T21:03:41.678557Z","steps":["trace[492457845] 'read index received' (duration: 118.146336ms)","trace[492457845] 'applied index is now lower than readState.Index' (duration: 326.109µs)"],"step_count":2} {"level":"info","ts":"2026-04-12T21:03:41.678667Z","caller":"traceutil/trace.go:171","msg":"trace[1952356588] transaction","detail":"{read_only:false; response_revision:8518; number_of_response:1; }","duration":"132.722508ms","start":"2026-04-12T21:03:41.545924Z","end":"2026-04-12T21:03:41.678646Z","steps":["trace[1952356588] 'process raft request' (duration: 132.475671ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T21:03:41.678893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.784904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-12T21:03:41.678954Z","caller":"traceutil/trace.go:171","msg":"trace[903829696] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8518; }","duration":"118.891387ms","start":"2026-04-12T21:03:41.560047Z","end":"2026-04-12T21:03:41.678938Z","steps":["trace[903829696] 'agreement among raft nodes before linearized reading' (duration: 118.683491ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T21:04:25.96618Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002404.wal"} {"level":"info","ts":"2026-04-12T21:04:58.051493Z","caller":"traceutil/trace.go:171","msg":"trace[344623439] transaction","detail":"{read_only:false; response_revision:9264; number_of_response:1; }","duration":"112.887457ms","start":"2026-04-12T21:04:57.938584Z","end":"2026-04-12T21:04:58.051471Z","steps":["trace[344623439] 'process raft request' (duration: 112.702592ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T21:04:58.05175Z","caller":"traceutil/trace.go:171","msg":"trace[1887040118] transaction","detail":"{read_only:false; response_revision:9265; number_of_response:1; }","duration":"100.444314ms","start":"2026-04-12T21:04:57.951285Z","end":"2026-04-12T21:04:58.05173Z","steps":["trace[1887040118] 'process raft request' (duration: 100.149785ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T21:05:53.900325Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"331455d6226d3423","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-12T21:05:53.907673Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-12T21:05:53.907741Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-12T21:08:14.87825Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8286} {"level":"info","ts":"2026-04-12T21:08:14.956018Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8286,"took":"75.633705ms","hash":1374362915,"current-db-size-bytes":58884096,"current-db-size":"59 MB","current-db-size-in-use-bytes":24764416,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-04-12T21:08:14.956095Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1374362915,"revision":8286,"compact-revision":6116} {"level":"info","ts":"2026-04-12T21:13:14.886052Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10676} {"level":"info","ts":"2026-04-12T21:13:14.962667Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10676,"took":"74.802826ms","hash":3926816396,"current-db-size-bytes":58884096,"current-db-size":"59 MB","current-db-size-in-use-bytes":20185088,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-04-12T21:13:14.962724Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3926816396,"revision":10676,"compact-revision":8286}