{"level":"warn","ts":"2026-01-30T09:29:50.649486Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-01-30T09:29:50.6496Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.52: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://162.253.55.52:2380","--initial-cluster=instance=https://162.253.55.52:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.52:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.52: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-01-30T09:29:50.6497Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-01-30T09:29:50.64971Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.52:2380"]}
{"level":"info","ts":"2026-01-30T09:29:50.649736Z","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-01-30T09:29:50.650466Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.52:2379"]}
{"level":"info","ts":"2026-01-30T09:29:50.650551Z","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://162.253.55.52:2380"],"listen-peer-urls":["https://162.253.55.52:2380"],"advertise-client-urls":["https://162.253.55.52:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.52:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.52: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-01-30T09:29:50.65507Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.267532ms"}
{"level":"info","ts":"2026-01-30T09:29:50.689147Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b11e7fc5714be64b","cluster-id":"9349e4f32a52a90a"}
{"level":"info","ts":"2026-01-30T09:29:50.689479Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b switched to configuration voters=()"}
{"level":"info","ts":"2026-01-30T09:29:50.689793Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became follower at term 0"}
{"level":"info","ts":"2026-01-30T09:29:50.689807Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b11e7fc5714be64b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-01-30T09:29:50.689819Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became follower at term 1"}
{"level":"info","ts":"2026-01-30T09:29:50.689849Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b switched to configuration voters=(12762778880000648779)"}
{"level":"warn","ts":"2026-01-30T09:29:50.698691Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-01-30T09:29:50.700152Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-01-30T09:29:50.702059Z","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-01-30T09:29:50.708057Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b11e7fc5714be64b","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-01-30T09:29:50.710186Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b switched to configuration voters=(12762778880000648779)"}
{"level":"info","ts":"2026-01-30T09:29:50.710285Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9349e4f32a52a90a","local-member-id":"b11e7fc5714be64b","added-peer-id":"b11e7fc5714be64b","added-peer-peer-urls":["https://162.253.55.52:2380"]}
{"level":"info","ts":"2026-01-30T09:29:50.710422Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b11e7fc5714be64b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-01-30T09:29:50.710501Z","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-01-30T09:29:50.710526Z","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-01-30T09:29:50.710534Z","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-01-30T09:29:50.728638Z","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-01-30T09:29:50.730099Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.52:2380"}
{"level":"info","ts":"2026-01-30T09:29:50.73016Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.52:2380"}
{"level":"info","ts":"2026-01-30T09:29:50.733418Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b11e7fc5714be64b","initial-advertise-peer-urls":["https://162.253.55.52:2380"],"listen-peer-urls":["https://162.253.55.52:2380"],"advertise-client-urls":["https://162.253.55.52:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.52:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-01-30T09:29:50.733978Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-01-30T09:29:51.490932Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b is starting a new election at term 1"}
{"level":"info","ts":"2026-01-30T09:29:51.491024Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became pre-candidate at term 1"}
{"level":"info","ts":"2026-01-30T09:29:51.491053Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b received MsgPreVoteResp from b11e7fc5714be64b at term 1"}
{"level":"info","ts":"2026-01-30T09:29:51.491073Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became candidate at term 2"}
{"level":"info","ts":"2026-01-30T09:29:51.491085Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b received MsgVoteResp from b11e7fc5714be64b at term 2"}
{"level":"info","ts":"2026-01-30T09:29:51.4911Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became leader at term 2"}
{"level":"info","ts":"2026-01-30T09:29:51.491109Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b11e7fc5714be64b elected leader b11e7fc5714be64b at term 2"}
{"level":"info","ts":"2026-01-30T09:29:51.492262Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b11e7fc5714be64b","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.52:2379]}","request-path":"/0/members/b11e7fc5714be64b/attributes","cluster-id":"9349e4f32a52a90a","publish-timeout":"7s"}
{"level":"info","ts":"2026-01-30T09:29:51.49359Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-01-30T09:29:51.494012Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-01-30T09:29:51.494152Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-01-30T09:29:51.495575Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-01-30T09:29:51.495594Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-01-30T09:29:51.497395Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-01-30T09:29:51.497565Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9349e4f32a52a90a","local-member-id":"b11e7fc5714be64b","cluster-version":"3.5"}
{"level":"info","ts":"2026-01-30T09:29:51.497695Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-01-30T09:29:51.497756Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-01-30T09:29:51.500834Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.52:2379"}
{"level":"info","ts":"2026-01-30T09:29:58.972662Z","caller":"traceutil/trace.go:171","msg":"trace[1938071940] transaction","detail":"{read_only:false; response_revision:328; number_of_response:1; }","duration":"127.205264ms","start":"2026-01-30T09:29:58.845436Z","end":"2026-01-30T09:29:58.972641Z","steps":["trace[1938071940] 'process raft request'  (duration: 79.705555ms)","trace[1938071940] 'compare'  (duration: 47.388317ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-30T09:30:05.289003Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16594528836940031092,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-01-30T09:30:05.789496Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16594528836940031092,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-01-30T09:30:05.849285Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.714023297s","expected-duration":"1s"}
{"level":"info","ts":"2026-01-30T09:30:05.849563Z","caller":"traceutil/trace.go:171","msg":"trace[77939936] linearizableReadLoop","detail":"{readStateIndex:417; appliedIndex:416; }","duration":"1.060833459s","start":"2026-01-30T09:30:04.788714Z","end":"2026-01-30T09:30:05.849548Z","steps":["trace[77939936] 'read index received'  (duration: 1.060692826s)","trace[77939936] 'applied index is now lower than readState.Index'  (duration: 140.063µs)"],"step_count":2}
{"level":"info","ts":"2026-01-30T09:30:05.849719Z","caller":"traceutil/trace.go:171","msg":"trace[121622413] transaction","detail":"{read_only:false; response_revision:406; number_of_response:1; }","duration":"1.714549699s","start":"2026-01-30T09:30:04.135164Z","end":"2026-01-30T09:30:05.849713Z","steps":["trace[121622413] 'process raft request'  (duration: 1.714291773s)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:30:05.850009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:30:04.135136Z","time spent":"1.714597431s","remote":"127.0.0.1:53628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7021,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-apiserver-instance\" mod_revision:405 > success:<request_put:<key:\"/registry/pods/kube-system/kube-apiserver-instance\" value_size:6963 >> failure:<request_range:<key:\"/registry/pods/kube-system/kube-apiserver-instance\" > >"}
{"level":"warn","ts":"2026-01-30T09:30:05.850121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.061407743s","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-01-30T09:30:05.850142Z","caller":"traceutil/trace.go:171","msg":"trace[1908409038] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:406; }","duration":"1.061463824s","start":"2026-01-30T09:30:04.788672Z","end":"2026-01-30T09:30:05.850136Z","steps":["trace[1908409038] 'agreement among raft nodes before linearized reading'  (duration: 1.061429354s)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:30:05.850157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:30:04.788653Z","time spent":"1.061501025s","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-01-30T09:30:05.850259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"883.411821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.52\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-01-30T09:30:05.850285Z","caller":"traceutil/trace.go:171","msg":"trace[1350062518] range","detail":"{range_begin:/registry/masterleases/162.253.55.52; range_end:; response_count:1; response_revision:406; }","duration":"883.472573ms","start":"2026-01-30T09:30:04.966808Z","end":"2026-01-30T09:30:05.85028Z","steps":["trace[1350062518] 'agreement among raft nodes before linearized reading'  (duration: 883.434602ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:30:05.850297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:30:04.966789Z","time spent":"883.505234ms","remote":"127.0.0.1:53472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/162.253.55.52\" "}
{"level":"warn","ts":"2026-01-30T09:30:05.850464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.054762ms","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-01-30T09:30:05.850484Z","caller":"traceutil/trace.go:171","msg":"trace[1505246736] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:406; }","duration":"358.111363ms","start":"2026-01-30T09:30:05.492366Z","end":"2026-01-30T09:30:05.850478Z","steps":["trace[1505246736] 'agreement among raft nodes before linearized reading'  (duration: 358.078363ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:30:05.850497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:30:05.492325Z","time spent":"358.168375ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-01-30T09:30:05.850559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.068434ms","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-01-30T09:30:05.850572Z","caller":"traceutil/trace.go:171","msg":"trace[162152039] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:406; }","duration":"377.110026ms","start":"2026-01-30T09:30:05.473459Z","end":"2026-01-30T09:30:05.850569Z","steps":["trace[162152039] 'agreement among raft nodes before linearized reading'  (duration: 377.087735ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:30:05.850583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:30:05.473443Z","time spent":"377.137336ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-01-30T09:30:05.850639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.357535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-01-30T09:30:05.850652Z","caller":"traceutil/trace.go:171","msg":"trace[1501040883] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:406; }","duration":"455.401107ms","start":"2026-01-30T09:30:05.395247Z","end":"2026-01-30T09:30:05.850648Z","steps":["trace[1501040883] 'agreement among raft nodes before linearized reading'  (duration: 455.379936ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:30:05.850664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:30:05.395234Z","time spent":"455.427917ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-01-30T09:30:05.85072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"731.134691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-30T09:30:05.850732Z","caller":"traceutil/trace.go:171","msg":"trace[501503777] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:406; }","duration":"731.147601ms","start":"2026-01-30T09:30:05.11958Z","end":"2026-01-30T09:30:05.850728Z","steps":["trace[501503777] 'agreement among raft nodes before linearized reading'  (duration: 731.127301ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:30:05.850744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:30:05.119549Z","time spent":"731.192572ms","remote":"127.0.0.1:53456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-01-30T09:30:07.408551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.008066ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-30T09:30:07.408694Z","caller":"traceutil/trace.go:171","msg":"trace[289468348] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:406; }","duration":"187.17053ms","start":"2026-01-30T09:30:07.221507Z","end":"2026-01-30T09:30:07.408677Z","steps":["trace[289468348] 'range keys from in-memory index tree'  (duration: 186.988676ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:30:07.409143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.21189105s","expected-duration":"100ms","prefix":"","request":"header:<ID:16594528836940031097 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:15-second id:664b9c0e3cc96478>","response":"size:41"}
{"level":"info","ts":"2026-01-30T09:30:07.409206Z","caller":"traceutil/trace.go:171","msg":"trace[250864309] linearizableReadLoop","detail":"{readStateIndex:418; appliedIndex:417; }","duration":"1.55513362s","start":"2026-01-30T09:30:05.854061Z","end":"2026-01-30T09:30:07.409195Z","steps":["trace[250864309] 'read index received'  (duration: 343.143717ms)","trace[250864309] 'applied index is now lower than readState.Index'  (duration: 1.211988753s)"],"step_count":2}
{"level":"warn","ts":"2026-01-30T09:30:07.409254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:30:05.853768Z","time spent":"1.555472288s","remote":"127.0.0.1:53472","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-01-30T09:30:07.409313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.555246993s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-30T09:30:07.409338Z","caller":"traceutil/trace.go:171","msg":"trace[324670538] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:406; }","duration":"1.555289984s","start":"2026-01-30T09:30:05.85404Z","end":"2026-01-30T09:30:07.40933Z","steps":["trace[324670538] 'agreement among raft nodes before linearized reading'  (duration: 1.555242323s)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:30:07.40937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:30:05.854032Z","time spent":"1.555330995s","remote":"127.0.0.1:53464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-01-30T09:30:07.462106Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.264813909s","expected-duration":"1s"}
{"level":"info","ts":"2026-01-30T09:30:07.462662Z","caller":"traceutil/trace.go:171","msg":"trace[1056723845] transaction","detail":"{read_only:false; response_revision:410; number_of_response:1; }","duration":"1.602418764s","start":"2026-01-30T09:30:05.860222Z","end":"2026-01-30T09:30:07.462641Z","steps":["trace[1056723845] 'process raft request'  (duration: 1.602385564s)"],"step_count":1}
{"level":"info","ts":"2026-01-30T09:30:07.462693Z","caller":"traceutil/trace.go:171","msg":"trace[1371409233] transaction","detail":"{read_only:false; response_revision:407; number_of_response:1; }","duration":"1.607008434s","start":"2026-01-30T09:30:05.855642Z","end":"2026-01-30T09:30:07.462651Z","steps":["trace[1371409233] 'process raft request'  (duration: 1.606755488s)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:30:07.462763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:30:05.860197Z","time spent":"1.602503246s","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:403 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-01-30T09:30:07.462846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:30:05.855632Z","time spent":"1.607128186s","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:401 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-01-30T09:30:07.46295Z","caller":"traceutil/trace.go:171","msg":"trace[868171099] transaction","detail":"{read_only:false; response_revision:408; number_of_response:1; }","duration":"1.60724624s","start":"2026-01-30T09:30:05.855692Z","end":"2026-01-30T09:30:07.462938Z","steps":["trace[868171099] 'process raft request'  (duration: 1.60683138s)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:30:07.463004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:30:05.855687Z","time spent":"1.60728843s","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:398 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-01-30T09:30:07.46308Z","caller":"traceutil/trace.go:171","msg":"trace[1749240618] transaction","detail":"{read_only:false; response_revision:409; number_of_response:1; }","duration":"1.604908114s","start":"2026-01-30T09:30:05.858162Z","end":"2026-01-30T09:30:07.46307Z","steps":["trace[1749240618] 'process raft request'  (duration: 1.604418582s)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:30:07.463121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:30:05.858151Z","time spent":"1.604946874s","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:402 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-01-30T09:30:07.749702Z","caller":"traceutil/trace.go:171","msg":"trace[1822894435] linearizableReadLoop","detail":"{readStateIndex:424; appliedIndex:421; }","duration":"340.426982ms","start":"2026-01-30T09:30:07.40926Z","end":"2026-01-30T09:30:07.749687Z","steps":["trace[1822894435] 'read index received'  (duration: 53.362248ms)","trace[1822894435] 'applied index is now lower than readState.Index'  (duration: 287.064064ms)"],"step_count":2}
{"level":"info","ts":"2026-01-30T09:30:07.749986Z","caller":"traceutil/trace.go:171","msg":"trace[377594988] transaction","detail":"{read_only:false; response_revision:411; number_of_response:1; }","duration":"699.07815ms","start":"2026-01-30T09:30:07.050894Z","end":"2026-01-30T09:30:07.749972Z","steps":["trace[377594988] 'process raft request'  (duration: 697.032441ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:30:07.750069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:30:07.050871Z","time spent":"699.141761ms","remote":"127.0.0.1:53624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4041,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:370 > success:<request_put:<key:\"/registry/minions/instance\" value_size:4007 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"warn","ts":"2026-01-30T09:30:07.750634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.566341886s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4256"}
{"level":"info","ts":"2026-01-30T09:30:07.750661Z","caller":"traceutil/trace.go:171","msg":"trace[1930000963] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:413; }","duration":"1.566406408s","start":"2026-01-30T09:30:06.184247Z","end":"2026-01-30T09:30:07.750654Z","steps":["trace[1930000963] 'agreement among raft nodes before linearized reading'  (duration: 1.566311406s)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:30:07.750681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:30:06.18423Z","time spent":"1.56644693s","remote":"127.0.0.1:53628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":4280,"request content":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" "}
{"level":"warn","ts":"2026-01-30T09:30:07.750979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.048901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-30T09:30:07.751001Z","caller":"traceutil/trace.go:171","msg":"trace[17670899] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:413; }","duration":"334.098312ms","start":"2026-01-30T09:30:07.416896Z","end":"2026-01-30T09:30:07.750995Z","steps":["trace[17670899] 'agreement among raft nodes before linearized reading'  (duration: 334.061971ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:30:07.75102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:30:07.416889Z","time spent":"334.125533ms","remote":"127.0.0.1:53456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-01-30T09:30:07.7532Z","caller":"traceutil/trace.go:171","msg":"trace[942730125] transaction","detail":"{read_only:false; response_revision:412; number_of_response:1; }","duration":"663.161345ms","start":"2026-01-30T09:30:07.090026Z","end":"2026-01-30T09:30:07.753187Z","steps":["trace[942730125] 'process raft request'  (duration: 659.603451ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:30:07.753283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:30:07.090006Z","time spent":"663.243037ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:278 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:471 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"info","ts":"2026-01-30T09:30:07.753387Z","caller":"traceutil/trace.go:171","msg":"trace[1014401555] transaction","detail":"{read_only:false; response_revision:413; number_of_response:1; }","duration":"341.99902ms","start":"2026-01-30T09:30:07.41138Z","end":"2026-01-30T09:30:07.753379Z","steps":["trace[1014401555] 'process raft request'  (duration: 338.282462ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:30:07.753424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:30:07.411359Z","time spent":"342.04249ms","remote":"127.0.0.1:53472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/masterleases/162.253.55.52\" mod_revision:241 > success:<request_put:<key:\"/registry/masterleases/162.253.55.52\" value_size:66 lease:7371156800085255288 >> failure:<request_range:<key:\"/registry/masterleases/162.253.55.52\" > >"}
{"level":"warn","ts":"2026-01-30T09:30:23.085083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.956677ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594528836940031264 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/serviceaccounts/kube-system/cilium-operator\" mod_revision:0 > success:<request_put:<key:\"/registry/serviceaccounts/kube-system/cilium-operator\" value_size:462 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-01-30T09:30:23.085534Z","caller":"traceutil/trace.go:171","msg":"trace[1708434554] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"225.862359ms","start":"2026-01-30T09:30:22.85965Z","end":"2026-01-30T09:30:23.085512Z","steps":["trace[1708434554] 'process raft request'  (duration: 225.732566ms)"],"step_count":1}
{"level":"info","ts":"2026-01-30T09:30:23.085943Z","caller":"traceutil/trace.go:171","msg":"trace[1089137866] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"227.097758ms","start":"2026-01-30T09:30:22.858823Z","end":"2026-01-30T09:30:23.08592Z","steps":["trace[1089137866] 'process raft request'  (duration: 78.217169ms)","trace[1089137866] 'compare'  (duration: 147.363963ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-30T09:30:25.841614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"724.590955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-30T09:30:25.841692Z","caller":"traceutil/trace.go:171","msg":"trace[1648844782] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:519; }","duration":"724.703068ms","start":"2026-01-30T09:30:25.116973Z","end":"2026-01-30T09:30:25.841676Z","steps":["trace[1648844782] 'range keys from in-memory index tree'  (duration: 724.541684ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:30:25.84173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:30:25.116931Z","time spent":"724.79089ms","remote":"127.0.0.1:53456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-01-30T09:30:25.842447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.326794ms","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-01-30T09:30:25.842507Z","caller":"traceutil/trace.go:171","msg":"trace[740194210] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:519; }","duration":"296.438167ms","start":"2026-01-30T09:30:25.546058Z","end":"2026-01-30T09:30:25.842496Z","steps":["trace[740194210] 'range keys from in-memory index tree'  (duration: 296.205191ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:30:25.842729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.2557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-01-30T09:30:25.84276Z","caller":"traceutil/trace.go:171","msg":"trace[1740816781] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:519; }","duration":"274.308201ms","start":"2026-01-30T09:30:25.568443Z","end":"2026-01-30T09:30:25.842751Z","steps":["trace[1740816781] 'range keys from in-memory index tree'  (duration: 274.163287ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:30:25.842954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.53859ms","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-01-30T09:30:25.842983Z","caller":"traceutil/trace.go:171","msg":"trace[1849041599] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:519; }","duration":"259.578791ms","start":"2026-01-30T09:30:25.583396Z","end":"2026-01-30T09:30:25.842975Z","steps":["trace[1849041599] 'range keys from in-memory index tree'  (duration: 259.480909ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:30:25.843227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.732583ms","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-01-30T09:30:25.843261Z","caller":"traceutil/trace.go:171","msg":"trace[917201179] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:519; }","duration":"182.799775ms","start":"2026-01-30T09:30:25.660449Z","end":"2026-01-30T09:30:25.843249Z","steps":["trace[917201179] 'range keys from in-memory index tree'  (duration: 182.58517ms)"],"step_count":1}
{"level":"info","ts":"2026-01-30T09:30:28.082947Z","caller":"traceutil/trace.go:171","msg":"trace[478300296] linearizableReadLoop","detail":"{readStateIndex:543; appliedIndex:542; }","duration":"208.073926ms","start":"2026-01-30T09:30:27.874859Z","end":"2026-01-30T09:30:28.082932Z","steps":["trace[478300296] 'read index received'  (duration: 207.948873ms)","trace[478300296] 'applied index is now lower than readState.Index'  (duration: 124.383µs)"],"step_count":2}
{"level":"info","ts":"2026-01-30T09:30:28.083025Z","caller":"traceutil/trace.go:171","msg":"trace[1929762119] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"212.969253ms","start":"2026-01-30T09:30:27.870049Z","end":"2026-01-30T09:30:28.083018Z","steps":["trace[1929762119] 'process raft request'  (duration: 212.751948ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:30:28.083133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.261621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-01-30T09:30:28.083149Z","caller":"traceutil/trace.go:171","msg":"trace[2020795946] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:525; }","duration":"208.299361ms","start":"2026-01-30T09:30:27.874844Z","end":"2026-01-30T09:30:28.083144Z","steps":["trace[2020795946] 'agreement among raft nodes before linearized reading'  (duration: 208.25528ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:30:28.08324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.466541ms","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-01-30T09:30:28.083283Z","caller":"traceutil/trace.go:171","msg":"trace[845580161] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:525; }","duration":"167.517032ms","start":"2026-01-30T09:30:27.915756Z","end":"2026-01-30T09:30:28.083273Z","steps":["trace[845580161] 'agreement among raft nodes before linearized reading'  (duration: 167.445201ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:30:28.083349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.568964ms","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-01-30T09:30:28.083367Z","caller":"traceutil/trace.go:171","msg":"trace[86396794] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:525; }","duration":"167.595755ms","start":"2026-01-30T09:30:27.915767Z","end":"2026-01-30T09:30:28.083362Z","steps":["trace[86396794] 'agreement among raft nodes before linearized reading'  (duration: 167.563144ms)"],"step_count":1}
{"level":"info","ts":"2026-01-30T09:30:28.767194Z","caller":"traceutil/trace.go:171","msg":"trace[638808929] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"680.751013ms","start":"2026-01-30T09:30:28.086201Z","end":"2026-01-30T09:30:28.766952Z","steps":["trace[638808929] 'process raft request'  (duration: 680.583349ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:30:28.767357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:30:28.08619Z","time spent":"681.079411ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:521 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-01-30T09:30:28.817703Z","caller":"traceutil/trace.go:171","msg":"trace[462987945] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"730.020325ms","start":"2026-01-30T09:30:28.087665Z","end":"2026-01-30T09:30:28.817685Z","steps":["trace[462987945] 'process raft request'  (duration: 729.742478ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:30:28.817785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:30:28.087651Z","time spent":"730.090926ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:522 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-01-30T09:30:28.817999Z","caller":"traceutil/trace.go:171","msg":"trace[2115314860] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"729.39257ms","start":"2026-01-30T09:30:28.088601Z","end":"2026-01-30T09:30:28.817994Z","steps":["trace[2115314860] 'process raft request'  (duration: 728.890508ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:30:28.818027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:30:28.088596Z","time spent":"729.41526ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:523 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-01-30T09:30:28.819634Z","caller":"traceutil/trace.go:171","msg":"trace[1007421875] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"334.82261ms","start":"2026-01-30T09:30:28.484804Z","end":"2026-01-30T09:30:28.819627Z","steps":["trace[1007421875] 'process raft request'  (duration: 333.13668ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:30:28.819676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:30:28.484782Z","time spent":"334.875481ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:471 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"info","ts":"2026-01-30T09:30:34.100886Z","caller":"traceutil/trace.go:171","msg":"trace[2063611649] linearizableReadLoop","detail":"{readStateIndex:560; appliedIndex:559; }","duration":"186.36377ms","start":"2026-01-30T09:30:33.914498Z","end":"2026-01-30T09:30:34.100862Z","steps":["trace[2063611649] 'read index received'  (duration: 186.176915ms)","trace[2063611649] 'applied index is now lower than readState.Index'  (duration: 185.945µs)"],"step_count":2}
{"level":"warn","ts":"2026-01-30T09:30:34.101163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.664267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-cpzgx\" ","response":"range_response_count:1 size:16652"}
{"level":"info","ts":"2026-01-30T09:30:34.101199Z","caller":"traceutil/trace.go:171","msg":"trace[1069158019] range","detail":"{range_begin:/registry/pods/kube-system/cilium-cpzgx; range_end:; response_count:1; response_revision:541; }","duration":"186.811391ms","start":"2026-01-30T09:30:33.914376Z","end":"2026-01-30T09:30:34.101187Z","steps":["trace[1069158019] 'agreement among raft nodes before linearized reading'  (duration: 186.599595ms)"],"step_count":1}
{"level":"info","ts":"2026-01-30T09:30:34.101611Z","caller":"traceutil/trace.go:171","msg":"trace[2031655717] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"285.551738ms","start":"2026-01-30T09:30:33.816049Z","end":"2026-01-30T09:30:34.1016Z","steps":["trace[2031655717] 'process raft request'  (duration: 284.687418ms)"],"step_count":1}
{"level":"info","ts":"2026-01-30T09:30:34.276486Z","caller":"traceutil/trace.go:171","msg":"trace[74783951] linearizableReadLoop","detail":"{readStateIndex:561; appliedIndex:560; }","duration":"159.892352ms","start":"2026-01-30T09:30:34.116544Z","end":"2026-01-30T09:30:34.276436Z","steps":["trace[74783951] 'read index received'  (duration: 153.743016ms)","trace[74783951] 'applied index is now lower than readState.Index'  (duration: 6.148166ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-30T09:30:34.276671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.095156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-30T09:30:34.276703Z","caller":"traceutil/trace.go:171","msg":"trace[1394734301] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:542; }","duration":"160.160858ms","start":"2026-01-30T09:30:34.11653Z","end":"2026-01-30T09:30:34.276691Z","steps":["trace[1394734301] 'agreement among raft nodes before linearized reading'  (duration: 160.036905ms)"],"step_count":1}
{"level":"info","ts":"2026-01-30T09:30:34.277312Z","caller":"traceutil/trace.go:171","msg":"trace[1572289342] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"166.232401ms","start":"2026-01-30T09:30:34.111042Z","end":"2026-01-30T09:30:34.277275Z","steps":["trace[1572289342] 'process raft request'  (duration: 159.327438ms)"],"step_count":1}
{"level":"info","ts":"2026-01-30T09:30:34.278826Z","caller":"traceutil/trace.go:171","msg":"trace[1709514587] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"160.971757ms","start":"2026-01-30T09:30:34.117836Z","end":"2026-01-30T09:30:34.278808Z","steps":["trace[1709514587] 'process raft request'  (duration: 160.844014ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:30:36.693371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"575.019879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-30T09:30:36.693431Z","caller":"traceutil/trace.go:171","msg":"trace[1081358886] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:555; }","duration":"575.118792ms","start":"2026-01-30T09:30:36.1183Z","end":"2026-01-30T09:30:36.693419Z","steps":["trace[1081358886] 'range keys from in-memory index tree'  (duration: 574.959548ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:30:36.693455Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:30:36.11828Z","time spent":"575.168803ms","remote":"127.0.0.1:53456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-01-30T09:30:36.693632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.843698ms","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-01-30T09:30:36.693646Z","caller":"traceutil/trace.go:171","msg":"trace[2088096459] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:555; }","duration":"405.893179ms","start":"2026-01-30T09:30:36.287748Z","end":"2026-01-30T09:30:36.693642Z","steps":["trace[2088096459] 'range keys from in-memory index tree'  (duration: 405.742286ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:30:36.693658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:30:36.287727Z","time spent":"405.92739ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-01-30T09:30:39.413027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.904091ms","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-01-30T09:30:39.413108Z","caller":"traceutil/trace.go:171","msg":"trace[292481724] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io; range_end:; response_count:1; response_revision:612; }","duration":"221.040684ms","start":"2026-01-30T09:30:39.192046Z","end":"2026-01-30T09:30:39.413087Z","steps":["trace[292481724] 'range keys from in-memory index tree'  (duration: 220.741037ms)"],"step_count":1}
{"level":"info","ts":"2026-01-30T09:30:39.416711Z","caller":"traceutil/trace.go:171","msg":"trace[532886230] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"212.693126ms","start":"2026-01-30T09:30:39.203993Z","end":"2026-01-30T09:30:39.416686Z","steps":["trace[532886230] 'process raft request'  (duration: 204.053931ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:30:49.357581Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16594528836940031706,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-01-30T09:30:49.85823Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16594528836940031706,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-01-30T09:30:50.00146Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.217255383s","expected-duration":"1s"}
{"level":"info","ts":"2026-01-30T09:30:50.001745Z","caller":"traceutil/trace.go:171","msg":"trace[339360724] transaction","detail":"{read_only:false; response_revision:717; number_of_response:1; }","duration":"1.217595692s","start":"2026-01-30T09:30:48.784133Z","end":"2026-01-30T09:30:50.001729Z","steps":["trace[339360724] 'process raft request'  (duration: 1.217488279s)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:30:50.001833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:30:48.784118Z","time spent":"1.217659673s","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:677 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-01-30T09:30:51.122646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999213898s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-01-30T09:30:51.12274Z","caller":"traceutil/trace.go:171","msg":"trace[1416851500] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"1.999339281s","start":"2026-01-30T09:30:49.12338Z","end":"2026-01-30T09:30:51.122719Z","steps":["trace[1416851500] 'agreement among raft nodes before linearized reading'  (duration: 1.999232009s)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:30:51.122788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:30:49.123302Z","time spent":"1.999477285s","remote":"127.0.0.1:53456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/01/30 09:30:51 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-01-30T09:30:52.242102Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.240526759s","expected-duration":"1s"}
{"level":"info","ts":"2026-01-30T09:30:52.242749Z","caller":"traceutil/trace.go:171","msg":"trace[1552893925] transaction","detail":"{read_only:false; response_revision:718; number_of_response:1; }","duration":"3.232794588s","start":"2026-01-30T09:30:49.009915Z","end":"2026-01-30T09:30:52.24271Z","steps":["trace[1552893925] 'process raft request'  (duration: 3.232302987s)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:30:52.2429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:30:49.009905Z","time spent":"3.232933091s","remote":"127.0.0.1:53526","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":723,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/coredns-5dd5756b68-q5p8z.188f784c9bdc43ff\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/coredns-5dd5756b68-q5p8z.188f784c9bdc43ff\" value_size:635 lease:7371156800085254830 >> failure:<>"}
{"level":"info","ts":"2026-01-30T09:30:52.24313Z","caller":"traceutil/trace.go:171","msg":"trace[723130960] transaction","detail":"{read_only:false; response_revision:719; number_of_response:1; }","duration":"2.529348499s","start":"2026-01-30T09:30:49.713777Z","end":"2026-01-30T09:30:52.243125Z","steps":["trace[723130960] 'process raft request'  (duration: 2.52851401s)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:30:52.243177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:30:49.713761Z","time spent":"2.52938261s","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:613 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"info","ts":"2026-01-30T09:30:52.340381Z","caller":"traceutil/trace.go:171","msg":"trace[1324960179] linearizableReadLoop","detail":"{readStateIndex:742; appliedIndex:740; }","duration":"3.48295087s","start":"2026-01-30T09:30:48.857409Z","end":"2026-01-30T09:30:52.34036Z","steps":["trace[1324960179] 'read index received'  (duration: 1.144744191s)","trace[1324960179] 'applied index is now lower than readState.Index'  (duration: 2.338205729s)"],"step_count":2}
{"level":"warn","ts":"2026-01-30T09:30:52.340719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.483305368s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-01-30T09:30:52.340738Z","caller":"traceutil/trace.go:171","msg":"trace[1339546353] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:719; }","duration":"3.4833592s","start":"2026-01-30T09:30:48.857373Z","end":"2026-01-30T09:30:52.340732Z","steps":["trace[1339546353] 'agreement among raft nodes before linearized reading'  (duration: 3.483278288s)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:30:52.340756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:30:48.857351Z","time spent":"3.483399591s","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-01-30T09:30:52.352212Z","caller":"traceutil/trace.go:171","msg":"trace[461747467] transaction","detail":"{read_only:false; response_revision:720; number_of_response:1; }","duration":"105.548207ms","start":"2026-01-30T09:30:52.246649Z","end":"2026-01-30T09:30:52.352197Z","steps":["trace[461747467] 'process raft request'  (duration: 105.459655ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:30:52.352374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.343009846s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-5dd5756b68-q5p8z\" ","response":"range_response_count:1 size:4817"}
{"level":"info","ts":"2026-01-30T09:30:52.352417Z","caller":"traceutil/trace.go:171","msg":"trace[1731566238] range","detail":"{range_begin:/registry/pods/kube-system/coredns-5dd5756b68-q5p8z; range_end:; response_count:1; response_revision:720; }","duration":"3.343093218s","start":"2026-01-30T09:30:49.009313Z","end":"2026-01-30T09:30:52.352406Z","steps":["trace[1731566238] 'agreement among raft nodes before linearized reading'  (duration: 3.342910184s)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:30:52.352439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:30:49.009298Z","time spent":"3.343136609s","remote":"127.0.0.1:53628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":4841,"request content":"key:\"/registry/pods/kube-system/coredns-5dd5756b68-q5p8z\" "}
{"level":"warn","ts":"2026-01-30T09:30:52.352527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.198398722s","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-01-30T09:30:52.352548Z","caller":"traceutil/trace.go:171","msg":"trace[1317197042] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:720; }","duration":"3.198437202s","start":"2026-01-30T09:30:49.154104Z","end":"2026-01-30T09:30:52.352541Z","steps":["trace[1317197042] 'agreement among raft nodes before linearized reading'  (duration: 3.19835115s)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:30:52.352565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:30:49.1541Z","time spent":"3.198462123s","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-01-30T09:30:52.352626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.201192108s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-01-30T09:30:52.352652Z","caller":"traceutil/trace.go:171","msg":"trace[1392022551] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:720; }","duration":"3.201233589s","start":"2026-01-30T09:30:49.151412Z","end":"2026-01-30T09:30:52.352646Z","steps":["trace[1392022551] 'agreement among raft nodes before linearized reading'  (duration: 3.201171567s)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:30:52.352663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.659588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-01-30T09:30:52.352669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:30:49.151403Z","time spent":"3.201262499s","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-01-30T09:30:52.352678Z","caller":"traceutil/trace.go:171","msg":"trace[1165705135] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:720; }","duration":"347.698219ms","start":"2026-01-30T09:30:52.004975Z","end":"2026-01-30T09:30:52.352674Z","steps":["trace[1165705135] 'agreement among raft nodes before linearized reading'  (duration: 347.656438ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:30:52.352701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:30:52.004956Z","time spent":"347.73337ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-01-30T09:30:52.352748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.229877272s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-30T09:30:52.352759Z","caller":"traceutil/trace.go:171","msg":"trace[302343836] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:720; }","duration":"1.229924663s","start":"2026-01-30T09:30:51.12283Z","end":"2026-01-30T09:30:52.352755Z","steps":["trace[302343836] 'agreement among raft nodes before linearized reading'  (duration: 1.229904983s)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:30:52.35277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:30:51.122809Z","time spent":"1.229958125s","remote":"127.0.0.1:53464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-01-30T09:30:52.352805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.218956909s","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-01-30T09:30:52.352821Z","caller":"traceutil/trace.go:171","msg":"trace[233066128] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:720; }","duration":"3.218993721s","start":"2026-01-30T09:30:49.133822Z","end":"2026-01-30T09:30:52.352816Z","steps":["trace[233066128] 'agreement among raft nodes before linearized reading'  (duration: 3.21894557s)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:30:52.352833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:30:49.133811Z","time spent":"3.219019991s","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-01-30T09:30:52.629618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.954755ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594528836940031713 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:681 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-01-30T09:30:52.629706Z","caller":"traceutil/trace.go:171","msg":"trace[696549943] transaction","detail":"{read_only:false; response_revision:721; number_of_response:1; }","duration":"286.245039ms","start":"2026-01-30T09:30:52.343447Z","end":"2026-01-30T09:30:52.629692Z","steps":["trace[696549943] 'process raft request'  (duration: 175.165401ms)","trace[696549943] 'compare'  (duration: 110.838573ms)"],"step_count":2}
{"level":"info","ts":"2026-01-30T09:30:53.162876Z","caller":"traceutil/trace.go:171","msg":"trace[928210108] transaction","detail":"{read_only:false; response_revision:722; number_of_response:1; }","duration":"799.690425ms","start":"2026-01-30T09:30:52.36314Z","end":"2026-01-30T09:30:53.162831Z","steps":["trace[928210108] 'process raft request'  (duration: 799.46421ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:30:53.163015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:30:52.363123Z","time spent":"799.815719ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:717 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-01-30T09:30:53.163035Z","caller":"traceutil/trace.go:171","msg":"trace[1326402356] linearizableReadLoop","detail":"{readStateIndex:750; appliedIndex:744; }","duration":"797.879812ms","start":"2026-01-30T09:30:52.365019Z","end":"2026-01-30T09:30:53.162899Z","steps":["trace[1326402356] 'read index received'  (duration: 153.601418ms)","trace[1326402356] 'applied index is now lower than readState.Index'  (duration: 644.277524ms)"],"step_count":2}
{"level":"info","ts":"2026-01-30T09:30:53.163264Z","caller":"traceutil/trace.go:171","msg":"trace[753438735] transaction","detail":"{read_only:false; response_revision:723; number_of_response:1; }","duration":"800.020104ms","start":"2026-01-30T09:30:52.363206Z","end":"2026-01-30T09:30:53.163226Z","steps":["trace[753438735] 'process raft request'  (duration: 799.523772ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:30:53.163424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:30:52.363201Z","time spent":"800.133336ms","remote":"127.0.0.1:53526","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/kube-apiserver-instance.188f784d636908bf\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/kube-apiserver-instance.188f784d636908bf\" value_size:672 lease:7371156800085254830 >> failure:<>"}
{"level":"info","ts":"2026-01-30T09:30:53.163525Z","caller":"traceutil/trace.go:171","msg":"trace[1024116793] transaction","detail":"{read_only:false; response_revision:726; number_of_response:1; }","duration":"799.163573ms","start":"2026-01-30T09:30:52.36435Z","end":"2026-01-30T09:30:53.163513Z","steps":["trace[1024116793] 'process raft request'  (duration: 798.492557ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:30:53.163575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:30:52.364343Z","time spent":"799.210354ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:705 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-01-30T09:30:53.164192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"799.153352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-30T09:30:53.164289Z","caller":"traceutil/trace.go:171","msg":"trace[161710932] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:726; }","duration":"799.274106ms","start":"2026-01-30T09:30:52.365002Z","end":"2026-01-30T09:30:53.164276Z","steps":["trace[161710932] 'agreement among raft nodes before linearized reading'  (duration: 799.132012ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:30:53.164377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:30:52.364996Z","time spent":"799.370218ms","remote":"127.0.0.1:53456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-01-30T09:30:53.164634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.164962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-30T09:30:53.164716Z","caller":"traceutil/trace.go:171","msg":"trace[373052802] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:726; }","duration":"335.275654ms","start":"2026-01-30T09:30:52.829429Z","end":"2026-01-30T09:30:53.164705Z","steps":["trace[373052802] 'agreement among raft nodes before linearized reading'  (duration: 335.172341ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:30:53.164801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:30:52.829414Z","time spent":"335.373546ms","remote":"127.0.0.1:53706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":0,"response size":29,"request content":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true "}
{"level":"info","ts":"2026-01-30T09:30:53.165433Z","caller":"traceutil/trace.go:171","msg":"trace[1018831964] transaction","detail":"{read_only:false; response_revision:724; number_of_response:1; }","duration":"802.172725ms","start":"2026-01-30T09:30:52.363247Z","end":"2026-01-30T09:30:53.16542Z","steps":["trace[1018831964] 'process raft request'  (duration: 799.532252ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:30:53.165624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:30:52.363243Z","time spent":"802.276707ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:700 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-01-30T09:30:53.16606Z","caller":"traceutil/trace.go:171","msg":"trace[1444825023] transaction","detail":"{read_only:false; response_revision:725; number_of_response:1; }","duration":"802.724558ms","start":"2026-01-30T09:30:52.363322Z","end":"2026-01-30T09:30:53.166047Z","steps":["trace[1444825023] 'process raft request'  (duration: 799.489481ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:30:53.166232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:30:52.363306Z","time spent":"802.84623ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:707 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-01-30T09:30:53.475992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.351672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-30T09:30:53.476067Z","caller":"traceutil/trace.go:171","msg":"trace[2037926150] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:726; }","duration":"302.453204ms","start":"2026-01-30T09:30:53.173591Z","end":"2026-01-30T09:30:53.476044Z","steps":["trace[2037926150] 'range keys from in-memory index tree'  (duration: 302.299541ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:30:53.476115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:30:53.173577Z","time spent":"302.526686ms","remote":"127.0.0.1:53464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-01-30T09:30:56.781266Z","caller":"traceutil/trace.go:171","msg":"trace[1778483792] transaction","detail":"{read_only:false; response_revision:739; number_of_response:1; }","duration":"138.103411ms","start":"2026-01-30T09:30:56.643147Z","end":"2026-01-30T09:30:56.78125Z","steps":["trace[1778483792] 'process raft request'  (duration: 137.992248ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:01.743029Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16594528836940031790,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-01-30T09:31:01.861033Z","caller":"traceutil/trace.go:171","msg":"trace[799692797] transaction","detail":"{read_only:false; response_revision:751; number_of_response:1; }","duration":"627.435183ms","start":"2026-01-30T09:31:01.233576Z","end":"2026-01-30T09:31:01.861011Z","steps":["trace[799692797] 'process raft request'  (duration: 627.32971ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:01.861129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:01.233549Z","time spent":"627.527415ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:746 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-01-30T09:31:02.37491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.347376ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594528836940031792 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:747 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-01-30T09:31:02.374978Z","caller":"traceutil/trace.go:171","msg":"trace[1712598225] linearizableReadLoop","detail":"{readStateIndex:778; appliedIndex:777; }","duration":"1.132727483s","start":"2026-01-30T09:31:01.242239Z","end":"2026-01-30T09:31:02.374966Z","steps":["trace[1712598225] 'read index received'  (duration: 619.167956ms)","trace[1712598225] 'applied index is now lower than readState.Index'  (duration: 513.558777ms)"],"step_count":2}
{"level":"info","ts":"2026-01-30T09:31:02.375115Z","caller":"traceutil/trace.go:171","msg":"trace[1486060126] transaction","detail":"{read_only:false; response_revision:752; number_of_response:1; }","duration":"1.139268939s","start":"2026-01-30T09:31:01.235837Z","end":"2026-01-30T09:31:02.375106Z","steps":["trace[1486060126] 'process raft request'  (duration: 907.666738ms)","trace[1486060126] 'compare'  (duration: 231.16887ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-30T09:31:02.375154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:01.235823Z","time spent":"1.13931129s","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:747 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-01-30T09:31:02.375322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.133078322s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-01-30T09:31:02.37534Z","caller":"traceutil/trace.go:171","msg":"trace[1673042548] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:752; }","duration":"1.133114893s","start":"2026-01-30T09:31:01.242219Z","end":"2026-01-30T09:31:02.375334Z","steps":["trace[1673042548] 'agreement among raft nodes before linearized reading'  (duration: 1.133037981s)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:02.375359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:01.242213Z","time spent":"1.133141014s","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-01-30T09:31:02.37547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.133202245s","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-01-30T09:31:02.375487Z","caller":"traceutil/trace.go:171","msg":"trace[109099881] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:752; }","duration":"1.133224656s","start":"2026-01-30T09:31:01.242257Z","end":"2026-01-30T09:31:02.375481Z","steps":["trace[109099881] 'agreement among raft nodes before linearized reading'  (duration: 1.133175314s)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:02.375504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:01.242254Z","time spent":"1.133245106s","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-01-30T09:31:02.375531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"777.60247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-01-30T09:31:02.375591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"790.218679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-30T09:31:02.375594Z","caller":"traceutil/trace.go:171","msg":"trace[1138685700] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:752; }","duration":"777.703802ms","start":"2026-01-30T09:31:01.597876Z","end":"2026-01-30T09:31:02.375579Z","steps":["trace[1138685700] 'agreement among raft nodes before linearized reading'  (duration: 777.567509ms)"],"step_count":1}
{"level":"info","ts":"2026-01-30T09:31:02.375612Z","caller":"traceutil/trace.go:171","msg":"trace[1339249441] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:752; }","duration":"790.24533ms","start":"2026-01-30T09:31:01.585361Z","end":"2026-01-30T09:31:02.375606Z","steps":["trace[1339249441] 'agreement among raft nodes before linearized reading'  (duration: 790.211509ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:02.375631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:01.585359Z","time spent":"790.26745ms","remote":"127.0.0.1:33610","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true "}
{"level":"warn","ts":"2026-01-30T09:31:02.37563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:01.597869Z","time spent":"777.754163ms","remote":"127.0.0.1:33622","response type":"/etcdserverpb.KV/Range","request count":0,"request size":95,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:500 "}
{"level":"warn","ts":"2026-01-30T09:31:02.375727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"790.365882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-30T09:31:02.375747Z","caller":"traceutil/trace.go:171","msg":"trace[863556979] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:752; }","duration":"790.394963ms","start":"2026-01-30T09:31:01.585346Z","end":"2026-01-30T09:31:02.375741Z","steps":["trace[863556979] 'agreement among raft nodes before linearized reading'  (duration: 790.365452ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:02.375763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:01.585344Z","time spent":"790.415383ms","remote":"127.0.0.1:33610","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:500 "}
{"level":"warn","ts":"2026-01-30T09:31:02.37584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"790.501656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-30T09:31:02.375856Z","caller":"traceutil/trace.go:171","msg":"trace[1224887032] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:752; }","duration":"790.527386ms","start":"2026-01-30T09:31:01.585323Z","end":"2026-01-30T09:31:02.375851Z","steps":["trace[1224887032] 'agreement among raft nodes before linearized reading'  (duration: 790.500776ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:02.375874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:01.585319Z","time spent":"790.550407ms","remote":"127.0.0.1:33610","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:10000 "}
{"level":"warn","ts":"2026-01-30T09:31:02.37595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"797.430461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-30T09:31:02.375967Z","caller":"traceutil/trace.go:171","msg":"trace[2070506094] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:752; }","duration":"797.461531ms","start":"2026-01-30T09:31:01.578501Z","end":"2026-01-30T09:31:02.375962Z","steps":["trace[2070506094] 'agreement among raft nodes before linearized reading'  (duration: 797.43376ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:02.375973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.192711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-01-30T09:31:02.375984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:01.578496Z","time spent":"797.483571ms","remote":"127.0.0.1:33596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:500 "}
{"level":"info","ts":"2026-01-30T09:31:02.375994Z","caller":"traceutil/trace.go:171","msg":"trace[2131548544] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:752; }","duration":"255.241603ms","start":"2026-01-30T09:31:02.120746Z","end":"2026-01-30T09:31:02.375988Z","steps":["trace[2131548544] 'agreement among raft nodes before linearized reading'  (duration: 255.205022ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:02.376078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"799.48463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-01-30T09:31:02.376095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"778.157753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-30T09:31:02.376098Z","caller":"traceutil/trace.go:171","msg":"trace[269053016] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:752; }","duration":"799.51618ms","start":"2026-01-30T09:31:01.576576Z","end":"2026-01-30T09:31:02.376092Z","steps":["trace[269053016] 'agreement among raft nodes before linearized reading'  (duration: 799.484089ms)"],"step_count":1}
{"level":"info","ts":"2026-01-30T09:31:02.376116Z","caller":"traceutil/trace.go:171","msg":"trace[792076389] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:752; }","duration":"778.191064ms","start":"2026-01-30T09:31:01.59792Z","end":"2026-01-30T09:31:02.376111Z","steps":["trace[792076389] 'agreement among raft nodes before linearized reading'  (duration: 778.159283ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:02.376119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:01.576571Z","time spent":"799.541631ms","remote":"127.0.0.1:33596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true "}
{"level":"warn","ts":"2026-01-30T09:31:02.376137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:01.597917Z","time spent":"778.213704ms","remote":"127.0.0.1:33622","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true "}
{"level":"warn","ts":"2026-01-30T09:31:02.376208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"799.788327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-30T09:31:02.376231Z","caller":"traceutil/trace.go:171","msg":"trace[1635359085] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:752; }","duration":"799.827227ms","start":"2026-01-30T09:31:01.576396Z","end":"2026-01-30T09:31:02.376223Z","steps":["trace[1635359085] 'agreement among raft nodes before linearized reading'  (duration: 799.794456ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:02.376235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"778.312636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-01-30T09:31:02.376251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:01.576383Z","time spent":"799.862278ms","remote":"127.0.0.1:33596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:10000 "}
{"level":"info","ts":"2026-01-30T09:31:02.376257Z","caller":"traceutil/trace.go:171","msg":"trace[2110111477] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:752; }","duration":"778.345307ms","start":"2026-01-30T09:31:01.597905Z","end":"2026-01-30T09:31:02.37625Z","steps":["trace[2110111477] 'agreement among raft nodes before linearized reading'  (duration: 778.310626ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:02.376282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:01.597901Z","time spent":"778.371957ms","remote":"127.0.0.1:33622","response type":"/etcdserverpb.KV/Range","request count":0,"request size":95,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:10000 "}
{"level":"warn","ts":"2026-01-30T09:31:02.376351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"891.431563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-30T09:31:02.376371Z","caller":"traceutil/trace.go:171","msg":"trace[1668015691] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:752; }","duration":"891.493795ms","start":"2026-01-30T09:31:01.484871Z","end":"2026-01-30T09:31:02.376365Z","steps":["trace[1668015691] 'agreement among raft nodes before linearized reading'  (duration: 891.460174ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:02.376388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:01.484852Z","time spent":"891.530895ms","remote":"127.0.0.1:53572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":29,"request content":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true "}
{"level":"info","ts":"2026-01-30T09:31:02.599772Z","caller":"traceutil/trace.go:171","msg":"trace[1584632992] transaction","detail":"{read_only:false; response_revision:754; number_of_response:1; }","duration":"213.287977ms","start":"2026-01-30T09:31:02.386456Z","end":"2026-01-30T09:31:02.599744Z","steps":["trace[1584632992] 'process raft request'  (duration: 133.252796ms)","trace[1584632992] 'compare'  (duration: 79.703033ms)"],"step_count":2}
{"level":"info","ts":"2026-01-30T09:31:16.280659Z","caller":"traceutil/trace.go:171","msg":"trace[2101619431] transaction","detail":"{read_only:false; response_revision:792; number_of_response:1; }","duration":"325.00987ms","start":"2026-01-30T09:31:15.955626Z","end":"2026-01-30T09:31:16.280636Z","steps":["trace[2101619431] 'process raft request'  (duration: 324.852676ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:16.280795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:15.95561Z","time spent":"325.113102ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:785 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-01-30T09:31:17.370629Z","caller":"traceutil/trace.go:171","msg":"trace[1931397770] linearizableReadLoop","detail":"{readStateIndex:825; appliedIndex:824; }","duration":"272.975364ms","start":"2026-01-30T09:31:17.097638Z","end":"2026-01-30T09:31:17.370614Z","steps":["trace[1931397770] 'read index received'  (duration: 272.839881ms)","trace[1931397770] 'applied index is now lower than readState.Index'  (duration: 134.943µs)"],"step_count":2}
{"level":"info","ts":"2026-01-30T09:31:17.370709Z","caller":"traceutil/trace.go:171","msg":"trace[327009317] transaction","detail":"{read_only:false; response_revision:796; number_of_response:1; }","duration":"458.03917ms","start":"2026-01-30T09:31:16.912664Z","end":"2026-01-30T09:31:17.370704Z","steps":["trace[327009317] 'process raft request'  (duration: 457.833695ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:17.370772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:16.912656Z","time spent":"458.071891ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:789 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-01-30T09:31:17.370851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.21117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-01-30T09:31:17.37087Z","caller":"traceutil/trace.go:171","msg":"trace[1176575044] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:796; }","duration":"273.258211ms","start":"2026-01-30T09:31:17.097606Z","end":"2026-01-30T09:31:17.370864Z","steps":["trace[1176575044] 'agreement among raft nodes before linearized reading'  (duration: 273.22347ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:17.370999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.570979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-30T09:31:17.371045Z","caller":"traceutil/trace.go:171","msg":"trace[858788322] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:796; }","duration":"252.644961ms","start":"2026-01-30T09:31:17.118389Z","end":"2026-01-30T09:31:17.371034Z","steps":["trace[858788322] 'agreement among raft nodes before linearized reading'  (duration: 252.567279ms)"],"step_count":1}
{"level":"info","ts":"2026-01-30T09:31:19.321385Z","caller":"traceutil/trace.go:171","msg":"trace[1562856701] linearizableReadLoop","detail":"{readStateIndex:829; appliedIndex:828; }","duration":"201.075786ms","start":"2026-01-30T09:31:19.120283Z","end":"2026-01-30T09:31:19.321358Z","steps":["trace[1562856701] 'read index received'  (duration: 200.855441ms)","trace[1562856701] 'applied index is now lower than readState.Index'  (duration: 219.315µs)"],"step_count":2}
{"level":"warn","ts":"2026-01-30T09:31:19.321611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.302291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-30T09:31:19.322592Z","caller":"traceutil/trace.go:171","msg":"trace[1742684110] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:800; }","duration":"202.327496ms","start":"2026-01-30T09:31:19.120249Z","end":"2026-01-30T09:31:19.322576Z","steps":["trace[1742684110] 'agreement among raft nodes before linearized reading'  (duration: 201.305962ms)"],"step_count":1}
{"level":"info","ts":"2026-01-30T09:31:19.321684Z","caller":"traceutil/trace.go:171","msg":"trace[318762243] transaction","detail":"{read_only:false; response_revision:800; number_of_response:1; }","duration":"661.458551ms","start":"2026-01-30T09:31:18.660201Z","end":"2026-01-30T09:31:19.321659Z","steps":["trace[318762243] 'process raft request'  (duration: 660.96715ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:19.322858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:18.660186Z","time spent":"662.585379ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:795 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-01-30T09:31:19.604744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.761518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-01-30T09:31:19.604813Z","caller":"traceutil/trace.go:171","msg":"trace[624175078] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:800; }","duration":"229.892221ms","start":"2026-01-30T09:31:19.374903Z","end":"2026-01-30T09:31:19.604795Z","steps":["trace[624175078] 'range keys from in-memory index tree'  (duration: 229.306076ms)"],"step_count":1}
{"level":"info","ts":"2026-01-30T09:31:19.729171Z","caller":"traceutil/trace.go:171","msg":"trace[510236516] transaction","detail":"{read_only:false; response_revision:801; number_of_response:1; }","duration":"117.993553ms","start":"2026-01-30T09:31:19.61116Z","end":"2026-01-30T09:31:19.729153Z","steps":["trace[510236516] 'process raft request'  (duration: 117.88829ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:20.210332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.041216ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594528836940031930 > lease_revoke:<id:664b9c0e3cc96748>","response":"size:29"}
{"level":"info","ts":"2026-01-30T09:31:20.775717Z","caller":"traceutil/trace.go:171","msg":"trace[573074609] transaction","detail":"{read_only:false; response_revision:804; number_of_response:1; }","duration":"218.410078ms","start":"2026-01-30T09:31:20.557276Z","end":"2026-01-30T09:31:20.775686Z","steps":["trace[573074609] 'process raft request'  (duration: 190.451084ms)","trace[573074609] 'compare'  (duration: 27.832911ms)"],"step_count":2}
{"level":"info","ts":"2026-01-30T09:31:21.912211Z","caller":"traceutil/trace.go:171","msg":"trace[1581487394] linearizableReadLoop","detail":"{readStateIndex:835; appliedIndex:834; }","duration":"170.198353ms","start":"2026-01-30T09:31:21.741997Z","end":"2026-01-30T09:31:21.912196Z","steps":["trace[1581487394] 'read index received'  (duration: 153.278981ms)","trace[1581487394] 'applied index is now lower than readState.Index'  (duration: 16.918792ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-30T09:31:21.912488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.472689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-01-30T09:31:21.912528Z","caller":"traceutil/trace.go:171","msg":"trace[2109392682] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:805; }","duration":"170.53015ms","start":"2026-01-30T09:31:21.741992Z","end":"2026-01-30T09:31:21.912522Z","steps":["trace[2109392682] 'agreement among raft nodes before linearized reading'  (duration: 170.329606ms)"],"step_count":1}
{"level":"info","ts":"2026-01-30T09:31:21.912661Z","caller":"traceutil/trace.go:171","msg":"trace[940154453] transaction","detail":"{read_only:false; response_revision:805; number_of_response:1; }","duration":"583.499249ms","start":"2026-01-30T09:31:21.329143Z","end":"2026-01-30T09:31:21.912643Z","steps":["trace[940154453] 'process raft request'  (duration: 566.2564ms)","trace[940154453] 'compare'  (duration: 16.723207ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-30T09:31:21.913409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:21.329126Z","time spent":"583.585841ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:800 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-01-30T09:31:22.748302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"649.722423ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594528836940031944 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:801 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-01-30T09:31:22.748393Z","caller":"traceutil/trace.go:171","msg":"trace[1566861464] linearizableReadLoop","detail":"{readStateIndex:836; appliedIndex:835; }","duration":"573.159325ms","start":"2026-01-30T09:31:22.175217Z","end":"2026-01-30T09:31:22.748377Z","steps":["trace[1566861464] 'read index received'  (duration: 54.661µs)","trace[1566861464] 'applied index is now lower than readState.Index'  (duration: 573.103544ms)"],"step_count":2}
{"level":"info","ts":"2026-01-30T09:31:22.748637Z","caller":"traceutil/trace.go:171","msg":"trace[210442241] transaction","detail":"{read_only:false; response_revision:806; number_of_response:1; }","duration":"833.176522ms","start":"2026-01-30T09:31:21.915442Z","end":"2026-01-30T09:31:22.748619Z","steps":["trace[210442241] 'process raft request'  (duration: 183.084169ms)","trace[210442241] 'compare'  (duration: 648.813932ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-30T09:31:22.748699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:21.915427Z","time spent":"833.239843ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:801 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-01-30T09:31:22.748916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"573.704757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-01-30T09:31:22.748947Z","caller":"traceutil/trace.go:171","msg":"trace[364938112] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:806; }","duration":"573.769739ms","start":"2026-01-30T09:31:22.175167Z","end":"2026-01-30T09:31:22.748937Z","steps":["trace[364938112] 'agreement among raft nodes before linearized reading'  (duration: 573.679347ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:22.748976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:22.175148Z","time spent":"573.821491ms","remote":"127.0.0.1:53526","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":104,"response size":31,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "}
{"level":"warn","ts":"2026-01-30T09:31:22.749127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"565.126674ms","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-01-30T09:31:22.749158Z","caller":"traceutil/trace.go:171","msg":"trace[1240624593] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:806; }","duration":"565.203866ms","start":"2026-01-30T09:31:22.183945Z","end":"2026-01-30T09:31:22.749149Z","steps":["trace[1240624593] 'agreement among raft nodes before linearized reading'  (duration: 565.157645ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:22.74919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:22.183922Z","time spent":"565.260467ms","remote":"127.0.0.1:53656","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":29,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "}
{"level":"warn","ts":"2026-01-30T09:31:22.752544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.782805ms","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-01-30T09:31:22.752582Z","caller":"traceutil/trace.go:171","msg":"trace[1051251679] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:806; }","duration":"167.857987ms","start":"2026-01-30T09:31:22.584713Z","end":"2026-01-30T09:31:22.752571Z","steps":["trace[1051251679] 'agreement among raft nodes before linearized reading'  (duration: 167.720254ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:22.753163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.581228ms","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-01-30T09:31:22.753198Z","caller":"traceutil/trace.go:171","msg":"trace[660212392] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:806; }","duration":"414.645429ms","start":"2026-01-30T09:31:22.338542Z","end":"2026-01-30T09:31:22.753188Z","steps":["trace[660212392] 'agreement among raft nodes before linearized reading'  (duration: 414.497615ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:22.753247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:22.338524Z","time spent":"414.716531ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-01-30T09:31:22.753516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"505.807395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-01-30T09:31:22.753552Z","caller":"traceutil/trace.go:171","msg":"trace[1034374149] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:806; }","duration":"505.878086ms","start":"2026-01-30T09:31:22.247662Z","end":"2026-01-30T09:31:22.75354Z","steps":["trace[1034374149] 'agreement among raft nodes before linearized reading'  (duration: 505.787724ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:22.75358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:22.247642Z","time spent":"505.931428ms","remote":"127.0.0.1:53746","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":66,"response size":31,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true "}
{"level":"warn","ts":"2026-01-30T09:31:23.635061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.799316ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594528836940031948 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:803 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-01-30T09:31:23.635212Z","caller":"traceutil/trace.go:171","msg":"trace[1829525439] transaction","detail":"{read_only:false; response_revision:809; number_of_response:1; }","duration":"609.23036ms","start":"2026-01-30T09:31:23.025968Z","end":"2026-01-30T09:31:23.635198Z","steps":["trace[1829525439] 'process raft request'  (duration: 609.190129ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:23.635275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:23.025939Z","time spent":"609.298171ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:783 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:471 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"info","ts":"2026-01-30T09:31:23.635556Z","caller":"traceutil/trace.go:171","msg":"trace[2112124354] transaction","detail":"{read_only:false; response_revision:808; number_of_response:1; }","duration":"873.807844ms","start":"2026-01-30T09:31:22.76174Z","end":"2026-01-30T09:31:23.635548Z","steps":["trace[2112124354] 'process raft request'  (duration: 710.459135ms)","trace[2112124354] 'compare'  (duration: 162.362796ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-30T09:31:23.635636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:22.761735Z","time spent":"873.848445ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:803 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-01-30T09:31:23.635729Z","caller":"traceutil/trace.go:171","msg":"trace[1087344790] linearizableReadLoop","detail":"{readStateIndex:838; appliedIndex:837; }","duration":"854.478415ms","start":"2026-01-30T09:31:22.781243Z","end":"2026-01-30T09:31:23.635721Z","steps":["trace[1087344790] 'read index received'  (duration: 28.857516ms)","trace[1087344790] 'applied index is now lower than readState.Index'  (duration: 825.620039ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-30T09:31:23.635928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"854.68665ms","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-01-30T09:31:23.635948Z","caller":"traceutil/trace.go:171","msg":"trace[610196258] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:809; }","duration":"854.743172ms","start":"2026-01-30T09:31:22.781198Z","end":"2026-01-30T09:31:23.635941Z","steps":["trace[610196258] 'agreement among raft nodes before linearized reading'  (duration: 854.649199ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:23.63597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:22.781184Z","time spent":"854.778953ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-01-30T09:31:23.636075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"708.053117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-01-30T09:31:23.636092Z","caller":"traceutil/trace.go:171","msg":"trace[1820654825] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:809; }","duration":"708.098078ms","start":"2026-01-30T09:31:22.927988Z","end":"2026-01-30T09:31:23.636086Z","steps":["trace[1820654825] 'agreement among raft nodes before linearized reading'  (duration: 708.061387ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:23.636109Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:22.927973Z","time spent":"708.131318ms","remote":"127.0.0.1:53730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":13,"response size":31,"request content":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true "}
{"level":"warn","ts":"2026-01-30T09:31:23.636287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"501.360308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-30T09:31:23.636308Z","caller":"traceutil/trace.go:171","msg":"trace[2009562911] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:809; }","duration":"501.403488ms","start":"2026-01-30T09:31:23.134899Z","end":"2026-01-30T09:31:23.636302Z","steps":["trace[2009562911] 'agreement among raft nodes before linearized reading'  (duration: 501.358457ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:23.63633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:23.134887Z","time spent":"501.43471ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":29,"request content":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true "}
{"level":"warn","ts":"2026-01-30T09:31:23.636429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"514.51496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-30T09:31:23.636464Z","caller":"traceutil/trace.go:171","msg":"trace[1631549619] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:809; }","duration":"514.576572ms","start":"2026-01-30T09:31:23.121873Z","end":"2026-01-30T09:31:23.63645Z","steps":["trace[1631549619] 'agreement among raft nodes before linearized reading'  (duration: 514.542141ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:23.636487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:23.121853Z","time spent":"514.630332ms","remote":"127.0.0.1:53456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-01-30T09:31:24.122862Z","caller":"traceutil/trace.go:171","msg":"trace[1882121221] linearizableReadLoop","detail":"{readStateIndex:840; appliedIndex:839; }","duration":"204.940887ms","start":"2026-01-30T09:31:23.917884Z","end":"2026-01-30T09:31:24.122825Z","steps":["trace[1882121221] 'read index received'  (duration: 203.824591ms)","trace[1882121221] 'applied index is now lower than readState.Index'  (duration: 1.114976ms)"],"step_count":2}
{"level":"info","ts":"2026-01-30T09:31:24.124611Z","caller":"traceutil/trace.go:171","msg":"trace[874659381] transaction","detail":"{read_only:false; response_revision:810; number_of_response:1; }","duration":"481.003355ms","start":"2026-01-30T09:31:23.64358Z","end":"2026-01-30T09:31:24.124584Z","steps":["trace[874659381] 'process raft request'  (duration: 478.184928ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:24.124765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:23.64357Z","time spent":"481.117128ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:804 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-01-30T09:31:24.137496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.613757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-01-30T09:31:24.137552Z","caller":"traceutil/trace.go:171","msg":"trace[1386755183] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:810; }","duration":"219.717499ms","start":"2026-01-30T09:31:23.917809Z","end":"2026-01-30T09:31:24.137527Z","steps":["trace[1386755183] 'agreement among raft nodes before linearized reading'  (duration: 205.363798ms)"],"step_count":1}
{"level":"info","ts":"2026-01-30T09:31:24.331153Z","caller":"traceutil/trace.go:171","msg":"trace[1875420786] linearizableReadLoop","detail":"{readStateIndex:841; appliedIndex:840; }","duration":"190.220088ms","start":"2026-01-30T09:31:24.140908Z","end":"2026-01-30T09:31:24.331128Z","steps":["trace[1875420786] 'read index received'  (duration: 154.292154ms)","trace[1875420786] 'applied index is now lower than readState.Index'  (duration: 35.926594ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-30T09:31:24.331933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.002597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-30T09:31:24.332019Z","caller":"traceutil/trace.go:171","msg":"trace[27549066] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:811; }","duration":"191.195951ms","start":"2026-01-30T09:31:24.140803Z","end":"2026-01-30T09:31:24.331999Z","steps":["trace[27549066] 'agreement among raft nodes before linearized reading'  (duration: 190.431943ms)"],"step_count":1}
{"level":"info","ts":"2026-01-30T09:31:24.332423Z","caller":"traceutil/trace.go:171","msg":"trace[1107631863] transaction","detail":"{read_only:false; response_revision:811; number_of_response:1; }","duration":"191.724984ms","start":"2026-01-30T09:31:24.140682Z","end":"2026-01-30T09:31:24.332407Z","steps":["trace[1107631863] 'process raft request'  (duration: 154.567001ms)","trace[1107631863] 'compare'  (duration: 35.579745ms)"],"step_count":2}
{"level":"info","ts":"2026-01-30T09:31:37.136266Z","caller":"traceutil/trace.go:171","msg":"trace[673311431] linearizableReadLoop","detail":"{readStateIndex:932; appliedIndex:931; }","duration":"437.521092ms","start":"2026-01-30T09:31:36.698726Z","end":"2026-01-30T09:31:37.136247Z","steps":["trace[673311431] 'read index received'  (duration: 437.311567ms)","trace[673311431] 'applied index is now lower than readState.Index'  (duration: 208.895µs)"],"step_count":2}
{"level":"info","ts":"2026-01-30T09:31:37.136548Z","caller":"traceutil/trace.go:171","msg":"trace[2135651008] transaction","detail":"{read_only:false; response_revision:897; number_of_response:1; }","duration":"661.872391ms","start":"2026-01-30T09:31:36.474669Z","end":"2026-01-30T09:31:37.136541Z","steps":["trace[2135651008] 'process raft request'  (duration: 661.43166ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:37.136653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:36.474645Z","time spent":"661.928512ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:881 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-01-30T09:31:37.136844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.109635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-01-30T09:31:37.136865Z","caller":"traceutil/trace.go:171","msg":"trace[838423584] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:897; }","duration":"438.184367ms","start":"2026-01-30T09:31:36.698674Z","end":"2026-01-30T09:31:37.136858Z","steps":["trace[838423584] 'agreement among raft nodes before linearized reading'  (duration: 438.101185ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:37.136881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:36.698651Z","time spent":"438.225659ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":7,"response size":31,"request content":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true "}
{"level":"warn","ts":"2026-01-30T09:31:37.137008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.313063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-01-30T09:31:37.137036Z","caller":"traceutil/trace.go:171","msg":"trace[1478435144] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:897; }","duration":"268.374504ms","start":"2026-01-30T09:31:36.868657Z","end":"2026-01-30T09:31:37.137032Z","steps":["trace[1478435144] 'agreement among raft nodes before linearized reading'  (duration: 268.282932ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:37.137238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.190962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-30T09:31:37.1373Z","caller":"traceutil/trace.go:171","msg":"trace[833669340] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:897; }","duration":"210.289024ms","start":"2026-01-30T09:31:36.927006Z","end":"2026-01-30T09:31:37.137295Z","steps":["trace[833669340] 'agreement among raft nodes before linearized reading'  (duration: 210.202902ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:37.13741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.692146ms","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-01-30T09:31:37.13743Z","caller":"traceutil/trace.go:171","msg":"trace[628774280] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:897; }","duration":"261.745637ms","start":"2026-01-30T09:31:36.875677Z","end":"2026-01-30T09:31:37.137423Z","steps":["trace[628774280] 'agreement among raft nodes before linearized reading'  (duration: 261.699276ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:40.72277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.605146727s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-30T09:31:40.722827Z","caller":"traceutil/trace.go:171","msg":"trace[1393746762] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:901; }","duration":"1.60525159s","start":"2026-01-30T09:31:39.117561Z","end":"2026-01-30T09:31:40.722813Z","steps":["trace[1393746762] 'range keys from in-memory index tree'  (duration: 1.605080966s)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:40.72289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:39.117537Z","time spent":"1.605312981s","remote":"127.0.0.1:53456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-01-30T09:31:40.723074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.581508676s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-01-30T09:31:40.723088Z","caller":"traceutil/trace.go:171","msg":"trace[8251247] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:901; }","duration":"1.581532416s","start":"2026-01-30T09:31:39.141551Z","end":"2026-01-30T09:31:40.723083Z","steps":["trace[8251247] 'range keys from in-memory index tree'  (duration: 1.581424564s)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:40.7231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:39.141545Z","time spent":"1.581552187s","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-01-30T09:31:40.723194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.570936914s","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-01-30T09:31:40.723206Z","caller":"traceutil/trace.go:171","msg":"trace[1597957223] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:901; }","duration":"1.570958135s","start":"2026-01-30T09:31:39.152244Z","end":"2026-01-30T09:31:40.723202Z","steps":["trace[1597957223] 'range keys from in-memory index tree'  (duration: 1.570890873s)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:40.723217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:39.152239Z","time spent":"1.570975355s","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-01-30T09:31:40.723944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.57031239s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-01-30T09:31:40.723965Z","caller":"traceutil/trace.go:171","msg":"trace[829581649] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:901; }","duration":"1.57033468s","start":"2026-01-30T09:31:39.153625Z","end":"2026-01-30T09:31:40.723959Z","steps":["trace[829581649] 'range keys from in-memory index tree'  (duration: 1.570269519s)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:40.723979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:39.153609Z","time spent":"1.570366191s","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-01-30T09:31:40.724191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.00153663s","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-01-30T09:31:40.724207Z","caller":"traceutil/trace.go:171","msg":"trace[943950598] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:901; }","duration":"1.001581011s","start":"2026-01-30T09:31:39.72262Z","end":"2026-01-30T09:31:40.724201Z","steps":["trace[943950598] 'range keys from in-memory index tree'  (duration: 1.001465928s)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:40.724231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:39.722602Z","time spent":"1.001615481s","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-01-30T09:31:40.736936Z","caller":"traceutil/trace.go:171","msg":"trace[1564914254] linearizableReadLoop","detail":"{readStateIndex:937; appliedIndex:936; }","duration":"431.51666ms","start":"2026-01-30T09:31:40.305372Z","end":"2026-01-30T09:31:40.736889Z","steps":["trace[1564914254] 'read index received'  (duration: 351.417608ms)","trace[1564914254] 'applied index is now lower than readState.Index'  (duration: 80.097632ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-30T09:31:40.737173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.787696ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-01-30T09:31:40.737237Z","caller":"traceutil/trace.go:171","msg":"trace[1493313678] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:901; }","duration":"431.896359ms","start":"2026-01-30T09:31:40.30531Z","end":"2026-01-30T09:31:40.737207Z","steps":["trace[1493313678] 'agreement among raft nodes before linearized reading'  (duration: 431.746765ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:40.737291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:40.305282Z","time spent":"432.000842ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-01-30T09:31:40.737736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.747475ms","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-01-30T09:31:40.741429Z","caller":"traceutil/trace.go:171","msg":"trace[1121097637] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:904; }","duration":"371.479054ms","start":"2026-01-30T09:31:40.369939Z","end":"2026-01-30T09:31:40.741418Z","steps":["trace[1121097637] 'agreement among raft nodes before linearized reading'  (duration: 367.768836ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:40.741873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:40.369914Z","time spent":"371.574126ms","remote":"127.0.0.1:53600","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":29,"request content":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true "}
{"level":"warn","ts":"2026-01-30T09:31:44.849003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.297981ms","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-01-30T09:31:44.849102Z","caller":"traceutil/trace.go:171","msg":"trace[1474378245] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:912; }","duration":"414.408804ms","start":"2026-01-30T09:31:44.434668Z","end":"2026-01-30T09:31:44.849077Z","steps":["trace[1474378245] 'count revisions from in-memory index tree'  (duration: 414.187069ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:44.849146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:44.434603Z","time spent":"414.532257ms","remote":"127.0.0.1:53824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":31,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "}
{"level":"warn","ts":"2026-01-30T09:31:44.851342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.32202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-30T09:31:44.853188Z","caller":"traceutil/trace.go:171","msg":"trace[1598590342] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:912; }","duration":"233.408762ms","start":"2026-01-30T09:31:44.61797Z","end":"2026-01-30T09:31:44.851379Z","steps":["trace[1598590342] 'count revisions from in-memory index tree'  (duration: 233.265059ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:45.47387Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16594528836940032196,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-01-30T09:31:45.532509Z","caller":"traceutil/trace.go:171","msg":"trace[1955907042] transaction","detail":"{read_only:false; response_revision:915; number_of_response:1; }","duration":"665.150021ms","start":"2026-01-30T09:31:44.867324Z","end":"2026-01-30T09:31:45.532474Z","steps":["trace[1955907042] 'process raft request'  (duration: 665.09697ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:45.532682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:44.867318Z","time spent":"665.272264ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:907 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-01-30T09:31:45.532825Z","caller":"traceutil/trace.go:171","msg":"trace[1425061364] transaction","detail":"{read_only:false; response_revision:916; number_of_response:1; }","duration":"665.442338ms","start":"2026-01-30T09:31:44.867359Z","end":"2026-01-30T09:31:45.532801Z","steps":["trace[1425061364] 'process raft request'  (duration: 665.090999ms)"],"step_count":1}
{"level":"info","ts":"2026-01-30T09:31:45.532915Z","caller":"traceutil/trace.go:171","msg":"trace[505969081] transaction","detail":"{read_only:false; response_revision:914; number_of_response:1; }","duration":"665.649142ms","start":"2026-01-30T09:31:44.867259Z","end":"2026-01-30T09:31:45.532908Z","steps":["trace[505969081] 'process raft request'  (duration: 664.979696ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:45.532947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:44.867251Z","time spent":"665.679453ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:910 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-01-30T09:31:45.532953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:44.867355Z","time spent":"665.521989ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:908 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-01-30T09:31:45.533128Z","caller":"traceutil/trace.go:171","msg":"trace[1062022726] transaction","detail":"{read_only:false; response_revision:917; number_of_response:1; }","duration":"662.455157ms","start":"2026-01-30T09:31:44.870667Z","end":"2026-01-30T09:31:45.533122Z","steps":["trace[1062022726] 'process raft request'  (duration: 662.062898ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:45.533155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:44.870656Z","time spent":"662.484438ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:909 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-01-30T09:31:45.633577Z","caller":"traceutil/trace.go:171","msg":"trace[227058800] linearizableReadLoop","detail":"{readStateIndex:954; appliedIndex:949; }","duration":"659.735354ms","start":"2026-01-30T09:31:44.97382Z","end":"2026-01-30T09:31:45.633556Z","steps":["trace[227058800] 'read index received'  (duration: 558.485571ms)","trace[227058800] 'applied index is now lower than readState.Index'  (duration: 101.249063ms)"],"step_count":2}
{"level":"info","ts":"2026-01-30T09:31:45.633682Z","caller":"traceutil/trace.go:171","msg":"trace[1783742406] transaction","detail":"{read_only:false; response_revision:918; number_of_response:1; }","duration":"246.980952ms","start":"2026-01-30T09:31:45.38669Z","end":"2026-01-30T09:31:45.633671Z","steps":["trace[1783742406] 'process raft request'  (duration: 213.927604ms)","trace[1783742406] 'compare'  (duration: 32.815983ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-30T09:31:45.63391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"660.057021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.52\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-01-30T09:31:45.633929Z","caller":"traceutil/trace.go:171","msg":"trace[1209021828] range","detail":"{range_begin:/registry/masterleases/162.253.55.52; range_end:; response_count:1; response_revision:918; }","duration":"660.143483ms","start":"2026-01-30T09:31:44.973781Z","end":"2026-01-30T09:31:45.633924Z","steps":["trace[1209021828] 'agreement among raft nodes before linearized reading'  (duration: 660.01528ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:45.633947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:44.973764Z","time spent":"660.177954ms","remote":"127.0.0.1:53472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/162.253.55.52\" "}
{"level":"warn","ts":"2026-01-30T09:31:45.634135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"515.544402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-30T09:31:45.634199Z","caller":"traceutil/trace.go:171","msg":"trace[923928213] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:918; }","duration":"515.653964ms","start":"2026-01-30T09:31:45.118528Z","end":"2026-01-30T09:31:45.634182Z","steps":["trace[923928213] 'agreement among raft nodes before linearized reading'  (duration: 515.552092ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:45.634212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.126748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-01-30T09:31:45.634232Z","caller":"traceutil/trace.go:171","msg":"trace[298625122] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:918; }","duration":"160.194459ms","start":"2026-01-30T09:31:45.474032Z","end":"2026-01-30T09:31:45.634226Z","steps":["trace[298625122] 'agreement among raft nodes before linearized reading'  (duration: 160.152458ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:45.634236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:45.118505Z","time spent":"515.720465ms","remote":"127.0.0.1:53456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-01-30T09:31:46.577172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"648.50565ms","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-01-30T09:31:46.57726Z","caller":"traceutil/trace.go:171","msg":"trace[1381484811] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:919; }","duration":"648.671174ms","start":"2026-01-30T09:31:45.92857Z","end":"2026-01-30T09:31:46.577241Z","steps":["trace[1381484811] 'count revisions from in-memory index tree'  (duration: 648.418768ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:46.577304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:45.928541Z","time spent":"648.754406ms","remote":"127.0.0.1:53880","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":3,"response size":31,"request content":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true "}
{"level":"warn","ts":"2026-01-30T09:31:46.577481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.20924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-01-30T09:31:46.57751Z","caller":"traceutil/trace.go:171","msg":"trace[1785124962] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:919; }","duration":"330.270801ms","start":"2026-01-30T09:31:46.247233Z","end":"2026-01-30T09:31:46.577504Z","steps":["trace[1785124962] 'count revisions from in-memory index tree'  (duration: 330.164329ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:46.577533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:46.247214Z","time spent":"330.313593ms","remote":"127.0.0.1:53548","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":15,"response size":31,"request content":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true "}
{"level":"info","ts":"2026-01-30T09:31:47.362287Z","caller":"traceutil/trace.go:171","msg":"trace[1002469796] linearizableReadLoop","detail":"{readStateIndex:957; appliedIndex:956; }","duration":"241.684616ms","start":"2026-01-30T09:31:47.120584Z","end":"2026-01-30T09:31:47.362269Z","steps":["trace[1002469796] 'read index received'  (duration: 241.471961ms)","trace[1002469796] 'applied index is now lower than readState.Index'  (duration: 211.795µs)"],"step_count":2}
{"level":"warn","ts":"2026-01-30T09:31:47.362452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.83505ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-30T09:31:47.362475Z","caller":"traceutil/trace.go:171","msg":"trace[1669308889] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:920; }","duration":"241.922152ms","start":"2026-01-30T09:31:47.120546Z","end":"2026-01-30T09:31:47.362469Z","steps":["trace[1669308889] 'agreement among raft nodes before linearized reading'  (duration: 241.82836ms)"],"step_count":1}
{"level":"info","ts":"2026-01-30T09:31:47.362731Z","caller":"traceutil/trace.go:171","msg":"trace[721395961] transaction","detail":"{read_only:false; response_revision:920; number_of_response:1; }","duration":"401.145629ms","start":"2026-01-30T09:31:46.961573Z","end":"2026-01-30T09:31:47.362719Z","steps":["trace[721395961] 'process raft request'  (duration: 400.552315ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:47.362796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:46.961556Z","time spent":"401.194591ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:913 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-01-30T09:31:48.179361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"642.806106ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-01-30T09:31:48.179426Z","caller":"traceutil/trace.go:171","msg":"trace[1794667395] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:920; }","duration":"642.918298ms","start":"2026-01-30T09:31:47.536493Z","end":"2026-01-30T09:31:48.179411Z","steps":["trace[1794667395] 'range keys from in-memory index tree'  (duration: 642.654132ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:48.179456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:47.536473Z","time spent":"642.97613ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-01-30T09:31:48.179614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"642.087649ms","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-01-30T09:31:48.179628Z","caller":"traceutil/trace.go:171","msg":"trace[693602558] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:920; }","duration":"642.108119ms","start":"2026-01-30T09:31:47.537515Z","end":"2026-01-30T09:31:48.179623Z","steps":["trace[693602558] 'range keys from in-memory index tree'  (duration: 642.051668ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:48.179641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:47.537513Z","time spent":"642.125359ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-01-30T09:31:48.179703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"642.185411ms","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-01-30T09:31:48.179753Z","caller":"traceutil/trace.go:171","msg":"trace[333335022] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:920; }","duration":"642.253893ms","start":"2026-01-30T09:31:47.537485Z","end":"2026-01-30T09:31:48.179739Z","steps":["trace[333335022] 'range keys from in-memory index tree'  (duration: 642.062218ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:48.179775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:47.53748Z","time spent":"642.289863ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-01-30T09:31:48.179852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"641.787702ms","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-01-30T09:31:48.17987Z","caller":"traceutil/trace.go:171","msg":"trace[1148284608] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:920; }","duration":"641.813542ms","start":"2026-01-30T09:31:47.538051Z","end":"2026-01-30T09:31:48.179865Z","steps":["trace[1148284608] 'range keys from in-memory index tree'  (duration: 641.743371ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:48.179887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:47.538046Z","time spent":"641.836783ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-01-30T09:31:52.572458Z","caller":"traceutil/trace.go:171","msg":"trace[1200597251] linearizableReadLoop","detail":"{readStateIndex:970; appliedIndex:968; }","duration":"232.185913ms","start":"2026-01-30T09:31:52.340252Z","end":"2026-01-30T09:31:52.572438Z","steps":["trace[1200597251] 'read index received'  (duration: 40.238147ms)","trace[1200597251] 'applied index is now lower than readState.Index'  (duration: 191.946986ms)"],"step_count":2}
{"level":"info","ts":"2026-01-30T09:31:52.572619Z","caller":"traceutil/trace.go:171","msg":"trace[702105708] transaction","detail":"{read_only:false; response_revision:932; number_of_response:1; }","duration":"280.4477ms","start":"2026-01-30T09:31:52.292164Z","end":"2026-01-30T09:31:52.572612Z","steps":["trace[702105708] 'process raft request'  (duration: 199.994517ms)","trace[702105708] 'compare'  (duration: 80.178617ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-30T09:31:52.57284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.570402ms","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-01-30T09:31:52.57286Z","caller":"traceutil/trace.go:171","msg":"trace[1838640304] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:932; }","duration":"232.644564ms","start":"2026-01-30T09:31:52.340209Z","end":"2026-01-30T09:31:52.572853Z","steps":["trace[1838640304] 'agreement among raft nodes before linearized reading'  (duration: 232.536981ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:52.572948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.084713ms","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-01-30T09:31:52.572964Z","caller":"traceutil/trace.go:171","msg":"trace[2019206773] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:932; }","duration":"224.109753ms","start":"2026-01-30T09:31:52.348849Z","end":"2026-01-30T09:31:52.572959Z","steps":["trace[2019206773] 'agreement among raft nodes before linearized reading'  (duration: 224.072103ms)"],"step_count":1}
{"level":"info","ts":"2026-01-30T09:31:52.753523Z","caller":"traceutil/trace.go:171","msg":"trace[219769785] transaction","detail":"{read_only:false; response_revision:934; number_of_response:1; }","duration":"172.608051ms","start":"2026-01-30T09:31:52.580892Z","end":"2026-01-30T09:31:52.7535Z","steps":["trace[219769785] 'process raft request'  (duration: 133.235695ms)","trace[219769785] 'compare'  (duration: 39.267704ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-30T09:31:53.892898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"717.083823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-01-30T09:31:53.892959Z","caller":"traceutil/trace.go:171","msg":"trace[332238992] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:934; }","duration":"717.197526ms","start":"2026-01-30T09:31:53.175747Z","end":"2026-01-30T09:31:53.892944Z","steps":["trace[332238992] 'count revisions from in-memory index tree'  (duration: 717.013182ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:53.893019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:53.175724Z","time spent":"717.287388ms","remote":"127.0.0.1:53850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":3,"response size":31,"request content":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true "}
{"level":"warn","ts":"2026-01-30T09:31:53.893165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"698.994458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-30T09:31:53.893182Z","caller":"traceutil/trace.go:171","msg":"trace[1340986233] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:934; }","duration":"699.033609ms","start":"2026-01-30T09:31:53.194144Z","end":"2026-01-30T09:31:53.893178Z","steps":["trace[1340986233] 'range keys from in-memory index tree'  (duration: 698.959367ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:53.893195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:53.194131Z","time spent":"699.060939ms","remote":"127.0.0.1:53456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-01-30T09:31:53.893494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"461.345326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-01-30T09:31:53.893509Z","caller":"traceutil/trace.go:171","msg":"trace[2026335191] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:934; }","duration":"461.394047ms","start":"2026-01-30T09:31:53.43211Z","end":"2026-01-30T09:31:53.893504Z","steps":["trace[2026335191] 'range keys from in-memory index tree'  (duration: 461.212303ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:53.893522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:53.432089Z","time spent":"461.429708ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-01-30T09:31:54.81437Z","caller":"traceutil/trace.go:171","msg":"trace[1925030838] transaction","detail":"{read_only:false; response_revision:935; number_of_response:1; }","duration":"913.214519ms","start":"2026-01-30T09:31:53.901132Z","end":"2026-01-30T09:31:54.814347Z","steps":["trace[1925030838] 'process raft request'  (duration: 913.040975ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:54.814529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:53.901106Z","time spent":"913.330001ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:930 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-01-30T09:31:54.814935Z","caller":"traceutil/trace.go:171","msg":"trace[598845627] linearizableReadLoop","detail":"{readStateIndex:973; appliedIndex:973; }","duration":"430.872018ms","start":"2026-01-30T09:31:54.384055Z","end":"2026-01-30T09:31:54.814927Z","steps":["trace[598845627] 'read index received'  (duration: 430.869048ms)","trace[598845627] 'applied index is now lower than readState.Index'  (duration: 2.34µs)"],"step_count":2}
{"level":"warn","ts":"2026-01-30T09:31:54.815076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.017152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-01-30T09:31:54.815099Z","caller":"traceutil/trace.go:171","msg":"trace[1833476461] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:935; }","duration":"431.072393ms","start":"2026-01-30T09:31:54.38402Z","end":"2026-01-30T09:31:54.815092Z","steps":["trace[1833476461] 'agreement among raft nodes before linearized reading'  (duration: 430.95335ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:54.81512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:54.384Z","time spent":"431.115364ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-01-30T09:31:54.817504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.909768ms","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-01-30T09:31:54.817578Z","caller":"traceutil/trace.go:171","msg":"trace[1970757671] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:936; }","duration":"238.041091ms","start":"2026-01-30T09:31:54.579517Z","end":"2026-01-30T09:31:54.817558Z","steps":["trace[1970757671] 'agreement among raft nodes before linearized reading'  (duration: 237.828566ms)"],"step_count":1}
{"level":"info","ts":"2026-01-30T09:31:54.817679Z","caller":"traceutil/trace.go:171","msg":"trace[1220058496] transaction","detail":"{read_only:false; response_revision:936; number_of_response:1; }","duration":"318.611097ms","start":"2026-01-30T09:31:54.499052Z","end":"2026-01-30T09:31:54.817663Z","steps":["trace[1220058496] 'process raft request'  (duration: 318.105805ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:54.817735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:54.499026Z","time spent":"318.678049ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:912 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-01-30T09:31:54.817951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.150899ms","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-01-30T09:31:54.817985Z","caller":"traceutil/trace.go:171","msg":"trace[1322899393] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:936; }","duration":"149.18187ms","start":"2026-01-30T09:31:54.668792Z","end":"2026-01-30T09:31:54.817974Z","steps":["trace[1322899393] 'agreement among raft nodes before linearized reading'  (duration: 149.105938ms)"],"step_count":1}
{"level":"info","ts":"2026-01-30T09:31:56.315324Z","caller":"traceutil/trace.go:171","msg":"trace[1193706774] linearizableReadLoop","detail":"{readStateIndex:981; appliedIndex:980; }","duration":"361.300292ms","start":"2026-01-30T09:31:55.954002Z","end":"2026-01-30T09:31:56.315302Z","steps":["trace[1193706774] 'read index received'  (duration: 361.071227ms)","trace[1193706774] 'applied index is now lower than readState.Index'  (duration: 228.245µs)"],"step_count":2}
{"level":"warn","ts":"2026-01-30T09:31:56.315859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.820414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-01-30T09:31:56.315918Z","caller":"traceutil/trace.go:171","msg":"trace[541929297] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:942; }","duration":"361.955577ms","start":"2026-01-30T09:31:55.953939Z","end":"2026-01-30T09:31:56.315894Z","steps":["trace[541929297] 'agreement among raft nodes before linearized reading'  (duration: 361.535297ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:56.315956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:55.953905Z","time spent":"362.042839ms","remote":"127.0.0.1:53544","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":6,"response size":31,"request content":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true "}
{"level":"info","ts":"2026-01-30T09:31:56.316573Z","caller":"traceutil/trace.go:171","msg":"trace[2040458423] transaction","detail":"{read_only:false; response_revision:942; number_of_response:1; }","duration":"476.42267ms","start":"2026-01-30T09:31:55.84014Z","end":"2026-01-30T09:31:56.316563Z","steps":["trace[2040458423] 'process raft request'  (duration: 475.025098ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:56.316667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:55.840108Z","time spent":"476.499753ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:918 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-01-30T09:31:56.320385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.89754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-30T09:31:56.320437Z","caller":"traceutil/trace.go:171","msg":"trace[769208233] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:942; }","duration":"198.985682ms","start":"2026-01-30T09:31:56.121441Z","end":"2026-01-30T09:31:56.320427Z","steps":["trace[769208233] 'agreement among raft nodes before linearized reading'  (duration: 198.917871ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:57.137602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.885417ms","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-01-30T09:31:57.137757Z","caller":"traceutil/trace.go:171","msg":"trace[633705099] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:942; }","duration":"303.068242ms","start":"2026-01-30T09:31:56.834663Z","end":"2026-01-30T09:31:57.137731Z","steps":["trace[633705099] 'range keys from in-memory index tree'  (duration: 302.723863ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:57.137744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.406303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"warn","ts":"2026-01-30T09:31:57.137806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:56.834652Z","time spent":"303.143003ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-01-30T09:31:57.137837Z","caller":"traceutil/trace.go:171","msg":"trace[399877154] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:942; }","duration":"290.567627ms","start":"2026-01-30T09:31:56.847244Z","end":"2026-01-30T09:31:57.137812Z","steps":["trace[399877154] 'range keys from in-memory index tree'  (duration: 290.193049ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:57.138048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.609842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-01-30T09:31:57.138079Z","caller":"traceutil/trace.go:171","msg":"trace[1073039461] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:942; }","duration":"308.691404ms","start":"2026-01-30T09:31:56.829378Z","end":"2026-01-30T09:31:57.138069Z","steps":["trace[1073039461] 'range keys from in-memory index tree'  (duration: 308.492559ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:57.138108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:56.82935Z","time spent":"308.750904ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-01-30T09:31:57.138177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.967129ms","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-01-30T09:31:57.138209Z","caller":"traceutil/trace.go:171","msg":"trace[1322177465] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:942; }","duration":"303.01597ms","start":"2026-01-30T09:31:56.835182Z","end":"2026-01-30T09:31:57.138198Z","steps":["trace[1322177465] 'range keys from in-memory index tree'  (duration: 302.882587ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:57.13824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:56.835173Z","time spent":"303.05763ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-01-30T09:31:57.138389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.097708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-01-30T09:31:57.138415Z","caller":"traceutil/trace.go:171","msg":"trace[2037078930] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:942; }","duration":"299.16661ms","start":"2026-01-30T09:31:56.839238Z","end":"2026-01-30T09:31:57.138405Z","steps":["trace[2037078930] 'range keys from in-memory index tree'  (duration: 298.933894ms)"],"step_count":1}
{"level":"info","ts":"2026-01-30T09:31:57.405568Z","caller":"traceutil/trace.go:171","msg":"trace[1717743497] transaction","detail":"{read_only:false; response_revision:943; number_of_response:1; }","duration":"259.661201ms","start":"2026-01-30T09:31:57.145885Z","end":"2026-01-30T09:31:57.405547Z","steps":["trace[1717743497] 'process raft request'  (duration: 259.361214ms)"],"step_count":1}
{"level":"info","ts":"2026-01-30T09:31:57.665645Z","caller":"traceutil/trace.go:171","msg":"trace[768995532] linearizableReadLoop","detail":"{readStateIndex:986; appliedIndex:982; }","duration":"320.887391ms","start":"2026-01-30T09:31:57.344712Z","end":"2026-01-30T09:31:57.6656Z","steps":["trace[768995532] 'read index received'  (duration: 61.478478ms)","trace[768995532] 'applied index is now lower than readState.Index'  (duration: 259.407883ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-30T09:31:57.66583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.098777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-01-30T09:31:57.665865Z","caller":"traceutil/trace.go:171","msg":"trace[1846095099] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:947; }","duration":"321.27649ms","start":"2026-01-30T09:31:57.344579Z","end":"2026-01-30T09:31:57.665855Z","steps":["trace[1846095099] 'agreement among raft nodes before linearized reading'  (duration: 321.136157ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:57.665902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:57.344554Z","time spent":"321.338422ms","remote":"127.0.0.1:53804","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":31,"request content":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true "}
{"level":"info","ts":"2026-01-30T09:31:57.666274Z","caller":"traceutil/trace.go:171","msg":"trace[639421523] transaction","detail":"{read_only:false; response_revision:945; number_of_response:1; }","duration":"518.098662ms","start":"2026-01-30T09:31:57.148158Z","end":"2026-01-30T09:31:57.666257Z","steps":["trace[639421523] 'process raft request'  (duration: 517.314143ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:57.666366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:57.148148Z","time spent":"518.157373ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:938 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-01-30T09:31:57.666655Z","caller":"traceutil/trace.go:171","msg":"trace[1488498156] transaction","detail":"{read_only:false; response_revision:944; number_of_response:1; }","duration":"519.464974ms","start":"2026-01-30T09:31:57.14718Z","end":"2026-01-30T09:31:57.666645Z","steps":["trace[1488498156] 'process raft request'  (duration: 518.145883ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:57.666711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:57.147172Z","time spent":"519.508775ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:937 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-01-30T09:31:57.667256Z","caller":"traceutil/trace.go:171","msg":"trace[922281049] transaction","detail":"{read_only:false; response_revision:946; number_of_response:1; }","duration":"517.935208ms","start":"2026-01-30T09:31:57.14931Z","end":"2026-01-30T09:31:57.667245Z","steps":["trace[922281049] 'process raft request'  (duration: 516.219108ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:57.667319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:57.149301Z","time spent":"517.982739ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:935 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-01-30T09:31:57.667558Z","caller":"traceutil/trace.go:171","msg":"trace[321466935] transaction","detail":"{read_only:false; response_revision:947; number_of_response:1; }","duration":"516.989125ms","start":"2026-01-30T09:31:57.150559Z","end":"2026-01-30T09:31:57.667548Z","steps":["trace[321466935] 'process raft request'  (duration: 515.007118ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:31:57.667613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:57.15055Z","time spent":"517.033157ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:940 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-01-30T09:32:00.496048Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16594528836940032304,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-01-30T09:32:00.732363Z","caller":"traceutil/trace.go:171","msg":"trace[1162552590] transaction","detail":"{read_only:false; response_revision:949; number_of_response:1; }","duration":"964.31824ms","start":"2026-01-30T09:31:59.76801Z","end":"2026-01-30T09:32:00.732328Z","steps":["trace[1162552590] 'process raft request'  (duration: 964.135316ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:32:00.732588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:59.76799Z","time spent":"964.484204ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:944 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-01-30T09:32:00.842125Z","caller":"traceutil/trace.go:171","msg":"trace[1729986034] linearizableReadLoop","detail":"{readStateIndex:991; appliedIndex:988; }","duration":"849.581721ms","start":"2026-01-30T09:31:59.992518Z","end":"2026-01-30T09:32:00.8421Z","steps":["trace[1729986034] 'read index received'  (duration: 740.498494ms)","trace[1729986034] 'applied index is now lower than readState.Index'  (duration: 109.082597ms)"],"step_count":2}
{"level":"info","ts":"2026-01-30T09:32:00.842419Z","caller":"traceutil/trace.go:171","msg":"trace[1670878495] transaction","detail":"{read_only:false; response_revision:950; number_of_response:1; }","duration":"1.073851728s","start":"2026-01-30T09:31:59.76856Z","end":"2026-01-30T09:32:00.842412Z","steps":["trace[1670878495] 'process raft request'  (duration: 1.052526417s)","trace[1670878495] 'compare'  (duration: 20.82951ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-30T09:32:00.842507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:59.768547Z","time spent":"1.073890509s","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:945 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-01-30T09:32:00.842637Z","caller":"traceutil/trace.go:171","msg":"trace[1426980054] transaction","detail":"{read_only:false; response_revision:951; number_of_response:1; }","duration":"1.073362477s","start":"2026-01-30T09:31:59.769267Z","end":"2026-01-30T09:32:00.84263Z","steps":["trace[1426980054] 'process raft request'  (duration: 1.072780973s)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:32:00.842665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:59.769259Z","time spent":"1.073388687s","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:947 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-01-30T09:32:00.842731Z","caller":"traceutil/trace.go:171","msg":"trace[245029957] transaction","detail":"{read_only:false; response_revision:952; number_of_response:1; }","duration":"1.070627372s","start":"2026-01-30T09:31:59.772097Z","end":"2026-01-30T09:32:00.842724Z","steps":["trace[245029957] 'process raft request'  (duration: 1.069973176s)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:32:00.842755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:59.772082Z","time spent":"1.070659223s","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:946 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-01-30T09:32:00.84284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"850.320358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-30T09:32:00.84286Z","caller":"traceutil/trace.go:171","msg":"trace[1374347684] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:952; }","duration":"850.38267ms","start":"2026-01-30T09:31:59.99247Z","end":"2026-01-30T09:32:00.842853Z","steps":["trace[1374347684] 'agreement among raft nodes before linearized reading'  (duration: 850.346359ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:32:00.842878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:31:59.992442Z","time spent":"850.431391ms","remote":"127.0.0.1:53896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":29,"request content":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true "}
{"level":"warn","ts":"2026-01-30T09:32:00.842974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"685.302396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-30T09:32:00.842986Z","caller":"traceutil/trace.go:171","msg":"trace[1389019640] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:952; }","duration":"685.359187ms","start":"2026-01-30T09:32:00.157623Z","end":"2026-01-30T09:32:00.842982Z","steps":["trace[1389019640] 'agreement among raft nodes before linearized reading'  (duration: 685.338826ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:32:00.842997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:32:00.157601Z","time spent":"685.393727ms","remote":"127.0.0.1:53464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-01-30T09:32:00.843195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.908887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-30T09:32:00.84321Z","caller":"traceutil/trace.go:171","msg":"trace[583659346] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:952; }","duration":"178.03199ms","start":"2026-01-30T09:32:00.665173Z","end":"2026-01-30T09:32:00.843205Z","steps":["trace[583659346] 'agreement among raft nodes before linearized reading'  (duration: 177.973149ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:32:01.620763Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16594528836940032310,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-01-30T09:32:01.841492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.287524ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594528836940032311 > lease_revoke:<id:664b9c0e3cc968cd>","response":"size:29"}
{"level":"info","ts":"2026-01-30T09:32:01.841602Z","caller":"traceutil/trace.go:171","msg":"trace[1077947356] linearizableReadLoop","detail":"{readStateIndex:992; appliedIndex:991; }","duration":"721.558438ms","start":"2026-01-30T09:32:01.120025Z","end":"2026-01-30T09:32:01.841584Z","steps":["trace[1077947356] 'read index received'  (duration: 549.10093ms)","trace[1077947356] 'applied index is now lower than readState.Index'  (duration: 172.456098ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-30T09:32:01.841871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"721.833655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-30T09:32:01.841896Z","caller":"traceutil/trace.go:171","msg":"trace[1155582048] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:952; }","duration":"721.906527ms","start":"2026-01-30T09:32:01.119981Z","end":"2026-01-30T09:32:01.841888Z","steps":["trace[1155582048] 'agreement among raft nodes before linearized reading'  (duration: 721.841066ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:32:01.841922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:32:01.119958Z","time spent":"721.958178ms","remote":"127.0.0.1:53456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-01-30T09:32:01.84218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.046162ms","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-01-30T09:32:01.842203Z","caller":"traceutil/trace.go:171","msg":"trace[1963166344] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:952; }","duration":"363.100463ms","start":"2026-01-30T09:32:01.479093Z","end":"2026-01-30T09:32:01.842194Z","steps":["trace[1963166344] 'agreement among raft nodes before linearized reading'  (duration: 362.988421ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:32:01.842223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:32:01.479072Z","time spent":"363.146445ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-01-30T09:32:01.842398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.296494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-01-30T09:32:01.842421Z","caller":"traceutil/trace.go:171","msg":"trace[597017500] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:952; }","duration":"308.355285ms","start":"2026-01-30T09:32:01.534057Z","end":"2026-01-30T09:32:01.842412Z","steps":["trace[597017500] 'agreement among raft nodes before linearized reading'  (duration: 308.315804ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:32:01.84244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:32:01.534035Z","time spent":"308.399957ms","remote":"127.0.0.1:41548","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":31,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true "}
{"level":"warn","ts":"2026-01-30T09:32:02.86788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"846.273733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-30T09:32:02.868794Z","caller":"traceutil/trace.go:171","msg":"trace[87017686] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:953; }","duration":"847.245386ms","start":"2026-01-30T09:32:02.021528Z","end":"2026-01-30T09:32:02.868774Z","steps":["trace[87017686] 'count revisions from in-memory index tree'  (duration: 846.188481ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:32:02.868896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:32:02.021505Z","time spent":"847.375898ms","remote":"127.0.0.1:53666","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":29,"request content":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true "}
{"level":"warn","ts":"2026-01-30T09:32:02.87114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.62259ms","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-01-30T09:32:02.871517Z","caller":"traceutil/trace.go:171","msg":"trace[372796082] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:953; }","duration":"249.03386ms","start":"2026-01-30T09:32:02.622474Z","end":"2026-01-30T09:32:02.871508Z","steps":["trace[372796082] 'count revisions from in-memory index tree'  (duration: 248.570439ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:32:02.8722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.60962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-01-30T09:32:02.872482Z","caller":"traceutil/trace.go:171","msg":"trace[1758451487] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:953; }","duration":"180.816785ms","start":"2026-01-30T09:32:02.691557Z","end":"2026-01-30T09:32:02.872373Z","steps":["trace[1758451487] 'count revisions from in-memory index tree'  (duration: 180.567829ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:32:02.872919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.265929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-01-30T09:32:02.873045Z","caller":"traceutil/trace.go:171","msg":"trace[1926060136] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:953; }","duration":"117.416733ms","start":"2026-01-30T09:32:02.7556Z","end":"2026-01-30T09:32:02.873017Z","steps":["trace[1926060136] 'range keys from in-memory index tree'  (duration: 117.111766ms)"],"step_count":1}
{"level":"info","ts":"2026-01-30T09:32:02.991428Z","caller":"traceutil/trace.go:171","msg":"trace[1294860468] transaction","detail":"{read_only:false; response_revision:954; number_of_response:1; }","duration":"110.806956ms","start":"2026-01-30T09:32:02.880595Z","end":"2026-01-30T09:32:02.991402Z","steps":["trace[1294860468] 'process raft request'  (duration: 110.579831ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:32:03.788485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.584226ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594528836940032326 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:952 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-01-30T09:32:03.788713Z","caller":"traceutil/trace.go:171","msg":"trace[1130749586] linearizableReadLoop","detail":"{readStateIndex:997; appliedIndex:994; }","duration":"667.27392ms","start":"2026-01-30T09:32:03.121418Z","end":"2026-01-30T09:32:03.788692Z","steps":["trace[1130749586] 'read index received'  (duration: 368.285996ms)","trace[1130749586] 'applied index is now lower than readState.Index'  (duration: 298.986754ms)"],"step_count":2}
{"level":"info","ts":"2026-01-30T09:32:03.788981Z","caller":"traceutil/trace.go:171","msg":"trace[1947811605] transaction","detail":"{read_only:false; response_revision:955; number_of_response:1; }","duration":"906.594711ms","start":"2026-01-30T09:32:02.882373Z","end":"2026-01-30T09:32:03.788968Z","steps":["trace[1947811605] 'process raft request'  (duration: 607.419532ms)","trace[1947811605] 'compare'  (duration: 298.424441ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-30T09:32:03.789052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:32:02.882365Z","time spent":"906.650812ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:952 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-01-30T09:32:03.79013Z","caller":"traceutil/trace.go:171","msg":"trace[1174067768] transaction","detail":"{read_only:false; response_revision:956; number_of_response:1; }","duration":"823.337913ms","start":"2026-01-30T09:32:02.966776Z","end":"2026-01-30T09:32:03.790114Z","steps":["trace[1174067768] 'process raft request'  (duration: 821.827977ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:32:03.790224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:32:02.966752Z","time spent":"823.426765ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:951 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-01-30T09:32:03.79031Z","caller":"traceutil/trace.go:171","msg":"trace[63766151] transaction","detail":"{read_only:false; response_revision:957; number_of_response:1; }","duration":"823.524007ms","start":"2026-01-30T09:32:02.966776Z","end":"2026-01-30T09:32:03.7903Z","steps":["trace[63766151] 'process raft request'  (duration: 821.874218ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:32:03.790356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:32:02.966752Z","time spent":"823.576329ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:950 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-01-30T09:32:03.790446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"669.027163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-30T09:32:03.790538Z","caller":"traceutil/trace.go:171","msg":"trace[50909275] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:957; }","duration":"669.092654ms","start":"2026-01-30T09:32:03.121369Z","end":"2026-01-30T09:32:03.790462Z","steps":["trace[50909275] 'agreement among raft nodes before linearized reading'  (duration: 669.045143ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:32:03.79078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:32:03.121345Z","time spent":"669.422421ms","remote":"127.0.0.1:53456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-01-30T09:32:03.791048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"591.675162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-01-30T09:32:03.791141Z","caller":"traceutil/trace.go:171","msg":"trace[1967716124] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:957; }","duration":"591.814366ms","start":"2026-01-30T09:32:03.199304Z","end":"2026-01-30T09:32:03.791118Z","steps":["trace[1967716124] 'agreement among raft nodes before linearized reading'  (duration: 591.56902ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:32:03.791187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:32:03.199289Z","time spent":"591.887357ms","remote":"127.0.0.1:53640","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":42,"response size":31,"request content":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true "}
{"level":"warn","ts":"2026-01-30T09:32:07.065181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.743309ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594528836940032378 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/endpointslices/kube-system/ceph-csi-rbd-nodeplugin-http-metrics-h4d5c\" mod_revision:884 > success:<request_put:<key:\"/registry/endpointslices/kube-system/ceph-csi-rbd-nodeplugin-http-metrics-h4d5c\" value_size:1420 >> failure:<request_range:<key:\"/registry/endpointslices/kube-system/ceph-csi-rbd-nodeplugin-http-metrics-h4d5c\" > >>","response":"size:16"}
{"level":"info","ts":"2026-01-30T09:32:07.065321Z","caller":"traceutil/trace.go:171","msg":"trace[302508000] transaction","detail":"{read_only:false; response_revision:983; number_of_response:1; }","duration":"459.677526ms","start":"2026-01-30T09:32:06.605622Z","end":"2026-01-30T09:32:07.065299Z","steps":["trace[302508000] 'process raft request'  (duration: 197.719792ms)","trace[302508000] 'compare'  (duration: 261.591505ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-30T09:32:07.06537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:32:06.605561Z","time spent":"459.787889ms","remote":"127.0.0.1:53694","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1507,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/endpointslices/kube-system/ceph-csi-rbd-nodeplugin-http-metrics-h4d5c\" mod_revision:884 > success:<request_put:<key:\"/registry/endpointslices/kube-system/ceph-csi-rbd-nodeplugin-http-metrics-h4d5c\" value_size:1420 >> failure:<request_range:<key:\"/registry/endpointslices/kube-system/ceph-csi-rbd-nodeplugin-http-metrics-h4d5c\" > >"}
{"level":"info","ts":"2026-01-30T09:32:07.069412Z","caller":"traceutil/trace.go:171","msg":"trace[1294024913] transaction","detail":"{read_only:false; response_revision:984; number_of_response:1; }","duration":"454.789431ms","start":"2026-01-30T09:32:06.614607Z","end":"2026-01-30T09:32:07.069396Z","steps":["trace[1294024913] 'process raft request'  (duration: 454.238858ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:32:07.069577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:32:06.614587Z","time spent":"454.931734ms","remote":"127.0.0.1:53614","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":914,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/services/endpoints/kube-system/ceph-csi-rbd-nodeplugin-http-metrics\" mod_revision:883 > success:<request_put:<key:\"/registry/services/endpoints/kube-system/ceph-csi-rbd-nodeplugin-http-metrics\" value_size:829 >> failure:<request_range:<key:\"/registry/services/endpoints/kube-system/ceph-csi-rbd-nodeplugin-http-metrics\" > >"}
{"level":"info","ts":"2026-01-30T09:32:07.070533Z","caller":"traceutil/trace.go:171","msg":"trace[1479669012] transaction","detail":"{read_only:false; response_revision:985; number_of_response:1; }","duration":"455.855576ms","start":"2026-01-30T09:32:06.614671Z","end":"2026-01-30T09:32:07.070526Z","steps":["trace[1479669012] 'process raft request'  (duration: 454.292689ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:32:07.071299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:32:06.614667Z","time spent":"456.600824ms","remote":"127.0.0.1:53870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9309,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/daemonsets/kube-system/ceph-csi-rbd-nodeplugin\" mod_revision:873 > success:<request_put:<key:\"/registry/daemonsets/kube-system/ceph-csi-rbd-nodeplugin\" value_size:9245 >> failure:<request_range:<key:\"/registry/daemonsets/kube-system/ceph-csi-rbd-nodeplugin\" > >"}
{"level":"info","ts":"2026-01-30T09:32:07.071602Z","caller":"traceutil/trace.go:171","msg":"trace[978212485] transaction","detail":"{read_only:false; response_revision:986; number_of_response:1; }","duration":"426.24677ms","start":"2026-01-30T09:32:06.645345Z","end":"2026-01-30T09:32:07.071592Z","steps":["trace[978212485] 'process raft request'  (duration: 423.654409ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:32:07.075188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:32:06.645311Z","time spent":"429.821764ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:942 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"info","ts":"2026-01-30T09:32:12.173725Z","caller":"traceutil/trace.go:171","msg":"trace[1798693465] transaction","detail":"{read_only:false; response_revision:1013; number_of_response:1; }","duration":"233.206517ms","start":"2026-01-30T09:32:11.940488Z","end":"2026-01-30T09:32:12.173695Z","steps":["trace[1798693465] 'process raft request'  (duration: 217.271312ms)","trace[1798693465] 'compare'  (duration: 14.478121ms)"],"step_count":2}
{"level":"info","ts":"2026-01-30T09:32:12.17405Z","caller":"traceutil/trace.go:171","msg":"trace[914097139] linearizableReadLoop","detail":"{readStateIndex:1056; appliedIndex:1054; }","duration":"209.646783ms","start":"2026-01-30T09:32:11.964394Z","end":"2026-01-30T09:32:12.174041Z","steps":["trace[914097139] 'read index received'  (duration: 193.609726ms)","trace[914097139] 'applied index is now lower than readState.Index'  (duration: 16.036597ms)"],"step_count":2}
{"level":"info","ts":"2026-01-30T09:32:12.1741Z","caller":"traceutil/trace.go:171","msg":"trace[2133044729] transaction","detail":"{read_only:false; response_revision:1014; number_of_response:1; }","duration":"230.130995ms","start":"2026-01-30T09:32:11.943964Z","end":"2026-01-30T09:32:12.174095Z","steps":["trace[2133044729] 'process raft request'  (duration: 229.693185ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:32:12.174318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.906939ms","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-01-30T09:32:12.17434Z","caller":"traceutil/trace.go:171","msg":"trace[698147566] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1014; }","duration":"209.985661ms","start":"2026-01-30T09:32:11.964348Z","end":"2026-01-30T09:32:12.174334Z","steps":["trace[698147566] 'agreement among raft nodes before linearized reading'  (duration: 209.872178ms)"],"step_count":1}
{"level":"info","ts":"2026-01-30T09:32:15.675916Z","caller":"traceutil/trace.go:171","msg":"trace[1337425528] transaction","detail":"{read_only:false; response_revision:1032; number_of_response:1; }","duration":"200.362355ms","start":"2026-01-30T09:32:15.475534Z","end":"2026-01-30T09:32:15.675896Z","steps":["trace[1337425528] 'process raft request'  (duration: 200.223182ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:32:21.112958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"761.784714ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594528836940032543 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:1062 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-01-30T09:32:21.113116Z","caller":"traceutil/trace.go:171","msg":"trace[1792014412] linearizableReadLoop","detail":"{readStateIndex:1113; appliedIndex:1111; }","duration":"475.177511ms","start":"2026-01-30T09:32:20.637926Z","end":"2026-01-30T09:32:21.113103Z","steps":["trace[1792014412] 'read index received'  (duration: 474.047994ms)","trace[1792014412] 'applied index is now lower than readState.Index'  (duration: 1.128567ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-30T09:32:21.113499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"475.5752ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:533"}
{"level":"info","ts":"2026-01-30T09:32:21.113526Z","caller":"traceutil/trace.go:171","msg":"trace[1813887481] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1069; }","duration":"475.648112ms","start":"2026-01-30T09:32:20.637871Z","end":"2026-01-30T09:32:21.113519Z","steps":["trace[1813887481] 'agreement among raft nodes before linearized reading'  (duration: 475.537209ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:32:21.113552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:32:20.637845Z","time spent":"475.701482ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":557,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "}
{"level":"info","ts":"2026-01-30T09:32:21.113631Z","caller":"traceutil/trace.go:171","msg":"trace[441518036] transaction","detail":"{read_only:false; response_revision:1068; number_of_response:1; }","duration":"843.695222ms","start":"2026-01-30T09:32:20.269927Z","end":"2026-01-30T09:32:21.113622Z","steps":["trace[441518036] 'process raft request'  (duration: 81.14013ms)","trace[441518036] 'compare'  (duration: 761.596549ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-30T09:32:21.113665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:32:20.269915Z","time spent":"843.732873ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:1062 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-01-30T09:32:21.11372Z","caller":"traceutil/trace.go:171","msg":"trace[276869434] transaction","detail":"{read_only:false; response_revision:1069; number_of_response:1; }","duration":"841.022608ms","start":"2026-01-30T09:32:20.272683Z","end":"2026-01-30T09:32:21.113706Z","steps":["trace[276869434] 'process raft request'  (duration: 840.378163ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:32:21.113751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:32:20.272659Z","time spent":"841.0767ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:1063 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-01-30T09:32:21.113821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.153328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:510"}
{"level":"info","ts":"2026-01-30T09:32:21.113835Z","caller":"traceutil/trace.go:171","msg":"trace[44112445] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1069; }","duration":"432.205559ms","start":"2026-01-30T09:32:20.681623Z","end":"2026-01-30T09:32:21.113829Z","steps":["trace[44112445] 'agreement among raft nodes before linearized reading'  (duration: 432.163218ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:32:21.113848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:32:20.681601Z","time spent":"432.24405ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":534,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "}
{"level":"warn","ts":"2026-01-30T09:32:21.645449Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16594528836940032548,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-01-30T09:32:22.146271Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16594528836940032548,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-01-30T09:32:22.647445Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16594528836940032548,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-01-30T09:32:22.819768Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.671143654s","expected-duration":"1s"}
{"level":"warn","ts":"2026-01-30T09:32:23.492884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:32:22.828421Z","time spent":"664.453925ms","remote":"127.0.0.1:45218","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-01-30T09:32:23.497449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"655.104735ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594528836940032549 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" mod_revision:1032 > success:<request_put:<key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" value_size:425 >> failure:<request_range:<key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" > >>","response":"size:16"}
{"level":"info","ts":"2026-01-30T09:32:23.497567Z","caller":"traceutil/trace.go:171","msg":"trace[1996855947] linearizableReadLoop","detail":"{readStateIndex:1115; appliedIndex:1113; }","duration":"2.352162859s","start":"2026-01-30T09:32:21.145389Z","end":"2026-01-30T09:32:23.497551Z","steps":["trace[1996855947] 'read index received'  (duration: 1.697014893s)","trace[1996855947] 'applied index is now lower than readState.Index'  (duration: 655.146956ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-30T09:32:23.497798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.974246376s","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-01-30T09:32:23.497814Z","caller":"traceutil/trace.go:171","msg":"trace[1890037723] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1071; }","duration":"1.974297887s","start":"2026-01-30T09:32:21.52351Z","end":"2026-01-30T09:32:23.497808Z","steps":["trace[1890037723] 'agreement among raft nodes before linearized reading'  (duration: 1.974211355s)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:32:23.497831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:32:21.523492Z","time spent":"1.974335328s","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":551,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "}
{"level":"warn","ts":"2026-01-30T09:32:23.497842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.352421845s","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-01-30T09:32:23.497923Z","caller":"traceutil/trace.go:171","msg":"trace[167207520] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1071; }","duration":"2.352544437s","start":"2026-01-30T09:32:21.145358Z","end":"2026-01-30T09:32:23.497903Z","steps":["trace[167207520] 'agreement among raft nodes before linearized reading'  (duration: 2.352284521s)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:32:23.497956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.938963ms","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-01-30T09:32:23.497976Z","caller":"traceutil/trace.go:171","msg":"trace[1262926967] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1071; }","duration":"347.018065ms","start":"2026-01-30T09:32:23.150952Z","end":"2026-01-30T09:32:23.49797Z","steps":["trace[1262926967] 'agreement among raft nodes before linearized reading'  (duration: 346.965404ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:32:23.49797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:32:21.145353Z","time spent":"2.352609769s","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-01-30T09:32:23.497995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:32:23.150927Z","time spent":"347.062777ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-01-30T09:32:23.498085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.987522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-01-30T09:32:23.498102Z","caller":"traceutil/trace.go:171","msg":"trace[588879853] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1071; }","duration":"349.051333ms","start":"2026-01-30T09:32:23.149045Z","end":"2026-01-30T09:32:23.498096Z","steps":["trace[588879853] 'agreement among raft nodes before linearized reading'  (duration: 349.006552ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:32:23.498116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:32:23.149017Z","time spent":"349.096795ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-01-30T09:32:23.498172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.345605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-30T09:32:23.498193Z","caller":"traceutil/trace.go:171","msg":"trace[41537567] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1071; }","duration":"376.404697ms","start":"2026-01-30T09:32:23.121782Z","end":"2026-01-30T09:32:23.498187Z","steps":["trace[41537567] 'agreement among raft nodes before linearized reading'  (duration: 376.362826ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:32:23.498223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:32:23.12176Z","time spent":"376.444358ms","remote":"127.0.0.1:53456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-01-30T09:32:23.498357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"559.2971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:536"}
{"level":"info","ts":"2026-01-30T09:32:23.498378Z","caller":"traceutil/trace.go:171","msg":"trace[1618397742] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1071; }","duration":"559.361442ms","start":"2026-01-30T09:32:22.939011Z","end":"2026-01-30T09:32:23.498372Z","steps":["trace[1618397742] 'agreement among raft nodes before linearized reading'  (duration: 559.306241ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:32:23.498393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:32:22.938985Z","time spent":"559.404012ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":560,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "}
{"level":"warn","ts":"2026-01-30T09:32:23.498478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"590.501534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"}
{"level":"info","ts":"2026-01-30T09:32:23.498505Z","caller":"traceutil/trace.go:171","msg":"trace[1032717357] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1071; }","duration":"590.566566ms","start":"2026-01-30T09:32:22.907932Z","end":"2026-01-30T09:32:23.498498Z","steps":["trace[1032717357] 'agreement among raft nodes before linearized reading'  (duration: 590.503004ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:32:23.498524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:32:22.90791Z","time spent":"590.610427ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":498,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "}
{"level":"warn","ts":"2026-01-30T09:32:23.498602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.228504367s","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-01-30T09:32:23.49862Z","caller":"traceutil/trace.go:171","msg":"trace[1001581849] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1071; }","duration":"1.228522068s","start":"2026-01-30T09:32:22.270093Z","end":"2026-01-30T09:32:23.498615Z","steps":["trace[1001581849] 'agreement among raft nodes before linearized reading'  (duration: 1.228470836s)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:32:23.498636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:32:22.270068Z","time spent":"1.228564998s","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-01-30T09:32:23.498703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.541070163s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-01-30T09:32:23.49872Z","caller":"traceutil/trace.go:171","msg":"trace[230925678] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1071; }","duration":"1.541135474s","start":"2026-01-30T09:32:21.95758Z","end":"2026-01-30T09:32:23.498716Z","steps":["trace[230925678] 'agreement among raft nodes before linearized reading'  (duration: 1.541092813s)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:32:23.498734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:32:21.957556Z","time spent":"1.541175685s","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-01-30T09:32:23.498867Z","caller":"traceutil/trace.go:171","msg":"trace[1657925344] transaction","detail":"{read_only:false; response_revision:1071; number_of_response:1; }","duration":"2.354518003s","start":"2026-01-30T09:32:21.144341Z","end":"2026-01-30T09:32:23.498859Z","steps":["trace[1657925344] 'process raft request'  (duration: 2.353170092s)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:32:23.498909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:32:21.144334Z","time spent":"2.354554205s","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":518,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" mod_revision:1064 > success:<request_put:<key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" value_size:453 >> failure:<request_range:<key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" > >"}
{"level":"info","ts":"2026-01-30T09:32:23.498959Z","caller":"traceutil/trace.go:171","msg":"trace[514861903] transaction","detail":"{read_only:false; response_revision:1070; number_of_response:1; }","duration":"2.356701545s","start":"2026-01-30T09:32:21.14225Z","end":"2026-01-30T09:32:23.498952Z","steps":["trace[514861903] 'process raft request'  (duration: 1.700029223s)","trace[514861903] 'compare'  (duration: 650.891846ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-30T09:32:23.499028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T09:32:21.142239Z","time spent":"2.356770557s","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":495,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" mod_revision:1032 > success:<request_put:<key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" value_size:425 >> failure:<request_range:<key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" > >"}
{"level":"info","ts":"2026-01-30T09:35:42.804486Z","caller":"traceutil/trace.go:171","msg":"trace[784405647] transaction","detail":"{read_only:false; response_revision:1916; number_of_response:1; }","duration":"129.440518ms","start":"2026-01-30T09:35:42.675006Z","end":"2026-01-30T09:35:42.804447Z","steps":["trace[784405647] 'process raft request'  (duration: 129.268694ms)"],"step_count":1}
{"level":"info","ts":"2026-01-30T09:35:43.071467Z","caller":"traceutil/trace.go:171","msg":"trace[1776459677] transaction","detail":"{read_only:false; response_revision:1917; number_of_response:1; }","duration":"137.737269ms","start":"2026-01-30T09:35:42.933706Z","end":"2026-01-30T09:35:43.071443Z","steps":["trace[1776459677] 'process raft request'  (duration: 137.415482ms)"],"step_count":1}
{"level":"info","ts":"2026-01-30T09:35:43.341417Z","caller":"traceutil/trace.go:171","msg":"trace[1154359263] transaction","detail":"{read_only:false; response_revision:1918; number_of_response:1; }","duration":"263.76199ms","start":"2026-01-30T09:35:43.077617Z","end":"2026-01-30T09:35:43.341379Z","steps":["trace[1154359263] 'process raft request'  (duration: 192.447499ms)","trace[1154359263] 'compare'  (duration: 70.768849ms)"],"step_count":2}
{"level":"info","ts":"2026-01-30T09:35:43.372936Z","caller":"traceutil/trace.go:171","msg":"trace[508291784] linearizableReadLoop","detail":"{readStateIndex:2005; appliedIndex:2002; }","duration":"251.638571ms","start":"2026-01-30T09:35:43.121277Z","end":"2026-01-30T09:35:43.372916Z","steps":["trace[508291784] 'read index received'  (duration: 148.698862ms)","trace[508291784] 'applied index is now lower than readState.Index'  (duration: 102.938299ms)"],"step_count":2}
{"level":"info","ts":"2026-01-30T09:35:43.373204Z","caller":"traceutil/trace.go:171","msg":"trace[258234860] transaction","detail":"{read_only:false; response_revision:1919; number_of_response:1; }","duration":"294.500227ms","start":"2026-01-30T09:35:43.078692Z","end":"2026-01-30T09:35:43.373193Z","steps":["trace[258234860] 'process raft request'  (duration: 294.044417ms)"],"step_count":1}
{"level":"info","ts":"2026-01-30T09:35:43.37359Z","caller":"traceutil/trace.go:171","msg":"trace[1154474820] transaction","detail":"{read_only:false; response_revision:1920; number_of_response:1; }","duration":"293.230678ms","start":"2026-01-30T09:35:43.080349Z","end":"2026-01-30T09:35:43.37358Z","steps":["trace[1154474820] 'process raft request'  (duration: 292.502391ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:35:43.374057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.545782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-30T09:35:43.374146Z","caller":"traceutil/trace.go:171","msg":"trace[196088362] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1920; }","duration":"252.93922ms","start":"2026-01-30T09:35:43.121196Z","end":"2026-01-30T09:35:43.374135Z","steps":["trace[196088362] 'agreement among raft nodes before linearized reading'  (duration: 252.571782ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T09:35:43.374047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.729978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-01-30T09:35:43.374336Z","caller":"traceutil/trace.go:171","msg":"trace[557171279] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:1920; }","duration":"237.078326ms","start":"2026-01-30T09:35:43.137211Z","end":"2026-01-30T09:35:43.37429Z","steps":["trace[557171279] 'agreement among raft nodes before linearized reading'  (duration: 236.716887ms)"],"step_count":1}