{"level":"warn","ts":"2026-02-24T12:59:53.006903Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-24T12:59:53.006987Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.105: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.19.213.105:2380","--initial-cluster=instance=https://199.19.213.105:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.105:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.105: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-02-24T12:59:53.007053Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-24T12:59:53.007069Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.105:2380"]} {"level":"info","ts":"2026-02-24T12:59:53.007087Z","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-02-24T12:59:53.007988Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.105:2379"]} {"level":"info","ts":"2026-02-24T12:59:53.008074Z","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":8,"max-cpu-available":8,"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.19.213.105:2380"],"listen-peer-urls":["https://199.19.213.105:2380"],"advertise-client-urls":["https://199.19.213.105:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.105:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.105: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-02-24T12:59:53.012736Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.403264ms"} {"level":"info","ts":"2026-02-24T12:59:53.022084Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"eb6db91b2c71522f","cluster-id":"f43476f3367c14fb"} {"level":"info","ts":"2026-02-24T12:59:53.022226Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eb6db91b2c71522f switched to configuration voters=()"} {"level":"info","ts":"2026-02-24T12:59:53.022263Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eb6db91b2c71522f became follower at term 0"} {"level":"info","ts":"2026-02-24T12:59:53.022279Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft eb6db91b2c71522f [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-24T12:59:53.022295Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eb6db91b2c71522f became follower at term 1"} {"level":"info","ts":"2026-02-24T12:59:53.022409Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eb6db91b2c71522f switched to configuration voters=(16964418897735406127)"} {"level":"warn","ts":"2026-02-24T12:59:53.033065Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-24T12:59:53.034661Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-24T12:59:53.036166Z","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-02-24T12:59:53.03942Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"eb6db91b2c71522f","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-24T12:59:53.039811Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"eb6db91b2c71522f","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-24T12:59:53.039958Z","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-02-24T12:59:53.040001Z","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-02-24T12:59:53.040012Z","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-02-24T12:59:53.041347Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eb6db91b2c71522f switched to configuration voters=(16964418897735406127)"} {"level":"info","ts":"2026-02-24T12:59:53.041538Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"f43476f3367c14fb","local-member-id":"eb6db91b2c71522f","added-peer-id":"eb6db91b2c71522f","added-peer-peer-urls":["https://199.19.213.105:2380"]} {"level":"info","ts":"2026-02-24T12:59:53.045659Z","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-02-24T12:59:53.045862Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"eb6db91b2c71522f","initial-advertise-peer-urls":["https://199.19.213.105:2380"],"listen-peer-urls":["https://199.19.213.105:2380"],"advertise-client-urls":["https://199.19.213.105:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.105:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-24T12:59:53.045885Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-24T12:59:53.045942Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.105:2380"} {"level":"info","ts":"2026-02-24T12:59:53.045954Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.105:2380"} {"level":"info","ts":"2026-02-24T12:59:53.223754Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eb6db91b2c71522f is starting a new election at term 1"} {"level":"info","ts":"2026-02-24T12:59:53.223823Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eb6db91b2c71522f became pre-candidate at term 1"} {"level":"info","ts":"2026-02-24T12:59:53.223848Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eb6db91b2c71522f received MsgPreVoteResp from eb6db91b2c71522f at term 1"} {"level":"info","ts":"2026-02-24T12:59:53.223869Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eb6db91b2c71522f became candidate at term 2"} {"level":"info","ts":"2026-02-24T12:59:53.223881Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eb6db91b2c71522f received MsgVoteResp from eb6db91b2c71522f at term 2"} {"level":"info","ts":"2026-02-24T12:59:53.223903Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eb6db91b2c71522f became leader at term 2"} {"level":"info","ts":"2026-02-24T12:59:53.223921Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: eb6db91b2c71522f elected leader eb6db91b2c71522f at term 2"} {"level":"info","ts":"2026-02-24T12:59:53.224878Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-24T12:59:53.226196Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-24T12:59:53.226247Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-24T12:59:53.226798Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"f43476f3367c14fb","local-member-id":"eb6db91b2c71522f","cluster-version":"3.5"} {"level":"info","ts":"2026-02-24T12:59:53.226911Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-24T12:59:53.226951Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-24T12:59:53.22691Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-24T12:59:53.227207Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-24T12:59:53.230497Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.105:2379"} {"level":"info","ts":"2026-02-24T12:59:53.230572Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-24T12:59:53.230815Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"eb6db91b2c71522f","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.105:2379]}","request-path":"/0/members/eb6db91b2c71522f/attributes","cluster-id":"f43476f3367c14fb","publish-timeout":"7s"} {"level":"info","ts":"2026-02-24T12:59:56.904523Z","caller":"traceutil/trace.go:171","msg":"trace[761292289] transaction","detail":"{read_only:false; response_revision:197; number_of_response:1; }","duration":"143.411285ms","start":"2026-02-24T12:59:56.761084Z","end":"2026-02-24T12:59:56.904496Z","steps":["trace[761292289] 'process raft request' (duration: 100.425254ms)","trace[761292289] 'compare' (duration: 42.816168ms)"],"step_count":2} {"level":"info","ts":"2026-02-24T12:59:56.904687Z","caller":"traceutil/trace.go:171","msg":"trace[986512283] transaction","detail":"{read_only:false; response_revision:198; number_of_response:1; }","duration":"109.557629ms","start":"2026-02-24T12:59:56.795078Z","end":"2026-02-24T12:59:56.904636Z","steps":["trace[986512283] 'process raft request' (duration: 109.437247ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T12:59:57.527741Z","caller":"traceutil/trace.go:171","msg":"trace[2132710045] transaction","detail":"{read_only:false; response_revision:205; number_of_response:1; }","duration":"131.796286ms","start":"2026-02-24T12:59:57.395913Z","end":"2026-02-24T12:59:57.527709Z","steps":["trace[2132710045] 'process raft request' (duration: 95.550038ms)","trace[2132710045] 'compare' (duration: 36.109425ms)"],"step_count":2} {"level":"info","ts":"2026-02-24T13:00:06.751041Z","caller":"traceutil/trace.go:171","msg":"trace[484247454] transaction","detail":"{read_only:false; response_revision:361; number_of_response:1; }","duration":"109.134906ms","start":"2026-02-24T13:00:06.641874Z","end":"2026-02-24T13:00:06.751008Z","steps":["trace[484247454] 'process raft request' (duration: 108.940692ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T13:00:21.387101Z","caller":"traceutil/trace.go:171","msg":"trace[1226304549] transaction","detail":"{read_only:false; response_revision:428; number_of_response:1; }","duration":"225.479988ms","start":"2026-02-24T13:00:21.161593Z","end":"2026-02-24T13:00:21.387073Z","steps":["trace[1226304549] 'process raft request' (duration: 225.312075ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T13:00:21.502809Z","caller":"traceutil/trace.go:171","msg":"trace[223100067] linearizableReadLoop","detail":"{readStateIndex:448; appliedIndex:446; }","duration":"245.176438ms","start":"2026-02-24T13:00:21.25761Z","end":"2026-02-24T13:00:21.502787Z","steps":["trace[223100067] 'read index received' (duration: 129.386908ms)","trace[223100067] 'applied index is now lower than readState.Index' (duration: 115.78844ms)"],"step_count":2} {"level":"warn","ts":"2026-02-24T13:00:21.502913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.288641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-24T13:00:21.502961Z","caller":"traceutil/trace.go:171","msg":"trace[2141129209] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:429; }","duration":"245.391543ms","start":"2026-02-24T13:00:21.257562Z","end":"2026-02-24T13:00:21.502953Z","steps":["trace[2141129209] 'agreement among raft nodes before linearized reading' (duration: 245.304811ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T13:00:21.502996Z","caller":"traceutil/trace.go:171","msg":"trace[1248407526] transaction","detail":"{read_only:false; response_revision:429; number_of_response:1; }","duration":"335.144986ms","start":"2026-02-24T13:00:21.16782Z","end":"2026-02-24T13:00:21.502965Z","steps":["trace[1248407526] 'process raft request' (duration: 322.082141ms)","trace[1248407526] 'compare' (duration: 12.760249ms)"],"step_count":2} {"level":"warn","ts":"2026-02-24T13:00:21.503647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T13:00:21.167802Z","time spent":"335.34476ms","remote":"127.0.0.1:33528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-24T13:00:22.127928Z","caller":"traceutil/trace.go:171","msg":"trace[1726192859] transaction","detail":"{read_only:false; response_revision:442; number_of_response:1; }","duration":"156.04309ms","start":"2026-02-24T13:00:21.97182Z","end":"2026-02-24T13:00:22.127863Z","steps":["trace[1726192859] 'process raft request' (duration: 107.370936ms)","trace[1726192859] 'compare' (duration: 48.288366ms)"],"step_count":2} {"level":"info","ts":"2026-02-24T13:00:22.127971Z","caller":"traceutil/trace.go:171","msg":"trace[1674297670] transaction","detail":"{read_only:false; response_revision:443; number_of_response:1; }","duration":"128.12703ms","start":"2026-02-24T13:00:21.999794Z","end":"2026-02-24T13:00:22.127921Z","steps":["trace[1674297670] 'process raft request' (duration: 127.888295ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T13:00:28.547594Z","caller":"traceutil/trace.go:171","msg":"trace[855763471] linearizableReadLoop","detail":"{readStateIndex:500; appliedIndex:499; }","duration":"290.274164ms","start":"2026-02-24T13:00:28.257303Z","end":"2026-02-24T13:00:28.547577Z","steps":["trace[855763471] 'read index received' (duration: 290.122101ms)","trace[855763471] 'applied index is now lower than readState.Index' (duration: 151.403µs)"],"step_count":2} {"level":"warn","ts":"2026-02-24T13:00:28.547702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.400427ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-24T13:00:28.547726Z","caller":"traceutil/trace.go:171","msg":"trace[1277488032] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:479; }","duration":"290.486568ms","start":"2026-02-24T13:00:28.25723Z","end":"2026-02-24T13:00:28.547717Z","steps":["trace[1277488032] 'agreement among raft nodes before linearized reading' (duration: 290.436137ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T13:00:28.547685Z","caller":"traceutil/trace.go:171","msg":"trace[1621017389] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"317.216733ms","start":"2026-02-24T13:00:28.230445Z","end":"2026-02-24T13:00:28.547662Z","steps":["trace[1621017389] 'process raft request' (duration: 316.975158ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:00:28.547857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T13:00:28.230422Z","time spent":"317.341695ms","remote":"127.0.0.1:33528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-24T13:00:28.798681Z","caller":"traceutil/trace.go:171","msg":"trace[1883775916] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"247.689784ms","start":"2026-02-24T13:00:28.550965Z","end":"2026-02-24T13:00:28.798655Z","steps":["trace[1883775916] 'process raft request' (duration: 242.96527ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T13:00:31.99546Z","caller":"traceutil/trace.go:171","msg":"trace[524018456] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"276.110005ms","start":"2026-02-24T13:00:31.71933Z","end":"2026-02-24T13:00:31.99544Z","steps":["trace[524018456] 'process raft request' (duration: 275.993302ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:00:32.231538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.981506ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-02-24T13:00:33.006604Z","caller":"traceutil/trace.go:171","msg":"trace[1639503439] linearizableReadLoop","detail":"{readStateIndex:514; appliedIndex:513; }","duration":"191.72171ms","start":"2026-02-24T13:00:32.814859Z","end":"2026-02-24T13:00:33.006581Z","steps":["trace[1639503439] 'read index received' (duration: 191.462585ms)","trace[1639503439] 'applied index is now lower than readState.Index' (duration: 258.205µs)"],"step_count":2} {"level":"warn","ts":"2026-02-24T13:00:33.006724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.853883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-02-24T13:00:33.006707Z","caller":"traceutil/trace.go:171","msg":"trace[1454591758] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"443.885461ms","start":"2026-02-24T13:00:32.56279Z","end":"2026-02-24T13:00:33.006675Z","steps":["trace[1454591758] 'process raft request' (duration: 443.619776ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T13:00:33.006759Z","caller":"traceutil/trace.go:171","msg":"trace[919686631] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:492; }","duration":"191.940195ms","start":"2026-02-24T13:00:32.81481Z","end":"2026-02-24T13:00:33.00675Z","steps":["trace[919686631] 'agreement among raft nodes before linearized reading' (duration: 191.858633ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:00:33.007505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T13:00:32.562762Z","time spent":"444.370862ms","remote":"127.0.0.1:33528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-24T13:00:33.287851Z","caller":"traceutil/trace.go:171","msg":"trace[188539785] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"276.857121ms","start":"2026-02-24T13:00:33.010958Z","end":"2026-02-24T13:00:33.287815Z","steps":["trace[188539785] 'process raft request' (duration: 227.911472ms)","trace[188539785] 'compare' (duration: 48.785136ms)"],"step_count":2} {"level":"info","ts":"2026-02-24T13:00:35.14707Z","caller":"traceutil/trace.go:171","msg":"trace[401621529] linearizableReadLoop","detail":"{readStateIndex:533; appliedIndex:530; }","duration":"134.609542ms","start":"2026-02-24T13:00:35.012431Z","end":"2026-02-24T13:00:35.14704Z","steps":["trace[401621529] 'read index received' (duration: 134.326875ms)","trace[401621529] 'applied index is now lower than readState.Index' (duration: 281.597µs)"],"step_count":2} {"level":"info","ts":"2026-02-24T13:00:35.147172Z","caller":"traceutil/trace.go:171","msg":"trace[1809236435] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"300.469688ms","start":"2026-02-24T13:00:34.846693Z","end":"2026-02-24T13:00:35.147162Z","steps":["trace[1809236435] 'process raft request' (duration: 300.247023ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T13:00:35.147216Z","caller":"traceutil/trace.go:171","msg":"trace[1717968529] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"300.426057ms","start":"2026-02-24T13:00:34.846776Z","end":"2026-02-24T13:00:35.147202Z","steps":["trace[1717968529] 'process raft request' (duration: 300.209482ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:00:35.147321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T13:00:34.846772Z","time spent":"300.482578ms","remote":"127.0.0.1:33290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12244,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-24T13:00:35.147322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T13:00:34.846687Z","time spent":"300.543999ms","remote":"127.0.0.1:33290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4234,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-24T13:00:35.14706Z","caller":"traceutil/trace.go:171","msg":"trace[639335759] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"301.418529ms","start":"2026-02-24T13:00:34.8456Z","end":"2026-02-24T13:00:35.147018Z","steps":["trace[639335759] 'process raft request' (duration: 301.215664ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:00:35.147496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T13:00:34.845587Z","time spent":"301.842598ms","remote":"127.0.0.1:33290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3353,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-24T13:00:35.147543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.811477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-24T13:00:35.147581Z","caller":"traceutil/trace.go:171","msg":"trace[578399325] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:0; response_revision:511; }","duration":"113.878879ms","start":"2026-02-24T13:00:35.033691Z","end":"2026-02-24T13:00:35.147569Z","steps":["trace[578399325] 'agreement among raft nodes before linearized reading' (duration: 113.784907ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:00:35.147727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.307098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-02-24T13:00:35.147777Z","caller":"traceutil/trace.go:171","msg":"trace[134261289] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:511; }","duration":"135.40792ms","start":"2026-02-24T13:00:35.012357Z","end":"2026-02-24T13:00:35.147765Z","steps":["trace[134261289] 'agreement among raft nodes before linearized reading' (duration: 135.316748ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T13:00:46.157404Z","caller":"traceutil/trace.go:171","msg":"trace[1633875794] transaction","detail":"{read_only:false; response_revision:660; number_of_response:1; }","duration":"125.313159ms","start":"2026-02-24T13:00:46.032061Z","end":"2026-02-24T13:00:46.157374Z","steps":["trace[1633875794] 'process raft request' (duration: 125.136586ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:00:51.926575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.060368ms","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-02-24T13:00:51.92666Z","caller":"traceutil/trace.go:171","msg":"trace[48569946] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:677; }","duration":"165.1882ms","start":"2026-02-24T13:00:51.76145Z","end":"2026-02-24T13:00:51.926639Z","steps":["trace[48569946] 'range keys from in-memory index tree' (duration: 164.914005ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:00:51.927421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.283785ms","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-02-24T13:00:51.927478Z","caller":"traceutil/trace.go:171","msg":"trace[619031013] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:677; }","duration":"403.384337ms","start":"2026-02-24T13:00:51.524078Z","end":"2026-02-24T13:00:51.927462Z","steps":["trace[619031013] 'range keys from in-memory index tree' (duration: 402.461217ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:00:51.927509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T13:00:51.524056Z","time spent":"403.445919ms","remote":"127.0.0.1:33528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-24T13:00:52.298647Z","caller":"traceutil/trace.go:171","msg":"trace[335498542] transaction","detail":"{read_only:false; response_revision:678; number_of_response:1; }","duration":"367.621375ms","start":"2026-02-24T13:00:51.931003Z","end":"2026-02-24T13:00:52.298624Z","steps":["trace[335498542] 'process raft request' (duration: 367.45111ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:00:52.2988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T13:00:51.930984Z","time spent":"367.737088ms","remote":"127.0.0.1:33528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-24T13:00:52.71124Z","caller":"traceutil/trace.go:171","msg":"trace[1852296982] transaction","detail":"{read_only:false; response_revision:679; number_of_response:1; }","duration":"779.989658ms","start":"2026-02-24T13:00:51.931201Z","end":"2026-02-24T13:00:52.711191Z","steps":["trace[1852296982] 'process raft request' (duration: 736.004777ms)","trace[1852296982] 'compare' (duration: 43.584642ms)"],"step_count":2} {"level":"warn","ts":"2026-02-24T13:00:52.711427Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T13:00:51.931195Z","time spent":"780.139571ms","remote":"127.0.0.1:33528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-24T13:00:52.784424Z","caller":"traceutil/trace.go:171","msg":"trace[665816812] linearizableReadLoop","detail":"{readStateIndex:706; appliedIndex:703; }","duration":"526.306113ms","start":"2026-02-24T13:00:52.258083Z","end":"2026-02-24T13:00:52.784389Z","steps":["trace[665816812] 'read index received' (duration: 40.457414ms)","trace[665816812] 'applied index is now lower than readState.Index' (duration: 485.845909ms)"],"step_count":2} {"level":"warn","ts":"2026-02-24T13:00:52.784551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"526.440886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-24T13:00:52.784586Z","caller":"traceutil/trace.go:171","msg":"trace[934270005] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:679; }","duration":"526.530928ms","start":"2026-02-24T13:00:52.258044Z","end":"2026-02-24T13:00:52.784575Z","steps":["trace[934270005] 'agreement among raft nodes before linearized reading' (duration: 526.447797ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:00:52.784621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T13:00:52.258025Z","time spent":"526.588529ms","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-24T13:00:53.406107Z","caller":"traceutil/trace.go:171","msg":"trace[283793951] transaction","detail":"{read_only:false; response_revision:680; number_of_response:1; }","duration":"396.172269ms","start":"2026-02-24T13:00:53.009893Z","end":"2026-02-24T13:00:53.406066Z","steps":["trace[283793951] 'process raft request' (duration: 396.025935ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:00:53.406246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T13:00:53.009861Z","time spent":"396.313082ms","remote":"127.0.0.1:33528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-24T13:00:53.40659Z","caller":"traceutil/trace.go:171","msg":"trace[645250480] linearizableReadLoop","detail":"{readStateIndex:707; appliedIndex:707; }","duration":"165.751172ms","start":"2026-02-24T13:00:53.240824Z","end":"2026-02-24T13:00:53.406575Z","steps":["trace[645250480] 'read index received' (duration: 165.746112ms)","trace[645250480] 'applied index is now lower than readState.Index' (duration: 4.05µs)"],"step_count":2} {"level":"warn","ts":"2026-02-24T13:00:53.406807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.972077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-24T13:00:53.40687Z","caller":"traceutil/trace.go:171","msg":"trace[452275388] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:680; }","duration":"166.07342ms","start":"2026-02-24T13:00:53.240773Z","end":"2026-02-24T13:00:53.406846Z","steps":["trace[452275388] 'agreement among raft nodes before linearized reading' (duration: 165.913867ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:00:53.406919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.053636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-24T13:00:53.406957Z","caller":"traceutil/trace.go:171","msg":"trace[822274572] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:680; }","duration":"148.347672ms","start":"2026-02-24T13:00:53.258596Z","end":"2026-02-24T13:00:53.406943Z","steps":["trace[822274572] 'agreement among raft nodes before linearized reading' (duration: 148.065156ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T13:00:53.894374Z","caller":"traceutil/trace.go:171","msg":"trace[650638519] transaction","detail":"{read_only:false; response_revision:681; number_of_response:1; }","duration":"484.1026ms","start":"2026-02-24T13:00:53.410242Z","end":"2026-02-24T13:00:53.894345Z","steps":["trace[650638519] 'process raft request' (duration: 483.934016ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:00:53.894529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T13:00:53.41022Z","time spent":"484.235272ms","remote":"127.0.0.1:33528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-24T13:00:53.896245Z","caller":"traceutil/trace.go:171","msg":"trace[1717923851] transaction","detail":"{read_only:false; response_revision:682; number_of_response:1; }","duration":"485.527052ms","start":"2026-02-24T13:00:53.410676Z","end":"2026-02-24T13:00:53.896203Z","steps":["trace[1717923851] 'process raft request' (duration: 485.39898ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:00:53.896395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T13:00:53.410659Z","time spent":"485.660045ms","remote":"127.0.0.1:33528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-24T13:01:14.41669Z","caller":"traceutil/trace.go:171","msg":"trace[594158562] linearizableReadLoop","detail":"{readStateIndex:776; appliedIndex:775; }","duration":"158.991037ms","start":"2026-02-24T13:01:14.257676Z","end":"2026-02-24T13:01:14.416667Z","steps":["trace[594158562] 'read index received' (duration: 158.797853ms)","trace[594158562] 'applied index is now lower than readState.Index' (duration: 192.334µs)"],"step_count":2} {"level":"info","ts":"2026-02-24T13:01:14.416762Z","caller":"traceutil/trace.go:171","msg":"trace[1558815681] transaction","detail":"{read_only:false; response_revision:744; number_of_response:1; }","duration":"365.288889ms","start":"2026-02-24T13:01:14.051433Z","end":"2026-02-24T13:01:14.416722Z","steps":["trace[1558815681] 'process raft request' (duration: 365.095425ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:01:14.41713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.427777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-24T13:01:14.417052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T13:01:14.051417Z","time spent":"365.515674ms","remote":"127.0.0.1:33528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-24T13:01:14.417224Z","caller":"traceutil/trace.go:171","msg":"trace[525311310] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:744; }","duration":"159.578249ms","start":"2026-02-24T13:01:14.257626Z","end":"2026-02-24T13:01:14.417204Z","steps":["trace[525311310] 'agreement among raft nodes before linearized reading' (duration: 159.196872ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T13:01:14.641784Z","caller":"traceutil/trace.go:171","msg":"trace[442309307] transaction","detail":"{read_only:false; response_revision:745; number_of_response:1; }","duration":"220.365295ms","start":"2026-02-24T13:01:14.421394Z","end":"2026-02-24T13:01:14.64176Z","steps":["trace[442309307] 'process raft request' (duration: 210.878885ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:01:14.992962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.572129ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-24T13:01:14.993474Z","caller":"traceutil/trace.go:171","msg":"trace[803839027] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:745; }","duration":"103.10042ms","start":"2026-02-24T13:01:14.890348Z","end":"2026-02-24T13:01:14.993448Z","steps":["trace[803839027] 'range keys from in-memory index tree' (duration: 102.551558ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:01:14.993185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.015968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-24T13:01:14.993578Z","caller":"traceutil/trace.go:171","msg":"trace[1507767049] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:745; }","duration":"163.471138ms","start":"2026-02-24T13:01:14.830089Z","end":"2026-02-24T13:01:14.99356Z","steps":["trace[1507767049] 'count revisions from in-memory index tree' (duration: 162.933957ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:01:14.993063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.50322ms","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-02-24T13:01:14.993722Z","caller":"traceutil/trace.go:171","msg":"trace[1832274502] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:745; }","duration":"178.170134ms","start":"2026-02-24T13:01:14.815503Z","end":"2026-02-24T13:01:14.993673Z","steps":["trace[1832274502] 'range keys from in-memory index tree' (duration: 177.344967ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T13:01:15.806019Z","caller":"traceutil/trace.go:171","msg":"trace[1179838768] transaction","detail":"{read_only:false; response_revision:747; number_of_response:1; }","duration":"112.362776ms","start":"2026-02-24T13:01:15.693631Z","end":"2026-02-24T13:01:15.805994Z","steps":["trace[1179838768] 'process raft request' (duration: 112.216293ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T13:01:16.342296Z","caller":"traceutil/trace.go:171","msg":"trace[1420978688] transaction","detail":"{read_only:false; response_revision:748; number_of_response:1; }","duration":"280.390535ms","start":"2026-02-24T13:01:16.061856Z","end":"2026-02-24T13:01:16.342247Z","steps":["trace[1420978688] 'process raft request' (duration: 280.162091ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:01:16.525508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.433446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-24T13:01:16.525675Z","caller":"traceutil/trace.go:171","msg":"trace[1954626947] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:748; }","duration":"103.62496ms","start":"2026-02-24T13:01:16.421984Z","end":"2026-02-24T13:01:16.525609Z","steps":["trace[1954626947] 'range keys from in-memory index tree' (duration: 103.151201ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T13:01:16.643719Z","caller":"traceutil/trace.go:171","msg":"trace[698275725] transaction","detail":"{read_only:false; response_revision:749; number_of_response:1; }","duration":"112.215304ms","start":"2026-02-24T13:01:16.531465Z","end":"2026-02-24T13:01:16.64368Z","steps":["trace[698275725] 'process raft request' (duration: 111.955649ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T13:01:16.758917Z","caller":"traceutil/trace.go:171","msg":"trace[102937481] transaction","detail":"{read_only:false; response_revision:750; number_of_response:1; }","duration":"108.535779ms","start":"2026-02-24T13:01:16.650349Z","end":"2026-02-24T13:01:16.758885Z","steps":["trace[102937481] 'process raft request' (duration: 108.323665ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T13:01:23.978168Z","caller":"traceutil/trace.go:171","msg":"trace[1846896154] transaction","detail":"{read_only:false; response_revision:770; number_of_response:1; }","duration":"139.809921ms","start":"2026-02-24T13:01:23.838329Z","end":"2026-02-24T13:01:23.978139Z","steps":["trace[1846896154] 'process raft request' (duration: 139.635696ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T13:01:28.983533Z","caller":"traceutil/trace.go:171","msg":"trace[199699585] transaction","detail":"{read_only:false; response_revision:836; number_of_response:1; }","duration":"101.431836ms","start":"2026-02-24T13:01:28.882082Z","end":"2026-02-24T13:01:28.983513Z","steps":["trace[199699585] 'process raft request' (duration: 101.326823ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T13:01:31.191102Z","caller":"traceutil/trace.go:171","msg":"trace[2102695010] transaction","detail":"{read_only:false; response_revision:839; number_of_response:1; }","duration":"739.167921ms","start":"2026-02-24T13:01:30.45191Z","end":"2026-02-24T13:01:31.191078Z","steps":["trace[2102695010] 'process raft request' (duration: 739.020788ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:01:31.191291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T13:01:30.45189Z","time spent":"739.282743ms","remote":"127.0.0.1:33528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-24T13:01:31.40223Z","caller":"traceutil/trace.go:171","msg":"trace[169282866] linearizableReadLoop","detail":"{readStateIndex:877; appliedIndex:875; }","duration":"689.402096ms","start":"2026-02-24T13:01:30.712788Z","end":"2026-02-24T13:01:31.40219Z","steps":["trace[169282866] 'read index received' (duration: 478.201255ms)","trace[169282866] 'applied index is now lower than readState.Index' (duration: 211.199491ms)"],"step_count":2} {"level":"info","ts":"2026-02-24T13:01:31.402275Z","caller":"traceutil/trace.go:171","msg":"trace[2087285154] transaction","detail":"{read_only:false; response_revision:840; number_of_response:1; }","duration":"884.843269ms","start":"2026-02-24T13:01:30.517401Z","end":"2026-02-24T13:01:31.402244Z","steps":["trace[2087285154] 'process raft request' (duration: 827.498102ms)","trace[2087285154] 'compare' (duration: 57.099832ms)"],"step_count":2} {"level":"warn","ts":"2026-02-24T13:01:31.402418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T13:01:30.517375Z","time spent":"884.971162ms","remote":"127.0.0.1:33528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-24T13:01:31.402885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.800873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-02-24T13:01:31.402883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"690.071289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-02-24T13:01:31.402942Z","caller":"traceutil/trace.go:171","msg":"trace[2084345589] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:840; }","duration":"156.881505ms","start":"2026-02-24T13:01:31.246045Z","end":"2026-02-24T13:01:31.402926Z","steps":["trace[2084345589] 'agreement among raft nodes before linearized reading' (duration: 156.538077ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T13:01:31.402977Z","caller":"traceutil/trace.go:171","msg":"trace[916223046] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:840; }","duration":"690.198493ms","start":"2026-02-24T13:01:30.712759Z","end":"2026-02-24T13:01:31.402958Z","steps":["trace[916223046] 'agreement among raft nodes before linearized reading' (duration: 689.557389ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:01:31.40303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T13:01:30.712743Z","time spent":"690.277704ms","remote":"127.0.0.1:33528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-24T13:01:31.403454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.604684ms","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-02-24T13:01:31.403496Z","caller":"traceutil/trace.go:171","msg":"trace[1794792936] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:840; }","duration":"416.681326ms","start":"2026-02-24T13:01:30.986803Z","end":"2026-02-24T13:01:31.403485Z","steps":["trace[1794792936] 'agreement among raft nodes before linearized reading' (duration: 415.540383ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:01:31.403526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T13:01:30.986785Z","time spent":"416.733717ms","remote":"127.0.0.1:33528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-24T13:01:31.565501Z","caller":"traceutil/trace.go:171","msg":"trace[1557960094] transaction","detail":"{read_only:false; response_revision:841; number_of_response:1; }","duration":"158.871515ms","start":"2026-02-24T13:01:31.406602Z","end":"2026-02-24T13:01:31.565474Z","steps":["trace[1557960094] 'process raft request' (duration: 157.252411ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T13:01:31.570542Z","caller":"traceutil/trace.go:171","msg":"trace[1927372401] transaction","detail":"{read_only:false; response_revision:843; number_of_response:1; }","duration":"159.898945ms","start":"2026-02-24T13:01:31.410618Z","end":"2026-02-24T13:01:31.570517Z","steps":["trace[1927372401] 'process raft request' (duration: 159.840554ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T13:01:31.570596Z","caller":"traceutil/trace.go:171","msg":"trace[2057462143] transaction","detail":"{read_only:false; response_revision:842; number_of_response:1; }","duration":"159.987067ms","start":"2026-02-24T13:01:31.410587Z","end":"2026-02-24T13:01:31.570574Z","steps":["trace[2057462143] 'process raft request' (duration: 159.759303ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T13:01:35.731251Z","caller":"traceutil/trace.go:171","msg":"trace[419966144] transaction","detail":"{read_only:false; response_revision:853; number_of_response:1; }","duration":"122.501042ms","start":"2026-02-24T13:01:35.608725Z","end":"2026-02-24T13:01:35.731226Z","steps":["trace[419966144] 'process raft request' (duration: 122.39416ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T13:01:44.01472Z","caller":"traceutil/trace.go:171","msg":"trace[104623397] transaction","detail":"{read_only:false; response_revision:875; number_of_response:1; }","duration":"148.71344ms","start":"2026-02-24T13:01:43.86595Z","end":"2026-02-24T13:01:44.014663Z","steps":["trace[104623397] 'process raft request' (duration: 63.194944ms)","trace[104623397] 'compare' (duration: 85.409853ms)"],"step_count":2} {"level":"info","ts":"2026-02-24T13:01:45.670475Z","caller":"traceutil/trace.go:171","msg":"trace[848413571] linearizableReadLoop","detail":"{readStateIndex:918; appliedIndex:917; }","duration":"306.270148ms","start":"2026-02-24T13:01:45.364182Z","end":"2026-02-24T13:01:45.670452Z","steps":["trace[848413571] 'read index received' (duration: 306.067143ms)","trace[848413571] 'applied index is now lower than readState.Index' (duration: 201.935µs)"],"step_count":2} {"level":"info","ts":"2026-02-24T13:01:45.67078Z","caller":"traceutil/trace.go:171","msg":"trace[1699066086] transaction","detail":"{read_only:false; response_revision:878; number_of_response:1; }","duration":"346.884847ms","start":"2026-02-24T13:01:45.323877Z","end":"2026-02-24T13:01:45.670762Z","steps":["trace[1699066086] 'process raft request' (duration: 346.378256ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:01:45.670644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.446811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-24T13:01:45.671084Z","caller":"traceutil/trace.go:171","msg":"trace[194486845] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:878; }","duration":"306.797678ms","start":"2026-02-24T13:01:45.364163Z","end":"2026-02-24T13:01:45.67096Z","steps":["trace[194486845] 'agreement among raft nodes before linearized reading' (duration: 306.421131ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:01:45.671087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T13:01:45.323857Z","time spent":"346.98138ms","remote":"127.0.0.1:33528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-24T13:01:45.671316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T13:01:45.364099Z","time spent":"307.038623ms","remote":"127.0.0.1:33500","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true "} {"level":"warn","ts":"2026-02-24T13:01:46.259819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.642574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-02-24T13:01:46.259819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.661389ms","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-02-24T13:01:46.2599Z","caller":"traceutil/trace.go:171","msg":"trace[1792757854] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:878; }","duration":"241.743177ms","start":"2026-02-24T13:01:46.018129Z","end":"2026-02-24T13:01:46.259872Z","steps":["trace[1792757854] 'range keys from in-memory index tree' (duration: 241.518131ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T13:01:46.25992Z","caller":"traceutil/trace.go:171","msg":"trace[1882556643] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:878; }","duration":"207.767761ms","start":"2026-02-24T13:01:46.052115Z","end":"2026-02-24T13:01:46.259883Z","steps":["trace[1882556643] 'range keys from in-memory index tree' (duration: 207.533866ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:01:46.259925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"458.628141ms","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-02-24T13:01:46.259974Z","caller":"traceutil/trace.go:171","msg":"trace[401370360] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:878; }","duration":"458.722923ms","start":"2026-02-24T13:01:45.801239Z","end":"2026-02-24T13:01:46.259962Z","steps":["trace[401370360] 'range keys from in-memory index tree' (duration: 458.474299ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:01:46.259999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T13:01:45.801219Z","time spent":"458.775344ms","remote":"127.0.0.1:33528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-24T13:01:48.817596Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5922124176164996846,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-24T13:01:48.844145Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.165201825s","expected-duration":"1s"} {"level":"info","ts":"2026-02-24T13:01:48.844585Z","caller":"traceutil/trace.go:171","msg":"trace[179983875] transaction","detail":"{read_only:false; response_revision:884; number_of_response:1; }","duration":"1.165758476s","start":"2026-02-24T13:01:47.678804Z","end":"2026-02-24T13:01:48.844562Z","steps":["trace[179983875] 'process raft request' (duration: 1.165626583s)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:01:48.844707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T13:01:47.678776Z","time spent":"1.165858028s","remote":"127.0.0.1:33528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-24T13:01:48.873143Z","caller":"traceutil/trace.go:171","msg":"trace[1270523819] linearizableReadLoop","detail":"{readStateIndex:926; appliedIndex:925; }","duration":"555.813262ms","start":"2026-02-24T13:01:48.317314Z","end":"2026-02-24T13:01:48.873127Z","steps":["trace[1270523819] 'read index received' (duration: 527.826907ms)","trace[1270523819] 'applied index is now lower than readState.Index' (duration: 27.985655ms)"],"step_count":2} {"level":"info","ts":"2026-02-24T13:01:48.873372Z","caller":"traceutil/trace.go:171","msg":"trace[1494757616] transaction","detail":"{read_only:false; response_revision:885; number_of_response:1; }","duration":"1.036219583s","start":"2026-02-24T13:01:47.837142Z","end":"2026-02-24T13:01:48.873361Z","steps":["trace[1494757616] 'process raft request' (duration: 1.035892956s)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:01:48.873451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T13:01:47.837114Z","time spent":"1.036289604s","remote":"127.0.0.1:33528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-24T13:01:48.873703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"556.401824ms","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-02-24T13:01:48.87374Z","caller":"traceutil/trace.go:171","msg":"trace[1481239529] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:885; }","duration":"556.490056ms","start":"2026-02-24T13:01:48.317241Z","end":"2026-02-24T13:01:48.873731Z","steps":["trace[1481239529] 'agreement among raft nodes before linearized reading' (duration: 556.364913ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:01:48.87377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T13:01:48.317208Z","time spent":"556.554166ms","remote":"127.0.0.1:33528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-24T13:01:48.873962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"549.845992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-02-24T13:01:48.873994Z","caller":"traceutil/trace.go:171","msg":"trace[693157393] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:885; }","duration":"549.923144ms","start":"2026-02-24T13:01:48.324063Z","end":"2026-02-24T13:01:48.873987Z","steps":["trace[693157393] 'agreement among raft nodes before linearized reading' (duration: 549.843672ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:01:48.874027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T13:01:48.324041Z","time spent":"549.981064ms","remote":"127.0.0.1:33528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-24T13:01:48.8743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.823238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-24T13:01:48.874337Z","caller":"traceutil/trace.go:171","msg":"trace[1749484283] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:885; }","duration":"358.901349ms","start":"2026-02-24T13:01:48.515426Z","end":"2026-02-24T13:01:48.874327Z","steps":["trace[1749484283] 'agreement among raft nodes before linearized reading' (duration: 358.818168ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:01:48.874364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T13:01:48.515402Z","time spent":"358.956421ms","remote":"127.0.0.1:33528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-24T13:01:48.874525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"550.371372ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-24T13:01:48.874556Z","caller":"traceutil/trace.go:171","msg":"trace[577143365] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:885; }","duration":"550.445624ms","start":"2026-02-24T13:01:48.324103Z","end":"2026-02-24T13:01:48.874548Z","steps":["trace[577143365] 'agreement among raft nodes before linearized reading' (duration: 550.369992ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:01:48.874581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T13:01:48.324079Z","time spent":"550.496284ms","remote":"127.0.0.1:33528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-24T13:01:48.984727Z","caller":"traceutil/trace.go:171","msg":"trace[782147128] transaction","detail":"{read_only:false; response_revision:886; number_of_response:1; }","duration":"107.265664ms","start":"2026-02-24T13:01:48.877429Z","end":"2026-02-24T13:01:48.984695Z","steps":["trace[782147128] 'process raft request' (duration: 75.698266ms)","trace[782147128] 'compare' (duration: 31.483206ms)"],"step_count":2} {"level":"info","ts":"2026-02-24T13:01:49.174001Z","caller":"traceutil/trace.go:171","msg":"trace[626722369] transaction","detail":"{read_only:false; response_revision:887; number_of_response:1; }","duration":"296.253527ms","start":"2026-02-24T13:01:48.877724Z","end":"2026-02-24T13:01:49.173978Z","steps":["trace[626722369] 'process raft request' (duration: 270.208971ms)","trace[626722369] 'compare' (duration: 25.893183ms)"],"step_count":2} {"level":"info","ts":"2026-02-24T13:01:49.174279Z","caller":"traceutil/trace.go:171","msg":"trace[2043238468] transaction","detail":"{read_only:false; response_revision:889; number_of_response:1; }","duration":"294.9664ms","start":"2026-02-24T13:01:48.87929Z","end":"2026-02-24T13:01:49.174257Z","steps":["trace[2043238468] 'process raft request' (duration: 294.890159ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T13:01:49.174378Z","caller":"traceutil/trace.go:171","msg":"trace[1711677011] transaction","detail":"{read_only:false; response_revision:888; number_of_response:1; }","duration":"296.368009ms","start":"2026-02-24T13:01:48.877989Z","end":"2026-02-24T13:01:49.174357Z","steps":["trace[1711677011] 'process raft request' (duration: 295.948651ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T13:01:51.38134Z","caller":"traceutil/trace.go:171","msg":"trace[201232919] transaction","detail":"{read_only:false; response_revision:895; number_of_response:1; }","duration":"114.253324ms","start":"2026-02-24T13:01:51.267046Z","end":"2026-02-24T13:01:51.3813Z","steps":["trace[201232919] 'process raft request' (duration: 80.758338ms)","trace[201232919] 'compare' (duration: 33.322742ms)"],"step_count":2} {"level":"info","ts":"2026-02-24T13:01:52.299501Z","caller":"traceutil/trace.go:171","msg":"trace[681002862] transaction","detail":"{read_only:false; response_revision:898; number_of_response:1; }","duration":"114.220743ms","start":"2026-02-24T13:01:52.185251Z","end":"2026-02-24T13:01:52.299471Z","steps":["trace[681002862] 'process raft request' (duration: 114.094831ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T13:01:54.177557Z","caller":"traceutil/trace.go:171","msg":"trace[1808784209] transaction","detail":"{read_only:false; response_revision:907; number_of_response:1; }","duration":"198.511265ms","start":"2026-02-24T13:01:53.979013Z","end":"2026-02-24T13:01:54.177524Z","steps":["trace[1808784209] 'process raft request' (duration: 198.3056ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:01:54.977397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.390423ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-24T13:01:54.977862Z","caller":"traceutil/trace.go:171","msg":"trace[848563433] linearizableReadLoop","detail":"{readStateIndex:950; appliedIndex:949; }","duration":"721.154237ms","start":"2026-02-24T13:01:54.25669Z","end":"2026-02-24T13:01:54.977845Z","steps":["trace[848563433] 'read index received' (duration: 341.247114ms)","trace[848563433] 'applied index is now lower than readState.Index' (duration: 379.905283ms)"],"step_count":2} {"level":"info","ts":"2026-02-24T13:01:54.977935Z","caller":"traceutil/trace.go:171","msg":"trace[1432335119] transaction","detail":"{read_only:false; response_revision:908; number_of_response:1; }","duration":"796.359444ms","start":"2026-02-24T13:01:54.181535Z","end":"2026-02-24T13:01:54.977894Z","steps":["trace[1432335119] 'process raft request' (duration: 416.4099ms)","trace[1432335119] 'compare' (duration: 379.115458ms)"],"step_count":2} {"level":"warn","ts":"2026-02-24T13:01:54.978002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"721.29464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-24T13:01:54.978068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T13:01:54.181512Z","time spent":"796.493287ms","remote":"127.0.0.1:33324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":823,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-24T13:01:54.978103Z","caller":"traceutil/trace.go:171","msg":"trace[1327620218] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:908; }","duration":"721.422522ms","start":"2026-02-24T13:01:54.256644Z","end":"2026-02-24T13:01:54.978067Z","steps":["trace[1327620218] 'agreement among raft nodes before linearized reading' (duration: 721.28604ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:01:54.978157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T13:01:54.256628Z","time spent":"721.517024ms","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-24T13:01:54.978544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"648.92044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-24T13:01:54.978662Z","caller":"traceutil/trace.go:171","msg":"trace[1414206604] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:908; }","duration":"649.055443ms","start":"2026-02-24T13:01:54.329567Z","end":"2026-02-24T13:01:54.978622Z","steps":["trace[1414206604] 'agreement among raft nodes before linearized reading' (duration: 648.930011ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:01:54.97875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T13:01:54.329557Z","time spent":"649.179035ms","remote":"127.0.0.1:56762","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":31,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true "} {"level":"warn","ts":"2026-02-24T13:01:55.622542Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5922124176164996899,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-24T13:01:56.123002Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5922124176164996899,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-24T13:01:56.498986Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.432402605s","expected-duration":"1s"} {"level":"info","ts":"2026-02-24T13:01:56.499338Z","caller":"traceutil/trace.go:171","msg":"trace[863759241] linearizableReadLoop","detail":"{readStateIndex:951; appliedIndex:950; }","duration":"1.377629299s","start":"2026-02-24T13:01:55.121687Z","end":"2026-02-24T13:01:56.499316Z","steps":["trace[863759241] 'read index received' (duration: 1.377406495s)","trace[863759241] 'applied index is now lower than readState.Index' (duration: 221.904µs)"],"step_count":2} {"level":"warn","ts":"2026-02-24T13:01:56.499582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.351197156s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-24T13:01:56.499622Z","caller":"traceutil/trace.go:171","msg":"trace[989282694] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:909; }","duration":"1.351251798s","start":"2026-02-24T13:01:55.14836Z","end":"2026-02-24T13:01:56.499612Z","steps":["trace[989282694] 'agreement among raft nodes before linearized reading' (duration: 1.351047124s)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:01:56.499657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T13:01:55.148294Z","time spent":"1.35135463s","remote":"127.0.0.1:33528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-24T13:01:56.499678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.151012638s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-24T13:01:56.499784Z","caller":"traceutil/trace.go:171","msg":"trace[808841062] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:909; }","duration":"1.151170431s","start":"2026-02-24T13:01:55.348587Z","end":"2026-02-24T13:01:56.499757Z","steps":["trace[808841062] 'agreement among raft nodes before linearized reading' (duration: 1.150988197s)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:01:56.499813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.197408414s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-02-24T13:01:56.499844Z","caller":"traceutil/trace.go:171","msg":"trace[702389889] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:909; }","duration":"1.197476185s","start":"2026-02-24T13:01:55.302358Z","end":"2026-02-24T13:01:56.499834Z","steps":["trace[702389889] 'agreement among raft nodes before linearized reading' (duration: 1.197397544s)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:01:56.499856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T13:01:55.348564Z","time spent":"1.151273843s","remote":"127.0.0.1:33458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":42,"response size":31,"request content":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true "} {"level":"warn","ts":"2026-02-24T13:01:56.499941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.198021186s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-02-24T13:01:56.499977Z","caller":"traceutil/trace.go:171","msg":"trace[739669331] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:909; }","duration":"1.198091597s","start":"2026-02-24T13:01:55.301878Z","end":"2026-02-24T13:01:56.499969Z","steps":["trace[739669331] 'agreement among raft nodes before linearized reading' (duration: 1.198012945s)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:01:56.500007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T13:01:55.30183Z","time spent":"1.198168768s","remote":"127.0.0.1:33528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-24T13:01:56.500116Z","caller":"traceutil/trace.go:171","msg":"trace[1934762434] transaction","detail":"{read_only:false; response_revision:909; number_of_response:1; }","duration":"1.517637393s","start":"2026-02-24T13:01:54.982454Z","end":"2026-02-24T13:01:56.500092Z","steps":["trace[1934762434] 'process raft request' (duration: 1.516698225s)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:01:56.50023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.010269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-02-24T13:01:56.499871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T13:01:55.302332Z","time spent":"1.197533196s","remote":"127.0.0.1:33528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-24T13:01:56.500397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.348489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-24T13:01:56.500435Z","caller":"traceutil/trace.go:171","msg":"trace[532286538] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:909; }","duration":"243.411601ms","start":"2026-02-24T13:01:56.257014Z","end":"2026-02-24T13:01:56.500425Z","steps":["trace[532286538] 'agreement among raft nodes before linearized reading' (duration: 243.3584ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T13:01:56.500292Z","caller":"traceutil/trace.go:171","msg":"trace[1278421539] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:909; }","duration":"110.128871ms","start":"2026-02-24T13:01:56.390149Z","end":"2026-02-24T13:01:56.500278Z","steps":["trace[1278421539] 'agreement among raft nodes before linearized reading' (duration: 110.025759ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:01:56.500416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T13:01:54.982406Z","time spent":"1.517821487s","remote":"127.0.0.1:33528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-24T13:01:56.499806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.377913874s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-24T13:01:56.501329Z","caller":"traceutil/trace.go:171","msg":"trace[97221821] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:909; }","duration":"1.37967386s","start":"2026-02-24T13:01:55.121635Z","end":"2026-02-24T13:01:56.501309Z","steps":["trace[97221821] 'agreement among raft nodes before linearized reading' (duration: 1.377779192s)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:01:56.501453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.238165175s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-02-24T13:01:56.501522Z","caller":"traceutil/trace.go:171","msg":"trace[437441937] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:909; }","duration":"1.238288518s","start":"2026-02-24T13:01:55.263218Z","end":"2026-02-24T13:01:56.501507Z","steps":["trace[437441937] 'agreement among raft nodes before linearized reading' (duration: 1.238125695s)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:01:56.501465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T13:01:55.121612Z","time spent":"1.379829854s","remote":"127.0.0.1:33424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":31,"request content":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true "} {"level":"warn","ts":"2026-02-24T13:01:56.501559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T13:01:55.263194Z","time spent":"1.23835651s","remote":"127.0.0.1:33528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-24T13:01:58.022323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.294871859s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-24T13:01:58.022482Z","caller":"traceutil/trace.go:171","msg":"trace[1177723598] transaction","detail":"{read_only:false; response_revision:910; number_of_response:1; }","duration":"1.518486321s","start":"2026-02-24T13:01:56.503978Z","end":"2026-02-24T13:01:58.022464Z","steps":["trace[1177723598] 'process raft request' (duration: 223.402647ms)","trace[1177723598] 'compare' (duration: 1.294068143s)"],"step_count":2} {"level":"warn","ts":"2026-02-24T13:01:58.022548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T13:01:56.503955Z","time spent":"1.518559993s","remote":"127.0.0.1:33528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-24T13:01:58.022768Z","caller":"traceutil/trace.go:171","msg":"trace[1796216040] linearizableReadLoop","detail":"{readStateIndex:955; appliedIndex:951; }","duration":"1.309198129s","start":"2026-02-24T13:01:56.713555Z","end":"2026-02-24T13:01:58.022754Z","steps":["trace[1796216040] 'read index received' (duration: 13.834229ms)","trace[1796216040] 'applied index is now lower than readState.Index' (duration: 1.29536148s)"],"step_count":2} {"level":"info","ts":"2026-02-24T13:01:58.022757Z","caller":"traceutil/trace.go:171","msg":"trace[1450175480] transaction","detail":"{read_only:false; response_revision:911; number_of_response:1; }","duration":"1.518356749s","start":"2026-02-24T13:01:56.504367Z","end":"2026-02-24T13:01:58.022724Z","steps":["trace[1450175480] 'process raft request' (duration: 1.518044173s)"],"step_count":1} {"level":"info","ts":"2026-02-24T13:01:58.022852Z","caller":"traceutil/trace.go:171","msg":"trace[1154035098] transaction","detail":"{read_only:false; response_revision:912; number_of_response:1; }","duration":"1.517995641s","start":"2026-02-24T13:01:56.504842Z","end":"2026-02-24T13:01:58.022838Z","steps":["trace[1154035098] 'process raft request' (duration: 1.517797087s)"],"step_count":1} {"level":"info","ts":"2026-02-24T13:01:58.022868Z","caller":"traceutil/trace.go:171","msg":"trace[561564756] transaction","detail":"{read_only:false; response_revision:913; number_of_response:1; }","duration":"1.517339778s","start":"2026-02-24T13:01:56.505517Z","end":"2026-02-24T13:01:58.022857Z","steps":["trace[561564756] 'process raft request' (duration: 1.517195695s)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:01:58.022912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T13:01:56.504833Z","time spent":"1.518047411s","remote":"127.0.0.1:33528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-24T13:01:58.022926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T13:01:56.505509Z","time spent":"1.517380019s","remote":"127.0.0.1:33528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-24T13:01:58.022917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T13:01:56.504352Z","time spent":"1.518477871s","remote":"127.0.0.1:33528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-24T13:01:58.023088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.731848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-24T13:01:58.023137Z","caller":"traceutil/trace.go:171","msg":"trace[1567114205] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:913; }","duration":"194.811929ms","start":"2026-02-24T13:01:57.828307Z","end":"2026-02-24T13:01:58.023119Z","steps":["trace[1567114205] 'agreement among raft nodes before linearized reading' (duration: 194.740938ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:01:58.023201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.309652908s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.105\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-24T13:01:58.023232Z","caller":"traceutil/trace.go:171","msg":"trace[380963564] range","detail":"{range_begin:/registry/masterleases/199.19.213.105; range_end:; response_count:1; response_revision:913; }","duration":"1.309723359s","start":"2026-02-24T13:01:56.713499Z","end":"2026-02-24T13:01:58.023222Z","steps":["trace[380963564] 'agreement among raft nodes before linearized reading' (duration: 1.309618797s)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:01:58.023258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T13:01:56.713468Z","time spent":"1.309782641s","remote":"127.0.0.1:33278","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":159,"request content":"key:\"/registry/masterleases/199.19.213.105\" "} {"level":"warn","ts":"2026-02-24T13:01:58.757164Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5922124176164996909,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-24T13:01:59.157992Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.132678638s","expected-duration":"1s"} {"level":"warn","ts":"2026-02-24T13:02:00.114457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"956.195273ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:41"} {"level":"info","ts":"2026-02-24T13:02:00.114846Z","caller":"traceutil/trace.go:171","msg":"trace[2012179177] transaction","detail":"{read_only:false; response_revision:914; number_of_response:1; }","duration":"1.084860978s","start":"2026-02-24T13:01:59.029965Z","end":"2026-02-24T13:02:00.114826Z","steps":["trace[2012179177] 'process raft request' (duration: 1.084682534s)"],"step_count":1} {"level":"info","ts":"2026-02-24T13:02:00.115012Z","caller":"traceutil/trace.go:171","msg":"trace[493487685] linearizableReadLoop","detail":"{readStateIndex:956; appliedIndex:955; }","duration":"1.85784251s","start":"2026-02-24T13:01:58.257123Z","end":"2026-02-24T13:02:00.114966Z","steps":["trace[493487685] 'read index received' (duration: 901.123698ms)","trace[493487685] 'applied index is now lower than readState.Index' (duration: 956.715732ms)"],"step_count":2} {"level":"warn","ts":"2026-02-24T13:02:00.115237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.858096765s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-24T13:02:00.115297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.608899498s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-02-24T13:02:00.11531Z","caller":"traceutil/trace.go:171","msg":"trace[1599603561] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:914; }","duration":"1.858217048s","start":"2026-02-24T13:01:58.257076Z","end":"2026-02-24T13:02:00.115293Z","steps":["trace[1599603561] 'agreement among raft nodes before linearized reading' (duration: 1.858051774s)"],"step_count":1} {"level":"info","ts":"2026-02-24T13:02:00.115335Z","caller":"traceutil/trace.go:171","msg":"trace[293909808] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:914; }","duration":"1.60898035s","start":"2026-02-24T13:01:58.506343Z","end":"2026-02-24T13:02:00.115323Z","steps":["trace[293909808] 'agreement among raft nodes before linearized reading' (duration: 1.608818427s)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:02:00.11537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T13:01:58.506322Z","time spent":"1.609040051s","remote":"127.0.0.1:33528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-24T13:02:00.115376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T13:01:58.257057Z","time spent":"1.858299099s","remote":"127.0.0.1:33260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-24T13:02:00.11526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T13:01:59.029941Z","time spent":"1.085062952s","remote":"127.0.0.1:33528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-24T13:02:00.115586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"599.558318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-24T13:02:00.115621Z","caller":"traceutil/trace.go:171","msg":"trace[822803605] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:914; }","duration":"599.63158ms","start":"2026-02-24T13:01:59.515981Z","end":"2026-02-24T13:02:00.115613Z","steps":["trace[822803605] 'agreement among raft nodes before linearized reading' (duration: 599.574719ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:02:00.115651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T13:01:59.515959Z","time spent":"599.684071ms","remote":"127.0.0.1:33698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":3,"response size":31,"request content":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true "} {"level":"warn","ts":"2026-02-24T13:02:00.11493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T13:01:58.025198Z","time spent":"2.089725127s","remote":"127.0.0.1:33278","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-02-24T13:02:00.115433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"580.279748ms","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-02-24T13:02:00.115723Z","caller":"traceutil/trace.go:171","msg":"trace[1089543552] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:914; }","duration":"580.607926ms","start":"2026-02-24T13:01:59.535095Z","end":"2026-02-24T13:02:00.115703Z","steps":["trace[1089543552] 'agreement among raft nodes before linearized reading' (duration: 580.272598ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:02:00.115789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T13:01:59.535073Z","time spent":"580.698617ms","remote":"127.0.0.1:56776","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":3,"response size":31,"request content":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true "} {"level":"warn","ts":"2026-02-24T13:02:01.004994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"574.48947ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-24T13:02:01.005268Z","caller":"traceutil/trace.go:171","msg":"trace[2111506641] transaction","detail":"{read_only:false; response_revision:915; number_of_response:1; }","duration":"888.154676ms","start":"2026-02-24T13:02:00.117027Z","end":"2026-02-24T13:02:01.005182Z","steps":["trace[2111506641] 'process raft request' (duration: 313.255858ms)","trace[2111506641] 'compare' (duration: 573.977819ms)"],"step_count":2} {"level":"warn","ts":"2026-02-24T13:02:01.005393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T13:02:00.117006Z","time spent":"888.34421ms","remote":"127.0.0.1:33278","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-24T13:02:02.042733Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.612441329s","expected-duration":"1s"} {"level":"info","ts":"2026-02-24T13:02:02.043268Z","caller":"traceutil/trace.go:171","msg":"trace[589759150] linearizableReadLoop","detail":"{readStateIndex:960; appliedIndex:957; }","duration":"1.921760717s","start":"2026-02-24T13:02:00.121479Z","end":"2026-02-24T13:02:02.04324Z","steps":["trace[589759150] 'read index received' (duration: 308.846569ms)","trace[589759150] 'applied index is now lower than readState.Index' (duration: 1.612912398s)"],"step_count":2} {"level":"info","ts":"2026-02-24T13:02:02.043583Z","caller":"traceutil/trace.go:171","msg":"trace[983942105] transaction","detail":"{read_only:false; response_revision:916; number_of_response:1; }","duration":"1.923075864s","start":"2026-02-24T13:02:00.120489Z","end":"2026-02-24T13:02:02.043565Z","steps":["trace[983942105] 'process raft request' (duration: 1.922441701s)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:02:02.043826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T13:02:00.120473Z","time spent":"1.923266997s","remote":"127.0.0.1:33528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-24T13:02:02.044033Z","caller":"traceutil/trace.go:171","msg":"trace[130698160] transaction","detail":"{read_only:false; response_revision:917; number_of_response:1; }","duration":"1.92339188s","start":"2026-02-24T13:02:00.120629Z","end":"2026-02-24T13:02:02.044021Z","steps":["trace[130698160] 'process raft request' (duration: 1.92242353s)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:02:02.044087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T13:02:00.12061Z","time spent":"1.923448152s","remote":"127.0.0.1:33528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-24T13:02:02.04421Z","caller":"traceutil/trace.go:171","msg":"trace[2126624173] transaction","detail":"{read_only:false; response_revision:918; number_of_response:1; }","duration":"1.922649394s","start":"2026-02-24T13:02:00.121551Z","end":"2026-02-24T13:02:02.044201Z","steps":["trace[2126624173] 'process raft request' (duration: 1.921559892s)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:02:02.044299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T13:02:00.121542Z","time spent":"1.922726796s","remote":"127.0.0.1:33528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-24T13:02:02.04441Z","caller":"traceutil/trace.go:171","msg":"trace[221979808] transaction","detail":"{read_only:false; response_revision:919; number_of_response:1; }","duration":"1.922588923s","start":"2026-02-24T13:02:00.121813Z","end":"2026-02-24T13:02:02.044402Z","steps":["trace[221979808] 'process raft request' (duration: 1.921347328s)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:02:02.044454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T13:02:00.121799Z","time spent":"1.922630544s","remote":"127.0.0.1:33528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-24T13:02:02.044563Z","caller":"traceutil/trace.go:171","msg":"trace[1512691476] transaction","detail":"{read_only:false; response_revision:920; number_of_response:1; }","duration":"1.922716796s","start":"2026-02-24T13:02:00.121836Z","end":"2026-02-24T13:02:02.044553Z","steps":["trace[1512691476] 'process raft request' (duration: 1.921358529s)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:02:02.044607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T13:02:00.121828Z","time spent":"1.922754807s","remote":"127.0.0.1:33528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-24T13:02:02.04473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.923246466s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-24T13:02:02.044836Z","caller":"traceutil/trace.go:171","msg":"trace[1485499289] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:920; }","duration":"1.923363718s","start":"2026-02-24T13:02:00.121461Z","end":"2026-02-24T13:02:02.044825Z","steps":["trace[1485499289] 'agreement among raft nodes before linearized reading' (duration: 1.923240706s)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:02:02.044897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T13:02:00.121453Z","time spent":"1.923435331s","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-24T13:02:02.155148Z","caller":"traceutil/trace.go:171","msg":"trace[1873820584] linearizableReadLoop","detail":"{readStateIndex:964; appliedIndex:963; }","duration":"111.799795ms","start":"2026-02-24T13:02:02.043325Z","end":"2026-02-24T13:02:02.155125Z","steps":["trace[1873820584] 'read index received' (duration: 111.684913ms)","trace[1873820584] 'applied index is now lower than readState.Index' (duration: 113.722µs)"],"step_count":2} {"level":"info","ts":"2026-02-24T13:02:02.15524Z","caller":"traceutil/trace.go:171","msg":"trace[741297553] transaction","detail":"{read_only:false; response_revision:921; number_of_response:1; }","duration":"877.284017ms","start":"2026-02-24T13:02:01.277919Z","end":"2026-02-24T13:02:02.155203Z","steps":["trace[741297553] 'process raft request' (duration: 877.058073ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:02:02.155333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.147554258s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"info","ts":"2026-02-24T13:02:02.155367Z","caller":"traceutil/trace.go:171","msg":"trace[1313663731] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:921; }","duration":"1.14764913s","start":"2026-02-24T13:02:01.007708Z","end":"2026-02-24T13:02:02.155357Z","steps":["trace[1313663731] 'agreement among raft nodes before linearized reading' (duration: 1.147521427s)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:02:02.155384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T13:02:01.277889Z","time spent":"877.41428ms","remote":"127.0.0.1:33424","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4867,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-24T13:02:02.155384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"682.57638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-02-24T13:02:02.155453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.378402147s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-24T13:02:02.155459Z","caller":"traceutil/trace.go:171","msg":"trace[324134534] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:921; }","duration":"682.706953ms","start":"2026-02-24T13:02:01.472733Z","end":"2026-02-24T13:02:02.15544Z","steps":["trace[324134534] 'agreement among raft nodes before linearized reading' (duration: 682.478718ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T13:02:02.155481Z","caller":"traceutil/trace.go:171","msg":"trace[472146402] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:921; }","duration":"1.378485808s","start":"2026-02-24T13:02:00.776988Z","end":"2026-02-24T13:02:02.155474Z","steps":["trace[472146402] 'agreement among raft nodes before linearized reading' (duration: 1.378439687s)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:02:02.155509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T13:02:00.776957Z","time spent":"1.37854499s","remote":"127.0.0.1:33686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":29,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "} {"level":"warn","ts":"2026-02-24T13:02:02.155406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T13:02:01.007688Z","time spent":"1.147705262s","remote":"127.0.0.1:33412","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":446,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "} {"level":"warn","ts":"2026-02-24T13:02:02.155507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T13:02:01.47271Z","time spent":"682.786745ms","remote":"127.0.0.1:33746","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":92,"response size":31,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"warn","ts":"2026-02-24T13:02:02.248263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.391892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-24T13:02:02.248358Z","caller":"traceutil/trace.go:171","msg":"trace[964134525] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:921; }","duration":"200.521515ms","start":"2026-02-24T13:02:02.047814Z","end":"2026-02-24T13:02:02.248335Z","steps":["trace[964134525] 'agreement among raft nodes before linearized reading' (duration: 200.366172ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T13:02:08.214481Z","caller":"traceutil/trace.go:171","msg":"trace[2058238889] transaction","detail":"{read_only:false; response_revision:934; number_of_response:1; }","duration":"101.466748ms","start":"2026-02-24T13:02:08.112986Z","end":"2026-02-24T13:02:08.214453Z","steps":["trace[2058238889] 'process raft request' (duration: 101.265564ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T13:02:10.386383Z","caller":"traceutil/trace.go:171","msg":"trace[329539668] linearizableReadLoop","detail":"{readStateIndex:984; appliedIndex:983; }","duration":"152.153328ms","start":"2026-02-24T13:02:10.234216Z","end":"2026-02-24T13:02:10.386369Z","steps":["trace[329539668] 'read index received' (duration: 152.020146ms)","trace[329539668] 'applied index is now lower than readState.Index' (duration: 132.652µs)"],"step_count":2} {"level":"info","ts":"2026-02-24T13:02:10.386451Z","caller":"traceutil/trace.go:171","msg":"trace[153234200] transaction","detail":"{read_only:false; response_revision:939; number_of_response:1; }","duration":"163.296543ms","start":"2026-02-24T13:02:10.223149Z","end":"2026-02-24T13:02:10.386446Z","steps":["trace[153234200] 'process raft request' (duration: 163.12805ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:02:10.386765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.806084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-02-24T13:02:10.386794Z","caller":"traceutil/trace.go:171","msg":"trace[585211954] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:939; }","duration":"107.863745ms","start":"2026-02-24T13:02:10.278921Z","end":"2026-02-24T13:02:10.386785Z","steps":["trace[585211954] 'agreement among raft nodes before linearized reading' (duration: 107.778304ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:02:10.386856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.410425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-02-24T13:02:10.38698Z","caller":"traceutil/trace.go:171","msg":"trace[609488430] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:939; }","duration":"107.536069ms","start":"2026-02-24T13:02:10.279395Z","end":"2026-02-24T13:02:10.386931Z","steps":["trace[609488430] 'agreement among raft nodes before linearized reading' (duration: 107.245743ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:02:10.386613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.185055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-24T13:02:10.38749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.934327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-02-24T13:02:10.387419Z","caller":"traceutil/trace.go:171","msg":"trace[1980013468] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:939; }","duration":"130.036642ms","start":"2026-02-24T13:02:10.257365Z","end":"2026-02-24T13:02:10.387401Z","steps":["trace[1980013468] 'agreement among raft nodes before linearized reading' (duration: 129.186945ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:02:10.387519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.300152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-02-24T13:02:10.387555Z","caller":"traceutil/trace.go:171","msg":"trace[2761549] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:939; }","duration":"108.036829ms","start":"2026-02-24T13:02:10.279502Z","end":"2026-02-24T13:02:10.387539Z","steps":["trace[2761549] 'agreement among raft nodes before linearized reading' (duration: 107.074919ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T13:02:10.387576Z","caller":"traceutil/trace.go:171","msg":"trace[1887900799] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:939; }","duration":"153.388914ms","start":"2026-02-24T13:02:10.234172Z","end":"2026-02-24T13:02:10.387561Z","steps":["trace[1887900799] 'agreement among raft nodes before linearized reading' (duration: 152.609417ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T13:02:10.582515Z","caller":"traceutil/trace.go:171","msg":"trace[863133400] transaction","detail":"{read_only:false; response_revision:940; number_of_response:1; }","duration":"191.467382ms","start":"2026-02-24T13:02:10.391017Z","end":"2026-02-24T13:02:10.582484Z","steps":["trace[863133400] 'process raft request' (duration: 173.262935ms)","trace[863133400] 'compare' (duration: 18.064415ms)"],"step_count":2} {"level":"info","ts":"2026-02-24T13:02:10.589066Z","caller":"traceutil/trace.go:171","msg":"trace[1439712109] transaction","detail":"{read_only:false; response_revision:944; number_of_response:1; }","duration":"123.92742ms","start":"2026-02-24T13:02:10.465114Z","end":"2026-02-24T13:02:10.589042Z","steps":["trace[1439712109] 'process raft request' (duration: 123.882119ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T13:02:10.589404Z","caller":"traceutil/trace.go:171","msg":"trace[368543174] transaction","detail":"{read_only:false; response_revision:941; number_of_response:1; }","duration":"197.681787ms","start":"2026-02-24T13:02:10.391711Z","end":"2026-02-24T13:02:10.589393Z","steps":["trace[368543174] 'process raft request' (duration: 197.060074ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T13:02:10.589554Z","caller":"traceutil/trace.go:171","msg":"trace[308076439] transaction","detail":"{read_only:false; response_revision:942; number_of_response:1; }","duration":"197.301489ms","start":"2026-02-24T13:02:10.392231Z","end":"2026-02-24T13:02:10.589533Z","steps":["trace[308076439] 'process raft request' (duration: 196.665407ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T13:02:10.589608Z","caller":"traceutil/trace.go:171","msg":"trace[984023856] transaction","detail":"{read_only:false; response_revision:943; number_of_response:1; }","duration":"197.080465ms","start":"2026-02-24T13:02:10.392477Z","end":"2026-02-24T13:02:10.589558Z","steps":["trace[984023856] 'process raft request' (duration: 196.473573ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T13:02:11.022615Z","caller":"traceutil/trace.go:171","msg":"trace[1425082081] transaction","detail":"{read_only:false; response_revision:945; number_of_response:1; }","duration":"264.633109ms","start":"2026-02-24T13:02:10.757953Z","end":"2026-02-24T13:02:11.022586Z","steps":["trace[1425082081] 'process raft request' (duration: 264.354923ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T13:02:22.604778Z","caller":"traceutil/trace.go:171","msg":"trace[1359863024] transaction","detail":"{read_only:false; response_revision:1029; number_of_response:1; }","duration":"135.824645ms","start":"2026-02-24T13:02:22.468929Z","end":"2026-02-24T13:02:22.604754Z","steps":["trace[1359863024] 'process raft request' (duration: 135.244113ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T13:02:22.832214Z","caller":"traceutil/trace.go:171","msg":"trace[2044038569] transaction","detail":"{read_only:false; response_revision:1030; number_of_response:1; }","duration":"196.815346ms","start":"2026-02-24T13:02:22.635283Z","end":"2026-02-24T13:02:22.832099Z","steps":["trace[2044038569] 'process raft request' (duration: 196.505621ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:02:22.832425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.683405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-24T13:02:22.832482Z","caller":"traceutil/trace.go:171","msg":"trace[677178190] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1030; }","duration":"195.794307ms","start":"2026-02-24T13:02:22.636675Z","end":"2026-02-24T13:02:22.832469Z","steps":["trace[677178190] 'agreement among raft nodes before linearized reading' (duration: 195.590333ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T13:02:22.832012Z","caller":"traceutil/trace.go:171","msg":"trace[1015062563] linearizableReadLoop","detail":"{readStateIndex:1078; appliedIndex:1077; }","duration":"195.253727ms","start":"2026-02-24T13:02:22.636731Z","end":"2026-02-24T13:02:22.831984Z","steps":["trace[1015062563] 'read index received' (duration: 195.055564ms)","trace[1015062563] 'applied index is now lower than readState.Index' (duration: 196.763µs)"],"step_count":2} {"level":"warn","ts":"2026-02-24T13:02:22.833541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.784088ms","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-02-24T13:02:22.833611Z","caller":"traceutil/trace.go:171","msg":"trace[695139233] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1030; }","duration":"187.973881ms","start":"2026-02-24T13:02:22.645618Z","end":"2026-02-24T13:02:22.833592Z","steps":["trace[695139233] 'agreement among raft nodes before linearized reading' (duration: 187.464102ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T13:02:22.834008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.057083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-02-24T13:02:22.834109Z","caller":"traceutil/trace.go:171","msg":"trace[4955679] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1030; }","duration":"196.143866ms","start":"2026-02-24T13:02:22.637918Z","end":"2026-02-24T13:02:22.834062Z","steps":["trace[4955679] 'agreement among raft nodes before linearized reading' (duration: 195.131327ms)"],"step_count":1}