{"level":"warn","ts":"2026-02-10T18:53:07.670196Z","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-10T18:53:07.670518Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.207: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.207:2380","--initial-cluster=instance=https://199.19.213.207:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.207:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.207: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-10T18:53:07.670706Z","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-10T18:53:07.670794Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.207:2380"]} {"level":"info","ts":"2026-02-10T18:53:07.670887Z","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-10T18:53:07.672063Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.207:2379"]} {"level":"info","ts":"2026-02-10T18:53:07.672289Z","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":2,"max-cpu-available":2,"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.207:2380"],"listen-peer-urls":["https://199.19.213.207:2380"],"advertise-client-urls":["https://199.19.213.207:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.207:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.207: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-10T18:53:08.863878Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"1.108305208s"} {"level":"info","ts":"2026-02-10T18:53:09.753805Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"520ed656383c33a4","cluster-id":"21f34f1629612ac4"} {"level":"info","ts":"2026-02-10T18:53:09.753938Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"520ed656383c33a4 switched to configuration voters=()"} {"level":"info","ts":"2026-02-10T18:53:09.75398Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"520ed656383c33a4 became follower at term 0"} {"level":"info","ts":"2026-02-10T18:53:09.754001Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 520ed656383c33a4 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-10T18:53:09.754014Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"520ed656383c33a4 became follower at term 1"} {"level":"info","ts":"2026-02-10T18:53:09.754078Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"520ed656383c33a4 switched to configuration voters=(5912899026583040932)"} {"level":"warn","ts":"2026-02-10T18:53:09.773378Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-10T18:53:09.778211Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-10T18:53:09.781933Z","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-10T18:53:09.807096Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"520ed656383c33a4","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-10T18:53:09.812004Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"520ed656383c33a4","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-10T18:53:09.81368Z","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-10T18:53:09.813717Z","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-10T18:53:09.813726Z","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-10T18:53:09.828525Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"520ed656383c33a4 switched to configuration voters=(5912899026583040932)"} {"level":"info","ts":"2026-02-10T18:53:09.828599Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"21f34f1629612ac4","local-member-id":"520ed656383c33a4","added-peer-id":"520ed656383c33a4","added-peer-peer-urls":["https://199.19.213.207:2380"]} {"level":"info","ts":"2026-02-10T18:53:09.828891Z","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-10T18:53:09.829028Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"520ed656383c33a4","initial-advertise-peer-urls":["https://199.19.213.207:2380"],"listen-peer-urls":["https://199.19.213.207:2380"],"advertise-client-urls":["https://199.19.213.207:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.207:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-10T18:53:09.829047Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-10T18:53:09.829125Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.207:2380"} {"level":"info","ts":"2026-02-10T18:53:09.829137Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.207:2380"} {"level":"info","ts":"2026-02-10T18:53:10.458704Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"520ed656383c33a4 is starting a new election at term 1"} {"level":"info","ts":"2026-02-10T18:53:10.458956Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"520ed656383c33a4 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-10T18:53:10.459004Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"520ed656383c33a4 received MsgPreVoteResp from 520ed656383c33a4 at term 1"} {"level":"info","ts":"2026-02-10T18:53:10.459045Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"520ed656383c33a4 became candidate at term 2"} {"level":"info","ts":"2026-02-10T18:53:10.459064Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"520ed656383c33a4 received MsgVoteResp from 520ed656383c33a4 at term 2"} {"level":"info","ts":"2026-02-10T18:53:10.459083Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"520ed656383c33a4 became leader at term 2"} {"level":"info","ts":"2026-02-10T18:53:10.4591Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 520ed656383c33a4 elected leader 520ed656383c33a4 at term 2"} {"level":"info","ts":"2026-02-10T18:53:10.51369Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-10T18:53:10.516155Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"520ed656383c33a4","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.207:2379]}","request-path":"/0/members/520ed656383c33a4/attributes","cluster-id":"21f34f1629612ac4","publish-timeout":"7s"} {"level":"info","ts":"2026-02-10T18:53:10.516351Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-10T18:53:10.516454Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-10T18:53:10.517952Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.207:2379"} {"level":"info","ts":"2026-02-10T18:53:10.52007Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-10T18:53:10.549404Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"21f34f1629612ac4","local-member-id":"520ed656383c33a4","cluster-version":"3.5"} {"level":"info","ts":"2026-02-10T18:53:10.553874Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-10T18:53:10.559577Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-10T18:53:10.559595Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-10T18:53:10.578507Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-10T18:53:22.647608Z","caller":"traceutil/trace.go:171","msg":"trace[1683946515] transaction","detail":"{read_only:false; response_revision:395; number_of_response:1; }","duration":"124.466232ms","start":"2026-02-10T18:53:22.523103Z","end":"2026-02-10T18:53:22.647569Z","steps":["trace[1683946515] 'process raft request' (duration: 124.357439ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:53:24.029258Z","caller":"traceutil/trace.go:171","msg":"trace[1847186365] transaction","detail":"{read_only:false; response_revision:403; number_of_response:1; }","duration":"101.836231ms","start":"2026-02-10T18:53:23.927399Z","end":"2026-02-10T18:53:24.029235Z","steps":["trace[1847186365] 'process raft request' (duration: 101.694097ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:53:39.42732Z","caller":"traceutil/trace.go:171","msg":"trace[1630598351] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"192.861368ms","start":"2026-02-10T18:53:39.234397Z","end":"2026-02-10T18:53:39.427258Z","steps":["trace[1630598351] 'process raft request' (duration: 192.743664ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:53:39.427749Z","caller":"traceutil/trace.go:171","msg":"trace[314247431] linearizableReadLoop","detail":"{readStateIndex:486; appliedIndex:486; }","duration":"192.978791ms","start":"2026-02-10T18:53:39.234751Z","end":"2026-02-10T18:53:39.42773Z","steps":["trace[314247431] 'read index received' (duration: 192.90957ms)","trace[314247431] 'applied index is now lower than readState.Index' (duration: 67.781µs)"],"step_count":2} {"level":"warn","ts":"2026-02-10T18:53:39.428067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.243149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/cilium-config\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T18:53:39.428123Z","caller":"traceutil/trace.go:171","msg":"trace[1767537976] range","detail":"{range_begin:/registry/configmaps/kube-system/cilium-config; range_end:; response_count:0; response_revision:473; }","duration":"193.371542ms","start":"2026-02-10T18:53:39.234738Z","end":"2026-02-10T18:53:39.428109Z","steps":["trace[1767537976] 'agreement among raft nodes before linearized reading' (duration: 193.230248ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:53:39.62498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.230882ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-02-10T18:53:39.625272Z","caller":"traceutil/trace.go:171","msg":"trace[1892285885] linearizableReadLoop","detail":"{readStateIndex:487; appliedIndex:486; }","duration":"197.438803ms","start":"2026-02-10T18:53:39.427813Z","end":"2026-02-10T18:53:39.625252Z","steps":["trace[1892285885] 'read index received' (duration: 53.754959ms)","trace[1892285885] 'applied index is now lower than readState.Index' (duration: 143.609912ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T18:53:39.625346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.942542ms","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-10T18:53:39.625433Z","caller":"traceutil/trace.go:171","msg":"trace[784089762] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:473; }","duration":"297.063876ms","start":"2026-02-10T18:53:39.328349Z","end":"2026-02-10T18:53:39.625413Z","steps":["trace[784089762] 'agreement among raft nodes before linearized reading' (duration: 296.873021ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:53:39.625515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.236593ms","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-10T18:53:39.625574Z","caller":"traceutil/trace.go:171","msg":"trace[422352462] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:473; }","duration":"324.338846ms","start":"2026-02-10T18:53:39.301221Z","end":"2026-02-10T18:53:39.62556Z","steps":["trace[422352462] 'agreement among raft nodes before linearized reading' (duration: 324.162511ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:53:39.625635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:39.301189Z","time spent":"324.434599ms","remote":"127.0.0.1:56336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-10T18:53:39.62583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.884123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/cilium\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T18:53:39.625885Z","caller":"traceutil/trace.go:171","msg":"trace[549002856] range","detail":"{range_begin:/registry/clusterroles/cilium; range_end:; response_count:0; response_revision:473; }","duration":"194.972206ms","start":"2026-02-10T18:53:39.430902Z","end":"2026-02-10T18:53:39.625875Z","steps":["trace[549002856] 'agreement among raft nodes before linearized reading' (duration: 194.898494ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:53:40.133504Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3721271029033139991,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-10T18:53:40.634566Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3721271029033139991,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-10T18:53:41.134943Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3721271029033139991,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-10T18:53:41.341005Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.683866073s","expected-duration":"1s"} {"level":"info","ts":"2026-02-10T18:53:41.3433Z","caller":"traceutil/trace.go:171","msg":"trace[1317444317] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"1.710785284s","start":"2026-02-10T18:53:39.632463Z","end":"2026-02-10T18:53:41.343248Z","steps":["trace[1317444317] 'process raft request' (duration: 1.71065617s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:53:41.343805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:39.632447Z","time spent":"1.710922318s","remote":"127.0.0.1:56336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T18:53:41.515004Z","caller":"traceutil/trace.go:171","msg":"trace[1365156873] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"1.880589027s","start":"2026-02-10T18:53:39.634406Z","end":"2026-02-10T18:53:41.514995Z","steps":["trace[1365156873] 'process raft request' (duration: 1.879804175s)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:53:41.514318Z","caller":"traceutil/trace.go:171","msg":"trace[1130390763] linearizableReadLoop","detail":"{readStateIndex:489; appliedIndex:488; }","duration":"1.880872075s","start":"2026-02-10T18:53:39.63343Z","end":"2026-02-10T18:53:41.514302Z","steps":["trace[1130390763] 'read index received' (duration: 1.710798585s)","trace[1130390763] 'applied index is now lower than readState.Index' (duration: 170.07275ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T18:53:41.515325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.881886383s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/cilium\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T18:53:41.51535Z","caller":"traceutil/trace.go:171","msg":"trace[520878448] range","detail":"{range_begin:/registry/clusterrolebindings/cilium; range_end:; response_count:0; response_revision:475; }","duration":"1.881927924s","start":"2026-02-10T18:53:39.633416Z","end":"2026-02-10T18:53:41.515344Z","steps":["trace[520878448] 'agreement among raft nodes before linearized reading' (duration: 1.881845451s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:53:41.515366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:39.633408Z","time spent":"1.881953574s","remote":"127.0.0.1:56458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":0,"response size":27,"request content":"key:\"/registry/clusterrolebindings/cilium\" "} {"level":"warn","ts":"2026-02-10T18:53:41.515776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:39.634395Z","time spent":"1.880649128s","remote":"127.0.0.1:56336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T18:53:41.515964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.74916125s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-10T18:53:41.515986Z","caller":"traceutil/trace.go:171","msg":"trace[1806718279] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:475; }","duration":"1.749210591s","start":"2026-02-10T18:53:39.76677Z","end":"2026-02-10T18:53:41.51598Z","steps":["trace[1806718279] 'agreement among raft nodes before linearized reading' (duration: 1.74917136s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:53:41.516003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:39.766752Z","time spent":"1.749247562s","remote":"127.0.0.1:56336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-10T18:53:41.516109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.624927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T18:53:41.516127Z","caller":"traceutil/trace.go:171","msg":"trace[2109635552] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:475; }","duration":"214.671878ms","start":"2026-02-10T18:53:41.301451Z","end":"2026-02-10T18:53:41.516123Z","steps":["trace[2109635552] 'agreement among raft nodes before linearized reading' (duration: 214.647247ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:53:41.516202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.29536936s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T18:53:41.51622Z","caller":"traceutil/trace.go:171","msg":"trace[1994247563] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:475; }","duration":"1.295420742s","start":"2026-02-10T18:53:40.220794Z","end":"2026-02-10T18:53:41.516215Z","steps":["trace[1994247563] 'agreement among raft nodes before linearized reading' (duration: 1.295396741s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:53:41.516235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:40.220775Z","time spent":"1.295456872s","remote":"127.0.0.1:56078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-10T18:53:43.828065Z","caller":"traceutil/trace.go:171","msg":"trace[182349984] linearizableReadLoop","detail":"{readStateIndex:527; appliedIndex:526; }","duration":"303.087352ms","start":"2026-02-10T18:53:43.524951Z","end":"2026-02-10T18:53:43.828039Z","steps":["trace[182349984] 'read index received' (duration: 302.763273ms)","trace[182349984] 'applied index is now lower than readState.Index' (duration: 323.319µs)"],"step_count":2} {"level":"info","ts":"2026-02-10T18:53:43.828264Z","caller":"traceutil/trace.go:171","msg":"trace[574088735] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"425.400588ms","start":"2026-02-10T18:53:43.402857Z","end":"2026-02-10T18:53:43.828258Z","steps":["trace[574088735] 'process raft request' (duration: 424.899334ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:53:43.828332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.503646ms","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-10T18:53:43.82838Z","caller":"traceutil/trace.go:171","msg":"trace[2111222471] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:513; }","duration":"298.567517ms","start":"2026-02-10T18:53:43.529801Z","end":"2026-02-10T18:53:43.828368Z","steps":["trace[2111222471] 'agreement among raft nodes before linearized reading' (duration: 298.489765ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:53:43.828356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:43.402839Z","time spent":"425.455919ms","remote":"127.0.0.1:56336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T18:53:43.828489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.542324ms","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-10T18:53:43.828506Z","caller":"traceutil/trace.go:171","msg":"trace[1589119727] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:513; }","duration":"303.585156ms","start":"2026-02-10T18:53:43.524917Z","end":"2026-02-10T18:53:43.828502Z","steps":["trace[1589119727] 'agreement among raft nodes before linearized reading' (duration: 303.555425ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:53:43.828521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:43.524888Z","time spent":"303.629446ms","remote":"127.0.0.1:56336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-10T18:53:43.828632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.337123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-10T18:53:43.828649Z","caller":"traceutil/trace.go:171","msg":"trace[1347611552] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:513; }","duration":"297.353384ms","start":"2026-02-10T18:53:43.531291Z","end":"2026-02-10T18:53:43.828645Z","steps":["trace[1347611552] 'agreement among raft nodes before linearized reading' (duration: 297.324693ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:53:45.514935Z","caller":"traceutil/trace.go:171","msg":"trace[575980531] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"133.475383ms","start":"2026-02-10T18:53:45.38144Z","end":"2026-02-10T18:53:45.514916Z","steps":["trace[575980531] 'process raft request' (duration: 120.460034ms)","trace[575980531] 'compare' (duration: 12.813943ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T18:53:45.515355Z","caller":"traceutil/trace.go:171","msg":"trace[1505922392] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"129.134203ms","start":"2026-02-10T18:53:45.386212Z","end":"2026-02-10T18:53:45.515346Z","steps":["trace[1505922392] 'process raft request' (duration: 128.64917ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:53:46.581348Z","caller":"traceutil/trace.go:171","msg":"trace[1310781494] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"153.998839ms","start":"2026-02-10T18:53:46.427306Z","end":"2026-02-10T18:53:46.581305Z","steps":["trace[1310781494] 'process raft request' (duration: 153.664809ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:53:46.704796Z","caller":"traceutil/trace.go:171","msg":"trace[1580757681] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"109.637578ms","start":"2026-02-10T18:53:46.595139Z","end":"2026-02-10T18:53:46.704777Z","steps":["trace[1580757681] 'process raft request' (duration: 71.853938ms)","trace[1580757681] 'compare' (duration: 37.701037ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T18:53:46.884168Z","caller":"traceutil/trace.go:171","msg":"trace[442147079] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"202.708599ms","start":"2026-02-10T18:53:46.681429Z","end":"2026-02-10T18:53:46.884138Z","steps":["trace[442147079] 'process raft request' (duration: 129.204796ms)","trace[442147079] 'compare' (duration: 73.234605ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T18:53:46.884766Z","caller":"traceutil/trace.go:171","msg":"trace[2083698982] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"162.082511ms","start":"2026-02-10T18:53:46.722669Z","end":"2026-02-10T18:53:46.884752Z","steps":["trace[2083698982] 'process raft request' (duration: 161.375991ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:53:47.071617Z","caller":"traceutil/trace.go:171","msg":"trace[1634772185] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"176.420085ms","start":"2026-02-10T18:53:46.895181Z","end":"2026-02-10T18:53:47.071601Z","steps":["trace[1634772185] 'process raft request' (duration: 175.783468ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:53:47.229565Z","caller":"traceutil/trace.go:171","msg":"trace[1556011921] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"109.39776ms","start":"2026-02-10T18:53:47.120151Z","end":"2026-02-10T18:53:47.229549Z","steps":["trace[1556011921] 'process raft request' (duration: 79.60041ms)","trace[1556011921] 'compare' (duration: 29.474691ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T18:53:47.927445Z","caller":"traceutil/trace.go:171","msg":"trace[1721202201] linearizableReadLoop","detail":"{readStateIndex:579; appliedIndex:578; }","duration":"399.205867ms","start":"2026-02-10T18:53:47.528224Z","end":"2026-02-10T18:53:47.927429Z","steps":["trace[1721202201] 'read index received' (duration: 398.94508ms)","trace[1721202201] 'applied index is now lower than readState.Index' (duration: 260.267µs)"],"step_count":2} {"level":"info","ts":"2026-02-10T18:53:47.92761Z","caller":"traceutil/trace.go:171","msg":"trace[389112070] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"417.716396ms","start":"2026-02-10T18:53:47.509887Z","end":"2026-02-10T18:53:47.927603Z","steps":["trace[389112070] 'process raft request' (duration: 417.427908ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:53:47.927658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:47.50987Z","time spent":"417.753558ms","remote":"127.0.0.1:56122","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187246,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-10T18:53:47.927806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.588357ms","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-10T18:53:47.927822Z","caller":"traceutil/trace.go:171","msg":"trace[255712087] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:564; }","duration":"399.630519ms","start":"2026-02-10T18:53:47.528186Z","end":"2026-02-10T18:53:47.927817Z","steps":["trace[255712087] 'agreement among raft nodes before linearized reading' (duration: 399.554477ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:53:47.927835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:47.528159Z","time spent":"399.672539ms","remote":"127.0.0.1:56336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-10T18:53:47.927917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.815173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" ","response":"range_response_count:1 size:5586"} {"level":"info","ts":"2026-02-10T18:53:47.927937Z","caller":"traceutil/trace.go:171","msg":"trace[873158372] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io; range_end:; response_count:1; response_revision:564; }","duration":"246.866354ms","start":"2026-02-10T18:53:47.681065Z","end":"2026-02-10T18:53:47.927931Z","steps":["trace[873158372] 'agreement among raft nodes before linearized reading' (duration: 246.819453ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:53:48.075249Z","caller":"traceutil/trace.go:171","msg":"trace[1484240] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"112.449415ms","start":"2026-02-10T18:53:47.962775Z","end":"2026-02-10T18:53:48.075224Z","steps":["trace[1484240] 'process raft request' (duration: 71.308262ms)","trace[1484240] 'compare' (duration: 37.538854ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T18:53:49.342294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"755.171313ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-10T18:53:49.344677Z","caller":"traceutil/trace.go:171","msg":"trace[1400446148] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"1.380456801s","start":"2026-02-10T18:53:47.964203Z","end":"2026-02-10T18:53:49.34466Z","steps":["trace[1400446148] 'process raft request' (duration: 622.860772ms)","trace[1400446148] 'compare' (duration: 754.874165ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T18:53:49.344752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:47.964188Z","time spent":"1.380528263s","remote":"127.0.0.1:56336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T18:53:49.345998Z","caller":"traceutil/trace.go:171","msg":"trace[1245979657] linearizableReadLoop","detail":"{readStateIndex:582; appliedIndex:579; }","duration":"1.350364524s","start":"2026-02-10T18:53:47.995612Z","end":"2026-02-10T18:53:49.345977Z","steps":["trace[1245979657] 'read index received' (duration: 38.477419ms)","trace[1245979657] 'applied index is now lower than readState.Index' (duration: 1.311885135s)"],"step_count":2} {"level":"info","ts":"2026-02-10T18:53:49.346054Z","caller":"traceutil/trace.go:171","msg":"trace[1825337564] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"1.369917242s","start":"2026-02-10T18:53:47.976132Z","end":"2026-02-10T18:53:49.346049Z","steps":["trace[1825337564] 'process raft request' (duration: 1.366250061s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:53:49.346089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:47.976105Z","time spent":"1.369962512s","remote":"127.0.0.1:56122","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187455,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-10T18:53:49.346211Z","caller":"traceutil/trace.go:171","msg":"trace[925537516] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"1.247483102s","start":"2026-02-10T18:53:48.098721Z","end":"2026-02-10T18:53:49.346204Z","steps":["trace[925537516] 'process raft request' (duration: 1.24377876s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:53:49.346244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:48.098702Z","time spent":"1.247523003s","remote":"127.0.0.1:56122","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":188228,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T18:53:49.430983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.435350803s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-10T18:53:49.431038Z","caller":"traceutil/trace.go:171","msg":"trace[1302193616] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:568; }","duration":"1.435442674s","start":"2026-02-10T18:53:47.995583Z","end":"2026-02-10T18:53:49.431026Z","steps":["trace[1302193616] 'agreement among raft nodes before linearized reading' (duration: 1.350585779s)","trace[1302193616] 'range keys from in-memory index tree' (duration: 84.724472ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T18:53:49.431062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:47.995571Z","time spent":"1.435486936s","remote":"127.0.0.1:56336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-10T18:53:49.431302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.719498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:1 size:9320"} {"level":"info","ts":"2026-02-10T18:53:49.431322Z","caller":"traceutil/trace.go:171","msg":"trace[608316652] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:1; response_revision:568; }","duration":"150.777809ms","start":"2026-02-10T18:53:49.280539Z","end":"2026-02-10T18:53:49.431317Z","steps":["trace[608316652] 'agreement among raft nodes before linearized reading' (duration: 150.706577ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:53:49.431884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.264637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T18:53:49.431905Z","caller":"traceutil/trace.go:171","msg":"trace[551123041] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:568; }","duration":"210.349439ms","start":"2026-02-10T18:53:49.22155Z","end":"2026-02-10T18:53:49.4319Z","steps":["trace[551123041] 'agreement among raft nodes before linearized reading' (duration: 210.315448ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:53:49.432171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.628693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:1 size:5177"} {"level":"info","ts":"2026-02-10T18:53:49.432205Z","caller":"traceutil/trace.go:171","msg":"trace[663082213] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:1; response_revision:568; }","duration":"349.709985ms","start":"2026-02-10T18:53:49.082489Z","end":"2026-02-10T18:53:49.432199Z","steps":["trace[663082213] 'agreement among raft nodes before linearized reading' (duration: 349.640783ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:53:49.432219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:49.082431Z","time spent":"349.784886ms","remote":"127.0.0.1:56122","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":1,"response size":5199,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" "} {"level":"warn","ts":"2026-02-10T18:53:49.432403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"551.335892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" ","response":"range_response_count:1 size:4333"} {"level":"info","ts":"2026-02-10T18:53:49.432423Z","caller":"traceutil/trace.go:171","msg":"trace[994155085] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io; range_end:; response_count:1; response_revision:568; }","duration":"551.393414ms","start":"2026-02-10T18:53:48.881025Z","end":"2026-02-10T18:53:49.432419Z","steps":["trace[994155085] 'agreement among raft nodes before linearized reading' (duration: 551.342502ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:53:49.432437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:48.881006Z","time spent":"551.427265ms","remote":"127.0.0.1:56122","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":1,"response size":4355,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" "} {"level":"warn","ts":"2026-02-10T18:53:49.432691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"750.817743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:1 size:24244"} {"level":"info","ts":"2026-02-10T18:53:49.432712Z","caller":"traceutil/trace.go:171","msg":"trace[2138818107] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:1; response_revision:568; }","duration":"750.876545ms","start":"2026-02-10T18:53:48.68183Z","end":"2026-02-10T18:53:49.432707Z","steps":["trace[2138818107] 'agreement among raft nodes before linearized reading' (duration: 750.819463ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:53:49.432725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:48.681811Z","time spent":"750.911325ms","remote":"127.0.0.1:56122","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":24266,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" "} {"level":"warn","ts":"2026-02-10T18:53:49.432893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"951.016963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:1 size:10377"} {"level":"info","ts":"2026-02-10T18:53:49.432913Z","caller":"traceutil/trace.go:171","msg":"trace[89101497] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:1; response_revision:568; }","duration":"951.067884ms","start":"2026-02-10T18:53:48.48184Z","end":"2026-02-10T18:53:49.432908Z","steps":["trace[89101497] 'agreement among raft nodes before linearized reading' (duration: 951.018423ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:53:49.432927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:48.481822Z","time spent":"951.101135ms","remote":"127.0.0.1:56122","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":1,"response size":10399,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" "} {"level":"warn","ts":"2026-02-10T18:53:49.433107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.152157138s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:1 size:13229"} {"level":"info","ts":"2026-02-10T18:53:49.433127Z","caller":"traceutil/trace.go:171","msg":"trace[1871257992] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:1; response_revision:568; }","duration":"1.152203589s","start":"2026-02-10T18:53:48.280918Z","end":"2026-02-10T18:53:49.433122Z","steps":["trace[1871257992] 'agreement among raft nodes before linearized reading' (duration: 1.152120637s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:53:49.433145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:48.280905Z","time spent":"1.152236041s","remote":"127.0.0.1:56122","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":1,"response size":13251,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" "} {"level":"warn","ts":"2026-02-10T18:53:49.433289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.349442547s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" ","response":"range_response_count:1 size:4180"} {"level":"info","ts":"2026-02-10T18:53:49.433309Z","caller":"traceutil/trace.go:171","msg":"trace[1680392857] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io; range_end:; response_count:1; response_revision:568; }","duration":"1.349463848s","start":"2026-02-10T18:53:48.08384Z","end":"2026-02-10T18:53:49.433304Z","steps":["trace[1680392857] 'agreement among raft nodes before linearized reading' (duration: 1.349415147s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:53:49.433332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:48.083774Z","time spent":"1.34954585s","remote":"127.0.0.1:56122","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":1,"response size":4202,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" "} {"level":"warn","ts":"2026-02-10T18:53:49.433504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.432826322s","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-10T18:53:49.433524Z","caller":"traceutil/trace.go:171","msg":"trace[1904300860] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:568; }","duration":"1.432865234s","start":"2026-02-10T18:53:48.000653Z","end":"2026-02-10T18:53:49.433519Z","steps":["trace[1904300860] 'agreement among raft nodes before linearized reading' (duration: 1.432816223s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:53:49.433537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:48.000645Z","time spent":"1.432889104s","remote":"127.0.0.1:56336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-10T18:53:50.258914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.617606ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-10T18:53:50.260098Z","caller":"traceutil/trace.go:171","msg":"trace[1785666983] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"808.8229ms","start":"2026-02-10T18:53:49.451251Z","end":"2026-02-10T18:53:50.260074Z","steps":["trace[1785666983] 'process raft request' (duration: 406.978641ms)","trace[1785666983] 'compare' (duration: 400.493472ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T18:53:50.260215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:49.451146Z","time spent":"809.011166ms","remote":"127.0.0.1:56336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T18:53:50.260231Z","caller":"traceutil/trace.go:171","msg":"trace[497219171] linearizableReadLoop","detail":"{readStateIndex:588; appliedIndex:585; }","duration":"768.372326ms","start":"2026-02-10T18:53:49.491845Z","end":"2026-02-10T18:53:50.260218Z","steps":["trace[497219171] 'read index received' (duration: 366.391793ms)","trace[497219171] 'applied index is now lower than readState.Index' (duration: 401.979903ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T18:53:50.260401Z","caller":"traceutil/trace.go:171","msg":"trace[134349719] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"807.941916ms","start":"2026-02-10T18:53:49.452379Z","end":"2026-02-10T18:53:50.260321Z","steps":["trace[134349719] 'process raft request' (duration: 806.649721ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:53:50.260482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:49.452362Z","time spent":"808.08839ms","remote":"127.0.0.1:56336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T18:53:50.260553Z","caller":"traceutil/trace.go:171","msg":"trace[1900491671] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"709.438024ms","start":"2026-02-10T18:53:49.551107Z","end":"2026-02-10T18:53:50.260545Z","steps":["trace[1900491671] 'process raft request' (duration: 708.795167ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:53:50.260595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:49.551088Z","time spent":"709.484926ms","remote":"127.0.0.1:56122","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":188237,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T18:53:50.263056Z","caller":"traceutil/trace.go:171","msg":"trace[970285700] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"785.624222ms","start":"2026-02-10T18:53:49.477412Z","end":"2026-02-10T18:53:50.263037Z","steps":["trace[970285700] 'process raft request' (duration: 781.759206ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:53:50.263296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:49.477395Z","time spent":"785.759105ms","remote":"127.0.0.1:56122","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":188471,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T18:53:50.264958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"773.106597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:1 size:4083"} {"level":"warn","ts":"2026-02-10T18:53:50.267877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"586.346637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:1 size:188252"} {"level":"info","ts":"2026-02-10T18:53:50.267927Z","caller":"traceutil/trace.go:171","msg":"trace[122223188] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:1; response_revision:573; }","duration":"586.45374ms","start":"2026-02-10T18:53:49.68146Z","end":"2026-02-10T18:53:50.267913Z","steps":["trace[122223188] 'agreement among raft nodes before linearized reading' (duration: 581.195965ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:53:50.267962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:49.68144Z","time spent":"586.515121ms","remote":"127.0.0.1:56122","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":1,"response size":188274,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" "} {"level":"info","ts":"2026-02-10T18:53:50.268102Z","caller":"traceutil/trace.go:171","msg":"trace[32279340] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:1; response_revision:573; }","duration":"773.743484ms","start":"2026-02-10T18:53:49.491818Z","end":"2026-02-10T18:53:50.265562Z","steps":["trace[32279340] 'agreement among raft nodes before linearized reading' (duration: 770.192627ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:53:50.268285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:49.491805Z","time spent":"776.46758ms","remote":"127.0.0.1:56122","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":1,"response size":4105,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" "} {"level":"warn","ts":"2026-02-10T18:53:50.273535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.440008ms","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-10T18:53:50.273576Z","caller":"traceutil/trace.go:171","msg":"trace[76226060] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:573; }","duration":"195.509551ms","start":"2026-02-10T18:53:50.078058Z","end":"2026-02-10T18:53:50.273568Z","steps":["trace[76226060] 'agreement among raft nodes before linearized reading' (duration: 195.12865ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:53:50.274203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.553414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T18:53:50.274232Z","caller":"traceutil/trace.go:171","msg":"trace[576140845] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:573; }","duration":"271.592475ms","start":"2026-02-10T18:53:50.002629Z","end":"2026-02-10T18:53:50.274222Z","steps":["trace[576140845] 'agreement among raft nodes before linearized reading' (duration: 271.493172ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:53:50.275455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.837108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T18:53:50.275482Z","caller":"traceutil/trace.go:171","msg":"trace[1936255620] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:573; }","duration":"272.88156ms","start":"2026-02-10T18:53:50.002591Z","end":"2026-02-10T18:53:50.275472Z","steps":["trace[1936255620] 'agreement among raft nodes before linearized reading' (duration: 272.845789ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:53:50.275721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.112767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T18:53:50.275746Z","caller":"traceutil/trace.go:171","msg":"trace[1451531425] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:573; }","duration":"273.137687ms","start":"2026-02-10T18:53:50.002599Z","end":"2026-02-10T18:53:50.275737Z","steps":["trace[1451531425] 'agreement among raft nodes before linearized reading' (duration: 273.097866ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:53:50.276046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.022567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T18:53:50.276114Z","caller":"traceutil/trace.go:171","msg":"trace[808956967] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:573; }","duration":"284.099679ms","start":"2026-02-10T18:53:49.991987Z","end":"2026-02-10T18:53:50.276087Z","steps":["trace[808956967] 'agreement among raft nodes before linearized reading' (duration: 284.005736ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:53:50.280856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.897541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T18:53:50.280935Z","caller":"traceutil/trace.go:171","msg":"trace[1172768316] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:573; }","duration":"289.002924ms","start":"2026-02-10T18:53:49.991919Z","end":"2026-02-10T18:53:50.280922Z","steps":["trace[1172768316] 'agreement among raft nodes before linearized reading' (duration: 288.901321ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:53:50.281183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.741104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" ","response":"range_response_count:1 size:188486"} {"level":"info","ts":"2026-02-10T18:53:50.281232Z","caller":"traceutil/trace.go:171","msg":"trace[1649850120] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:1; response_revision:573; }","duration":"390.816115ms","start":"2026-02-10T18:53:49.890409Z","end":"2026-02-10T18:53:50.281225Z","steps":["trace[1649850120] 'agreement among raft nodes before linearized reading' (duration: 390.61223ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:53:50.281266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:49.890393Z","time spent":"390.865967ms","remote":"127.0.0.1:56122","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":1,"response size":188508,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" "} {"level":"warn","ts":"2026-02-10T18:53:50.281378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.374514ms","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:5"} {"level":"info","ts":"2026-02-10T18:53:50.281432Z","caller":"traceutil/trace.go:171","msg":"trace[1209734668] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:573; }","duration":"289.457717ms","start":"2026-02-10T18:53:49.991963Z","end":"2026-02-10T18:53:50.281421Z","steps":["trace[1209734668] 'agreement among raft nodes before linearized reading' (duration: 286.802724ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:53:51.666844Z","caller":"traceutil/trace.go:171","msg":"trace[2117672061] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"312.891991ms","start":"2026-02-10T18:53:51.353939Z","end":"2026-02-10T18:53:51.666831Z","steps":["trace[2117672061] 'process raft request' (duration: 312.393888ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:53:51.666575Z","caller":"traceutil/trace.go:171","msg":"trace[1818806464] linearizableReadLoop","detail":"{readStateIndex:592; appliedIndex:591; }","duration":"187.143081ms","start":"2026-02-10T18:53:51.479407Z","end":"2026-02-10T18:53:51.66655Z","steps":["trace[1818806464] 'read index received' (duration: 187.042678ms)","trace[1818806464] 'applied index is now lower than readState.Index' (duration: 99.483µs)"],"step_count":2} {"level":"warn","ts":"2026-02-10T18:53:51.667089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:51.35393Z","time spent":"312.988974ms","remote":"127.0.0.1:56336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T18:53:51.667896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.453667ms","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-10T18:53:51.667938Z","caller":"traceutil/trace.go:171","msg":"trace[1438430132] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:576; }","duration":"188.539199ms","start":"2026-02-10T18:53:51.479387Z","end":"2026-02-10T18:53:51.667926Z","steps":["trace[1438430132] 'agreement among raft nodes before linearized reading' (duration: 187.629304ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:53:51.709359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.013396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T18:53:51.709449Z","caller":"traceutil/trace.go:171","msg":"trace[1921161410] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:577; }","duration":"159.256583ms","start":"2026-02-10T18:53:51.550178Z","end":"2026-02-10T18:53:51.709435Z","steps":["trace[1921161410] 'agreement among raft nodes before linearized reading' (duration: 159.042177ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:53:51.709601Z","caller":"traceutil/trace.go:171","msg":"trace[314943794] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"188.674893ms","start":"2026-02-10T18:53:51.52092Z","end":"2026-02-10T18:53:51.709595Z","steps":["trace[314943794] 'process raft request' (duration: 188.132968ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:53:51.709702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.329325ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T18:53:51.709717Z","caller":"traceutil/trace.go:171","msg":"trace[566336627] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:577; }","duration":"159.422758ms","start":"2026-02-10T18:53:51.550289Z","end":"2026-02-10T18:53:51.709712Z","steps":["trace[566336627] 'agreement among raft nodes before linearized reading' (duration: 159.385087ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:53:51.709801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.454468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T18:53:51.709815Z","caller":"traceutil/trace.go:171","msg":"trace[67164744] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:577; }","duration":"159.479939ms","start":"2026-02-10T18:53:51.550332Z","end":"2026-02-10T18:53:51.709811Z","steps":["trace[67164744] 'agreement among raft nodes before linearized reading' (duration: 159.432348ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:53:51.710062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.932337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T18:53:51.710078Z","caller":"traceutil/trace.go:171","msg":"trace[202171579] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:577; }","duration":"185.966358ms","start":"2026-02-10T18:53:51.524106Z","end":"2026-02-10T18:53:51.710072Z","steps":["trace[202171579] 'agreement among raft nodes before linearized reading' (duration: 185.941387ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:53:51.710179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.013519ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T18:53:51.7102Z","caller":"traceutil/trace.go:171","msg":"trace[1628808547] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:577; }","duration":"186.05616ms","start":"2026-02-10T18:53:51.52414Z","end":"2026-02-10T18:53:51.710196Z","steps":["trace[1628808547] 'agreement among raft nodes before linearized reading' (duration: 186.015419ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:53:51.710965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.778991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T18:53:51.711018Z","caller":"traceutil/trace.go:171","msg":"trace[43914046] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:577; }","duration":"186.847882ms","start":"2026-02-10T18:53:51.524156Z","end":"2026-02-10T18:53:51.711003Z","steps":["trace[43914046] 'agreement among raft nodes before linearized reading' (duration: 185.30272ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:53:59.722557Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3721271029033140243,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-10T18:54:00.054114Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.04032087s","expected-duration":"1s"} {"level":"info","ts":"2026-02-10T18:54:00.0544Z","caller":"traceutil/trace.go:171","msg":"trace[505671188] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"1.040708691s","start":"2026-02-10T18:53:59.013673Z","end":"2026-02-10T18:54:00.054382Z","steps":["trace[505671188] 'process raft request' (duration: 1.040594978s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:54:00.054509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:59.013661Z","time spent":"1.040790024s","remote":"127.0.0.1:56250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16803,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T18:54:00.284357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.493457ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-02-10T18:54:00.2847Z","caller":"traceutil/trace.go:171","msg":"trace[1993658714] linearizableReadLoop","detail":"{readStateIndex:621; appliedIndex:620; }","duration":"1.062784219s","start":"2026-02-10T18:53:59.221863Z","end":"2026-02-10T18:54:00.284647Z","steps":["trace[1993658714] 'read index received' (duration: 833.087828ms)","trace[1993658714] 'applied index is now lower than readState.Index' (duration: 229.694841ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T18:54:00.284973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.063092808s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T18:54:00.285049Z","caller":"traceutil/trace.go:171","msg":"trace[1062804291] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:603; }","duration":"1.063203811s","start":"2026-02-10T18:53:59.22183Z","end":"2026-02-10T18:54:00.285034Z","steps":["trace[1062804291] 'agreement among raft nodes before linearized reading' (duration: 1.063031296s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:54:00.285088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:59.221814Z","time spent":"1.063265662s","remote":"127.0.0.1:56078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-10T18:54:00.285376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"573.926365ms","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-10T18:54:00.285529Z","caller":"traceutil/trace.go:171","msg":"trace[1904212834] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:603; }","duration":"574.11903ms","start":"2026-02-10T18:53:59.711394Z","end":"2026-02-10T18:54:00.285513Z","steps":["trace[1904212834] 'agreement among raft nodes before linearized reading' (duration: 573.511333ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:54:00.285606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:59.71138Z","time spent":"574.213152ms","remote":"127.0.0.1:56336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-10T18:54:00.285976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"478.437718ms","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-10T18:54:00.286105Z","caller":"traceutil/trace.go:171","msg":"trace[248727659] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:603; }","duration":"478.564261ms","start":"2026-02-10T18:53:59.807496Z","end":"2026-02-10T18:54:00.28606Z","steps":["trace[248727659] 'agreement among raft nodes before linearized reading' (duration: 478.404727ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:54:00.286183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:59.807478Z","time spent":"478.692664ms","remote":"127.0.0.1:56336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-10T18:54:00.392038Z","caller":"traceutil/trace.go:171","msg":"trace[396732146] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"100.203718ms","start":"2026-02-10T18:54:00.291812Z","end":"2026-02-10T18:54:00.392016Z","steps":["trace[396732146] 'process raft request' (duration: 100.017193ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:54:01.743917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"516.475855ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-10T18:54:01.743984Z","caller":"traceutil/trace.go:171","msg":"trace[1038857354] linearizableReadLoop","detail":"{readStateIndex:623; appliedIndex:621; }","duration":"1.445273416s","start":"2026-02-10T18:54:00.298699Z","end":"2026-02-10T18:54:01.743972Z","steps":["trace[1038857354] 'read index received' (duration: 93.151163ms)","trace[1038857354] 'applied index is now lower than readState.Index' (duration: 1.352121303s)"],"step_count":2} {"level":"info","ts":"2026-02-10T18:54:01.744158Z","caller":"traceutil/trace.go:171","msg":"trace[199076639] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"1.451731824s","start":"2026-02-10T18:54:00.292418Z","end":"2026-02-10T18:54:01.74415Z","steps":["trace[199076639] 'process raft request' (duration: 934.968972ms)","trace[199076639] 'compare' (duration: 516.164715ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T18:54:01.744199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:54:00.292399Z","time spent":"1.451779416s","remote":"127.0.0.1:56336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T18:54:01.744321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.445627106s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T18:54:01.744339Z","caller":"traceutil/trace.go:171","msg":"trace[991431292] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:605; }","duration":"1.445645477s","start":"2026-02-10T18:54:00.298687Z","end":"2026-02-10T18:54:01.744333Z","steps":["trace[991431292] 'agreement among raft nodes before linearized reading' (duration: 1.445611636s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:54:01.744355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:54:00.298629Z","time spent":"1.445722228s","remote":"127.0.0.1:56078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-10T18:54:01.744484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.435280531s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-10T18:54:01.744504Z","caller":"traceutil/trace.go:171","msg":"trace[16762986] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:605; }","duration":"1.435328552s","start":"2026-02-10T18:54:00.309169Z","end":"2026-02-10T18:54:01.744498Z","steps":["trace[16762986] 'agreement among raft nodes before linearized reading' (duration: 1.43525385s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:54:01.744521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:54:00.309156Z","time spent":"1.435361113s","remote":"127.0.0.1:56336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-10T18:54:01.744638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.174914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T18:54:01.744658Z","caller":"traceutil/trace.go:171","msg":"trace[1022463237] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:605; }","duration":"444.230216ms","start":"2026-02-10T18:54:01.300421Z","end":"2026-02-10T18:54:01.744651Z","steps":["trace[1022463237] 'agreement among raft nodes before linearized reading' (duration: 444.200055ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:54:01.744675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:54:01.300379Z","time spent":"444.291687ms","remote":"127.0.0.1:56078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-10T18:54:01.744775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.373580273s","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-10T18:54:01.744791Z","caller":"traceutil/trace.go:171","msg":"trace[381063506] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:605; }","duration":"1.373630014s","start":"2026-02-10T18:54:00.371156Z","end":"2026-02-10T18:54:01.744786Z","steps":["trace[381063506] 'agreement among raft nodes before linearized reading' (duration: 1.373580963s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:54:01.744805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:54:00.371139Z","time spent":"1.373661995s","remote":"127.0.0.1:56336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-10T18:54:01.744899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.430031206s","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-10T18:54:01.744927Z","caller":"traceutil/trace.go:171","msg":"trace[74775541] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:605; }","duration":"1.430080568s","start":"2026-02-10T18:54:00.314842Z","end":"2026-02-10T18:54:01.744922Z","steps":["trace[74775541] 'agreement among raft nodes before linearized reading' (duration: 1.430017996s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:54:01.744943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:54:00.314831Z","time spent":"1.430107728s","remote":"127.0.0.1:56336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-02-10T18:54:01.898228Z","caller":"traceutil/trace.go:171","msg":"trace[454454888] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"144.95913ms","start":"2026-02-10T18:54:01.753065Z","end":"2026-02-10T18:54:01.898024Z","steps":["trace[454454888] 'process raft request' (duration: 142.79386ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:54:01.901253Z","caller":"traceutil/trace.go:171","msg":"trace[590700667] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"140.510607ms","start":"2026-02-10T18:54:01.760665Z","end":"2026-02-10T18:54:01.901176Z","steps":["trace[590700667] 'process raft request' (duration: 140.143607ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:54:01.901119Z","caller":"traceutil/trace.go:171","msg":"trace[884284923] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"139.314684ms","start":"2026-02-10T18:54:01.761794Z","end":"2026-02-10T18:54:01.901109Z","steps":["trace[884284923] 'process raft request' (duration: 139.117369ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:54:03.464294Z","caller":"traceutil/trace.go:171","msg":"trace[1679578275] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"101.37043ms","start":"2026-02-10T18:54:03.362905Z","end":"2026-02-10T18:54:03.464276Z","steps":["trace[1679578275] 'process raft request' (duration: 101.250777ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:54:04.136728Z","caller":"traceutil/trace.go:171","msg":"trace[1014222097] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"100.579298ms","start":"2026-02-10T18:54:04.036126Z","end":"2026-02-10T18:54:04.136705Z","steps":["trace[1014222097] 'process raft request' (duration: 22.336954ms)","trace[1014222097] 'compare' (duration: 78.11238ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T18:54:04.173415Z","caller":"traceutil/trace.go:171","msg":"trace[1299636286] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"131.110458ms","start":"2026-02-10T18:54:04.042272Z","end":"2026-02-10T18:54:04.173383Z","steps":["trace[1299636286] 'process raft request' (duration: 130.984465ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:54:06.548548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.40786ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-10T18:54:06.548611Z","caller":"traceutil/trace.go:171","msg":"trace[1474192432] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"596.369713ms","start":"2026-02-10T18:54:05.952231Z","end":"2026-02-10T18:54:06.5486Z","steps":["trace[1474192432] 'process raft request' (duration: 183.8687ms)","trace[1474192432] 'compare' (duration: 412.212375ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T18:54:06.548648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:54:05.952224Z","time spent":"596.403364ms","remote":"127.0.0.1:56336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T18:54:06.921044Z","caller":"traceutil/trace.go:171","msg":"trace[735098615] linearizableReadLoop","detail":"{readStateIndex:655; appliedIndex:653; }","duration":"870.121587ms","start":"2026-02-10T18:54:06.050904Z","end":"2026-02-10T18:54:06.921026Z","steps":["trace[735098615] 'read index received' (duration: 85.204314ms)","trace[735098615] 'applied index is now lower than readState.Index' (duration: 784.916153ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T18:54:06.92107Z","caller":"traceutil/trace.go:171","msg":"trace[1213302667] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"908.570896ms","start":"2026-02-10T18:54:06.01248Z","end":"2026-02-10T18:54:06.921051Z","steps":["trace[1213302667] 'process raft request' (duration: 862.828517ms)","trace[1213302667] 'compare' (duration: 45.533243ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T18:54:06.921157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:54:06.012463Z","time spent":"908.652367ms","remote":"127.0.0.1:56146","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":712,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-10T18:54:06.921226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"870.313533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-vwfm8\" ","response":"range_response_count:1 size:17670"} {"level":"info","ts":"2026-02-10T18:54:06.921245Z","caller":"traceutil/trace.go:171","msg":"trace[642537048] range","detail":"{range_begin:/registry/pods/kube-system/cilium-vwfm8; range_end:; response_count:1; response_revision:636; }","duration":"870.365534ms","start":"2026-02-10T18:54:06.050874Z","end":"2026-02-10T18:54:06.921239Z","steps":["trace[642537048] 'agreement among raft nodes before linearized reading' (duration: 870.244041ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:54:06.921262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:54:06.050849Z","time spent":"870.409455ms","remote":"127.0.0.1:56250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":17692,"request content":"key:\"/registry/pods/kube-system/cilium-vwfm8\" "} {"level":"warn","ts":"2026-02-10T18:54:06.921457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.2545ms","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-10T18:54:06.921529Z","caller":"traceutil/trace.go:171","msg":"trace[151644978] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:636; }","duration":"467.308841ms","start":"2026-02-10T18:54:06.454165Z","end":"2026-02-10T18:54:06.921474Z","steps":["trace[151644978] 'agreement among raft nodes before linearized reading' (duration: 467.212229ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:54:06.921555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:54:06.454152Z","time spent":"467.398853ms","remote":"127.0.0.1:56336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-10T18:54:07.111923Z","caller":"traceutil/trace.go:171","msg":"trace[441607690] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"175.381207ms","start":"2026-02-10T18:54:06.936526Z","end":"2026-02-10T18:54:07.111907Z","steps":["trace[441607690] 'process raft request' (duration: 173.600288ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:54:07.176316Z","caller":"traceutil/trace.go:171","msg":"trace[238501125] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"207.08386ms","start":"2026-02-10T18:54:06.969217Z","end":"2026-02-10T18:54:07.176301Z","steps":["trace[238501125] 'process raft request' (duration: 207.004247ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:54:07.58619Z","caller":"traceutil/trace.go:171","msg":"trace[529878876] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"150.06129ms","start":"2026-02-10T18:54:07.436111Z","end":"2026-02-10T18:54:07.586172Z","steps":["trace[529878876] 'process raft request' (duration: 149.931206ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:54:09.895551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.035449439s","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-10T18:54:09.895598Z","caller":"traceutil/trace.go:171","msg":"trace[1649593621] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:643; }","duration":"2.035547412s","start":"2026-02-10T18:54:07.860039Z","end":"2026-02-10T18:54:09.895587Z","steps":["trace[1649593621] 'range keys from in-memory index tree' (duration: 2.035341437s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:54:09.895619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:54:07.860022Z","time spent":"2.035591993s","remote":"127.0.0.1:56336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-10T18:54:09.895776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.962150182s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-10T18:54:09.895796Z","caller":"traceutil/trace.go:171","msg":"trace[131217961] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:643; }","duration":"1.962192253s","start":"2026-02-10T18:54:07.9336Z","end":"2026-02-10T18:54:09.895792Z","steps":["trace[131217961] 'range keys from in-memory index tree' (duration: 1.962093151s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:54:09.895812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:54:07.933587Z","time spent":"1.962221924s","remote":"127.0.0.1:56336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-10T18:54:09.895917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.900816134s","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-10T18:54:09.895933Z","caller":"traceutil/trace.go:171","msg":"trace[554160753] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:643; }","duration":"1.900858595s","start":"2026-02-10T18:54:07.995071Z","end":"2026-02-10T18:54:09.895929Z","steps":["trace[554160753] 'range keys from in-memory index tree' (duration: 1.900742441s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:54:09.895946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:54:07.995056Z","time spent":"1.900887006s","remote":"127.0.0.1:56336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-10T18:54:09.896131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.698262199s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-vwfm8\" ","response":"range_response_count:1 size:17918"} {"level":"info","ts":"2026-02-10T18:54:09.896149Z","caller":"traceutil/trace.go:171","msg":"trace[1401456951] range","detail":"{range_begin:/registry/pods/kube-system/cilium-vwfm8; range_end:; response_count:1; response_revision:643; }","duration":"1.69830332s","start":"2026-02-10T18:54:08.197842Z","end":"2026-02-10T18:54:09.896145Z","steps":["trace[1401456951] 'range keys from in-memory index tree' (duration: 1.698195417s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:54:09.896161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:54:08.197828Z","time spent":"1.698330501s","remote":"127.0.0.1:56250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":17940,"request content":"key:\"/registry/pods/kube-system/cilium-vwfm8\" "} {"level":"warn","ts":"2026-02-10T18:54:09.896334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.343850825s","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-10T18:54:09.896352Z","caller":"traceutil/trace.go:171","msg":"trace[532443377] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:643; }","duration":"1.343885356s","start":"2026-02-10T18:54:08.552462Z","end":"2026-02-10T18:54:09.896348Z","steps":["trace[532443377] 'range keys from in-memory index tree' (duration: 1.343793704s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:54:09.896364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:54:08.552449Z","time spent":"1.343912126s","remote":"127.0.0.1:56336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-10T18:54:09.896489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"936.358981ms","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-10T18:54:09.896506Z","caller":"traceutil/trace.go:171","msg":"trace[1585501234] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:643; }","duration":"936.397861ms","start":"2026-02-10T18:54:08.960105Z","end":"2026-02-10T18:54:09.896502Z","steps":["trace[1585501234] 'range keys from in-memory index tree' (duration: 936.303589ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:54:09.896518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:54:08.960092Z","time spent":"936.423233ms","remote":"127.0.0.1:56336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-10T18:54:09.89671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"677.340982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T18:54:09.896731Z","caller":"traceutil/trace.go:171","msg":"trace[709481709] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:643; }","duration":"677.387143ms","start":"2026-02-10T18:54:09.219339Z","end":"2026-02-10T18:54:09.896727Z","steps":["trace[709481709] 'range keys from in-memory index tree' (duration: 677.27311ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:54:09.896745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:54:09.219322Z","time spent":"677.420294ms","remote":"127.0.0.1:56078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-10T18:54:17.97879Z","caller":"traceutil/trace.go:171","msg":"trace[2080269666] transaction","detail":"{read_only:false; response_revision:709; number_of_response:1; }","duration":"149.198737ms","start":"2026-02-10T18:54:17.829557Z","end":"2026-02-10T18:54:17.978756Z","steps":["trace[2080269666] 'process raft request' (duration: 148.686923ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:54:18.154459Z","caller":"traceutil/trace.go:171","msg":"trace[509832052] transaction","detail":"{read_only:false; response_revision:710; number_of_response:1; }","duration":"170.694778ms","start":"2026-02-10T18:54:17.983748Z","end":"2026-02-10T18:54:18.154443Z","steps":["trace[509832052] 'process raft request' (duration: 163.047327ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:54:18.215727Z","caller":"traceutil/trace.go:171","msg":"trace[198602083] linearizableReadLoop","detail":"{readStateIndex:735; appliedIndex:732; }","duration":"227.105061ms","start":"2026-02-10T18:54:17.988604Z","end":"2026-02-10T18:54:18.215709Z","steps":["trace[198602083] 'read index received' (duration: 158.201274ms)","trace[198602083] 'applied index is now lower than readState.Index' (duration: 68.902667ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T18:54:18.215961Z","caller":"traceutil/trace.go:171","msg":"trace[751029880] transaction","detail":"{read_only:false; response_revision:711; number_of_response:1; }","duration":"231.943943ms","start":"2026-02-10T18:54:17.98401Z","end":"2026-02-10T18:54:18.215954Z","steps":["trace[751029880] 'process raft request' (duration: 231.533762ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:54:18.216089Z","caller":"traceutil/trace.go:171","msg":"trace[252445801] transaction","detail":"{read_only:false; response_revision:712; number_of_response:1; }","duration":"230.639578ms","start":"2026-02-10T18:54:17.985444Z","end":"2026-02-10T18:54:18.216084Z","steps":["trace[252445801] 'process raft request' (duration: 230.189826ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:54:18.216268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.645345ms","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-10T18:54:18.21629Z","caller":"traceutil/trace.go:171","msg":"trace[1058653545] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:712; }","duration":"227.697707ms","start":"2026-02-10T18:54:17.988587Z","end":"2026-02-10T18:54:18.216284Z","steps":["trace[1058653545] 'agreement among raft nodes before linearized reading' (duration: 227.575213ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:54:18.216412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.088652ms","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-10T18:54:18.216429Z","caller":"traceutil/trace.go:171","msg":"trace[1985107853] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:712; }","duration":"218.117173ms","start":"2026-02-10T18:54:17.998307Z","end":"2026-02-10T18:54:18.216424Z","steps":["trace[1985107853] 'agreement among raft nodes before linearized reading' (duration: 218.058972ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:54:18.6796Z","caller":"traceutil/trace.go:171","msg":"trace[55590942] linearizableReadLoop","detail":"{readStateIndex:737; appliedIndex:735; }","duration":"432.751361ms","start":"2026-02-10T18:54:18.246827Z","end":"2026-02-10T18:54:18.679578Z","steps":["trace[55590942] 'read index received' (duration: 421.264944ms)","trace[55590942] 'applied index is now lower than readState.Index' (duration: 11.485687ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T18:54:18.679841Z","caller":"traceutil/trace.go:171","msg":"trace[1716325215] transaction","detail":"{read_only:false; response_revision:713; number_of_response:1; }","duration":"458.288163ms","start":"2026-02-10T18:54:18.221539Z","end":"2026-02-10T18:54:18.679827Z","steps":["trace[1716325215] 'process raft request' (duration: 446.54384ms)","trace[1716325215] 'compare' (duration: 10.768547ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T18:54:18.679938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:54:18.221517Z","time spent":"458.354365ms","remote":"127.0.0.1:56336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T18:54:18.680805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.374845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-77cccfdc44-s7rvp\" ","response":"range_response_count:1 size:4733"} {"level":"info","ts":"2026-02-10T18:54:18.68085Z","caller":"traceutil/trace.go:171","msg":"trace[297698208] range","detail":"{range_begin:/registry/pods/kube-system/coredns-77cccfdc44-s7rvp; range_end:; response_count:1; response_revision:714; }","duration":"430.432146ms","start":"2026-02-10T18:54:18.250402Z","end":"2026-02-10T18:54:18.680834Z","steps":["trace[297698208] 'agreement among raft nodes before linearized reading' (duration: 430.300823ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:54:18.680884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:54:18.250395Z","time spent":"430.482128ms","remote":"127.0.0.1:56250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":4755,"request content":"key:\"/registry/pods/kube-system/coredns-77cccfdc44-s7rvp\" "} {"level":"info","ts":"2026-02-10T18:54:18.681076Z","caller":"traceutil/trace.go:171","msg":"trace[1221064969] transaction","detail":"{read_only:false; response_revision:714; number_of_response:1; }","duration":"457.142991ms","start":"2026-02-10T18:54:18.223922Z","end":"2026-02-10T18:54:18.681065Z","steps":["trace[1221064969] 'process raft request' (duration: 455.607589ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:54:18.681205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:54:18.22389Z","time spent":"457.276405ms","remote":"127.0.0.1:56336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T18:54:18.681296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.466708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T18:54:18.681321Z","caller":"traceutil/trace.go:171","msg":"trace[238443775] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:714; }","duration":"434.489578ms","start":"2026-02-10T18:54:18.246823Z","end":"2026-02-10T18:54:18.681312Z","steps":["trace[238443775] 'agreement among raft nodes before linearized reading' (duration: 434.450957ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:54:18.681352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:54:18.246787Z","time spent":"434.55913ms","remote":"127.0.0.1:56078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-10T18:54:22.442346Z","caller":"traceutil/trace.go:171","msg":"trace[1236518224] linearizableReadLoop","detail":"{readStateIndex:773; appliedIndex:772; }","duration":"221.456885ms","start":"2026-02-10T18:54:22.220872Z","end":"2026-02-10T18:54:22.442329Z","steps":["trace[1236518224] 'read index received' (duration: 221.28887ms)","trace[1236518224] 'applied index is now lower than readState.Index' (duration: 167.355µs)"],"step_count":2} {"level":"info","ts":"2026-02-10T18:54:22.442583Z","caller":"traceutil/trace.go:171","msg":"trace[479741535] transaction","detail":"{read_only:false; response_revision:748; number_of_response:1; }","duration":"274.428273ms","start":"2026-02-10T18:54:22.168147Z","end":"2026-02-10T18:54:22.442576Z","steps":["trace[479741535] 'process raft request' (duration: 274.057543ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:54:22.442718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.836345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T18:54:22.442742Z","caller":"traceutil/trace.go:171","msg":"trace[1068683402] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:748; }","duration":"221.891907ms","start":"2026-02-10T18:54:22.220841Z","end":"2026-02-10T18:54:22.442733Z","steps":["trace[1068683402] 'agreement among raft nodes before linearized reading' (duration: 221.843605ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:54:22.442885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.438931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-10T18:54:22.442903Z","caller":"traceutil/trace.go:171","msg":"trace[1467367186] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:748; }","duration":"186.484082ms","start":"2026-02-10T18:54:22.256413Z","end":"2026-02-10T18:54:22.442897Z","steps":["trace[1467367186] 'agreement among raft nodes before linearized reading' (duration: 186.41676ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:54:22.443037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.886165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-10T18:54:22.443055Z","caller":"traceutil/trace.go:171","msg":"trace[1440380616] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:748; }","duration":"129.907895ms","start":"2026-02-10T18:54:22.313142Z","end":"2026-02-10T18:54:22.44305Z","steps":["trace[1440380616] 'agreement among raft nodes before linearized reading' (duration: 129.871184ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:54:22.443164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.992951ms","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-10T18:54:22.44318Z","caller":"traceutil/trace.go:171","msg":"trace[283653590] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:748; }","duration":"185.035272ms","start":"2026-02-10T18:54:22.25814Z","end":"2026-02-10T18:54:22.443176Z","steps":["trace[283653590] 'agreement among raft nodes before linearized reading' (duration: 184.987331ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:54:26.651603Z","caller":"traceutil/trace.go:171","msg":"trace[629750068] transaction","detail":"{read_only:false; response_revision:760; number_of_response:1; }","duration":"188.94223ms","start":"2026-02-10T18:54:26.462639Z","end":"2026-02-10T18:54:26.651581Z","steps":["trace[629750068] 'process raft request' (duration: 188.787326ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:54:26.663363Z","caller":"traceutil/trace.go:171","msg":"trace[1322852554] linearizableReadLoop","detail":"{readStateIndex:787; appliedIndex:786; }","duration":"197.30211ms","start":"2026-02-10T18:54:26.466046Z","end":"2026-02-10T18:54:26.663348Z","steps":["trace[1322852554] 'read index received' (duration: 186.131643ms)","trace[1322852554] 'applied index is now lower than readState.Index' (duration: 11.169437ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T18:54:26.663516Z","caller":"traceutil/trace.go:171","msg":"trace[710989106] transaction","detail":"{read_only:false; response_revision:761; number_of_response:1; }","duration":"199.0881ms","start":"2026-02-10T18:54:26.464419Z","end":"2026-02-10T18:54:26.663508Z","steps":["trace[710989106] 'process raft request' (duration: 198.812112ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:54:26.663613Z","caller":"traceutil/trace.go:171","msg":"trace[618860134] transaction","detail":"{read_only:false; response_revision:762; number_of_response:1; }","duration":"174.336738ms","start":"2026-02-10T18:54:26.48927Z","end":"2026-02-10T18:54:26.663607Z","steps":["trace[618860134] 'process raft request' (duration: 174.04632ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:54:26.663762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.701541ms","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-10T18:54:26.663786Z","caller":"traceutil/trace.go:171","msg":"trace[833709126] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:762; }","duration":"197.747082ms","start":"2026-02-10T18:54:26.466031Z","end":"2026-02-10T18:54:26.663779Z","steps":["trace[833709126] 'agreement among raft nodes before linearized reading' (duration: 197.65825ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:54:26.663878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.159553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-10T18:54:26.663895Z","caller":"traceutil/trace.go:171","msg":"trace[1592341576] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:762; }","duration":"182.201255ms","start":"2026-02-10T18:54:26.481689Z","end":"2026-02-10T18:54:26.66389Z","steps":["trace[1592341576] 'agreement among raft nodes before linearized reading' (duration: 182.169784ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:54:26.831904Z","caller":"traceutil/trace.go:171","msg":"trace[1377385745] transaction","detail":"{read_only:false; response_revision:765; number_of_response:1; }","duration":"118.328996ms","start":"2026-02-10T18:54:26.71356Z","end":"2026-02-10T18:54:26.831889Z","steps":["trace[1377385745] 'process raft request' (duration: 118.303606ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:54:26.832238Z","caller":"traceutil/trace.go:171","msg":"trace[213591420] transaction","detail":"{read_only:false; response_revision:764; number_of_response:1; }","duration":"119.759076ms","start":"2026-02-10T18:54:26.712472Z","end":"2026-02-10T18:54:26.832231Z","steps":["trace[213591420] 'process raft request' (duration: 50.524291ms)","trace[213591420] 'compare' (duration: 68.781852ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T18:54:28.302801Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3721271029033140572,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-10T18:54:28.447459Z","caller":"traceutil/trace.go:171","msg":"trace[23458799] linearizableReadLoop","detail":"{readStateIndex:792; appliedIndex:791; }","duration":"644.688562ms","start":"2026-02-10T18:54:27.802753Z","end":"2026-02-10T18:54:28.447442Z","steps":["trace[23458799] 'read index received' (duration: 644.504497ms)","trace[23458799] 'applied index is now lower than readState.Index' (duration: 183.475µs)"],"step_count":2} {"level":"info","ts":"2026-02-10T18:54:28.447642Z","caller":"traceutil/trace.go:171","msg":"trace[903266877] transaction","detail":"{read_only:false; response_revision:766; number_of_response:1; }","duration":"876.923653ms","start":"2026-02-10T18:54:27.570711Z","end":"2026-02-10T18:54:28.447634Z","steps":["trace[903266877] 'process raft request' (duration: 876.605805ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:54:28.447709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:54:27.57069Z","time spent":"876.971765ms","remote":"127.0.0.1:56336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T18:54:28.44785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"645.093103ms","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-10T18:54:28.447874Z","caller":"traceutil/trace.go:171","msg":"trace[890927677] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:766; }","duration":"645.119734ms","start":"2026-02-10T18:54:27.802747Z","end":"2026-02-10T18:54:28.447867Z","steps":["trace[890927677] 'agreement among raft nodes before linearized reading' (duration: 645.079803ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:54:28.447892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:54:27.802727Z","time spent":"645.159935ms","remote":"127.0.0.1:56298","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":27,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"warn","ts":"2026-02-10T18:54:28.448003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"555.714543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T18:54:28.448021Z","caller":"traceutil/trace.go:171","msg":"trace[677700112] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:766; }","duration":"555.767685ms","start":"2026-02-10T18:54:27.892248Z","end":"2026-02-10T18:54:28.448016Z","steps":["trace[677700112] 'agreement among raft nodes before linearized reading' (duration: 555.728574ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:54:28.448037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:54:27.892231Z","time spent":"555.801935ms","remote":"127.0.0.1:56408","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":27,"request content":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true "} {"level":"warn","ts":"2026-02-10T18:54:28.448204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.42809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-10T18:54:28.448227Z","caller":"traceutil/trace.go:171","msg":"trace[62350463] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:766; }","duration":"432.478172ms","start":"2026-02-10T18:54:28.015744Z","end":"2026-02-10T18:54:28.448222Z","steps":["trace[62350463] 'agreement among raft nodes before linearized reading' (duration: 432.42224ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:54:28.448246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:54:28.015732Z","time spent":"432.509192ms","remote":"127.0.0.1:56168","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":4,"response size":29,"request content":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true "} {"level":"info","ts":"2026-02-10T18:54:39.24039Z","caller":"traceutil/trace.go:171","msg":"trace[1847509866] linearizableReadLoop","detail":"{readStateIndex:827; appliedIndex:826; }","duration":"439.711679ms","start":"2026-02-10T18:54:38.800654Z","end":"2026-02-10T18:54:39.240365Z","steps":["trace[1847509866] 'read index received' (duration: 439.523494ms)","trace[1847509866] 'applied index is now lower than readState.Index' (duration: 187.135µs)"],"step_count":2} {"level":"info","ts":"2026-02-10T18:54:39.24103Z","caller":"traceutil/trace.go:171","msg":"trace[232945228] transaction","detail":"{read_only:false; response_revision:799; number_of_response:1; }","duration":"773.131094ms","start":"2026-02-10T18:54:38.467881Z","end":"2026-02-10T18:54:39.241012Z","steps":["trace[232945228] 'process raft request' (duration: 772.361583ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:54:39.241373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:54:38.467857Z","time spent":"773.226607ms","remote":"127.0.0.1:56336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T18:54:39.241782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.121407ms","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-10T18:54:39.241832Z","caller":"traceutil/trace.go:171","msg":"trace[467344073] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:799; }","duration":"441.203999ms","start":"2026-02-10T18:54:38.800613Z","end":"2026-02-10T18:54:39.241817Z","steps":["trace[467344073] 'agreement among raft nodes before linearized reading' (duration: 441.073816ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:54:39.242598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:54:38.800594Z","time spent":"441.96352ms","remote":"127.0.0.1:56336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-10T18:54:39.243054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.449337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-10T18:54:39.243097Z","caller":"traceutil/trace.go:171","msg":"trace[2072794552] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:799; }","duration":"437.512419ms","start":"2026-02-10T18:54:38.805574Z","end":"2026-02-10T18:54:39.243086Z","steps":["trace[2072794552] 'agreement among raft nodes before linearized reading' (duration: 437.389246ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:54:39.243127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:54:38.805564Z","time spent":"437.55583ms","remote":"127.0.0.1:56336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-10T18:54:39.243431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.829927ms","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-10T18:54:39.24347Z","caller":"traceutil/trace.go:171","msg":"trace[1516977392] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:799; }","duration":"258.879389ms","start":"2026-02-10T18:54:38.984581Z","end":"2026-02-10T18:54:39.243461Z","steps":["trace[1516977392] 'agreement among raft nodes before linearized reading' (duration: 258.777266ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:54:39.243644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.548315ms","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-10T18:54:39.245706Z","caller":"traceutil/trace.go:171","msg":"trace[1552271481] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:799; }","duration":"407.045576ms","start":"2026-02-10T18:54:38.838055Z","end":"2026-02-10T18:54:39.245101Z","steps":["trace[1552271481] 'agreement among raft nodes before linearized reading' (duration: 405.490414ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:54:39.245965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:54:38.838044Z","time spent":"407.762845ms","remote":"127.0.0.1:56336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-10T18:54:39.243712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.172237ms","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-10T18:54:39.248424Z","caller":"traceutil/trace.go:171","msg":"trace[1944089896] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:799; }","duration":"266.906266ms","start":"2026-02-10T18:54:38.981494Z","end":"2026-02-10T18:54:39.2484Z","steps":["trace[1944089896] 'agreement among raft nodes before linearized reading' (duration: 262.170318ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:54:39.493089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.004194ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-10T18:54:39.493202Z","caller":"traceutil/trace.go:171","msg":"trace[1831310357] transaction","detail":"{read_only:false; response_revision:800; number_of_response:1; }","duration":"244.008249ms","start":"2026-02-10T18:54:39.249174Z","end":"2026-02-10T18:54:39.493182Z","steps":["trace[1831310357] 'process raft request' (duration: 92.81874ms)","trace[1831310357] 'compare' (duration: 150.836779ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T18:54:39.51213Z","caller":"traceutil/trace.go:171","msg":"trace[1156370279] transaction","detail":"{read_only:false; response_revision:804; number_of_response:1; }","duration":"258.013267ms","start":"2026-02-10T18:54:39.254096Z","end":"2026-02-10T18:54:39.512109Z","steps":["trace[1156370279] 'process raft request' (duration: 257.976426ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:54:39.513002Z","caller":"traceutil/trace.go:171","msg":"trace[1777899386] transaction","detail":"{read_only:false; response_revision:801; number_of_response:1; }","duration":"263.29649ms","start":"2026-02-10T18:54:39.249692Z","end":"2026-02-10T18:54:39.512989Z","steps":["trace[1777899386] 'process raft request' (duration: 262.218221ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:54:39.513823Z","caller":"traceutil/trace.go:171","msg":"trace[280898405] transaction","detail":"{read_only:false; response_revision:802; number_of_response:1; }","duration":"261.227504ms","start":"2026-02-10T18:54:39.252416Z","end":"2026-02-10T18:54:39.513643Z","steps":["trace[280898405] 'process raft request' (duration: 259.586829ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:54:39.513882Z","caller":"traceutil/trace.go:171","msg":"trace[898152345] transaction","detail":"{read_only:false; response_revision:803; number_of_response:1; }","duration":"259.821006ms","start":"2026-02-10T18:54:39.254051Z","end":"2026-02-10T18:54:39.513872Z","steps":["trace[898152345] 'process raft request' (duration: 257.991377ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:54:39.775896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.373859ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-02-10T18:54:39.776237Z","caller":"traceutil/trace.go:171","msg":"trace[384914485] linearizableReadLoop","detail":"{readStateIndex:833; appliedIndex:832; }","duration":"177.170151ms","start":"2026-02-10T18:54:39.599047Z","end":"2026-02-10T18:54:39.776217Z","steps":["trace[384914485] 'read index received' (duration: 26.101µs)","trace[384914485] 'applied index is now lower than readState.Index' (duration: 177.14184ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T18:54:39.776471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.407357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T18:54:39.776696Z","caller":"traceutil/trace.go:171","msg":"trace[1043828289] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:804; }","duration":"177.671104ms","start":"2026-02-10T18:54:39.599011Z","end":"2026-02-10T18:54:39.776682Z","steps":["trace[1043828289] 'agreement among raft nodes before linearized reading' (duration: 177.351656ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:54:52.092867Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3721271029033140856,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-10T18:54:52.169108Z","caller":"traceutil/trace.go:171","msg":"trace[352401606] linearizableReadLoop","detail":"{readStateIndex:917; appliedIndex:916; }","duration":"576.54245ms","start":"2026-02-10T18:54:51.59255Z","end":"2026-02-10T18:54:52.169092Z","steps":["trace[352401606] 'read index received' (duration: 576.392096ms)","trace[352401606] 'applied index is now lower than readState.Index' (duration: 149.784µs)"],"step_count":2} {"level":"info","ts":"2026-02-10T18:54:52.169179Z","caller":"traceutil/trace.go:171","msg":"trace[566845517] transaction","detail":"{read_only:false; response_revision:885; number_of_response:1; }","duration":"619.963154ms","start":"2026-02-10T18:54:51.549211Z","end":"2026-02-10T18:54:52.169174Z","steps":["trace[566845517] 'process raft request' (duration: 619.79546ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:54:52.169246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:54:51.549194Z","time spent":"620.000346ms","remote":"127.0.0.1:56336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T18:54:52.169366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"576.820337ms","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-10T18:54:52.169383Z","caller":"traceutil/trace.go:171","msg":"trace[1799404122] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:885; }","duration":"576.862369ms","start":"2026-02-10T18:54:51.592514Z","end":"2026-02-10T18:54:52.169377Z","steps":["trace[1799404122] 'agreement among raft nodes before linearized reading' (duration: 576.799607ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:54:52.169397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:54:51.592452Z","time spent":"576.941611ms","remote":"127.0.0.1:56336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-10T18:54:52.169459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"567.896166ms","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-10T18:54:52.16947Z","caller":"traceutil/trace.go:171","msg":"trace[1998546097] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:885; }","duration":"567.917437ms","start":"2026-02-10T18:54:51.601549Z","end":"2026-02-10T18:54:52.169466Z","steps":["trace[1998546097] 'agreement among raft nodes before linearized reading' (duration: 567.885966ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:54:52.169481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:54:51.601543Z","time spent":"567.935658ms","remote":"127.0.0.1:56336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-10T18:54:52.169645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"550.154217ms","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-10T18:54:52.169661Z","caller":"traceutil/trace.go:171","msg":"trace[580053535] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:885; }","duration":"550.198308ms","start":"2026-02-10T18:54:51.619458Z","end":"2026-02-10T18:54:52.169656Z","steps":["trace[580053535] 'agreement among raft nodes before linearized reading' (duration: 550.156087ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:54:52.169673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:54:51.619436Z","time spent":"550.233789ms","remote":"127.0.0.1:56336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-10T18:54:52.169719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.518513ms","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-10T18:54:52.169809Z","caller":"traceutil/trace.go:171","msg":"trace[1396440231] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:885; }","duration":"548.658576ms","start":"2026-02-10T18:54:51.621132Z","end":"2026-02-10T18:54:52.169791Z","steps":["trace[1396440231] 'agreement among raft nodes before linearized reading' (duration: 548.383839ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:54:52.1699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:54:51.621103Z","time spent":"548.739288ms","remote":"127.0.0.1:56336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-10T18:54:52.333329Z","caller":"traceutil/trace.go:171","msg":"trace[152300599] transaction","detail":"{read_only:false; response_revision:887; number_of_response:1; }","duration":"152.71497ms","start":"2026-02-10T18:54:52.180589Z","end":"2026-02-10T18:54:52.333304Z","steps":["trace[152300599] 'process raft request' (duration: 75.875512ms)","trace[152300599] 'compare' (duration: 76.129498ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T18:54:52.334185Z","caller":"traceutil/trace.go:171","msg":"trace[149206445] transaction","detail":"{read_only:false; response_revision:889; number_of_response:1; }","duration":"148.956658ms","start":"2026-02-10T18:54:52.185213Z","end":"2026-02-10T18:54:52.33417Z","steps":["trace[149206445] 'process raft request' (duration: 148.892296ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:54:52.334426Z","caller":"traceutil/trace.go:171","msg":"trace[1301743331] transaction","detail":"{read_only:false; response_revision:888; number_of_response:1; }","duration":"152.062692ms","start":"2026-02-10T18:54:52.182352Z","end":"2026-02-10T18:54:52.334415Z","steps":["trace[1301743331] 'process raft request' (duration: 150.861689ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:54:58.315016Z","caller":"traceutil/trace.go:171","msg":"trace[961580463] transaction","detail":"{read_only:false; response_revision:902; number_of_response:1; }","duration":"125.974846ms","start":"2026-02-10T18:54:58.189019Z","end":"2026-02-10T18:54:58.314994Z","steps":["trace[961580463] 'process raft request' (duration: 125.510113ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:54:58.763589Z","caller":"traceutil/trace.go:171","msg":"trace[745117894] transaction","detail":"{read_only:false; response_revision:904; number_of_response:1; }","duration":"371.804954ms","start":"2026-02-10T18:54:58.391768Z","end":"2026-02-10T18:54:58.763573Z","steps":["trace[745117894] 'process raft request' (duration: 371.708691ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:54:58.763694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:54:58.391751Z","time spent":"371.884166ms","remote":"127.0.0.1:56336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T18:54:58.83849Z","caller":"traceutil/trace.go:171","msg":"trace[2110432596] transaction","detail":"{read_only:false; response_revision:906; number_of_response:1; }","duration":"444.401977ms","start":"2026-02-10T18:54:58.394072Z","end":"2026-02-10T18:54:58.838474Z","steps":["trace[2110432596] 'process raft request' (duration: 444.378457ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:54:58.838604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:54:58.394066Z","time spent":"444.469239ms","remote":"127.0.0.1:56336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T18:54:58.838856Z","caller":"traceutil/trace.go:171","msg":"trace[1626338008] transaction","detail":"{read_only:false; response_revision:905; number_of_response:1; }","duration":"446.027861ms","start":"2026-02-10T18:54:58.392823Z","end":"2026-02-10T18:54:58.838851Z","steps":["trace[1626338008] 'process raft request' (duration: 445.552438ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:54:58.838881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:54:58.392811Z","time spent":"446.056962ms","remote":"127.0.0.1:56336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T18:55:06.81168Z","caller":"traceutil/trace.go:171","msg":"trace[704285947] linearizableReadLoop","detail":"{readStateIndex:960; appliedIndex:959; }","duration":"404.536809ms","start":"2026-02-10T18:55:06.407131Z","end":"2026-02-10T18:55:06.811668Z","steps":["trace[704285947] 'read index received' (duration: 404.466357ms)","trace[704285947] 'applied index is now lower than readState.Index' (duration: 69.882µs)"],"step_count":2} {"level":"info","ts":"2026-02-10T18:55:06.811779Z","caller":"traceutil/trace.go:171","msg":"trace[1835600171] transaction","detail":"{read_only:false; response_revision:925; number_of_response:1; }","duration":"419.569185ms","start":"2026-02-10T18:55:06.392203Z","end":"2026-02-10T18:55:06.811772Z","steps":["trace[1835600171] 'process raft request' (duration: 419.38364ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:55:06.811834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:55:06.392195Z","time spent":"419.596836ms","remote":"127.0.0.1:56336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T18:55:06.811931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.802706ms","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-10T18:55:06.811948Z","caller":"traceutil/trace.go:171","msg":"trace[435874749] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:925; }","duration":"404.833367ms","start":"2026-02-10T18:55:06.407109Z","end":"2026-02-10T18:55:06.811942Z","steps":["trace[435874749] 'agreement among raft nodes before linearized reading' (duration: 404.778486ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:55:06.81196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:55:06.407102Z","time spent":"404.855457ms","remote":"127.0.0.1:56336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-02-10T18:55:06.942527Z","caller":"traceutil/trace.go:171","msg":"trace[337519031] transaction","detail":"{read_only:false; response_revision:926; number_of_response:1; }","duration":"127.21504ms","start":"2026-02-10T18:55:06.815294Z","end":"2026-02-10T18:55:06.942509Z","steps":["trace[337519031] 'process raft request' (duration: 57.786382ms)","trace[337519031] 'compare' (duration: 68.957875ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T18:55:06.9426Z","caller":"traceutil/trace.go:171","msg":"trace[537778977] transaction","detail":"{read_only:false; response_revision:927; number_of_response:1; }","duration":"125.984367ms","start":"2026-02-10T18:55:06.81661Z","end":"2026-02-10T18:55:06.942595Z","steps":["trace[537778977] 'process raft request' (duration: 125.577106ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:55:09.269669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.537465ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-10T18:55:09.269826Z","caller":"traceutil/trace.go:171","msg":"trace[1237313615] linearizableReadLoop","detail":"{readStateIndex:967; appliedIndex:965; }","duration":"317.883406ms","start":"2026-02-10T18:55:08.951928Z","end":"2026-02-10T18:55:09.269811Z","steps":["trace[1237313615] 'read index received' (duration: 182.123535ms)","trace[1237313615] 'applied index is now lower than readState.Index' (duration: 135.758961ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T18:55:09.269913Z","caller":"traceutil/trace.go:171","msg":"trace[340488290] transaction","detail":"{read_only:false; response_revision:932; number_of_response:1; }","duration":"320.167388ms","start":"2026-02-10T18:55:08.949736Z","end":"2026-02-10T18:55:09.269903Z","steps":["trace[340488290] 'process raft request' (duration: 320.028154ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:55:09.269905Z","caller":"traceutil/trace.go:171","msg":"trace[1458101172] transaction","detail":"{read_only:false; response_revision:931; number_of_response:1; }","duration":"320.214249ms","start":"2026-02-10T18:55:08.949672Z","end":"2026-02-10T18:55:09.269886Z","steps":["trace[1458101172] 'process raft request' (duration: 184.372996ms)","trace[1458101172] 'compare' (duration: 135.435092ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T18:55:09.269968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:55:08.949721Z","time spent":"320.216379ms","remote":"127.0.0.1:56336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T18:55:09.27Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:55:08.949663Z","time spent":"320.284591ms","remote":"127.0.0.1:56336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T18:55:09.270157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.225465ms","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-10T18:55:09.270186Z","caller":"traceutil/trace.go:171","msg":"trace[280549592] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:932; }","duration":"318.267986ms","start":"2026-02-10T18:55:08.951909Z","end":"2026-02-10T18:55:09.270177Z","steps":["trace[280549592] 'agreement among raft nodes before linearized reading' (duration: 318.161983ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:55:09.270212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:55:08.951903Z","time spent":"318.304118ms","remote":"127.0.0.1:56336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-10T18:55:09.270257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.247826ms","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-10T18:55:09.270278Z","caller":"traceutil/trace.go:171","msg":"trace[1732803927] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:932; }","duration":"318.276216ms","start":"2026-02-10T18:55:08.951996Z","end":"2026-02-10T18:55:09.270272Z","steps":["trace[1732803927] 'agreement among raft nodes before linearized reading' (duration: 318.195864ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:55:09.270292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:55:08.951992Z","time spent":"318.297157ms","remote":"127.0.0.1:56336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-10T18:55:09.703853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.857708ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-10T18:55:09.70399Z","caller":"traceutil/trace.go:171","msg":"trace[2093889898] transaction","detail":"{read_only:false; response_revision:933; number_of_response:1; }","duration":"425.879326ms","start":"2026-02-10T18:55:09.278093Z","end":"2026-02-10T18:55:09.703973Z","steps":["trace[2093889898] 'process raft request' (duration: 172.675359ms)","trace[2093889898] 'compare' (duration: 252.688523ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T18:55:09.704047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:55:09.278079Z","time spent":"425.942658ms","remote":"127.0.0.1:56336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T18:55:09.757643Z","caller":"traceutil/trace.go:171","msg":"trace[1667157539] transaction","detail":"{read_only:false; response_revision:934; number_of_response:1; }","duration":"479.392883ms","start":"2026-02-10T18:55:09.278223Z","end":"2026-02-10T18:55:09.757616Z","steps":["trace[1667157539] 'process raft request' (duration: 479.262849ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:55:09.757796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:55:09.278219Z","time spent":"479.496367ms","remote":"127.0.0.1:56336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T18:55:10.020177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.412969ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-02-10T18:55:10.020282Z","caller":"traceutil/trace.go:171","msg":"trace[241025029] linearizableReadLoop","detail":"{readStateIndex:970; appliedIndex:968; }","duration":"318.465432ms","start":"2026-02-10T18:55:09.701796Z","end":"2026-02-10T18:55:10.020261Z","steps":["trace[241025029] 'read index received' (duration: 55.620734ms)","trace[241025029] 'applied index is now lower than readState.Index' (duration: 262.842738ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T18:55:10.020392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.561025ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-10T18:55:10.020442Z","caller":"traceutil/trace.go:171","msg":"trace[912331155] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:934; }","duration":"318.670448ms","start":"2026-02-10T18:55:09.701756Z","end":"2026-02-10T18:55:10.020427Z","steps":["trace[912331155] 'agreement among raft nodes before linearized reading' (duration: 318.561895ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:55:10.020494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:55:09.701737Z","time spent":"318.741929ms","remote":"127.0.0.1:56586","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":3,"response size":29,"request content":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true "} {"level":"info","ts":"2026-02-10T18:55:10.223265Z","caller":"traceutil/trace.go:171","msg":"trace[895155759] transaction","detail":"{read_only:false; response_revision:935; number_of_response:1; }","duration":"232.058845ms","start":"2026-02-10T18:55:09.991187Z","end":"2026-02-10T18:55:10.223246Z","steps":["trace[895155759] 'process raft request' (duration: 231.945602ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:55:11.156862Z","caller":"traceutil/trace.go:171","msg":"trace[1907743690] transaction","detail":"{read_only:false; response_revision:936; number_of_response:1; }","duration":"200.023389ms","start":"2026-02-10T18:55:10.956821Z","end":"2026-02-10T18:55:11.156845Z","steps":["trace[1907743690] 'process raft request' (duration: 199.925766ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:55:14.751323Z","caller":"traceutil/trace.go:171","msg":"trace[118877355] transaction","detail":"{read_only:false; response_revision:958; number_of_response:1; }","duration":"145.939106ms","start":"2026-02-10T18:55:14.605366Z","end":"2026-02-10T18:55:14.751305Z","steps":["trace[118877355] 'process raft request' (duration: 145.818463ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:55:15.88494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.972664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-10T18:55:15.88501Z","caller":"traceutil/trace.go:171","msg":"trace[591719904] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:970; }","duration":"201.088227ms","start":"2026-02-10T18:55:15.683912Z","end":"2026-02-10T18:55:15.885Z","steps":["trace[591719904] 'count revisions from in-memory index tree' (duration: 200.908153ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:55:15.885237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.534033ms","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-10T18:55:15.885252Z","caller":"traceutil/trace.go:171","msg":"trace[61554639] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:970; }","duration":"139.572244ms","start":"2026-02-10T18:55:15.745674Z","end":"2026-02-10T18:55:15.885247Z","steps":["trace[61554639] 'range keys from in-memory index tree' (duration: 139.414819ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:55:15.885343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.096099ms","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-10T18:55:15.885355Z","caller":"traceutil/trace.go:171","msg":"trace[354140583] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:970; }","duration":"113.109039ms","start":"2026-02-10T18:55:15.772242Z","end":"2026-02-10T18:55:15.885351Z","steps":["trace[354140583] 'range keys from in-memory index tree' (duration: 113.007436ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:55:27.828669Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3721271029033141220,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-10T18:55:28.145374Z","caller":"traceutil/trace.go:171","msg":"trace[1028043103] linearizableReadLoop","detail":"{readStateIndex:1088; appliedIndex:1087; }","duration":"817.27035ms","start":"2026-02-10T18:55:27.328075Z","end":"2026-02-10T18:55:28.145346Z","steps":["trace[1028043103] 'read index received' (duration: 816.878689ms)","trace[1028043103] 'applied index is now lower than readState.Index' (duration: 389.811µs)"],"step_count":2} {"level":"info","ts":"2026-02-10T18:55:28.145668Z","caller":"traceutil/trace.go:171","msg":"trace[375362440] transaction","detail":"{read_only:false; response_revision:1048; number_of_response:1; }","duration":"916.923464ms","start":"2026-02-10T18:55:27.228728Z","end":"2026-02-10T18:55:28.145652Z","steps":["trace[375362440] 'process raft request' (duration: 916.288127ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:55:28.146083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:55:27.228719Z","time spent":"917.045887ms","remote":"127.0.0.1:56336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T18:55:28.147352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"819.269904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:527"} {"level":"info","ts":"2026-02-10T18:55:28.147473Z","caller":"traceutil/trace.go:171","msg":"trace[691963138] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1048; }","duration":"819.639984ms","start":"2026-02-10T18:55:27.327816Z","end":"2026-02-10T18:55:28.147456Z","steps":["trace[691963138] 'agreement among raft nodes before linearized reading' (duration: 819.249854ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:55:28.147568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:55:27.32779Z","time spent":"819.764708ms","remote":"127.0.0.1:56336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":549,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-02-10T18:55:28.147992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"783.437394ms","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-10T18:55:28.148075Z","caller":"traceutil/trace.go:171","msg":"trace[1050446156] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1048; }","duration":"783.546748ms","start":"2026-02-10T18:55:27.364516Z","end":"2026-02-10T18:55:28.148063Z","steps":["trace[1050446156] 'agreement among raft nodes before linearized reading' (duration: 783.354322ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:55:28.148426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:55:27.3645Z","time spent":"783.856737ms","remote":"127.0.0.1:56336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-10T18:55:28.149021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.446066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-02-10T18:55:28.149103Z","caller":"traceutil/trace.go:171","msg":"trace[1330764879] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1048; }","duration":"134.549768ms","start":"2026-02-10T18:55:28.01454Z","end":"2026-02-10T18:55:28.14909Z","steps":["trace[1330764879] 'agreement among raft nodes before linearized reading' (duration: 134.291201ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:55:28.149647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.31782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-02-10T18:55:28.149759Z","caller":"traceutil/trace.go:171","msg":"trace[1451560466] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1048; }","duration":"138.543377ms","start":"2026-02-10T18:55:28.0112Z","end":"2026-02-10T18:55:28.149743Z","steps":["trace[1451560466] 'agreement among raft nodes before linearized reading' (duration: 138.324771ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:55:28.150149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"777.152285ms","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-10T18:55:28.150194Z","caller":"traceutil/trace.go:171","msg":"trace[793229353] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1048; }","duration":"777.240547ms","start":"2026-02-10T18:55:27.372942Z","end":"2026-02-10T18:55:28.150182Z","steps":["trace[793229353] 'agreement among raft nodes before linearized reading' (duration: 777.076362ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:55:28.150288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:55:27.372931Z","time spent":"777.345339ms","remote":"127.0.0.1:56336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-02-10T18:55:28.577228Z","caller":"traceutil/trace.go:171","msg":"trace[2063593561] transaction","detail":"{read_only:false; response_revision:1049; number_of_response:1; }","duration":"422.059083ms","start":"2026-02-10T18:55:28.155147Z","end":"2026-02-10T18:55:28.577206Z","steps":["trace[2063593561] 'process raft request' (duration: 421.94781ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:55:28.577368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:55:28.155132Z","time spent":"422.156176ms","remote":"127.0.0.1:56336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T18:55:28.579798Z","caller":"traceutil/trace.go:171","msg":"trace[1855935452] transaction","detail":"{read_only:false; response_revision:1050; number_of_response:1; }","duration":"416.316848ms","start":"2026-02-10T18:55:28.163464Z","end":"2026-02-10T18:55:28.579781Z","steps":["trace[1855935452] 'process raft request' (duration: 415.909947ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:55:28.579878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:55:28.163442Z","time spent":"416.39413ms","remote":"127.0.0.1:56336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":512,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T18:55:28.580504Z","caller":"traceutil/trace.go:171","msg":"trace[742119462] transaction","detail":"{read_only:false; response_revision:1051; number_of_response:1; }","duration":"416.936965ms","start":"2026-02-10T18:55:28.163554Z","end":"2026-02-10T18:55:28.580491Z","steps":["trace[742119462] 'process raft request' (duration: 416.631937ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:55:28.580569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:55:28.163547Z","time spent":"416.986486ms","remote":"127.0.0.1:56336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T18:55:28.58115Z","caller":"traceutil/trace.go:171","msg":"trace[1330803291] transaction","detail":"{read_only:false; response_revision:1052; number_of_response:1; }","duration":"417.50414ms","start":"2026-02-10T18:55:28.163636Z","end":"2026-02-10T18:55:28.58114Z","steps":["trace[1330803291] 'process raft request' (duration: 416.642357ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:55:28.58121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:55:28.163628Z","time spent":"417.549251ms","remote":"127.0.0.1:56336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T18:55:28.581452Z","caller":"traceutil/trace.go:171","msg":"trace[1603485780] transaction","detail":"{read_only:false; response_revision:1053; number_of_response:1; }","duration":"417.766956ms","start":"2026-02-10T18:55:28.163676Z","end":"2026-02-10T18:55:28.581442Z","steps":["trace[1603485780] 'process raft request' (duration: 416.755769ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:55:28.581502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:55:28.163671Z","time spent":"417.805448ms","remote":"127.0.0.1:56336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T18:55:28.581035Z","caller":"traceutil/trace.go:171","msg":"trace[94080375] linearizableReadLoop","detail":"{readStateIndex:1093; appliedIndex:1089; }","duration":"358.589256ms","start":"2026-02-10T18:55:28.222433Z","end":"2026-02-10T18:55:28.581023Z","steps":["trace[94080375] 'read index received' (duration: 356.198082ms)","trace[94080375] 'applied index is now lower than readState.Index' (duration: 2.390384ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T18:55:28.581775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.333357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T18:55:28.585493Z","caller":"traceutil/trace.go:171","msg":"trace[352109898] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1053; }","duration":"359.46607ms","start":"2026-02-10T18:55:28.222406Z","end":"2026-02-10T18:55:28.581872Z","steps":["trace[352109898] 'agreement among raft nodes before linearized reading' (duration: 359.337246ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:55:28.585559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:55:28.222393Z","time spent":"363.13899ms","remote":"127.0.0.1:56078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-10T18:58:43.320015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.975862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T18:58:43.320084Z","caller":"traceutil/trace.go:171","msg":"trace[712660608] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1876; }","duration":"102.072794ms","start":"2026-02-10T18:58:43.217999Z","end":"2026-02-10T18:58:43.320072Z","steps":["trace[712660608] 'range keys from in-memory index tree' (duration: 101.875429ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:58:44.229601Z","caller":"traceutil/trace.go:171","msg":"trace[315172677] linearizableReadLoop","detail":"{readStateIndex:1961; appliedIndex:1960; }","duration":"192.601884ms","start":"2026-02-10T18:58:44.03698Z","end":"2026-02-10T18:58:44.229582Z","steps":["trace[315172677] 'read index received' (duration: 192.490701ms)","trace[315172677] 'applied index is now lower than readState.Index' (duration: 110.503µs)"],"step_count":2} {"level":"info","ts":"2026-02-10T18:58:44.229717Z","caller":"traceutil/trace.go:171","msg":"trace[1370033231] transaction","detail":"{read_only:false; response_revision:1881; number_of_response:1; }","duration":"467.673346ms","start":"2026-02-10T18:58:43.762035Z","end":"2026-02-10T18:58:44.229709Z","steps":["trace[1370033231] 'process raft request' (duration: 467.446959ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:58:44.229879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:58:43.762023Z","time spent":"467.746078ms","remote":"127.0.0.1:56336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":518,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T18:58:44.23031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.339825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"} {"level":"info","ts":"2026-02-10T18:58:44.23036Z","caller":"traceutil/trace.go:171","msg":"trace[221297134] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1881; }","duration":"193.424448ms","start":"2026-02-10T18:58:44.036927Z","end":"2026-02-10T18:58:44.230351Z","steps":["trace[221297134] 'agreement among raft nodes before linearized reading' (duration: 193.302074ms)"],"step_count":1}