{"level":"warn","ts":"2026-02-12T03:41:40.448552Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-02-12T03:41:40.448764Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.209:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.209:2380","--initial-cluster=instance=https://199.204.45.209:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.209:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.209:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-02-12T03:41:40.448877Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-02-12T03:41:40.448888Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.209:2380"]}
{"level":"info","ts":"2026-02-12T03:41:40.448926Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-02-12T03:41:40.449688Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.209:2379"]}
{"level":"info","ts":"2026-02-12T03:41:40.44978Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":2,"max-cpu-available":2,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.209:2380"],"listen-peer-urls":["https://199.204.45.209:2380"],"advertise-client-urls":["https://199.204.45.209:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.209:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.209:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-02-12T03:41:40.454642Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.614889ms"}
{"level":"info","ts":"2026-02-12T03:41:40.467487Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"adfb641115bf6cbd","cluster-id":"3da6b677d4b80c6"}
{"level":"info","ts":"2026-02-12T03:41:40.467712Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd switched to configuration voters=()"}
{"level":"info","ts":"2026-02-12T03:41:40.467751Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd became follower at term 0"}
{"level":"info","ts":"2026-02-12T03:41:40.46776Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft adfb641115bf6cbd [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-02-12T03:41:40.46777Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd became follower at term 1"}
{"level":"info","ts":"2026-02-12T03:41:40.467813Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd switched to configuration voters=(12536724012257995965)"}
{"level":"warn","ts":"2026-02-12T03:41:40.476245Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-02-12T03:41:40.485558Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-02-12T03:41:40.487386Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
{"level":"info","ts":"2026-02-12T03:41:40.494011Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"adfb641115bf6cbd","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-02-12T03:41:40.500853Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-02-12T03:41:40.5027Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"adfb641115bf6cbd","initial-advertise-peer-urls":["https://199.204.45.209:2380"],"listen-peer-urls":["https://199.204.45.209:2380"],"advertise-client-urls":["https://199.204.45.209:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.209:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-02-12T03:41:40.502786Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-02-12T03:41:40.502999Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"adfb641115bf6cbd","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-02-12T03:41:40.503242Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-02-12T03:41:40.503316Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-02-12T03:41:40.504607Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-02-12T03:41:40.503477Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.209:2380"}
{"level":"info","ts":"2026-02-12T03:41:40.505829Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.209:2380"}
{"level":"info","ts":"2026-02-12T03:41:40.504457Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd switched to configuration voters=(12536724012257995965)"}
{"level":"info","ts":"2026-02-12T03:41:40.506033Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"3da6b677d4b80c6","local-member-id":"adfb641115bf6cbd","added-peer-id":"adfb641115bf6cbd","added-peer-peer-urls":["https://199.204.45.209:2380"]}
{"level":"info","ts":"2026-02-12T03:41:40.768277Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd is starting a new election at term 1"}
{"level":"info","ts":"2026-02-12T03:41:40.768582Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd became pre-candidate at term 1"}
{"level":"info","ts":"2026-02-12T03:41:40.768694Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd received MsgPreVoteResp from adfb641115bf6cbd at term 1"}
{"level":"info","ts":"2026-02-12T03:41:40.768772Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd became candidate at term 2"}
{"level":"info","ts":"2026-02-12T03:41:40.768789Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd received MsgVoteResp from adfb641115bf6cbd at term 2"}
{"level":"info","ts":"2026-02-12T03:41:40.768809Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd became leader at term 2"}
{"level":"info","ts":"2026-02-12T03:41:40.768842Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: adfb641115bf6cbd elected leader adfb641115bf6cbd at term 2"}
{"level":"info","ts":"2026-02-12T03:41:40.770271Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-12T03:41:40.771089Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"adfb641115bf6cbd","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.209:2379]}","request-path":"/0/members/adfb641115bf6cbd/attributes","cluster-id":"3da6b677d4b80c6","publish-timeout":"7s"}
{"level":"info","ts":"2026-02-12T03:41:40.771514Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-12T03:41:40.774702Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-12T03:41:40.778023Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"3da6b677d4b80c6","local-member-id":"adfb641115bf6cbd","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-12T03:41:40.778109Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-12T03:41:40.778135Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-12T03:41:40.811004Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.209:2379"}
{"level":"info","ts":"2026-02-12T03:41:40.811193Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-02-12T03:41:40.811469Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-02-12T03:41:40.811494Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-02-12T03:41:59.050255Z","caller":"traceutil/trace.go:171","msg":"trace[963532699] transaction","detail":"{read_only:false; response_revision:414; number_of_response:1; }","duration":"138.490009ms","start":"2026-02-12T03:41:58.911752Z","end":"2026-02-12T03:41:59.050242Z","steps":["trace[963532699] 'process raft request'  (duration: 138.387816ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:41:59.055238Z","caller":"traceutil/trace.go:171","msg":"trace[1482723810] transaction","detail":"{read_only:false; response_revision:413; number_of_response:1; }","duration":"135.479131ms","start":"2026-02-12T03:41:58.911603Z","end":"2026-02-12T03:41:59.047082Z","steps":["trace[1482723810] 'process raft request'  (duration: 135.287236ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:41:59.572501Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835590793849140883,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-12T03:42:01.071496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999624572s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-12T03:42:01.071831Z","caller":"traceutil/trace.go:171","msg":"trace[1843942339] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000031383s","start":"2026-02-12T03:41:59.071783Z","end":"2026-02-12T03:42:01.071814Z","steps":["trace[1843942339] 'agreement among raft nodes before linearized reading'  (duration: 1.999653223s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:01.07213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:41:59.071774Z","time spent":"2.000330681s","remote":"127.0.0.1:43340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/02/12 03:42:01 WARNING: [core] [Server #6] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-12T03:42:01.08305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.008159894s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-12T03:42:01.083155Z","caller":"traceutil/trace.go:171","msg":"trace[884566164] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.008304898s","start":"2026-02-12T03:41:59.074824Z","end":"2026-02-12T03:42:01.083129Z","steps":["trace[884566164] 'agreement among raft nodes before linearized reading'  (duration: 2.008160844s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:01.083204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:41:59.074817Z","time spent":"2.008376559s","remote":"127.0.0.1:43354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-12T03:42:01.814323Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.793466627s","expected-duration":"1s"}
{"level":"warn","ts":"2026-02-12T03:42:02.045672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.053782225s","expected-duration":"100ms","prefix":"","request":"header:<ID:7835590793849140884 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:411 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-12T03:42:02.04583Z","caller":"traceutil/trace.go:171","msg":"trace[813448039] linearizableReadLoop","detail":"{readStateIndex:430; appliedIndex:426; }","duration":"2.973994552s","start":"2026-02-12T03:41:59.071825Z","end":"2026-02-12T03:42:02.04582Z","steps":["trace[813448039] 'read index received'  (duration: 919.621042ms)","trace[813448039] 'applied index is now lower than readState.Index'  (duration: 2.0543719s)"],"step_count":2}
{"level":"info","ts":"2026-02-12T03:42:02.046102Z","caller":"traceutil/trace.go:171","msg":"trace[1897060442] transaction","detail":"{read_only:false; response_revision:415; number_of_response:1; }","duration":"2.992557895s","start":"2026-02-12T03:41:59.053481Z","end":"2026-02-12T03:42:02.046038Z","steps":["trace[1897060442] 'process raft request'  (duration: 937.853016ms)","trace[1897060442] 'compare'  (duration: 2.053688362s)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T03:42:02.046158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:41:59.053459Z","time spent":"2.992676987s","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:411 > 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-02-12T03:42:02.046297Z","caller":"traceutil/trace.go:171","msg":"trace[1256508498] transaction","detail":"{read_only:false; response_revision:416; number_of_response:1; }","duration":"2.983883549s","start":"2026-02-12T03:41:59.062387Z","end":"2026-02-12T03:42:02.046271Z","steps":["trace[1256508498] 'process raft request'  (duration: 2.983356775s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:02.04633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:41:59.062371Z","time spent":"2.983941851s","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:408 > 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-02-12T03:42:02.046414Z","caller":"traceutil/trace.go:171","msg":"trace[1571565172] transaction","detail":"{read_only:false; response_revision:417; number_of_response:1; }","duration":"2.983032507s","start":"2026-02-12T03:41:59.063375Z","end":"2026-02-12T03:42:02.046408Z","steps":["trace[1571565172] 'process raft request'  (duration: 2.982399851s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:02.046458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:41:59.063369Z","time spent":"2.983073598s","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:409 > 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":"info","ts":"2026-02-12T03:42:02.046632Z","caller":"traceutil/trace.go:171","msg":"trace[1534701412] transaction","detail":"{read_only:false; response_revision:418; number_of_response:1; }","duration":"2.951408405s","start":"2026-02-12T03:41:59.095215Z","end":"2026-02-12T03:42:02.046623Z","steps":["trace[1534701412] 'process raft request'  (duration: 2.950576483s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:02.046665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:41:59.095196Z","time spent":"2.951452157s","remote":"127.0.0.1:43536","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4042,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:346 > success:<request_put:<key:\"/registry/minions/instance\" value_size:4008 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"warn","ts":"2026-02-12T03:42:02.115114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.69240457s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6898"}
{"level":"info","ts":"2026-02-12T03:42:02.115408Z","caller":"traceutil/trace.go:171","msg":"trace[499390574] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:419; }","duration":"2.69275219s","start":"2026-02-12T03:41:59.422635Z","end":"2026-02-12T03:42:02.115387Z","steps":["trace[499390574] 'agreement among raft nodes before linearized reading'  (duration: 2.692358629s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:02.115491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:41:59.422616Z","time spent":"2.692845521s","remote":"127.0.0.1:43544","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":6921,"request content":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" "}
{"level":"info","ts":"2026-02-12T03:42:02.11578Z","caller":"traceutil/trace.go:171","msg":"trace[1822764941] transaction","detail":"{read_only:false; response_revision:419; number_of_response:1; }","duration":"1.030031694s","start":"2026-02-12T03:42:01.085738Z","end":"2026-02-12T03:42:02.115769Z","steps":["trace[1822764941] 'process raft request'  (duration: 1.02908197s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:02.115854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:42:01.085717Z","time spent":"1.030089285s","remote":"127.0.0.1:43408","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":758,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/kube-apiserver-instance.189362cf52bd57d4\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/kube-apiserver-instance.189362cf52bd57d4\" value_size:671 lease:7835590793849140175 >> failure:<>"}
{"level":"warn","ts":"2026-02-12T03:42:02.11604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.027674223s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T03:42:02.116103Z","caller":"traceutil/trace.go:171","msg":"trace[1888156748] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:419; }","duration":"1.027739034s","start":"2026-02-12T03:42:01.088329Z","end":"2026-02-12T03:42:02.116068Z","steps":["trace[1888156748] 'agreement among raft nodes before linearized reading'  (duration: 1.027675463s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:02.116133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:42:01.088319Z","time spent":"1.027805957s","remote":"127.0.0.1:43340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-12T03:42:02.116294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.050924677s","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-02-12T03:42:02.116321Z","caller":"traceutil/trace.go:171","msg":"trace[2137750519] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:419; }","duration":"1.050990399s","start":"2026-02-12T03:42:01.065322Z","end":"2026-02-12T03:42:02.116312Z","steps":["trace[2137750519] 'agreement among raft nodes before linearized reading'  (duration: 1.050933827s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:02.116349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:42:01.065302Z","time spent":"1.051038209s","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-02-12T03:42:20.158713Z","caller":"traceutil/trace.go:171","msg":"trace[366633965] linearizableReadLoop","detail":"{readStateIndex:542; appliedIndex:541; }","duration":"204.586278ms","start":"2026-02-12T03:42:19.954098Z","end":"2026-02-12T03:42:20.158684Z","steps":["trace[366633965] 'read index received'  (duration: 204.368812ms)","trace[366633965] 'applied index is now lower than readState.Index'  (duration: 216.336µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T03:42:20.158836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.721422ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T03:42:20.158863Z","caller":"traceutil/trace.go:171","msg":"trace[435087005] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:526; }","duration":"204.818614ms","start":"2026-02-12T03:42:19.954035Z","end":"2026-02-12T03:42:20.158854Z","steps":["trace[435087005] 'agreement among raft nodes before linearized reading'  (duration: 204.752442ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:42:20.158989Z","caller":"traceutil/trace.go:171","msg":"trace[1145716671] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"800.752673ms","start":"2026-02-12T03:42:19.358216Z","end":"2026-02-12T03:42:20.158969Z","steps":["trace[1145716671] 'process raft request'  (duration: 800.308612ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:20.15911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:42:19.358193Z","time spent":"800.839555ms","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:468 > 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-02-12T03:42:22.5879Z","caller":"traceutil/trace.go:171","msg":"trace[1233928512] linearizableReadLoop","detail":"{readStateIndex:549; appliedIndex:548; }","duration":"239.987559ms","start":"2026-02-12T03:42:22.347889Z","end":"2026-02-12T03:42:22.587877Z","steps":["trace[1233928512] 'read index received'  (duration: 239.762694ms)","trace[1233928512] 'applied index is now lower than readState.Index'  (duration: 223.865µs)"],"step_count":2}
{"level":"info","ts":"2026-02-12T03:42:22.588199Z","caller":"traceutil/trace.go:171","msg":"trace[744010434] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"314.247156ms","start":"2026-02-12T03:42:22.273941Z","end":"2026-02-12T03:42:22.588189Z","steps":["trace[744010434] 'process raft request'  (duration: 313.775154ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:22.588327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:42:22.273923Z","time spent":"314.311228ms","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:528 > 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-02-12T03:42:22.588521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.630275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-02-12T03:42:22.588562Z","caller":"traceutil/trace.go:171","msg":"trace[2054368228] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:532; }","duration":"240.696367ms","start":"2026-02-12T03:42:22.347854Z","end":"2026-02-12T03:42:22.58855Z","steps":["trace[2054368228] 'agreement among raft nodes before linearized reading'  (duration: 240.627045ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:22.588697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.449716ms","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-02-12T03:42:22.588728Z","caller":"traceutil/trace.go:171","msg":"trace[1440103917] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:532; }","duration":"223.521588ms","start":"2026-02-12T03:42:22.365199Z","end":"2026-02-12T03:42:22.58872Z","steps":["trace[1440103917] 'agreement among raft nodes before linearized reading'  (duration: 223.473147ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:22.588965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.931526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-02-12T03:42:22.588998Z","caller":"traceutil/trace.go:171","msg":"trace[903096312] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:532; }","duration":"220.986577ms","start":"2026-02-12T03:42:22.368003Z","end":"2026-02-12T03:42:22.58899Z","steps":["trace[903096312] 'agreement among raft nodes before linearized reading'  (duration: 220.889544ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:23.577931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.064004ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7835590793849141124 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:530 > 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-02-12T03:42:23.578073Z","caller":"traceutil/trace.go:171","msg":"trace[923461572] linearizableReadLoop","detail":"{readStateIndex:552; appliedIndex:550; }","duration":"622.601778ms","start":"2026-02-12T03:42:22.955459Z","end":"2026-02-12T03:42:23.578061Z","steps":["trace[923461572] 'read index received'  (duration: 379.311519ms)","trace[923461572] 'applied index is now lower than readState.Index'  (duration: 243.289349ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T03:42:23.578162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"622.725011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T03:42:23.578177Z","caller":"traceutil/trace.go:171","msg":"trace[1081120877] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:535; }","duration":"622.766633ms","start":"2026-02-12T03:42:22.955403Z","end":"2026-02-12T03:42:23.57817Z","steps":["trace[1081120877] 'agreement among raft nodes before linearized reading'  (duration: 622.686011ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:23.578193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:42:22.955385Z","time spent":"622.804793ms","remote":"127.0.0.1:43340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-02-12T03:42:23.578351Z","caller":"traceutil/trace.go:171","msg":"trace[502526082] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"980.685761ms","start":"2026-02-12T03:42:22.597659Z","end":"2026-02-12T03:42:23.578345Z","steps":["trace[502526082] 'process raft request'  (duration: 737.151376ms)","trace[502526082] 'compare'  (duration: 242.991172ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T03:42:23.57838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:42:22.597642Z","time spent":"980.722631ms","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:530 > 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-02-12T03:42:23.578453Z","caller":"traceutil/trace.go:171","msg":"trace[1084331340] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"978.277111ms","start":"2026-02-12T03:42:22.600172Z","end":"2026-02-12T03:42:23.578449Z","steps":["trace[1084331340] 'process raft request'  (duration: 977.849821ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:23.578487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:42:22.600162Z","time spent":"978.308003ms","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:531 > 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-02-12T03:42:24.46617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"506.407001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T03:42:24.466223Z","caller":"traceutil/trace.go:171","msg":"trace[908214136] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:535; }","duration":"506.499193ms","start":"2026-02-12T03:42:23.95971Z","end":"2026-02-12T03:42:24.466209Z","steps":["trace[908214136] 'range keys from in-memory index tree'  (duration: 506.33247ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:24.466247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:42:23.959691Z","time spent":"506.551585ms","remote":"127.0.0.1:43340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-12T03:42:24.46617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"679.117974ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T03:42:24.466276Z","caller":"traceutil/trace.go:171","msg":"trace[723548338] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:535; }","duration":"679.234427ms","start":"2026-02-12T03:42:23.787032Z","end":"2026-02-12T03:42:24.466266Z","steps":["trace[723548338] 'range keys from in-memory index tree'  (duration: 679.107553ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:25.093367Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835590793849141128,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-12T03:42:25.193429Z","caller":"traceutil/trace.go:171","msg":"trace[1646623335] linearizableReadLoop","detail":"{readStateIndex:553; appliedIndex:552; }","duration":"600.732166ms","start":"2026-02-12T03:42:24.592675Z","end":"2026-02-12T03:42:25.193408Z","steps":["trace[1646623335] 'read index received'  (duration: 600.49521ms)","trace[1646623335] 'applied index is now lower than readState.Index'  (duration: 235.976µs)"],"step_count":2}
{"level":"info","ts":"2026-02-12T03:42:25.19389Z","caller":"traceutil/trace.go:171","msg":"trace[1786444475] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"647.919584ms","start":"2026-02-12T03:42:24.54594Z","end":"2026-02-12T03:42:25.19386Z","steps":["trace[1786444475] 'process raft request'  (duration: 647.283268ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:25.194044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:42:24.54592Z","time spent":"648.029966ms","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:480 > 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-02-12T03:42:25.194202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"601.526825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-02-12T03:42:25.194223Z","caller":"traceutil/trace.go:171","msg":"trace[1270930235] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:536; }","duration":"601.577626ms","start":"2026-02-12T03:42:24.592639Z","end":"2026-02-12T03:42:25.194216Z","steps":["trace[1270930235] 'agreement among raft nodes before linearized reading'  (duration: 601.515035ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:25.19424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:42:24.59262Z","time spent":"601.616387ms","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-12T03:42:25.194392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"555.443994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-02-12T03:42:25.194412Z","caller":"traceutil/trace.go:171","msg":"trace[744127463] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:536; }","duration":"555.496205ms","start":"2026-02-12T03:42:24.638909Z","end":"2026-02-12T03:42:25.194405Z","steps":["trace[744127463] 'agreement among raft nodes before linearized reading'  (duration: 555.407943ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:25.194425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:42:24.638868Z","time spent":"555.553866ms","remote":"127.0.0.1:43628","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-02-12T03:42:25.194681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.099072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T03:42:25.194701Z","caller":"traceutil/trace.go:171","msg":"trace[1390768026] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:536; }","duration":"171.145053ms","start":"2026-02-12T03:42:25.023551Z","end":"2026-02-12T03:42:25.194696Z","steps":["trace[1390768026] 'agreement among raft nodes before linearized reading'  (duration: 171.112332ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:25.858256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"573.319309ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"}
{"level":"info","ts":"2026-02-12T03:42:25.858333Z","caller":"traceutil/trace.go:171","msg":"trace[1733636778] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:539; }","duration":"573.441282ms","start":"2026-02-12T03:42:25.284877Z","end":"2026-02-12T03:42:25.858318Z","steps":["trace[1733636778] 'range keys from in-memory index tree'  (duration: 573.183626ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:25.858358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:42:25.284856Z","time spent":"573.497233ms","remote":"127.0.0.1:43526","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":445,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "}
{"level":"warn","ts":"2026-02-12T03:42:25.858693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.355371ms","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-02-12T03:42:25.85871Z","caller":"traceutil/trace.go:171","msg":"trace[1742126938] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:539; }","duration":"273.409312ms","start":"2026-02-12T03:42:25.585295Z","end":"2026-02-12T03:42:25.858704Z","steps":["trace[1742126938] 'range keys from in-memory index tree'  (duration: 273.277719ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:25.858803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.09379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-02-12T03:42:25.858821Z","caller":"traceutil/trace.go:171","msg":"trace[1551956042] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:539; }","duration":"272.127821ms","start":"2026-02-12T03:42:25.586685Z","end":"2026-02-12T03:42:25.858813Z","steps":["trace[1551956042] 'range keys from in-memory index tree'  (duration: 272.033878ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:42:25.978763Z","caller":"traceutil/trace.go:171","msg":"trace[2078920723] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"114.612598ms","start":"2026-02-12T03:42:25.864125Z","end":"2026-02-12T03:42:25.978737Z","steps":["trace[2078920723] 'process raft request'  (duration: 114.469925ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:42:25.97903Z","caller":"traceutil/trace.go:171","msg":"trace[4231131] linearizableReadLoop","detail":"{readStateIndex:558; appliedIndex:558; }","duration":"114.328192ms","start":"2026-02-12T03:42:25.864466Z","end":"2026-02-12T03:42:25.978794Z","steps":["trace[4231131] 'read index received'  (duration: 114.315481ms)","trace[4231131] 'applied index is now lower than readState.Index'  (duration: 10.751µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T03:42:25.979288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.803293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-02-12T03:42:25.979326Z","caller":"traceutil/trace.go:171","msg":"trace[1381435971] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:540; }","duration":"114.883935ms","start":"2026-02-12T03:42:25.864433Z","end":"2026-02-12T03:42:25.979317Z","steps":["trace[1381435971] 'agreement among raft nodes before linearized reading'  (duration: 114.806803ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:42:25.98174Z","caller":"traceutil/trace.go:171","msg":"trace[682862310] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"117.039158ms","start":"2026-02-12T03:42:25.864685Z","end":"2026-02-12T03:42:25.981724Z","steps":["trace[682862310] 'process raft request'  (duration: 116.623418ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:30.345088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.263401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-drflj\" ","response":"range_response_count:1 size:16656"}
{"level":"info","ts":"2026-02-12T03:42:30.345174Z","caller":"traceutil/trace.go:171","msg":"trace[1987153642] range","detail":"{range_begin:/registry/pods/kube-system/cilium-drflj; range_end:; response_count:1; response_revision:552; }","duration":"158.416225ms","start":"2026-02-12T03:42:30.186738Z","end":"2026-02-12T03:42:30.345154Z","steps":["trace[1987153642] 'range keys from in-memory index tree'  (duration: 158.163578ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:42:30.345868Z","caller":"traceutil/trace.go:171","msg":"trace[627229705] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"136.284676ms","start":"2026-02-12T03:42:30.209575Z","end":"2026-02-12T03:42:30.345859Z","steps":["trace[627229705] 'process raft request'  (duration: 133.474677ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:31.454688Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835590793849141173,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-12T03:42:31.540049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"853.578219ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7835590793849141174 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/kube-system/cilium-drflj\" mod_revision:515 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-drflj\" value_size:16754 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-drflj\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-12T03:42:31.540412Z","caller":"traceutil/trace.go:171","msg":"trace[1693409108] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"1.175311316s","start":"2026-02-12T03:42:30.365076Z","end":"2026-02-12T03:42:31.540387Z","steps":["trace[1693409108] 'process raft request'  (duration: 321.320197ms)","trace[1693409108] 'compare'  (duration: 852.79405ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T03:42:31.540513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:42:30.365037Z","time spent":"1.175412878s","remote":"127.0.0.1:43544","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16803,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-drflj\" mod_revision:515 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-drflj\" value_size:16754 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-drflj\" > >"}
{"level":"warn","ts":"2026-02-12T03:42:32.362508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"822.343206ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7835590793849141175 > lease_revoke:<id:6cbd9c4ff0b2f718>","response":"size:28"}
{"level":"info","ts":"2026-02-12T03:42:32.362626Z","caller":"traceutil/trace.go:171","msg":"trace[1901444863] linearizableReadLoop","detail":"{readStateIndex:573; appliedIndex:571; }","duration":"1.408713743s","start":"2026-02-12T03:42:30.95389Z","end":"2026-02-12T03:42:32.362604Z","steps":["trace[1901444863] 'read index received'  (duration: 584.182774ms)","trace[1901444863] 'applied index is now lower than readState.Index'  (duration: 824.529489ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T03:42:32.362942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.409038201s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T03:42:32.362967Z","caller":"traceutil/trace.go:171","msg":"trace[2024852413] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:554; }","duration":"1.409102993s","start":"2026-02-12T03:42:30.953856Z","end":"2026-02-12T03:42:32.362959Z","steps":["trace[2024852413] 'agreement among raft nodes before linearized reading'  (duration: 1.409033811s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:32.362992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:42:30.953837Z","time spent":"1.409148725s","remote":"127.0.0.1:43340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-12T03:42:32.363085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.06864867s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-02-12T03:42:32.363163Z","caller":"traceutil/trace.go:171","msg":"trace[455664841] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:554; }","duration":"1.068720761s","start":"2026-02-12T03:42:31.29441Z","end":"2026-02-12T03:42:32.36313Z","steps":["trace[455664841] 'agreement among raft nodes before linearized reading'  (duration: 1.068561947s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:32.363195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:42:31.294334Z","time spent":"1.068855175s","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-12T03:42:32.363311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.475283ms","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-02-12T03:42:32.363333Z","caller":"traceutil/trace.go:171","msg":"trace[2035535882] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:554; }","duration":"356.552364ms","start":"2026-02-12T03:42:32.006774Z","end":"2026-02-12T03:42:32.363326Z","steps":["trace[2035535882] 'agreement among raft nodes before linearized reading'  (duration: 356.440301ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:32.363351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:42:32.006746Z","time spent":"356.601626ms","remote":"127.0.0.1:43628","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-02-12T03:42:32.363384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.068079576s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-02-12T03:42:32.363406Z","caller":"traceutil/trace.go:171","msg":"trace[13690853] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:554; }","duration":"1.068119377s","start":"2026-02-12T03:42:31.29528Z","end":"2026-02-12T03:42:32.363399Z","steps":["trace[13690853] 'agreement among raft nodes before linearized reading'  (duration: 1.068055895s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:32.363424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:42:31.295271Z","time spent":"1.068148847s","remote":"127.0.0.1:43628","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-02-12T03:42:32.363494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.831785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-02-12T03:42:32.363524Z","caller":"traceutil/trace.go:171","msg":"trace[850325615] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:554; }","duration":"350.904857ms","start":"2026-02-12T03:42:32.012608Z","end":"2026-02-12T03:42:32.363513Z","steps":["trace[850325615] 'agreement among raft nodes before linearized reading'  (duration: 350.840275ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:32.36358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:42:32.01258Z","time spent":"350.971819ms","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-02-12T03:42:32.638179Z","caller":"traceutil/trace.go:171","msg":"trace[896821593] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"263.814568ms","start":"2026-02-12T03:42:32.374308Z","end":"2026-02-12T03:42:32.638123Z","steps":["trace[896821593] 'process raft request'  (duration: 263.634544ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:42:32.93602Z","caller":"traceutil/trace.go:171","msg":"trace[2138363392] linearizableReadLoop","detail":"{readStateIndex:577; appliedIndex:574; }","duration":"554.795938ms","start":"2026-02-12T03:42:32.381202Z","end":"2026-02-12T03:42:32.935998Z","steps":["trace[2138363392] 'read index received'  (duration: 257.643809ms)","trace[2138363392] 'applied index is now lower than readState.Index'  (duration: 297.151179ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T03:42:32.936164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"554.946652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T03:42:32.936186Z","caller":"traceutil/trace.go:171","msg":"trace[511473560] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:558; }","duration":"555.018064ms","start":"2026-02-12T03:42:32.381162Z","end":"2026-02-12T03:42:32.93618Z","steps":["trace[511473560] 'agreement among raft nodes before linearized reading'  (duration: 554.920261ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:32.936212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:42:32.381151Z","time spent":"555.056254ms","remote":"127.0.0.1:43340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-02-12T03:42:32.936665Z","caller":"traceutil/trace.go:171","msg":"trace[1992788448] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"559.80234ms","start":"2026-02-12T03:42:32.37685Z","end":"2026-02-12T03:42:32.936652Z","steps":["trace[1992788448] 'process raft request'  (duration: 558.921689ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:32.936743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:42:32.376838Z","time spent":"559.855621ms","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:551 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-02-12T03:42:32.93684Z","caller":"traceutil/trace.go:171","msg":"trace[1427144685] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"559.855952ms","start":"2026-02-12T03:42:32.376978Z","end":"2026-02-12T03:42:32.936834Z","steps":["trace[1427144685] 'process raft request'  (duration: 558.94802ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:32.936871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:42:32.376946Z","time spent":"559.908052ms","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:547 > 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-02-12T03:42:32.936951Z","caller":"traceutil/trace.go:171","msg":"trace[959628979] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"558.893807ms","start":"2026-02-12T03:42:32.378051Z","end":"2026-02-12T03:42:32.936945Z","steps":["trace[959628979] 'process raft request'  (duration: 557.915214ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:32.936982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:42:32.378044Z","time spent":"558.919949ms","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:546 > 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-02-12T03:42:35.774682Z","caller":"traceutil/trace.go:171","msg":"trace[1859668899] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"334.779636ms","start":"2026-02-12T03:42:35.439584Z","end":"2026-02-12T03:42:35.774364Z","steps":["trace[1859668899] 'process raft request'  (duration: 334.54978ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:35.774887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:42:35.439565Z","time spent":"335.210416ms","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:0 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<>"}
{"level":"info","ts":"2026-02-12T03:42:35.968294Z","caller":"traceutil/trace.go:171","msg":"trace[891790157] linearizableReadLoop","detail":"{readStateIndex:600; appliedIndex:599; }","duration":"184.886277ms","start":"2026-02-12T03:42:35.783377Z","end":"2026-02-12T03:42:35.968264Z","steps":["trace[891790157] 'read index received'  (duration: 171.950203ms)","trace[891790157] 'applied index is now lower than readState.Index'  (duration: 12.934604ms)"],"step_count":2}
{"level":"info","ts":"2026-02-12T03:42:35.968436Z","caller":"traceutil/trace.go:171","msg":"trace[793604161] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"498.629861ms","start":"2026-02-12T03:42:35.469779Z","end":"2026-02-12T03:42:35.968409Z","steps":["trace[793604161] 'process raft request'  (duration: 485.605724ms)","trace[793604161] 'compare'  (duration: 12.677318ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T03:42:35.968477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.064932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T03:42:35.968508Z","caller":"traceutil/trace.go:171","msg":"trace[283015919] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io; range_end:; response_count:0; response_revision:580; }","duration":"185.164134ms","start":"2026-02-12T03:42:35.783334Z","end":"2026-02-12T03:42:35.968498Z","steps":["trace[283015919] 'agreement among raft nodes before linearized reading'  (duration: 185.073502ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:35.968562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:42:35.46975Z","time spent":"498.740164ms","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:536 > 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-02-12T03:42:35.968761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.340538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-02-12T03:42:35.968778Z","caller":"traceutil/trace.go:171","msg":"trace[907032217] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:580; }","duration":"185.368289ms","start":"2026-02-12T03:42:35.783405Z","end":"2026-02-12T03:42:35.968774Z","steps":["trace[907032217] 'agreement among raft nodes before linearized reading'  (duration: 185.261296ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:35.968805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.669354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T03:42:35.96884Z","caller":"traceutil/trace.go:171","msg":"trace[1733596523] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:0; response_revision:580; }","duration":"136.747166ms","start":"2026-02-12T03:42:35.83208Z","end":"2026-02-12T03:42:35.968827Z","steps":["trace[1733596523] 'agreement among raft nodes before linearized reading'  (duration: 136.695965ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:35.968871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.115812ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T03:42:35.968889Z","caller":"traceutil/trace.go:171","msg":"trace[729772794] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:0; response_revision:580; }","duration":"157.152422ms","start":"2026-02-12T03:42:35.811731Z","end":"2026-02-12T03:42:35.968884Z","steps":["trace[729772794] 'agreement among raft nodes before linearized reading'  (duration: 157.126162ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:35.96894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.305834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T03:42:35.968952Z","caller":"traceutil/trace.go:171","msg":"trace[1476838910] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io; range_end:; response_count:0; response_revision:580; }","duration":"161.337134ms","start":"2026-02-12T03:42:35.80761Z","end":"2026-02-12T03:42:35.968948Z","steps":["trace[1476838910] 'agreement among raft nodes before linearized reading'  (duration: 161.318104ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:35.969035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.901767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T03:42:35.969049Z","caller":"traceutil/trace.go:171","msg":"trace[844640050] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:0; response_revision:580; }","duration":"163.916257ms","start":"2026-02-12T03:42:35.805128Z","end":"2026-02-12T03:42:35.969044Z","steps":["trace[844640050] 'agreement among raft nodes before linearized reading'  (duration: 163.893787ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:35.9691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.978097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-12T03:42:35.969116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.33107ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T03:42:35.969133Z","caller":"traceutil/trace.go:171","msg":"trace[3790236] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:0; response_revision:580; }","duration":"167.3589ms","start":"2026-02-12T03:42:35.801769Z","end":"2026-02-12T03:42:35.969128Z","steps":["trace[3790236] 'agreement among raft nodes before linearized reading'  (duration: 167.33273ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:42:35.969131Z","caller":"traceutil/trace.go:171","msg":"trace[1858896053] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:0; response_revision:580; }","duration":"129.015208ms","start":"2026-02-12T03:42:35.840106Z","end":"2026-02-12T03:42:35.969122Z","steps":["trace[1858896053] 'agreement among raft nodes before linearized reading'  (duration: 128.970167ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:35.969205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.599645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T03:42:35.969219Z","caller":"traceutil/trace.go:171","msg":"trace[1473316861] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:0; response_revision:580; }","duration":"169.643107ms","start":"2026-02-12T03:42:35.799572Z","end":"2026-02-12T03:42:35.969215Z","steps":["trace[1473316861] 'agreement among raft nodes before linearized reading'  (duration: 169.621926ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:35.96929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.907528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T03:42:35.969303Z","caller":"traceutil/trace.go:171","msg":"trace[149607950] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io; range_end:; response_count:0; response_revision:580; }","duration":"184.935469ms","start":"2026-02-12T03:42:35.784362Z","end":"2026-02-12T03:42:35.969298Z","steps":["trace[149607950] 'agreement among raft nodes before linearized reading'  (duration: 184.915978ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:35.969477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.375497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T03:42:35.969501Z","caller":"traceutil/trace.go:171","msg":"trace[2038555725] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:580; }","duration":"129.420037ms","start":"2026-02-12T03:42:35.840074Z","end":"2026-02-12T03:42:35.969494Z","steps":["trace[2038555725] 'agreement among raft nodes before linearized reading'  (duration: 129.383986ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:42:37.79373Z","caller":"traceutil/trace.go:171","msg":"trace[1519959967] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"407.222458ms","start":"2026-02-12T03:42:37.386476Z","end":"2026-02-12T03:42:37.793698Z","steps":["trace[1519959967] 'process raft request'  (duration: 401.867738ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:37.793899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:42:37.38645Z","time spent":"407.33245ms","remote":"127.0.0.1:43390","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4580,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" value_size:4482 >> failure:<>"}
{"level":"info","ts":"2026-02-12T03:42:37.795106Z","caller":"traceutil/trace.go:171","msg":"trace[314615561] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"208.123824ms","start":"2026-02-12T03:42:37.586971Z","end":"2026-02-12T03:42:37.795095Z","steps":["trace[314615561] 'process raft request'  (duration: 207.432337ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:45.38242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.747129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.209\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-02-12T03:42:45.382767Z","caller":"traceutil/trace.go:171","msg":"trace[999914203] range","detail":"{range_begin:/registry/masterleases/199.204.45.209; range_end:; response_count:1; response_revision:686; }","duration":"202.112127ms","start":"2026-02-12T03:42:45.180641Z","end":"2026-02-12T03:42:45.382753Z","steps":["trace[999914203] 'range keys from in-memory index tree'  (duration: 201.578984ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:45.829139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.218238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-12T03:42:45.829192Z","caller":"traceutil/trace.go:171","msg":"trace[1918287771] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:687; }","duration":"220.30582ms","start":"2026-02-12T03:42:45.608874Z","end":"2026-02-12T03:42:45.82918Z","steps":["trace[1918287771] 'count revisions from in-memory index tree'  (duration: 220.167717ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:42:51.107553Z","caller":"traceutil/trace.go:171","msg":"trace[166955271] transaction","detail":"{read_only:false; response_revision:738; number_of_response:1; }","duration":"243.445004ms","start":"2026-02-12T03:42:50.864091Z","end":"2026-02-12T03:42:51.107536Z","steps":["trace[166955271] 'process raft request'  (duration: 243.332041ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:52.566516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"646.360867ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7835590793849141524 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:657 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-12T03:42:52.566581Z","caller":"traceutil/trace.go:171","msg":"trace[1579472573] linearizableReadLoop","detail":"{readStateIndex:764; appliedIndex:762; }","duration":"1.613322703s","start":"2026-02-12T03:42:50.953246Z","end":"2026-02-12T03:42:52.566568Z","steps":["trace[1579472573] 'read index received'  (duration: 154.1281ms)","trace[1579472573] 'applied index is now lower than readState.Index'  (duration: 1.459193753s)"],"step_count":2}
{"level":"info","ts":"2026-02-12T03:42:52.566712Z","caller":"traceutil/trace.go:171","msg":"trace[1249923492] transaction","detail":"{read_only:false; response_revision:739; number_of_response:1; }","duration":"1.665358649s","start":"2026-02-12T03:42:50.901347Z","end":"2026-02-12T03:42:52.566706Z","steps":["trace[1249923492] 'process raft request'  (duration: 1.018726356s)","trace[1249923492] 'compare'  (duration: 646.119401ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T03:42:52.566755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:42:50.901324Z","time spent":"1.665414661s","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:657 > 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-02-12T03:42:52.566842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.528271854s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-02-12T03:42:52.566904Z","caller":"traceutil/trace.go:171","msg":"trace[127580689] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:739; }","duration":"1.528366156s","start":"2026-02-12T03:42:51.038522Z","end":"2026-02-12T03:42:52.566888Z","steps":["trace[127580689] 'agreement among raft nodes before linearized reading'  (duration: 1.528210372s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:52.566931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:42:51.038478Z","time spent":"1.528446388s","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-02-12T03:42:52.566977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"494.226435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-02-12T03:42:52.566995Z","caller":"traceutil/trace.go:171","msg":"trace[759976504] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:739; }","duration":"494.272816ms","start":"2026-02-12T03:42:52.072717Z","end":"2026-02-12T03:42:52.56699Z","steps":["trace[759976504] 'agreement among raft nodes before linearized reading'  (duration: 494.189294ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:52.56701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:42:52.072701Z","time spent":"494.306047ms","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-02-12T03:42:52.567086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.613841265s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-12T03:42:52.567092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.471998255s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-02-12T03:42:52.567098Z","caller":"traceutil/trace.go:171","msg":"trace[263927256] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:739; }","duration":"1.613907788s","start":"2026-02-12T03:42:50.953186Z","end":"2026-02-12T03:42:52.567094Z","steps":["trace[263927256] 'agreement among raft nodes before linearized reading'  (duration: 1.613888747s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:52.567113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:42:50.953173Z","time spent":"1.613937658s","remote":"127.0.0.1:43340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-02-12T03:42:52.567114Z","caller":"traceutil/trace.go:171","msg":"trace[559175331] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:739; }","duration":"1.472054086s","start":"2026-02-12T03:42:51.095054Z","end":"2026-02-12T03:42:52.567108Z","steps":["trace[559175331] 'agreement among raft nodes before linearized reading'  (duration: 1.471992395s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:52.567133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:42:51.095042Z","time spent":"1.472086017s","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-12T03:42:52.567254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.527363302s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-02-12T03:42:52.567271Z","caller":"traceutil/trace.go:171","msg":"trace[141932855] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:739; }","duration":"1.527394213s","start":"2026-02-12T03:42:51.039872Z","end":"2026-02-12T03:42:52.567266Z","steps":["trace[141932855] 'agreement among raft nodes before linearized reading'  (duration: 1.527339492s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:52.567287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:42:51.039864Z","time spent":"1.527418723s","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-12T03:42:53.743931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"863.231803ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7835590793849141528 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:733 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-12T03:42:53.744108Z","caller":"traceutil/trace.go:171","msg":"trace[124643169] transaction","detail":"{read_only:false; response_revision:740; number_of_response:1; }","duration":"1.172077657s","start":"2026-02-12T03:42:52.572004Z","end":"2026-02-12T03:42:53.744081Z","steps":["trace[124643169] 'process raft request'  (duration: 308.559868ms)","trace[124643169] 'compare'  (duration: 862.094654ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T03:42:53.744192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:42:52.571992Z","time spent":"1.172156158s","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:733 > 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-02-12T03:42:54.191426Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.310955525s","expected-duration":"1s"}
{"level":"warn","ts":"2026-02-12T03:42:54.582399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000281447s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-12T03:42:54.582471Z","caller":"traceutil/trace.go:171","msg":"trace[1398667197] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000386899s","start":"2026-02-12T03:42:52.58207Z","end":"2026-02-12T03:42:54.582457Z","steps":["trace[1398667197] 'agreement among raft nodes before linearized reading'  (duration: 2.000292287s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:54.582523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:42:52.582062Z","time spent":"2.00045002s","remote":"127.0.0.1:43340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-12T03:42:55.506601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.314982234s","expected-duration":"100ms","prefix":"","request":"header:<ID:7835590793849141529 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:732 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-12T03:42:55.506831Z","caller":"traceutil/trace.go:171","msg":"trace[1965021619] linearizableReadLoop","detail":"{readStateIndex:768; appliedIndex:764; }","duration":"2.924714659s","start":"2026-02-12T03:42:52.582089Z","end":"2026-02-12T03:42:55.506804Z","steps":["trace[1965021619] 'read index received'  (duration: 298.484833ms)","trace[1965021619] 'applied index is now lower than readState.Index'  (duration: 2.626229016s)"],"step_count":2}
{"level":"info","ts":"2026-02-12T03:42:55.507032Z","caller":"traceutil/trace.go:171","msg":"trace[655454187] transaction","detail":"{read_only:false; response_revision:741; number_of_response:1; }","duration":"2.934468756s","start":"2026-02-12T03:42:52.572552Z","end":"2026-02-12T03:42:55.507021Z","steps":["trace[655454187] 'process raft request'  (duration: 1.61900316s)","trace[655454187] 'compare'  (duration: 1.314327429s)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T03:42:55.50709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:42:52.572539Z","time spent":"2.934519677s","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:732 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-02-12T03:42:55.507239Z","caller":"traceutil/trace.go:171","msg":"trace[989002814] transaction","detail":"{read_only:false; response_revision:742; number_of_response:1; }","duration":"2.933308147s","start":"2026-02-12T03:42:52.573922Z","end":"2026-02-12T03:42:55.50723Z","steps":["trace[989002814] 'process raft request'  (duration: 2.932755764s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:55.507285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:42:52.573914Z","time spent":"2.933346338s","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:736 > 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":"info","ts":"2026-02-12T03:42:55.507401Z","caller":"traceutil/trace.go:171","msg":"trace[293750355] transaction","detail":"{read_only:false; response_revision:743; number_of_response:1; }","duration":"2.932965539s","start":"2026-02-12T03:42:52.574428Z","end":"2026-02-12T03:42:55.507393Z","steps":["trace[293750355] 'process raft request'  (duration: 2.932295823s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:55.507444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:42:52.574422Z","time spent":"2.93299929s","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:734 > 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-02-12T03:42:55.507667Z","caller":"traceutil/trace.go:171","msg":"trace[1342727390] transaction","detail":"{read_only:false; response_revision:744; number_of_response:1; }","duration":"2.715092648s","start":"2026-02-12T03:42:52.792564Z","end":"2026-02-12T03:42:55.507657Z","steps":["trace[1342727390] 'process raft request'  (duration: 2.714191666s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:55.507722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:42:52.792539Z","time spent":"2.71515726s","remote":"127.0.0.1:43536","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4769,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:680 > success:<request_put:<key:\"/registry/minions/instance\" value_size:4735 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"warn","ts":"2026-02-12T03:42:55.5079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.867481675s","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-02-12T03:42:55.507934Z","caller":"traceutil/trace.go:171","msg":"trace[1927114579] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:744; }","duration":"2.867540747s","start":"2026-02-12T03:42:52.640385Z","end":"2026-02-12T03:42:55.507925Z","steps":["trace[1927114579] 'agreement among raft nodes before linearized reading'  (duration: 2.867444315s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:55.507962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:42:52.640373Z","time spent":"2.867580968s","remote":"127.0.0.1:43408","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":101,"response size":30,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "}
{"level":"warn","ts":"2026-02-12T03:42:55.508315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.68662ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.209\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-02-12T03:42:55.508343Z","caller":"traceutil/trace.go:171","msg":"trace[44712112] range","detail":"{range_begin:/registry/masterleases/199.204.45.209; range_end:; response_count:1; response_revision:744; }","duration":"326.74628ms","start":"2026-02-12T03:42:55.181588Z","end":"2026-02-12T03:42:55.508334Z","steps":["trace[44712112] 'agreement among raft nodes before linearized reading'  (duration: 326.649448ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:55.508377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:42:55.181573Z","time spent":"326.798182ms","remote":"127.0.0.1:43374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.209\" "}
{"level":"warn","ts":"2026-02-12T03:42:55.50858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"925.250072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T03:42:55.508609Z","caller":"traceutil/trace.go:171","msg":"trace[1078959383] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:744; }","duration":"925.295904ms","start":"2026-02-12T03:42:54.583304Z","end":"2026-02-12T03:42:55.5086Z","steps":["trace[1078959383] 'agreement among raft nodes before linearized reading'  (duration: 925.253543ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:55.508649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:42:54.583291Z","time spent":"925.352115ms","remote":"127.0.0.1:43354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-12T03:42:55.508771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.744688849s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T03:42:55.508811Z","caller":"traceutil/trace.go:171","msg":"trace[416338679] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:744; }","duration":"1.744756171s","start":"2026-02-12T03:42:53.764047Z","end":"2026-02-12T03:42:55.508803Z","steps":["trace[416338679] 'agreement among raft nodes before linearized reading'  (duration: 1.744702649s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:55.508841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:42:53.764029Z","time spent":"1.744804461s","remote":"127.0.0.1:43510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true "}
{"level":"warn","ts":"2026-02-12T03:42:55.508989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.39747313s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-02-12T03:42:55.509013Z","caller":"traceutil/trace.go:171","msg":"trace[884294008] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:744; }","duration":"2.397524932s","start":"2026-02-12T03:42:53.111481Z","end":"2026-02-12T03:42:55.509006Z","steps":["trace[884294008] 'agreement among raft nodes before linearized reading'  (duration: 2.39745464s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:55.509038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:42:53.111462Z","time spent":"2.397571303s","remote":"127.0.0.1:43628","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-02-12T03:42:55.964062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.257685ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7835590793849141536 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:15-second id:6cbd9c4ff0b2f91f>","response":"size:40"}
{"level":"info","ts":"2026-02-12T03:42:55.964126Z","caller":"traceutil/trace.go:171","msg":"trace[273352570] linearizableReadLoop","detail":"{readStateIndex:770; appliedIndex:769; }","duration":"444.104285ms","start":"2026-02-12T03:42:55.520009Z","end":"2026-02-12T03:42:55.964113Z","steps":["trace[273352570] 'read index received'  (duration: 261.720977ms)","trace[273352570] 'applied index is now lower than readState.Index'  (duration: 182.382328ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T03:42:55.964577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:42:55.514886Z","time spent":"449.670521ms","remote":"127.0.0.1:43374","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-02-12T03:42:55.964813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.794713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-apiserver-instance.189362cf53727af4\" ","response":"range_response_count:1 size:774"}
{"level":"info","ts":"2026-02-12T03:42:55.96486Z","caller":"traceutil/trace.go:171","msg":"trace[1795831815] range","detail":"{range_begin:/registry/events/kube-system/kube-apiserver-instance.189362cf53727af4; range_end:; response_count:1; response_revision:744; }","duration":"444.857234ms","start":"2026-02-12T03:42:55.519994Z","end":"2026-02-12T03:42:55.964852Z","steps":["trace[1795831815] 'agreement among raft nodes before linearized reading'  (duration: 444.773662ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:55.964902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:42:55.519988Z","time spent":"444.908095ms","remote":"127.0.0.1:43408","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":797,"request content":"key:\"/registry/events/kube-system/kube-apiserver-instance.189362cf53727af4\" "}
{"level":"info","ts":"2026-02-12T03:42:55.983377Z","caller":"traceutil/trace.go:171","msg":"trace[1503228280] transaction","detail":"{read_only:false; response_revision:745; number_of_response:1; }","duration":"461.417426ms","start":"2026-02-12T03:42:55.521942Z","end":"2026-02-12T03:42:55.98336Z","steps":["trace[1503228280] 'process raft request'  (duration: 461.278543ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:55.983499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:42:55.521934Z","time spent":"461.501428ms","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:738 > 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-02-12T03:42:55.984061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"463.178049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T03:42:55.984101Z","caller":"traceutil/trace.go:171","msg":"trace[611012121] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:745; }","duration":"463.225121ms","start":"2026-02-12T03:42:55.520864Z","end":"2026-02-12T03:42:55.984089Z","steps":["trace[611012121] 'agreement among raft nodes before linearized reading'  (duration: 463.16894ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:55.984125Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:42:55.520859Z","time spent":"463.260362ms","remote":"127.0.0.1:43340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-12T03:42:55.984278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.25728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-02-12T03:42:55.984304Z","caller":"traceutil/trace.go:171","msg":"trace[1896601922] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:745; }","duration":"234.311601ms","start":"2026-02-12T03:42:55.749986Z","end":"2026-02-12T03:42:55.984298Z","steps":["trace[1896601922] 'agreement among raft nodes before linearized reading'  (duration: 234.235339ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:55.984875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.029486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T03:42:55.984901Z","caller":"traceutil/trace.go:171","msg":"trace[597448306] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:745; }","duration":"313.081768ms","start":"2026-02-12T03:42:55.671809Z","end":"2026-02-12T03:42:55.984891Z","steps":["trace[597448306] 'agreement among raft nodes before linearized reading'  (duration: 313.043047ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:55.984921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:42:55.671794Z","time spent":"313.122048ms","remote":"127.0.0.1:43590","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":28,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "}
{"level":"info","ts":"2026-02-12T03:42:57.74768Z","caller":"traceutil/trace.go:171","msg":"trace[1082916894] transaction","detail":"{read_only:false; response_revision:757; number_of_response:1; }","duration":"222.299159ms","start":"2026-02-12T03:42:57.52536Z","end":"2026-02-12T03:42:57.747659Z","steps":["trace[1082916894] 'process raft request'  (duration: 222.251838ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:42:57.747803Z","caller":"traceutil/trace.go:171","msg":"trace[284912397] transaction","detail":"{read_only:false; response_revision:756; number_of_response:1; }","duration":"223.19299ms","start":"2026-02-12T03:42:57.524594Z","end":"2026-02-12T03:42:57.747787Z","steps":["trace[284912397] 'process raft request'  (duration: 222.515084ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:43:11.979757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.276586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"warn","ts":"2026-02-12T03:43:11.979773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.585919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-02-12T03:43:11.97982Z","caller":"traceutil/trace.go:171","msg":"trace[693736654] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:793; }","duration":"170.383168ms","start":"2026-02-12T03:43:11.809423Z","end":"2026-02-12T03:43:11.979806Z","steps":["trace[693736654] 'range keys from in-memory index tree'  (duration: 170.151463ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:43:11.979836Z","caller":"traceutil/trace.go:171","msg":"trace[1191972753] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:793; }","duration":"169.687342ms","start":"2026-02-12T03:43:11.810137Z","end":"2026-02-12T03:43:11.979825Z","steps":["trace[1191972753] 'range keys from in-memory index tree'  (duration: 169.464176ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:43:15.884302Z","caller":"traceutil/trace.go:171","msg":"trace[1104915503] transaction","detail":"{read_only:false; response_revision:805; number_of_response:1; }","duration":"118.235172ms","start":"2026-02-12T03:43:15.766032Z","end":"2026-02-12T03:43:15.884268Z","steps":["trace[1104915503] 'process raft request'  (duration: 118.107389ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:43:17.138237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.962189ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7835590793849141712 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:801 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:367 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-12T03:43:17.138381Z","caller":"traceutil/trace.go:171","msg":"trace[2133364678] transaction","detail":"{read_only:false; response_revision:808; number_of_response:1; }","duration":"866.270229ms","start":"2026-02-12T03:43:16.272098Z","end":"2026-02-12T03:43:17.138368Z","steps":["trace[2133364678] 'process raft request'  (duration: 866.228888ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:43:17.138435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:43:16.272076Z","time spent":"866.33803ms","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:782 > 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-02-12T03:43:17.138685Z","caller":"traceutil/trace.go:171","msg":"trace[1086365439] transaction","detail":"{read_only:false; response_revision:807; number_of_response:1; }","duration":"1.133323885s","start":"2026-02-12T03:43:16.005351Z","end":"2026-02-12T03:43:17.138675Z","steps":["trace[1086365439] 'process raft request'  (duration: 712.858254ms)","trace[1086365439] 'compare'  (duration: 419.810255ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T03:43:17.138723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:43:16.005332Z","time spent":"1.133371136s","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:801 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:367 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-02-12T03:43:17.138808Z","caller":"traceutil/trace.go:171","msg":"trace[1757558477] linearizableReadLoop","detail":"{readStateIndex:838; appliedIndex:837; }","duration":"1.081608868s","start":"2026-02-12T03:43:16.057192Z","end":"2026-02-12T03:43:17.138801Z","steps":["trace[1757558477] 'read index received'  (duration: 15.471095ms)","trace[1757558477] 'applied index is now lower than readState.Index'  (duration: 1.066137063s)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T03:43:17.139073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.081876555s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-02-12T03:43:17.139102Z","caller":"traceutil/trace.go:171","msg":"trace[1588514367] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:808; }","duration":"1.081935526s","start":"2026-02-12T03:43:16.057158Z","end":"2026-02-12T03:43:17.139093Z","steps":["trace[1588514367] 'agreement among raft nodes before linearized reading'  (duration: 1.081842324s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:43:17.139129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:43:16.057143Z","time spent":"1.081979637s","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-12T03:43:17.139232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.068431849s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-02-12T03:43:17.139465Z","caller":"traceutil/trace.go:171","msg":"trace[724004841] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:808; }","duration":"1.068696345s","start":"2026-02-12T03:43:16.07076Z","end":"2026-02-12T03:43:17.139456Z","steps":["trace[724004841] 'agreement among raft nodes before linearized reading'  (duration: 1.068434939s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:43:17.139493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:43:16.070745Z","time spent":"1.068740986s","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-12T03:43:17.140392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.923384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T03:43:17.140419Z","caller":"traceutil/trace.go:171","msg":"trace[2123437613] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:808; }","duration":"187.980946ms","start":"2026-02-12T03:43:16.952431Z","end":"2026-02-12T03:43:17.140412Z","steps":["trace[2123437613] 'agreement among raft nodes before linearized reading'  (duration: 187.863243ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:43:18.047967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.932992ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7835590793849141717 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:803 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-12T03:43:18.048039Z","caller":"traceutil/trace.go:171","msg":"trace[1900531041] transaction","detail":"{read_only:false; response_revision:809; number_of_response:1; }","duration":"902.112589ms","start":"2026-02-12T03:43:17.145912Z","end":"2026-02-12T03:43:18.048025Z","steps":["trace[1900531041] 'process raft request'  (duration: 682.072976ms)","trace[1900531041] 'compare'  (duration: 219.771437ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T03:43:18.048077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:43:17.145892Z","time spent":"902.166841ms","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:803 > 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-02-12T03:43:18.078013Z","caller":"traceutil/trace.go:171","msg":"trace[983425763] linearizableReadLoop","detail":"{readStateIndex:841; appliedIndex:840; }","duration":"190.023684ms","start":"2026-02-12T03:43:17.887979Z","end":"2026-02-12T03:43:18.078002Z","steps":["trace[983425763] 'read index received'  (duration: 189.935372ms)","trace[983425763] 'applied index is now lower than readState.Index'  (duration: 87.802µs)"],"step_count":2}
{"level":"info","ts":"2026-02-12T03:43:18.078578Z","caller":"traceutil/trace.go:171","msg":"trace[2016381244] transaction","detail":"{read_only:false; response_revision:810; number_of_response:1; }","duration":"929.971896ms","start":"2026-02-12T03:43:17.148596Z","end":"2026-02-12T03:43:18.078568Z","steps":["trace[2016381244] 'process raft request'  (duration: 929.350961ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:43:18.078647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:43:17.148586Z","time spent":"930.014137ms","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:802 > 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-02-12T03:43:18.078877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.900246ms","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-02-12T03:43:18.0789Z","caller":"traceutil/trace.go:171","msg":"trace[1320568489] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:810; }","duration":"190.943747ms","start":"2026-02-12T03:43:17.887949Z","end":"2026-02-12T03:43:18.078893Z","steps":["trace[1320568489] 'agreement among raft nodes before linearized reading'  (duration: 190.855755ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:43:18.07906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.321545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T03:43:18.07908Z","caller":"traceutil/trace.go:171","msg":"trace[918599381] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:810; }","duration":"116.366226ms","start":"2026-02-12T03:43:17.962708Z","end":"2026-02-12T03:43:18.079074Z","steps":["trace[918599381] 'agreement among raft nodes before linearized reading'  (duration: 116.322755ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:43:30.681717Z","caller":"traceutil/trace.go:171","msg":"trace[749732638] transaction","detail":"{read_only:false; response_revision:897; number_of_response:1; }","duration":"377.906648ms","start":"2026-02-12T03:43:30.303774Z","end":"2026-02-12T03:43:30.681681Z","steps":["trace[749732638] 'process raft request'  (duration: 372.380304ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:43:30.682113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:43:30.30375Z","time spent":"378.252797ms","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:888 > 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-02-12T03:43:33.639515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"679.837631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T03:43:33.639593Z","caller":"traceutil/trace.go:171","msg":"trace[267045772] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:902; }","duration":"680.032235ms","start":"2026-02-12T03:43:32.959547Z","end":"2026-02-12T03:43:33.639579Z","steps":["trace[267045772] 'range keys from in-memory index tree'  (duration: 679.713727ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:43:33.639622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:43:32.959512Z","time spent":"680.103347ms","remote":"127.0.0.1:43340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-12T03:43:34.13946Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835590793849141933,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-12T03:43:34.249166Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.121573549s","expected-duration":"1s"}
{"level":"info","ts":"2026-02-12T03:43:34.249491Z","caller":"traceutil/trace.go:171","msg":"trace[622863505] linearizableReadLoop","detail":"{readStateIndex:938; appliedIndex:937; }","duration":"610.312992ms","start":"2026-02-12T03:43:33.63916Z","end":"2026-02-12T03:43:34.249473Z","steps":["trace[622863505] 'read index received'  (duration: 610.145318ms)","trace[622863505] 'applied index is now lower than readState.Index'  (duration: 167.044µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T03:43:34.249767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"610.582879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-02-12T03:43:34.249841Z","caller":"traceutil/trace.go:171","msg":"trace[1371178421] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:903; }","duration":"610.709602ms","start":"2026-02-12T03:43:33.639112Z","end":"2026-02-12T03:43:34.249821Z","steps":["trace[1371178421] 'agreement among raft nodes before linearized reading'  (duration: 610.476476ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:43:34.249878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:43:33.639083Z","time spent":"610.786714ms","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-02-12T03:43:34.249992Z","caller":"traceutil/trace.go:171","msg":"trace[136924518] transaction","detail":"{read_only:false; response_revision:903; number_of_response:1; }","duration":"1.122514622s","start":"2026-02-12T03:43:33.127468Z","end":"2026-02-12T03:43:34.249983Z","steps":["trace[136924518] 'process raft request'  (duration: 1.121889157s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:43:34.250079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:43:33.127439Z","time spent":"1.122571293s","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:823 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:471 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-02-12T03:43:34.249794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"608.219102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T03:43:34.25017Z","caller":"traceutil/trace.go:171","msg":"trace[1796174674] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:903; }","duration":"608.652882ms","start":"2026-02-12T03:43:33.641509Z","end":"2026-02-12T03:43:34.250162Z","steps":["trace[1796174674] 'agreement among raft nodes before linearized reading'  (duration: 608.231252ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:43:34.250192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:43:33.64148Z","time spent":"608.705884ms","remote":"127.0.0.1:43354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-12T03:43:34.879178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.762299ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7835590793849141937 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:899 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-12T03:43:34.879246Z","caller":"traceutil/trace.go:171","msg":"trace[1197451450] transaction","detail":"{read_only:false; response_revision:904; number_of_response:1; }","duration":"623.243066ms","start":"2026-02-12T03:43:34.25599Z","end":"2026-02-12T03:43:34.879233Z","steps":["trace[1197451450] 'process raft request'  (duration: 293.369845ms)","trace[1197451450] 'compare'  (duration: 329.636946ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T03:43:34.879283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:43:34.255972Z","time spent":"623.293728ms","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:899 > 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-02-12T03:43:35.471444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.902994ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7835590793849141938 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:900 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-12T03:43:35.471614Z","caller":"traceutil/trace.go:171","msg":"trace[1394164139] linearizableReadLoop","detail":"{readStateIndex:940; appliedIndex:938; }","duration":"1.210726155s","start":"2026-02-12T03:43:34.260868Z","end":"2026-02-12T03:43:35.471595Z","steps":["trace[1394164139] 'read index received'  (duration: 288.498917ms)","trace[1394164139] 'applied index is now lower than readState.Index'  (duration: 922.226128ms)"],"step_count":2}
{"level":"info","ts":"2026-02-12T03:43:35.471893Z","caller":"traceutil/trace.go:171","msg":"trace[1740901617] transaction","detail":"{read_only:false; response_revision:905; number_of_response:1; }","duration":"1.211273518s","start":"2026-02-12T03:43:34.260601Z","end":"2026-02-12T03:43:35.471875Z","steps":["trace[1740901617] 'process raft request'  (duration: 980.847811ms)","trace[1740901617] 'compare'  (duration: 229.673418ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T03:43:35.471974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:43:34.260589Z","time spent":"1.21134097s","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:900 > 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":"info","ts":"2026-02-12T03:43:35.473403Z","caller":"traceutil/trace.go:171","msg":"trace[1005191638] transaction","detail":"{read_only:false; response_revision:906; number_of_response:1; }","duration":"1.211360041s","start":"2026-02-12T03:43:34.262033Z","end":"2026-02-12T03:43:35.473393Z","steps":["trace[1005191638] 'process raft request'  (duration: 1.209502085s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:43:35.473455Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:43:34.262027Z","time spent":"1.211404022s","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:898 > 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-02-12T03:43:35.473537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.212666932s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T03:43:35.473551Z","caller":"traceutil/trace.go:171","msg":"trace[269958456] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:906; }","duration":"1.212696822s","start":"2026-02-12T03:43:34.260849Z","end":"2026-02-12T03:43:35.473546Z","steps":["trace[269958456] 'agreement among raft nodes before linearized reading'  (duration: 1.212670242s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:43:35.473566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:43:34.260844Z","time spent":"1.212717153s","remote":"127.0.0.1:43340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-12T03:43:35.473695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.163206131s","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-02-12T03:43:35.473707Z","caller":"traceutil/trace.go:171","msg":"trace[1874165676] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:906; }","duration":"1.163242091s","start":"2026-02-12T03:43:34.310461Z","end":"2026-02-12T03:43:35.473703Z","steps":["trace[1874165676] 'agreement among raft nodes before linearized reading'  (duration: 1.16318028s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:43:35.473719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:43:34.310431Z","time spent":"1.163285812s","remote":"127.0.0.1:43628","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-02-12T03:43:35.473968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.098061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.209\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-02-12T03:43:35.473982Z","caller":"traceutil/trace.go:171","msg":"trace[1055072005] range","detail":"{range_begin:/registry/masterleases/199.204.45.209; range_end:; response_count:1; response_revision:906; }","duration":"275.139672ms","start":"2026-02-12T03:43:35.198838Z","end":"2026-02-12T03:43:35.473978Z","steps":["trace[1055072005] 'agreement among raft nodes before linearized reading'  (duration: 275.099661ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:43:35.474069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"691.785881ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-02-12T03:43:35.474081Z","caller":"traceutil/trace.go:171","msg":"trace[1544585514] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:906; }","duration":"691.832692ms","start":"2026-02-12T03:43:34.782245Z","end":"2026-02-12T03:43:35.474078Z","steps":["trace[1544585514] 'agreement among raft nodes before linearized reading'  (duration: 691.796871ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:43:35.474092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:43:34.782227Z","time spent":"691.862893ms","remote":"127.0.0.1:43628","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":"info","ts":"2026-02-12T03:43:41.492209Z","caller":"traceutil/trace.go:171","msg":"trace[1190296291] transaction","detail":"{read_only:false; response_revision:921; number_of_response:1; }","duration":"537.454463ms","start":"2026-02-12T03:43:40.954736Z","end":"2026-02-12T03:43:41.492191Z","steps":["trace[1190296291] 'process raft request'  (duration: 537.297599ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:43:41.492303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:43:40.954729Z","time spent":"537.524764ms","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:916 > 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-02-12T03:43:41.859679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.308849ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7835590793849141993 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:919 > 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-02-12T03:43:41.859768Z","caller":"traceutil/trace.go:171","msg":"trace[1968901620] linearizableReadLoop","detail":"{readStateIndex:961; appliedIndex:960; }","duration":"314.273593ms","start":"2026-02-12T03:43:41.54548Z","end":"2026-02-12T03:43:41.859753Z","steps":["trace[1968901620] 'read index received'  (duration: 57.794634ms)","trace[1968901620] 'applied index is now lower than readState.Index'  (duration: 256.477819ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T03:43:41.85992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.432877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-02-12T03:43:41.859949Z","caller":"traceutil/trace.go:171","msg":"trace[1939579030] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:924; }","duration":"314.476247ms","start":"2026-02-12T03:43:41.545463Z","end":"2026-02-12T03:43:41.859939Z","steps":["trace[1939579030] 'agreement among raft nodes before linearized reading'  (duration: 314.333004ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:43:41.859981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:43:41.545456Z","time spent":"314.517438ms","remote":"127.0.0.1:43628","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":"info","ts":"2026-02-12T03:43:41.860231Z","caller":"traceutil/trace.go:171","msg":"trace[775155927] transaction","detail":"{read_only:false; response_revision:924; number_of_response:1; }","duration":"318.495715ms","start":"2026-02-12T03:43:41.541723Z","end":"2026-02-12T03:43:41.860218Z","steps":["trace[775155927] 'process raft request'  (duration: 193.569901ms)","trace[775155927] 'compare'  (duration: 124.074844ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T03:43:41.86029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:43:41.541713Z","time spent":"318.544656ms","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:919 > 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-02-12T03:43:42.254996Z","caller":"traceutil/trace.go:171","msg":"trace[1685787769] linearizableReadLoop","detail":"{readStateIndex:962; appliedIndex:961; }","duration":"301.685666ms","start":"2026-02-12T03:43:41.953295Z","end":"2026-02-12T03:43:42.254981Z","steps":["trace[1685787769] 'read index received'  (duration: 223.407895ms)","trace[1685787769] 'applied index is now lower than readState.Index'  (duration: 78.275231ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T03:43:42.255105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.800269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T03:43:42.255121Z","caller":"traceutil/trace.go:171","msg":"trace[1803155369] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:925; }","duration":"301.853521ms","start":"2026-02-12T03:43:41.953263Z","end":"2026-02-12T03:43:42.255117Z","steps":["trace[1803155369] 'agreement among raft nodes before linearized reading'  (duration: 301.772529ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:43:42.255139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:43:41.953248Z","time spent":"301.886341ms","remote":"127.0.0.1:43340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-02-12T03:43:42.255313Z","caller":"traceutil/trace.go:171","msg":"trace[2071699428] transaction","detail":"{read_only:false; response_revision:925; number_of_response:1; }","duration":"387.430279ms","start":"2026-02-12T03:43:41.867875Z","end":"2026-02-12T03:43:42.255305Z","steps":["trace[2071699428] 'process raft request'  (duration: 308.890852ms)","trace[2071699428] 'compare'  (duration: 78.052746ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T03:43:42.255366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:43:41.867862Z","time spent":"387.46609ms","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:920 > 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-02-12T03:43:43.766394Z","caller":"traceutil/trace.go:171","msg":"trace[240711185] linearizableReadLoop","detail":"{readStateIndex:963; appliedIndex:962; }","duration":"221.205091ms","start":"2026-02-12T03:43:43.545172Z","end":"2026-02-12T03:43:43.766378Z","steps":["trace[240711185] 'read index received'  (duration: 221.075248ms)","trace[240711185] 'applied index is now lower than readState.Index'  (duration: 129.233µs)"],"step_count":2}
{"level":"info","ts":"2026-02-12T03:43:43.76664Z","caller":"traceutil/trace.go:171","msg":"trace[1598274877] transaction","detail":"{read_only:false; response_revision:926; number_of_response:1; }","duration":"261.496021ms","start":"2026-02-12T03:43:43.505137Z","end":"2026-02-12T03:43:43.766633Z","steps":["trace[1598274877] 'process raft request'  (duration: 261.153692ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:43:43.766841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.656253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-02-12T03:43:43.76687Z","caller":"traceutil/trace.go:171","msg":"trace[1158728108] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:926; }","duration":"221.727464ms","start":"2026-02-12T03:43:43.545135Z","end":"2026-02-12T03:43:43.766863Z","steps":["trace[1158728108] 'agreement among raft nodes before linearized reading'  (duration: 221.631722ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:43:43.766983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.02268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-02-12T03:43:43.767092Z","caller":"traceutil/trace.go:171","msg":"trace[613786507] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:926; }","duration":"161.168294ms","start":"2026-02-12T03:43:43.605913Z","end":"2026-02-12T03:43:43.767082Z","steps":["trace[613786507] 'agreement among raft nodes before linearized reading'  (duration: 161.03401ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:43:44.348078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.862391ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7835590793849142003 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:923 > 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-02-12T03:43:44.348338Z","caller":"traceutil/trace.go:171","msg":"trace[130816074] linearizableReadLoop","detail":"{readStateIndex:965; appliedIndex:963; }","duration":"475.043107ms","start":"2026-02-12T03:43:43.873272Z","end":"2026-02-12T03:43:44.348315Z","steps":["trace[130816074] 'read index received'  (duration: 368.770246ms)","trace[130816074] 'applied index is now lower than readState.Index'  (duration: 106.271361ms)"],"step_count":2}
{"level":"info","ts":"2026-02-12T03:43:44.348791Z","caller":"traceutil/trace.go:171","msg":"trace[1232303962] transaction","detail":"{read_only:false; response_revision:927; number_of_response:1; }","duration":"576.174642ms","start":"2026-02-12T03:43:43.7726Z","end":"2026-02-12T03:43:44.348775Z","steps":["trace[1232303962] 'process raft request'  (duration: 469.42831ms)","trace[1232303962] 'compare'  (duration: 105.678446ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T03:43:44.348866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:43:43.772588Z","time spent":"576.239734ms","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:923 > 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-02-12T03:43:44.349068Z","caller":"traceutil/trace.go:171","msg":"trace[1538429205] transaction","detail":"{read_only:false; response_revision:928; number_of_response:1; }","duration":"575.130167ms","start":"2026-02-12T03:43:43.773921Z","end":"2026-02-12T03:43:44.349051Z","steps":["trace[1538429205] 'process raft request'  (duration: 574.298517ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:43:44.349134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:43:43.773916Z","time spent":"575.180638ms","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:922 > 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-02-12T03:43:44.349338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.109913ms","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-02-12T03:43:44.349355Z","caller":"traceutil/trace.go:171","msg":"trace[684224495] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:928; }","duration":"476.179804ms","start":"2026-02-12T03:43:43.873168Z","end":"2026-02-12T03:43:44.349348Z","steps":["trace[684224495] 'agreement among raft nodes before linearized reading'  (duration: 476.046291ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:43:44.349371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:43:43.873139Z","time spent":"476.228456ms","remote":"127.0.0.1:43628","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-02-12T03:43:44.349491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.697257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T03:43:44.349507Z","caller":"traceutil/trace.go:171","msg":"trace[1831255040] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:928; }","duration":"394.766668ms","start":"2026-02-12T03:43:43.954734Z","end":"2026-02-12T03:43:44.349501Z","steps":["trace[1831255040] 'agreement among raft nodes before linearized reading'  (duration: 394.741987ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:43:44.349519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:43:43.954674Z","time spent":"394.84187ms","remote":"127.0.0.1:43354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-02-12T03:43:44.63288Z","caller":"traceutil/trace.go:171","msg":"trace[560231895] transaction","detail":"{read_only:false; response_revision:929; number_of_response:1; }","duration":"220.251811ms","start":"2026-02-12T03:43:44.412601Z","end":"2026-02-12T03:43:44.632853Z","steps":["trace[560231895] 'process raft request'  (duration: 220.095967ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:43:44.7199Z","caller":"traceutil/trace.go:171","msg":"trace[227840728] transaction","detail":"{read_only:false; response_revision:931; number_of_response:1; }","duration":"160.158311ms","start":"2026-02-12T03:43:44.559726Z","end":"2026-02-12T03:43:44.719884Z","steps":["trace[227840728] 'process raft request'  (duration: 160.13139ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:43:44.72016Z","caller":"traceutil/trace.go:171","msg":"trace[1222232662] transaction","detail":"{read_only:false; response_revision:930; number_of_response:1; }","duration":"307.349737ms","start":"2026-02-12T03:43:44.412776Z","end":"2026-02-12T03:43:44.720125Z","steps":["trace[1222232662] 'process raft request'  (duration: 306.980938ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:43:44.720345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:43:44.412771Z","time spent":"307.473459ms","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:925 > 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-02-12T03:43:45.09823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.027997ms","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-02-12T03:43:45.098281Z","caller":"traceutil/trace.go:171","msg":"trace[2076912489] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:931; }","duration":"363.118388ms","start":"2026-02-12T03:43:44.73515Z","end":"2026-02-12T03:43:45.098269Z","steps":["trace[2076912489] 'count revisions from in-memory index tree'  (duration: 362.970416ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:43:45.098303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:43:44.735134Z","time spent":"363.16373ms","remote":"127.0.0.1:43484","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":28,"request content":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true "}
{"level":"warn","ts":"2026-02-12T03:43:45.09841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.117099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T03:43:45.098424Z","caller":"traceutil/trace.go:171","msg":"trace[24524342] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:931; }","duration":"146.18483ms","start":"2026-02-12T03:43:44.952233Z","end":"2026-02-12T03:43:45.098418Z","steps":["trace[24524342] 'range keys from in-memory index tree'  (duration: 146.010206ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:43:46.033585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.576215ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7835590793849142016 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/masterleases/199.204.45.209\" mod_revision:907 > success:<request_put:<key:\"/registry/masterleases/199.204.45.209\" value_size:67 lease:7835590793849142014 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.209\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-12T03:43:46.03368Z","caller":"traceutil/trace.go:171","msg":"trace[856005071] linearizableReadLoop","detail":"{readStateIndex:970; appliedIndex:969; }","duration":"262.198418ms","start":"2026-02-12T03:43:45.771464Z","end":"2026-02-12T03:43:46.033663Z","steps":["trace[856005071] 'read index received'  (duration: 25.392487ms)","trace[856005071] 'applied index is now lower than readState.Index'  (duration: 236.804371ms)"],"step_count":2}
{"level":"info","ts":"2026-02-12T03:43:46.033753Z","caller":"traceutil/trace.go:171","msg":"trace[1717075992] transaction","detail":"{read_only:false; response_revision:932; number_of_response:1; }","duration":"554.694861ms","start":"2026-02-12T03:43:45.479043Z","end":"2026-02-12T03:43:46.033738Z","steps":["trace[1717075992] 'process raft request'  (duration: 317.89696ms)","trace[1717075992] 'compare'  (duration: 236.35983ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T03:43:46.033789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:43:45.479017Z","time spent":"554.751662ms","remote":"127.0.0.1:43374","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/masterleases/199.204.45.209\" mod_revision:907 > success:<request_put:<key:\"/registry/masterleases/199.204.45.209\" value_size:67 lease:7835590793849142014 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.209\" > >"}
{"level":"warn","ts":"2026-02-12T03:43:46.034018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.550906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-02-12T03:43:46.034036Z","caller":"traceutil/trace.go:171","msg":"trace[1157783349] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:932; }","duration":"262.592258ms","start":"2026-02-12T03:43:45.771438Z","end":"2026-02-12T03:43:46.03403Z","steps":["trace[1157783349] 'agreement among raft nodes before linearized reading'  (duration: 262.466785ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:43:47.226967Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835590793849142027,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-12T03:43:47.41178Z","caller":"traceutil/trace.go:171","msg":"trace[656600144] linearizableReadLoop","detail":"{readStateIndex:974; appliedIndex:973; }","duration":"685.602424ms","start":"2026-02-12T03:43:46.726155Z","end":"2026-02-12T03:43:47.411757Z","steps":["trace[656600144] 'read index received'  (duration: 685.396759ms)","trace[656600144] 'applied index is now lower than readState.Index'  (duration: 204.934µs)"],"step_count":2}
{"level":"info","ts":"2026-02-12T03:43:47.412109Z","caller":"traceutil/trace.go:171","msg":"trace[881001083] transaction","detail":"{read_only:false; response_revision:936; number_of_response:1; }","duration":"748.579485ms","start":"2026-02-12T03:43:46.66352Z","end":"2026-02-12T03:43:47.4121Z","steps":["trace[881001083] 'process raft request'  (duration: 748.093943ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:43:47.412213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:43:46.663507Z","time spent":"748.627856ms","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:929 > 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-02-12T03:43:47.412421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"686.27467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-02-12T03:43:47.412443Z","caller":"traceutil/trace.go:171","msg":"trace[2122590620] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:936; }","duration":"686.341781ms","start":"2026-02-12T03:43:46.726093Z","end":"2026-02-12T03:43:47.412435Z","steps":["trace[2122590620] 'agreement among raft nodes before linearized reading'  (duration: 686.245719ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:43:47.412461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:43:46.726069Z","time spent":"686.389013ms","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-02-12T03:43:47.412634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.733804ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T03:43:47.412654Z","caller":"traceutil/trace.go:171","msg":"trace[178232150] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:936; }","duration":"447.777725ms","start":"2026-02-12T03:43:46.96487Z","end":"2026-02-12T03:43:47.412648Z","steps":["trace[178232150] 'agreement among raft nodes before linearized reading'  (duration: 447.725704ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:43:47.412672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:43:46.964855Z","time spent":"447.813406ms","remote":"127.0.0.1:43340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-02-12T03:43:47.579771Z","caller":"traceutil/trace.go:171","msg":"trace[244371167] transaction","detail":"{read_only:false; response_revision:937; number_of_response:1; }","duration":"163.210582ms","start":"2026-02-12T03:43:47.41653Z","end":"2026-02-12T03:43:47.579741Z","steps":["trace[244371167] 'process raft request'  (duration: 65.789777ms)","trace[244371167] 'compare'  (duration: 97.132608ms)"],"step_count":2}
{"level":"info","ts":"2026-02-12T03:43:48.526795Z","caller":"traceutil/trace.go:171","msg":"trace[2032110381] transaction","detail":"{read_only:false; response_revision:941; number_of_response:1; }","duration":"145.834252ms","start":"2026-02-12T03:43:48.380942Z","end":"2026-02-12T03:43:48.526776Z","steps":["trace[2032110381] 'process raft request'  (duration: 130.411067ms)","trace[2032110381] 'compare'  (duration: 15.25038ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T03:43:48.795389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.440139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-12T03:43:48.795443Z","caller":"traceutil/trace.go:171","msg":"trace[457468202] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:941; }","duration":"100.522191ms","start":"2026-02-12T03:43:48.694909Z","end":"2026-02-12T03:43:48.795431Z","steps":["trace[457468202] 'count revisions from in-memory index tree'  (duration: 100.377008ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:43:50.734654Z","caller":"traceutil/trace.go:171","msg":"trace[1893178905] transaction","detail":"{read_only:false; response_revision:944; number_of_response:1; }","duration":"653.024327ms","start":"2026-02-12T03:43:50.081594Z","end":"2026-02-12T03:43:50.734618Z","steps":["trace[1893178905] 'process raft request'  (duration: 652.830322ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:43:50.734694Z","caller":"traceutil/trace.go:171","msg":"trace[128458218] linearizableReadLoop","detail":"{readStateIndex:982; appliedIndex:982; }","duration":"399.575622ms","start":"2026-02-12T03:43:50.335051Z","end":"2026-02-12T03:43:50.734626Z","steps":["trace[128458218] 'read index received'  (duration: 399.559622ms)","trace[128458218] 'applied index is now lower than readState.Index'  (duration: 13.35µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T03:43:50.73488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:43:50.081573Z","time spent":"653.199212ms","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:939 > 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-02-12T03:43:50.735013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.92681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T03:43:50.735061Z","caller":"traceutil/trace.go:171","msg":"trace[526140626] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:944; }","duration":"400.057424ms","start":"2026-02-12T03:43:50.33499Z","end":"2026-02-12T03:43:50.735047Z","steps":["trace[526140626] 'agreement among raft nodes before linearized reading'  (duration: 399.869379ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:43:50.73511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:43:50.33496Z","time spent":"400.135456ms","remote":"127.0.0.1:43604","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true "}
{"level":"warn","ts":"2026-02-12T03:43:50.745367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.607379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-02-12T03:43:50.745429Z","caller":"traceutil/trace.go:171","msg":"trace[1793183086] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:944; }","duration":"214.701602ms","start":"2026-02-12T03:43:50.530713Z","end":"2026-02-12T03:43:50.745414Z","steps":["trace[1793183086] 'agreement among raft nodes before linearized reading'  (duration: 214.596399ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:43:50.745272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.782359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-02-12T03:43:50.746613Z","caller":"traceutil/trace.go:171","msg":"trace[1248600239] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:944; }","duration":"322.212324ms","start":"2026-02-12T03:43:50.424391Z","end":"2026-02-12T03:43:50.746603Z","steps":["trace[1248600239] 'agreement among raft nodes before linearized reading'  (duration: 320.687616ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:43:50.746646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:43:50.424369Z","time spent":"322.262484ms","remote":"127.0.0.1:43628","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-02-12T03:43:51.564835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.116557ms","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-02-12T03:43:51.56489Z","caller":"traceutil/trace.go:171","msg":"trace[1584835895] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:946; }","duration":"141.21107ms","start":"2026-02-12T03:43:51.423667Z","end":"2026-02-12T03:43:51.564878Z","steps":["trace[1584835895] 'range keys from in-memory index tree'  (duration: 141.007325ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:43:51.565219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"606.996091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T03:43:51.565259Z","caller":"traceutil/trace.go:171","msg":"trace[625154284] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:946; }","duration":"607.036052ms","start":"2026-02-12T03:43:50.958218Z","end":"2026-02-12T03:43:51.565254Z","steps":["trace[625154284] 'range keys from in-memory index tree'  (duration: 606.933479ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:43:51.565274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:43:50.958153Z","time spent":"607.116424ms","remote":"127.0.0.1:43340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-02-12T03:43:53.198608Z","caller":"traceutil/trace.go:171","msg":"trace[1310458034] transaction","detail":"{read_only:false; response_revision:949; number_of_response:1; }","duration":"452.118261ms","start":"2026-02-12T03:43:52.746371Z","end":"2026-02-12T03:43:53.198489Z","steps":["trace[1310458034] 'process raft request'  (duration: 451.018555ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:43:53.199182Z","caller":"traceutil/trace.go:171","msg":"trace[191587200] linearizableReadLoop","detail":"{readStateIndex:988; appliedIndex:988; }","duration":"445.007628ms","start":"2026-02-12T03:43:52.754164Z","end":"2026-02-12T03:43:53.199171Z","steps":["trace[191587200] 'read index received'  (duration: 445.004138ms)","trace[191587200] 'applied index is now lower than readState.Index'  (duration: 2.92µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T03:43:53.199195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:43:52.746353Z","time spent":"452.771417ms","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:944 > 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-02-12T03:43:53.199812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.642873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-02-12T03:43:53.200181Z","caller":"traceutil/trace.go:171","msg":"trace[637200530] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:949; }","duration":"446.048073ms","start":"2026-02-12T03:43:52.754117Z","end":"2026-02-12T03:43:53.200165Z","steps":["trace[637200530] 'agreement among raft nodes before linearized reading'  (duration: 445.590262ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:43:53.200228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:43:52.754101Z","time spent":"446.116165ms","remote":"127.0.0.1:43628","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-02-12T03:43:53.200462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.241885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-02-12T03:43:53.200574Z","caller":"traceutil/trace.go:171","msg":"trace[274975912] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:949; }","duration":"443.380599ms","start":"2026-02-12T03:43:52.757183Z","end":"2026-02-12T03:43:53.200564Z","steps":["trace[274975912] 'agreement among raft nodes before linearized reading'  (duration: 443.159933ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:43:53.200657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.592391ms","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-02-12T03:43:53.200703Z","caller":"traceutil/trace.go:171","msg":"trace[587044267] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:949; }","duration":"377.672193ms","start":"2026-02-12T03:43:52.823018Z","end":"2026-02-12T03:43:53.20069Z","steps":["trace[587044267] 'agreement among raft nodes before linearized reading'  (duration: 377.616281ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:43:53.200739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:43:52.822998Z","time spent":"377.732065ms","remote":"127.0.0.1:43578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":28,"request content":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true "}
{"level":"warn","ts":"2026-02-12T03:43:53.200601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.737801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T03:43:53.200885Z","caller":"traceutil/trace.go:171","msg":"trace[716381490] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:949; }","duration":"249.048258ms","start":"2026-02-12T03:43:52.951828Z","end":"2026-02-12T03:43:53.200876Z","steps":["trace[716381490] 'agreement among raft nodes before linearized reading'  (duration: 248.745511ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:43:53.20085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:43:52.757174Z","time spent":"443.509081ms","remote":"127.0.0.1:43628","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-02-12T03:43:53.798082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.589924ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7835590793849142066 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-12T03:43:53.798501Z","caller":"traceutil/trace.go:171","msg":"trace[2126161498] linearizableReadLoop","detail":"{readStateIndex:990; appliedIndex:988; }","duration":"529.975261ms","start":"2026-02-12T03:43:53.268509Z","end":"2026-02-12T03:43:53.798484Z","steps":["trace[2126161498] 'read index received'  (duration: 73.136516ms)","trace[2126161498] 'applied index is now lower than readState.Index'  (duration: 456.837755ms)"],"step_count":2}
{"level":"info","ts":"2026-02-12T03:43:53.79859Z","caller":"traceutil/trace.go:171","msg":"trace[1258162896] transaction","detail":"{read_only:false; response_revision:950; number_of_response:1; }","duration":"590.923881ms","start":"2026-02-12T03:43:53.207657Z","end":"2026-02-12T03:43:53.79858Z","steps":["trace[1258162896] 'process raft request'  (duration: 133.981944ms)","trace[1258162896] 'compare'  (duration: 455.061972ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T03:43:53.798753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.241428ms","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-02-12T03:43:53.798796Z","caller":"traceutil/trace.go:171","msg":"trace[1982245227] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:951; }","duration":"530.317679ms","start":"2026-02-12T03:43:53.268466Z","end":"2026-02-12T03:43:53.798784Z","steps":["trace[1982245227] 'agreement among raft nodes before linearized reading'  (duration: 530.248718ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:43:53.798829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:43:53.26845Z","time spent":"530.370831ms","remote":"127.0.0.1:41130","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true "}
{"level":"info","ts":"2026-02-12T03:43:53.798994Z","caller":"traceutil/trace.go:171","msg":"trace[137569216] transaction","detail":"{read_only:false; response_revision:951; number_of_response:1; }","duration":"589.947788ms","start":"2026-02-12T03:43:53.209034Z","end":"2026-02-12T03:43:53.798981Z","steps":["trace[137569216] 'process raft request'  (duration: 589.137298ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:43:53.799129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:43:53.209028Z","time spent":"589.988509ms","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:946 > 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-02-12T03:43:53.799658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.268595ms","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-02-12T03:43:53.799694Z","caller":"traceutil/trace.go:171","msg":"trace[1505838110] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:951; }","duration":"219.346247ms","start":"2026-02-12T03:43:53.580338Z","end":"2026-02-12T03:43:53.799684Z","steps":["trace[1505838110] 'agreement among raft nodes before linearized reading'  (duration: 219.231144ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:43:53.800086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.15695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-02-12T03:43:53.800195Z","caller":"traceutil/trace.go:171","msg":"trace[1595212732] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:951; }","duration":"195.233412ms","start":"2026-02-12T03:43:53.604885Z","end":"2026-02-12T03:43:53.800119Z","steps":["trace[1595212732] 'agreement among raft nodes before linearized reading'  (duration: 195.137269ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:43:53.798652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:43:53.207641Z","time spent":"590.973032ms","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"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-02-12T03:43:54.124155Z","caller":"traceutil/trace.go:171","msg":"trace[1573449006] linearizableReadLoop","detail":"{readStateIndex:992; appliedIndex:991; }","duration":"168.570184ms","start":"2026-02-12T03:43:53.955562Z","end":"2026-02-12T03:43:54.124132Z","steps":["trace[1573449006] 'read index received'  (duration: 168.349899ms)","trace[1573449006] 'applied index is now lower than readState.Index'  (duration: 218.695µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T03:43:54.124417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.83187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T03:43:54.124482Z","caller":"traceutil/trace.go:171","msg":"trace[1175273817] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:953; }","duration":"168.952203ms","start":"2026-02-12T03:43:53.955519Z","end":"2026-02-12T03:43:54.124471Z","steps":["trace[1175273817] 'agreement among raft nodes before linearized reading'  (duration: 168.733388ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:43:54.124903Z","caller":"traceutil/trace.go:171","msg":"trace[527236270] transaction","detail":"{read_only:false; response_revision:953; number_of_response:1; }","duration":"319.166742ms","start":"2026-02-12T03:43:53.80572Z","end":"2026-02-12T03:43:54.124887Z","steps":["trace[527236270] 'process raft request'  (duration: 318.252729ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:43:54.124989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:43:53.805713Z","time spent":"319.223333ms","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:948 > 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-02-12T03:43:55.265665Z","caller":"traceutil/trace.go:171","msg":"trace[294667405] transaction","detail":"{read_only:false; response_revision:954; number_of_response:1; }","duration":"195.039516ms","start":"2026-02-12T03:43:55.070594Z","end":"2026-02-12T03:43:55.265634Z","steps":["trace[294667405] 'process raft request'  (duration: 194.750069ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:43:55.471206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.153505ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7835590793849142080 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:15-second id:6cbd9c4ff0b2fb3f>","response":"size:40"}
{"level":"info","ts":"2026-02-12T03:43:55.472484Z","caller":"traceutil/trace.go:171","msg":"trace[171073350] transaction","detail":"{read_only:false; response_revision:955; number_of_response:1; }","duration":"200.608352ms","start":"2026-02-12T03:43:55.271854Z","end":"2026-02-12T03:43:55.472463Z","steps":["trace[171073350] 'process raft request'  (duration: 200.472778ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:43:56.738634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.024681865s","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-02-12T03:43:56.738688Z","caller":"traceutil/trace.go:171","msg":"trace[741480025] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:956; }","duration":"1.024793478s","start":"2026-02-12T03:43:55.713882Z","end":"2026-02-12T03:43:56.738676Z","steps":["trace[741480025] 'count revisions from in-memory index tree'  (duration: 1.024253075s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:43:56.738716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:43:55.713856Z","time spent":"1.024853109s","remote":"127.0.0.1:43408","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":108,"response size":30,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "}
{"level":"warn","ts":"2026-02-12T03:43:56.738942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"935.506139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-02-12T03:43:56.738961Z","caller":"traceutil/trace.go:171","msg":"trace[803565919] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:956; }","duration":"935.571931ms","start":"2026-02-12T03:43:55.803383Z","end":"2026-02-12T03:43:56.738955Z","steps":["trace[803565919] 'range keys from in-memory index tree'  (duration: 935.363686ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:43:56.738978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:43:55.803355Z","time spent":"935.618032ms","remote":"127.0.0.1:43628","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-02-12T03:43:56.739111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"932.761872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-02-12T03:43:56.739134Z","caller":"traceutil/trace.go:171","msg":"trace[484543974] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:956; }","duration":"932.798124ms","start":"2026-02-12T03:43:55.806329Z","end":"2026-02-12T03:43:56.739128Z","steps":["trace[484543974] 'range keys from in-memory index tree'  (duration: 932.67751ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:43:56.739205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:43:55.80632Z","time spent":"932.877876ms","remote":"127.0.0.1:43628","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-02-12T03:43:56.739374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"861.078392ms","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-02-12T03:43:56.739392Z","caller":"traceutil/trace.go:171","msg":"trace[1130551443] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:956; }","duration":"861.138243ms","start":"2026-02-12T03:43:55.878249Z","end":"2026-02-12T03:43:56.739387Z","steps":["trace[1130551443] 'range keys from in-memory index tree'  (duration: 860.974289ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:43:56.739411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:43:55.878224Z","time spent":"861.183275ms","remote":"127.0.0.1:43628","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-02-12T03:43:56.739534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"789.3387ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T03:43:56.739556Z","caller":"traceutil/trace.go:171","msg":"trace[2038125933] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:956; }","duration":"789.413671ms","start":"2026-02-12T03:43:55.950133Z","end":"2026-02-12T03:43:56.739547Z","steps":["trace[2038125933] 'count revisions from in-memory index tree'  (duration: 789.167215ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:43:56.739574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:43:55.950082Z","time spent":"789.487733ms","remote":"127.0.0.1:43510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true "}
{"level":"warn","ts":"2026-02-12T03:43:56.739657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"765.009219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T03:43:56.739672Z","caller":"traceutil/trace.go:171","msg":"trace[824129174] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:956; }","duration":"765.06448ms","start":"2026-02-12T03:43:55.974603Z","end":"2026-02-12T03:43:56.739667Z","steps":["trace[824129174] 'range keys from in-memory index tree'  (duration: 764.933336ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:43:56.739687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:43:55.974577Z","time spent":"765.10629ms","remote":"127.0.0.1:43340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-12T03:43:56.739876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"608.887517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-02-12T03:43:56.739894Z","caller":"traceutil/trace.go:171","msg":"trace[1835187267] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:956; }","duration":"608.946628ms","start":"2026-02-12T03:43:56.130942Z","end":"2026-02-12T03:43:56.739889Z","steps":["trace[1835187267] 'range keys from in-memory index tree'  (duration: 608.781714ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:43:56.73991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:43:56.130921Z","time spent":"608.9855ms","remote":"127.0.0.1:43628","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":"info","ts":"2026-02-12T03:43:57.204737Z","caller":"traceutil/trace.go:171","msg":"trace[1603637422] transaction","detail":"{read_only:false; response_revision:957; number_of_response:1; }","duration":"418.882284ms","start":"2026-02-12T03:43:56.785823Z","end":"2026-02-12T03:43:57.204705Z","steps":["trace[1603637422] 'process raft request'  (duration: 418.635458ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:43:57.205556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:43:56.785801Z","time spent":"419.660022ms","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:953 > 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-02-12T03:43:57.998209Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835590793849142093,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-12T03:43:58.172649Z","caller":"traceutil/trace.go:171","msg":"trace[915672979] transaction","detail":"{read_only:false; response_revision:960; number_of_response:1; }","duration":"1.385010617s","start":"2026-02-12T03:43:56.787618Z","end":"2026-02-12T03:43:58.172628Z","steps":["trace[915672979] 'process raft request'  (duration: 1.384980027s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:43:58.172782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:43:56.787615Z","time spent":"1.385094259s","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:952 > 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-02-12T03:43:58.173255Z","caller":"traceutil/trace.go:171","msg":"trace[107459073] transaction","detail":"{read_only:false; response_revision:958; number_of_response:1; }","duration":"1.385722654s","start":"2026-02-12T03:43:56.787526Z","end":"2026-02-12T03:43:58.173248Z","steps":["trace[107459073] 'process raft request'  (duration: 1.38469182s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:43:58.173337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:43:56.787519Z","time spent":"1.385780646s","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"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-02-12T03:43:58.173455Z","caller":"traceutil/trace.go:171","msg":"trace[765390432] transaction","detail":"{read_only:false; response_revision:959; number_of_response:1; }","duration":"1.385860018s","start":"2026-02-12T03:43:56.787591Z","end":"2026-02-12T03:43:58.173451Z","steps":["trace[765390432] 'process raft request'  (duration: 1.384985917s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:43:58.173605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:43:56.787586Z","time spent":"1.385998422s","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"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":"info","ts":"2026-02-12T03:43:58.261003Z","caller":"traceutil/trace.go:171","msg":"trace[71407089] linearizableReadLoop","detail":"{readStateIndex:1001; appliedIndex:1000; }","duration":"763.760049ms","start":"2026-02-12T03:43:57.49722Z","end":"2026-02-12T03:43:58.26098Z","steps":["trace[71407089] 'read index received'  (duration: 676.153292ms)","trace[71407089] 'applied index is now lower than readState.Index'  (duration: 87.605807ms)"],"step_count":2}
{"level":"info","ts":"2026-02-12T03:43:58.261317Z","caller":"traceutil/trace.go:171","msg":"trace[1045755929] transaction","detail":"{read_only:false; response_revision:961; number_of_response:1; }","duration":"492.729516ms","start":"2026-02-12T03:43:57.768578Z","end":"2026-02-12T03:43:58.261308Z","steps":["trace[1045755929] 'process raft request'  (duration: 492.281575ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:43:58.261433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:43:57.768552Z","time spent":"492.789567ms","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:938 > 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-02-12T03:43:58.261634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"764.413634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-02-12T03:43:58.261656Z","caller":"traceutil/trace.go:171","msg":"trace[391774225] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:961; }","duration":"764.488776ms","start":"2026-02-12T03:43:57.497161Z","end":"2026-02-12T03:43:58.261649Z","steps":["trace[391774225] 'agreement among raft nodes before linearized reading'  (duration: 764.400324ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:43:58.261675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:43:57.497137Z","time spent":"764.534597ms","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-12T03:43:58.26176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.55374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T03:43:58.261774Z","caller":"traceutil/trace.go:171","msg":"trace[1597573090] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:961; }","duration":"298.596731ms","start":"2026-02-12T03:43:57.963173Z","end":"2026-02-12T03:43:58.261769Z","steps":["trace[1597573090] 'agreement among raft nodes before linearized reading'  (duration: 298.57297ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:44:02.283836Z","caller":"traceutil/trace.go:171","msg":"trace[1554196759] transaction","detail":"{read_only:false; response_revision:979; number_of_response:1; }","duration":"198.171483ms","start":"2026-02-12T03:44:02.085642Z","end":"2026-02-12T03:44:02.283813Z","steps":["trace[1554196759] 'process raft request'  (duration: 198.04954ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:44:02.313589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.208322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-02-12T03:44:02.313835Z","caller":"traceutil/trace.go:171","msg":"trace[831684191] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:980; }","duration":"114.47821ms","start":"2026-02-12T03:44:02.199341Z","end":"2026-02-12T03:44:02.31382Z","steps":["trace[831684191] 'agreement among raft nodes before linearized reading'  (duration: 114.0668ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:44:02.314099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.766016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-02-12T03:44:02.314197Z","caller":"traceutil/trace.go:171","msg":"trace[241649885] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:980; }","duration":"114.88999ms","start":"2026-02-12T03:44:02.1993Z","end":"2026-02-12T03:44:02.31419Z","steps":["trace[241649885] 'agreement among raft nodes before linearized reading'  (duration: 114.758006ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:44:02.613875Z","caller":"traceutil/trace.go:171","msg":"trace[1093511026] transaction","detail":"{read_only:false; response_revision:985; number_of_response:1; }","duration":"289.511563ms","start":"2026-02-12T03:44:02.324343Z","end":"2026-02-12T03:44:02.613854Z","steps":["trace[1093511026] 'process raft request'  (duration: 289.485542ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:44:02.614112Z","caller":"traceutil/trace.go:171","msg":"trace[1354916748] transaction","detail":"{read_only:false; response_revision:982; number_of_response:1; }","duration":"291.684115ms","start":"2026-02-12T03:44:02.322422Z","end":"2026-02-12T03:44:02.614106Z","steps":["trace[1354916748] 'process raft request'  (duration: 290.543767ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:44:02.614172Z","caller":"traceutil/trace.go:171","msg":"trace[1258430163] transaction","detail":"{read_only:false; response_revision:983; number_of_response:1; }","duration":"291.586632ms","start":"2026-02-12T03:44:02.322581Z","end":"2026-02-12T03:44:02.614168Z","steps":["trace[1258430163] 'process raft request'  (duration: 291.205383ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:44:02.614226Z","caller":"traceutil/trace.go:171","msg":"trace[522174673] transaction","detail":"{read_only:false; response_revision:984; number_of_response:1; }","duration":"290.039755ms","start":"2026-02-12T03:44:02.324182Z","end":"2026-02-12T03:44:02.614222Z","steps":["trace[522174673] 'process raft request'  (duration: 289.629815ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:44:02.615009Z","caller":"traceutil/trace.go:171","msg":"trace[2007663277] transaction","detail":"{read_only:false; response_revision:986; number_of_response:1; }","duration":"273.626296ms","start":"2026-02-12T03:44:02.341377Z","end":"2026-02-12T03:44:02.615003Z","steps":["trace[2007663277] 'process raft request'  (duration: 273.574474ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:44:04.962001Z","caller":"traceutil/trace.go:171","msg":"trace[1614601971] linearizableReadLoop","detail":"{readStateIndex:1036; appliedIndex:1035; }","duration":"328.510269ms","start":"2026-02-12T03:44:04.633476Z","end":"2026-02-12T03:44:04.961986Z","steps":["trace[1614601971] 'read index received'  (duration: 328.482028ms)","trace[1614601971] 'applied index is now lower than readState.Index'  (duration: 27.621µs)"],"step_count":2}
{"level":"info","ts":"2026-02-12T03:44:04.962166Z","caller":"traceutil/trace.go:171","msg":"trace[1515468129] transaction","detail":"{read_only:false; response_revision:994; number_of_response:1; }","duration":"329.621015ms","start":"2026-02-12T03:44:04.632539Z","end":"2026-02-12T03:44:04.96216Z","steps":["trace[1515468129] 'process raft request'  (duration: 329.298727ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:44:04.962443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.96415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-02-12T03:44:04.962469Z","caller":"traceutil/trace.go:171","msg":"trace[1553175698] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:994; }","duration":"328.99884ms","start":"2026-02-12T03:44:04.633464Z","end":"2026-02-12T03:44:04.962463Z","steps":["trace[1553175698] 'agreement among raft nodes before linearized reading'  (duration: 328.908588ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:44:04.962485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:44:04.633459Z","time spent":"329.022391ms","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-12T03:44:04.962355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:44:04.632528Z","time spent":"329.770589ms","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:982 > 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-02-12T03:44:06.955764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000591696s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-12T03:44:06.956022Z","caller":"traceutil/trace.go:171","msg":"trace[841684823] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000913914s","start":"2026-02-12T03:44:04.955077Z","end":"2026-02-12T03:44:06.955991Z","steps":["trace[841684823] 'agreement among raft nodes before linearized reading'  (duration: 2.000614197s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:44:06.956176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:44:04.955064Z","time spent":"2.001096859s","remote":"127.0.0.1:43340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-12T03:44:07.065318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.92745125s","expected-duration":"100ms","prefix":"","request":"header:<ID:7835590793849142163 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:983 > 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-02-12T03:44:07.067743Z","caller":"traceutil/trace.go:171","msg":"trace[1198583552] transaction","detail":"{read_only:false; response_revision:995; number_of_response:1; }","duration":"2.416491387s","start":"2026-02-12T03:44:04.651228Z","end":"2026-02-12T03:44:07.067719Z","steps":["trace[1198583552] 'process raft request'  (duration: 486.534626ms)","trace[1198583552] 'compare'  (duration: 1.927247285s)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T03:44:07.067886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:44:04.65122Z","time spent":"2.416583149s","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:983 > 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-02-12T03:44:07.068194Z","caller":"traceutil/trace.go:171","msg":"trace[1165466447] transaction","detail":"{read_only:false; response_revision:996; number_of_response:1; }","duration":"2.401136915s","start":"2026-02-12T03:44:04.667047Z","end":"2026-02-12T03:44:07.068184Z","steps":["trace[1165466447] 'process raft request'  (duration: 2.400954251s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:44:07.068231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:44:04.667035Z","time spent":"2.401178736s","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:984 > 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-02-12T03:44:07.068341Z","caller":"traceutil/trace.go:171","msg":"trace[1246915728] linearizableReadLoop","detail":"{readStateIndex:1038; appliedIndex:1036; }","duration":"2.106190052s","start":"2026-02-12T03:44:04.962144Z","end":"2026-02-12T03:44:07.068335Z","steps":["trace[1246915728] 'read index received'  (duration: 175.642336ms)","trace[1246915728] 'applied index is now lower than readState.Index'  (duration: 1.930547066s)"],"step_count":2}
{"level":"info","ts":"2026-02-12T03:44:07.069171Z","caller":"traceutil/trace.go:171","msg":"trace[857269689] transaction","detail":"{read_only:false; response_revision:997; number_of_response:1; }","duration":"2.101714023s","start":"2026-02-12T03:44:04.967442Z","end":"2026-02-12T03:44:07.069156Z","steps":["trace[857269689] 'process raft request'  (duration: 2.100698658s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:44:07.069221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:44:04.967427Z","time spent":"2.101767824s","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:985 > 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-02-12T03:44:07.071029Z","caller":"traceutil/trace.go:171","msg":"trace[2048535467] transaction","detail":"{read_only:false; response_revision:998; number_of_response:1; }","duration":"1.56215592s","start":"2026-02-12T03:44:05.508844Z","end":"2026-02-12T03:44:07.071Z","steps":["trace[2048535467] 'process raft request'  (duration: 1.559502295s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:44:07.071429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.884883417s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.209\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-02-12T03:44:07.07147Z","caller":"traceutil/trace.go:171","msg":"trace[930225246] range","detail":"{range_begin:/registry/masterleases/199.204.45.209; range_end:; response_count:1; response_revision:998; }","duration":"1.884957949s","start":"2026-02-12T03:44:05.186499Z","end":"2026-02-12T03:44:07.071457Z","steps":["trace[930225246] 'agreement among raft nodes before linearized reading'  (duration: 1.884569409s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:44:07.071562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:44:05.186469Z","time spent":"1.885084861s","remote":"127.0.0.1:43374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.209\" "}
{"level":"warn","ts":"2026-02-12T03:44:07.071849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:44:05.508809Z","time spent":"1.562348605s","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:954 > 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-02-12T03:44:07.072291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.707723ms","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-02-12T03:44:07.072325Z","caller":"traceutil/trace.go:171","msg":"trace[1971940386] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:998; }","duration":"104.785425ms","start":"2026-02-12T03:44:06.967533Z","end":"2026-02-12T03:44:07.072319Z","steps":["trace[1971940386] 'agreement among raft nodes before linearized reading'  (duration: 104.630251ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:44:07.07267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.020014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T03:44:07.072697Z","caller":"traceutil/trace.go:171","msg":"trace[1096384979] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:998; }","duration":"115.075255ms","start":"2026-02-12T03:44:06.957612Z","end":"2026-02-12T03:44:07.072687Z","steps":["trace[1096384979] 'agreement among raft nodes before linearized reading'  (duration: 114.964792ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:44:07.074971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.294316ms","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-02-12T03:44:07.075004Z","caller":"traceutil/trace.go:171","msg":"trace[879082600] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:998; }","duration":"268.359818ms","start":"2026-02-12T03:44:06.806631Z","end":"2026-02-12T03:44:07.074991Z","steps":["trace[879082600] 'agreement among raft nodes before linearized reading'  (duration: 268.307807ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:44:07.075429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"887.063773ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-12T03:44:07.075453Z","caller":"traceutil/trace.go:171","msg":"trace[2109672836] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:998; }","duration":"887.127855ms","start":"2026-02-12T03:44:06.188319Z","end":"2026-02-12T03:44:07.075447Z","steps":["trace[2109672836] 'agreement among raft nodes before linearized reading'  (duration: 887.007572ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:44:07.075574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:44:06.188294Z","time spent":"887.174606ms","remote":"127.0.0.1:43536","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":30,"request content":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true "}
{"level":"warn","ts":"2026-02-12T03:44:07.076205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.79813859s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-02-12T03:44:07.076233Z","caller":"traceutil/trace.go:171","msg":"trace[1812333734] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:998; }","duration":"1.798213622s","start":"2026-02-12T03:44:05.278009Z","end":"2026-02-12T03:44:07.076223Z","steps":["trace[1812333734] 'agreement among raft nodes before linearized reading'  (duration: 1.797999667s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:44:07.079135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:44:05.277991Z","time spent":"1.801134853s","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-02-12T03:44:07.319397Z","caller":"traceutil/trace.go:171","msg":"trace[379831880] linearizableReadLoop","detail":"{readStateIndex:1042; appliedIndex:1040; }","duration":"225.416455ms","start":"2026-02-12T03:44:07.093957Z","end":"2026-02-12T03:44:07.319373Z","steps":["trace[379831880] 'read index received'  (duration: 223.075848ms)","trace[379831880] 'applied index is now lower than readState.Index'  (duration: 2.339857ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T03:44:07.319563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.777498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-apiserver-instance.189362cf53727af4\" ","response":"range_response_count:1 size:774"}
{"level":"info","ts":"2026-02-12T03:44:07.319589Z","caller":"traceutil/trace.go:171","msg":"trace[2120900900] range","detail":"{range_begin:/registry/events/kube-system/kube-apiserver-instance.189362cf53727af4; range_end:; response_count:1; response_revision:1000; }","duration":"226.88641ms","start":"2026-02-12T03:44:07.092691Z","end":"2026-02-12T03:44:07.319578Z","steps":["trace[2120900900] 'agreement among raft nodes before linearized reading'  (duration: 226.763097ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:44:07.319815Z","caller":"traceutil/trace.go:171","msg":"trace[1161836114] transaction","detail":"{read_only:false; response_revision:1000; number_of_response:1; }","duration":"223.225372ms","start":"2026-02-12T03:44:07.096582Z","end":"2026-02-12T03:44:07.319808Z","steps":["trace[1161836114] 'process raft request'  (duration: 222.75323ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:44:07.319975Z","caller":"traceutil/trace.go:171","msg":"trace[1524919121] transaction","detail":"{read_only:false; response_revision:999; number_of_response:1; }","duration":"227.097075ms","start":"2026-02-12T03:44:07.092853Z","end":"2026-02-12T03:44:07.31995Z","steps":["trace[1524919121] 'process raft request'  (duration: 224.162514ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:44:15.302003Z","caller":"traceutil/trace.go:171","msg":"trace[1147103065] linearizableReadLoop","detail":"{readStateIndex:1085; appliedIndex:1084; }","duration":"114.893624ms","start":"2026-02-12T03:44:15.187066Z","end":"2026-02-12T03:44:15.301959Z","steps":["trace[1147103065] 'read index received'  (duration: 114.123905ms)","trace[1147103065] 'applied index is now lower than readState.Index'  (duration: 768.169µs)"],"step_count":2}
{"level":"info","ts":"2026-02-12T03:44:15.303569Z","caller":"traceutil/trace.go:171","msg":"trace[728048174] transaction","detail":"{read_only:false; response_revision:1041; number_of_response:1; }","duration":"177.262443ms","start":"2026-02-12T03:44:15.126286Z","end":"2026-02-12T03:44:15.303548Z","steps":["trace[728048174] 'process raft request'  (duration: 175.006407ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:44:15.303961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.872573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.209\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-02-12T03:44:15.304011Z","caller":"traceutil/trace.go:171","msg":"trace[779589540] range","detail":"{range_begin:/registry/masterleases/199.204.45.209; range_end:; response_count:1; response_revision:1041; }","duration":"116.974356ms","start":"2026-02-12T03:44:15.187021Z","end":"2026-02-12T03:44:15.303995Z","steps":["trace[779589540] 'agreement among raft nodes before linearized reading'  (duration: 116.791251ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:44:15.528094Z","caller":"traceutil/trace.go:171","msg":"trace[1662935682] transaction","detail":"{read_only:false; response_revision:1043; number_of_response:1; }","duration":"204.087404ms","start":"2026-02-12T03:44:15.323904Z","end":"2026-02-12T03:44:15.527991Z","steps":["trace[1662935682] 'process raft request'  (duration: 111.175322ms)","trace[1662935682] 'compare'  (duration: 84.760691ms)"],"step_count":2}
{"level":"info","ts":"2026-02-12T03:44:15.528563Z","caller":"traceutil/trace.go:171","msg":"trace[1491847047] transaction","detail":"{read_only:false; response_revision:1044; number_of_response:1; }","duration":"204.547426ms","start":"2026-02-12T03:44:15.324008Z","end":"2026-02-12T03:44:15.528555Z","steps":["trace[1491847047] 'process raft request'  (duration: 203.10839ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:44:15.530845Z","caller":"traceutil/trace.go:171","msg":"trace[1006748631] linearizableReadLoop","detail":"{readStateIndex:1089; appliedIndex:1087; }","duration":"142.609018ms","start":"2026-02-12T03:44:15.388218Z","end":"2026-02-12T03:44:15.530827Z","steps":["trace[1006748631] 'read index received'  (duration: 46.706192ms)","trace[1006748631] 'applied index is now lower than readState.Index'  (duration: 95.901226ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T03:44:15.531149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.916015ms","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-02-12T03:44:15.531177Z","caller":"traceutil/trace.go:171","msg":"trace[902570387] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1044; }","duration":"143.223983ms","start":"2026-02-12T03:44:15.387946Z","end":"2026-02-12T03:44:15.53117Z","steps":["trace[902570387] 'agreement among raft nodes before linearized reading'  (duration: 143.003178ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:44:16.893037Z","caller":"traceutil/trace.go:171","msg":"trace[409666272] transaction","detail":"{read_only:false; response_revision:1050; number_of_response:1; }","duration":"133.332499ms","start":"2026-02-12T03:44:16.759548Z","end":"2026-02-12T03:44:16.89288Z","steps":["trace[409666272] 'process raft request'  (duration: 95.229869ms)","trace[409666272] 'compare'  (duration: 37.968957ms)"],"step_count":2}
{"level":"info","ts":"2026-02-12T03:44:17.16743Z","caller":"traceutil/trace.go:171","msg":"trace[1162426467] transaction","detail":"{read_only:false; response_revision:1052; number_of_response:1; }","duration":"267.434257ms","start":"2026-02-12T03:44:16.899942Z","end":"2026-02-12T03:44:17.167377Z","steps":["trace[1162426467] 'process raft request'  (duration: 171.378937ms)","trace[1162426467] 'compare'  (duration: 95.823644ms)"],"step_count":2}
{"level":"info","ts":"2026-02-12T03:44:17.167544Z","caller":"traceutil/trace.go:171","msg":"trace[655222370] transaction","detail":"{read_only:false; response_revision:1054; number_of_response:1; }","duration":"193.108604ms","start":"2026-02-12T03:44:16.97439Z","end":"2026-02-12T03:44:17.167499Z","steps":["trace[655222370] 'process raft request'  (duration: 193.023672ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:44:17.167821Z","caller":"traceutil/trace.go:171","msg":"trace[1475351686] linearizableReadLoop","detail":"{readStateIndex:1097; appliedIndex:1096; }","duration":"200.105226ms","start":"2026-02-12T03:44:16.967701Z","end":"2026-02-12T03:44:17.167806Z","steps":["trace[1475351686] 'read index received'  (duration: 103.635037ms)","trace[1475351686] 'applied index is now lower than readState.Index'  (duration: 96.468919ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T03:44:17.167953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.094707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T03:44:17.168Z","caller":"traceutil/trace.go:171","msg":"trace[1048595343] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1054; }","duration":"209.19506ms","start":"2026-02-12T03:44:16.958794Z","end":"2026-02-12T03:44:17.167989Z","steps":["trace[1048595343] 'agreement among raft nodes before linearized reading'  (duration: 209.052946ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:44:17.168133Z","caller":"traceutil/trace.go:171","msg":"trace[1485053631] transaction","detail":"{read_only:false; response_revision:1053; number_of_response:1; }","duration":"195.317398ms","start":"2026-02-12T03:44:16.972801Z","end":"2026-02-12T03:44:17.168118Z","steps":["trace[1485053631] 'process raft request'  (duration: 194.56633ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:44:17.176531Z","caller":"traceutil/trace.go:171","msg":"trace[1644702359] transaction","detail":"{read_only:false; response_revision:1055; number_of_response:1; }","duration":"103.708578ms","start":"2026-02-12T03:44:17.072802Z","end":"2026-02-12T03:44:17.17651Z","steps":["trace[1644702359] 'process raft request'  (duration: 103.591755ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:44:19.952443Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835590793849142324,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-12T03:44:20.012142Z","caller":"traceutil/trace.go:171","msg":"trace[1298677231] transaction","detail":"{read_only:false; response_revision:1077; number_of_response:1; }","duration":"671.162064ms","start":"2026-02-12T03:44:19.340956Z","end":"2026-02-12T03:44:20.012118Z","steps":["trace[1298677231] 'process raft request'  (duration: 671.027411ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:44:20.01254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:44:19.340926Z","time spent":"671.530833ms","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:1060 > 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-02-12T03:44:20.012993Z","caller":"traceutil/trace.go:171","msg":"trace[1197413854] linearizableReadLoop","detail":"{readStateIndex:1122; appliedIndex:1122; }","duration":"560.680738ms","start":"2026-02-12T03:44:19.452303Z","end":"2026-02-12T03:44:20.012984Z","steps":["trace[1197413854] 'read index received'  (duration: 560.676368ms)","trace[1197413854] 'applied index is now lower than readState.Index'  (duration: 3.53µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T03:44:20.013148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.058767ms","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-02-12T03:44:20.01322Z","caller":"traceutil/trace.go:171","msg":"trace[71057904] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1077; }","duration":"503.214531ms","start":"2026-02-12T03:44:19.509999Z","end":"2026-02-12T03:44:20.013213Z","steps":["trace[71057904] 'agreement among raft nodes before linearized reading'  (duration: 503.078478ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:44:20.013344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:44:19.509973Z","time spent":"503.363145ms","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":556,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "}
{"level":"warn","ts":"2026-02-12T03:44:20.013541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"561.240603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-02-12T03:44:20.013635Z","caller":"traceutil/trace.go:171","msg":"trace[1421217674] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1077; }","duration":"561.369455ms","start":"2026-02-12T03:44:19.452257Z","end":"2026-02-12T03:44:20.013626Z","steps":["trace[1421217674] 'agreement among raft nodes before linearized reading'  (duration: 561.235682ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:44:20.013686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:44:19.452233Z","time spent":"561.447008ms","remote":"127.0.0.1:43628","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-02-12T03:44:20.013897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.246041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-02-12T03:44:20.013951Z","caller":"traceutil/trace.go:171","msg":"trace[1618761236] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1077; }","duration":"372.337883ms","start":"2026-02-12T03:44:19.641608Z","end":"2026-02-12T03:44:20.013946Z","steps":["trace[1618761236] 'agreement among raft nodes before linearized reading'  (duration: 372.250531ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:44:20.013996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:44:19.6416Z","time spent":"372.386794ms","remote":"127.0.0.1:43628","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-02-12T03:44:20.01413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.576349ms","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-02-12T03:44:20.014182Z","caller":"traceutil/trace.go:171","msg":"trace[1129249179] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1077; }","duration":"372.677281ms","start":"2026-02-12T03:44:19.641499Z","end":"2026-02-12T03:44:20.014176Z","steps":["trace[1129249179] 'agreement among raft nodes before linearized reading'  (duration: 372.589349ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:44:20.01424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:44:19.641467Z","time spent":"372.765623ms","remote":"127.0.0.1:43628","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-02-12T03:44:20.014432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.075396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-02-12T03:44:20.014503Z","caller":"traceutil/trace.go:171","msg":"trace[2014386717] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1077; }","duration":"404.181428ms","start":"2026-02-12T03:44:19.610313Z","end":"2026-02-12T03:44:20.014495Z","steps":["trace[2014386717] 'agreement among raft nodes before linearized reading'  (duration: 404.069145ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:44:20.014576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:44:19.610291Z","time spent":"404.2657ms","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-02-12T03:44:20.529349Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835590793849142327,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-12T03:44:21.042909Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835590793849142327,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-12T03:44:21.544379Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835590793849142327,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-12T03:44:21.806047Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.778028888s","expected-duration":"1s"}
{"level":"warn","ts":"2026-02-12T03:44:22.019874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.991425812s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-12T03:44:22.019963Z","caller":"traceutil/trace.go:171","msg":"trace[521382292] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"1.991553354s","start":"2026-02-12T03:44:20.028388Z","end":"2026-02-12T03:44:22.019941Z","steps":["trace[521382292] 'agreement among raft nodes before linearized reading'  (duration: 1.991439842s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:44:22.020014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:44:20.028378Z","time spent":"1.991626187s","remote":"127.0.0.1:43354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/02/12 03:44:22 WARNING: [core] [Server #6] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-12T03:44:22.634444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"827.859141ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7835590793849142328 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:1067 > 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-02-12T03:44:22.634821Z","caller":"traceutil/trace.go:171","msg":"trace[1524224860] linearizableReadLoop","detail":"{readStateIndex:1127; appliedIndex:1122; }","duration":"2.606395031s","start":"2026-02-12T03:44:20.028413Z","end":"2026-02-12T03:44:22.634808Z","steps":["trace[1524224860] 'read index received'  (duration: 1.77810295s)","trace[1524224860] 'applied index is now lower than readState.Index'  (duration: 828.291381ms)"],"step_count":2}
{"level":"info","ts":"2026-02-12T03:44:22.635046Z","caller":"traceutil/trace.go:171","msg":"trace[1891324427] transaction","detail":"{read_only:false; response_revision:1078; number_of_response:1; }","duration":"2.607135969s","start":"2026-02-12T03:44:20.027901Z","end":"2026-02-12T03:44:22.635037Z","steps":["trace[1891324427] 'process raft request'  (duration: 1.778600011s)","trace[1891324427] 'compare'  (duration: 827.446431ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T03:44:22.635139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:44:20.027877Z","time spent":"2.60719417s","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:1067 > 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-02-12T03:44:22.635367Z","caller":"traceutil/trace.go:171","msg":"trace[1622505153] transaction","detail":"{read_only:false; response_revision:1079; number_of_response:1; }","duration":"2.606898353s","start":"2026-02-12T03:44:20.028458Z","end":"2026-02-12T03:44:22.635357Z","steps":["trace[1622505153] 'process raft request'  (duration: 2.606068203s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:44:22.635408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:44:20.028453Z","time spent":"2.606936084s","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:1068 > 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-02-12T03:44:22.635637Z","caller":"traceutil/trace.go:171","msg":"trace[443255047] transaction","detail":"{read_only:false; response_revision:1080; number_of_response:1; }","duration":"2.604553255s","start":"2026-02-12T03:44:20.031076Z","end":"2026-02-12T03:44:22.635629Z","steps":["trace[443255047] 'process raft request'  (duration: 2.603483539s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:44:22.635676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:44:20.031067Z","time spent":"2.604591546s","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:1062 > 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-02-12T03:44:22.636648Z","caller":"traceutil/trace.go:171","msg":"trace[2131436862] transaction","detail":"{read_only:false; response_revision:1081; number_of_response:1; }","duration":"2.604237868s","start":"2026-02-12T03:44:20.03166Z","end":"2026-02-12T03:44:22.635898Z","steps":["trace[2131436862] 'process raft request'  (duration: 2.602917625s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:44:22.636704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:44:20.031652Z","time spent":"2.605024687s","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:1066 > 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-02-12T03:44:22.636807Z","caller":"traceutil/trace.go:171","msg":"trace[290996836] transaction","detail":"{read_only:false; response_revision:1082; number_of_response:1; }","duration":"2.595042911s","start":"2026-02-12T03:44:20.041756Z","end":"2026-02-12T03:44:22.636799Z","steps":["trace[290996836] 'process raft request'  (duration: 2.593024211s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:44:22.636849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:44:20.041727Z","time spent":"2.595095842s","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":518,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" mod_revision:1065 > 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":"warn","ts":"2026-02-12T03:44:22.658433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.58607588s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-12T03:44:22.658507Z","caller":"traceutil/trace.go:171","msg":"trace[482786442] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:1082; }","duration":"2.586206583s","start":"2026-02-12T03:44:20.072285Z","end":"2026-02-12T03:44:22.658491Z","steps":["trace[482786442] 'agreement among raft nodes before linearized reading'  (duration: 2.58605696s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:44:22.658542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:44:20.072234Z","time spent":"2.586300295s","remote":"127.0.0.1:43696","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":14,"response size":30,"request content":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true "}
{"level":"warn","ts":"2026-02-12T03:44:22.65887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"612.700633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-apiserver-instance.189362cf53727af4\" ","response":"range_response_count:1 size:774"}
{"level":"warn","ts":"2026-02-12T03:44:22.658831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"599.104578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-02-12T03:44:22.658901Z","caller":"traceutil/trace.go:171","msg":"trace[1152560777] range","detail":"{range_begin:/registry/events/kube-system/kube-apiserver-instance.189362cf53727af4; range_end:; response_count:1; response_revision:1082; }","duration":"612.768965ms","start":"2026-02-12T03:44:22.046124Z","end":"2026-02-12T03:44:22.658893Z","steps":["trace[1152560777] 'agreement among raft nodes before linearized reading'  (duration: 612.656482ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:44:22.659069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:44:22.046106Z","time spent":"612.953569ms","remote":"127.0.0.1:43408","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":797,"request content":"key:\"/registry/events/kube-system/kube-apiserver-instance.189362cf53727af4\" "}
{"level":"info","ts":"2026-02-12T03:44:22.659042Z","caller":"traceutil/trace.go:171","msg":"trace[1071430847] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1082; }","duration":"599.402815ms","start":"2026-02-12T03:44:22.059622Z","end":"2026-02-12T03:44:22.659025Z","steps":["trace[1071430847] 'agreement among raft nodes before linearized reading'  (duration: 598.733659ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:44:22.659294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:44:22.059601Z","time spent":"599.682352ms","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-12T03:44:22.65973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.321579919s","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:508"}
{"level":"info","ts":"2026-02-12T03:44:22.659762Z","caller":"traceutil/trace.go:171","msg":"trace[511701141] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1082; }","duration":"1.321615019s","start":"2026-02-12T03:44:21.338139Z","end":"2026-02-12T03:44:22.659754Z","steps":["trace[511701141] 'agreement among raft nodes before linearized reading'  (duration: 1.321440185s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:44:22.659856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:44:21.338067Z","time spent":"1.321712312s","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "}
{"level":"warn","ts":"2026-02-12T03:44:22.659947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.442900868s","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-02-12T03:44:22.659967Z","caller":"traceutil/trace.go:171","msg":"trace[728292276] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:1082; }","duration":"2.44295284s","start":"2026-02-12T03:44:20.217006Z","end":"2026-02-12T03:44:22.659959Z","steps":["trace[728292276] 'agreement among raft nodes before linearized reading'  (duration: 2.442918669s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:44:22.660019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:44:20.216985Z","time spent":"2.4429971s","remote":"127.0.0.1:33552","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true "}
{"level":"warn","ts":"2026-02-12T03:44:22.661347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"484.83607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:527"}
{"level":"info","ts":"2026-02-12T03:44:22.661458Z","caller":"traceutil/trace.go:171","msg":"trace[1931962901] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1082; }","duration":"485.017406ms","start":"2026-02-12T03:44:22.176402Z","end":"2026-02-12T03:44:22.66142Z","steps":["trace[1931962901] 'agreement among raft nodes before linearized reading'  (duration: 484.735089ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:44:22.662102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:44:22.176379Z","time spent":"485.710562ms","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":550,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "}
{"level":"warn","ts":"2026-02-12T03:44:22.661363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"580.741347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T03:44:22.667499Z","caller":"traceutil/trace.go:171","msg":"trace[1458584797] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1082; }","duration":"586.765466ms","start":"2026-02-12T03:44:22.080612Z","end":"2026-02-12T03:44:22.667377Z","steps":["trace[1458584797] 'agreement among raft nodes before linearized reading'  (duration: 580.724257ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:44:22.667681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:44:22.080587Z","time spent":"587.026282ms","remote":"127.0.0.1:43340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-12T03:45:08.157646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.866467ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7835590793849142812 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:1244 > success:<request_put:<key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" value_size:424 >> failure:<request_range:<key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-12T03:45:08.157782Z","caller":"traceutil/trace.go:171","msg":"trace[1137769777] transaction","detail":"{read_only:false; response_revision:1268; number_of_response:1; }","duration":"111.10613ms","start":"2026-02-12T03:45:08.046662Z","end":"2026-02-12T03:45:08.157768Z","steps":["trace[1137769777] 'process raft request'  (duration: 111.070789ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:45:08.157958Z","caller":"traceutil/trace.go:171","msg":"trace[2072321859] linearizableReadLoop","detail":"{readStateIndex:1322; appliedIndex:1321; }","duration":"204.229148ms","start":"2026-02-12T03:45:07.953722Z","end":"2026-02-12T03:45:08.157951Z","steps":["trace[2072321859] 'read index received'  (duration: 70.93047ms)","trace[2072321859] 'applied index is now lower than readState.Index'  (duration: 133.297718ms)"],"step_count":2}
{"level":"info","ts":"2026-02-12T03:45:08.157939Z","caller":"traceutil/trace.go:171","msg":"trace[407244730] transaction","detail":"{read_only:false; response_revision:1267; number_of_response:1; }","duration":"231.760597ms","start":"2026-02-12T03:45:07.926147Z","end":"2026-02-12T03:45:08.157908Z","steps":["trace[407244730] 'process raft request'  (duration: 98.560101ms)","trace[407244730] 'compare'  (duration: 132.753715ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T03:45:08.158015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.292129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T03:45:08.158029Z","caller":"traceutil/trace.go:171","msg":"trace[831878015] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1268; }","duration":"204.33028ms","start":"2026-02-12T03:45:07.953695Z","end":"2026-02-12T03:45:08.158025Z","steps":["trace[831878015] 'agreement among raft nodes before linearized reading'  (duration: 204.275268ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:45:08.39578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.345105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-12T03:45:08.395865Z","caller":"traceutil/trace.go:171","msg":"trace[1911491696] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:1268; }","duration":"117.477968ms","start":"2026-02-12T03:45:08.278366Z","end":"2026-02-12T03:45:08.395844Z","steps":["trace[1911491696] 'count revisions from in-memory index tree'  (duration: 117.236452ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:45:08.545542Z","caller":"traceutil/trace.go:171","msg":"trace[1825717619] transaction","detail":"{read_only:false; response_revision:1269; number_of_response:1; }","duration":"126.342077ms","start":"2026-02-12T03:45:08.419178Z","end":"2026-02-12T03:45:08.54552Z","steps":["trace[1825717619] 'process raft request'  (duration: 126.236604ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:45:09.308276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.530124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-02-12T03:45:09.308352Z","caller":"traceutil/trace.go:171","msg":"trace[1480244510] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1273; }","duration":"103.651367ms","start":"2026-02-12T03:45:09.204682Z","end":"2026-02-12T03:45:09.308333Z","steps":["trace[1480244510] 'range keys from in-memory index tree'  (duration: 103.34826ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:45:10.816036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.240893ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7835590793849142838 > lease_revoke:<id:6cbd9c4ff0b2fd9d>","response":"size:28"}
{"level":"info","ts":"2026-02-12T03:45:11.43487Z","caller":"traceutil/trace.go:171","msg":"trace[1557547764] transaction","detail":"{read_only:false; response_revision:1280; number_of_response:1; }","duration":"250.187311ms","start":"2026-02-12T03:45:11.184653Z","end":"2026-02-12T03:45:11.43484Z","steps":["trace[1557547764] 'process raft request'  (duration: 216.010288ms)","trace[1557547764] 'compare'  (duration: 33.6408ms)"],"step_count":2}
{"level":"info","ts":"2026-02-12T03:45:11.576508Z","caller":"traceutil/trace.go:171","msg":"trace[1098127049] transaction","detail":"{read_only:false; response_revision:1283; number_of_response:1; }","duration":"129.690749ms","start":"2026-02-12T03:45:11.446782Z","end":"2026-02-12T03:45:11.576473Z","steps":["trace[1098127049] 'process raft request'  (duration: 129.609727ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:45:11.578651Z","caller":"traceutil/trace.go:171","msg":"trace[1255273068] transaction","detail":"{read_only:false; response_revision:1282; number_of_response:1; }","duration":"131.909794ms","start":"2026-02-12T03:45:11.446714Z","end":"2026-02-12T03:45:11.578623Z","steps":["trace[1255273068] 'process raft request'  (duration: 90.684547ms)","trace[1255273068] 'compare'  (duration: 38.865359ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T03:47:44.1783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.020437ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T03:47:44.178392Z","caller":"traceutil/trace.go:171","msg":"trace[613973805] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1931; }","duration":"410.116269ms","start":"2026-02-12T03:47:43.768264Z","end":"2026-02-12T03:47:44.17838Z","steps":["trace[613973805] 'range keys from in-memory index tree'  (duration: 409.990857ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:47:44.178418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.920189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"warn","ts":"2026-02-12T03:47:44.178698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.861532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:473"}
{"level":"info","ts":"2026-02-12T03:47:44.17872Z","caller":"traceutil/trace.go:171","msg":"trace[1308856691] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1931; }","duration":"318.893523ms","start":"2026-02-12T03:47:43.85982Z","end":"2026-02-12T03:47:44.178714Z","steps":["trace[1308856691] 'range keys from in-memory index tree'  (duration: 318.798811ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:47:44.178713Z","caller":"traceutil/trace.go:171","msg":"trace[152798441] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1931; }","duration":"299.254117ms","start":"2026-02-12T03:47:43.879444Z","end":"2026-02-12T03:47:44.178698Z","steps":["trace[152798441] 'range keys from in-memory index tree'  (duration: 298.756155ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:47:44.178742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:47:43.859814Z","time spent":"318.923334ms","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":496,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "}
{"level":"warn","ts":"2026-02-12T03:47:44.178865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.480491ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T03:47:44.178885Z","caller":"traceutil/trace.go:171","msg":"trace[1783430292] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1931; }","duration":"224.537122ms","start":"2026-02-12T03:47:43.954341Z","end":"2026-02-12T03:47:44.178879Z","steps":["trace[1783430292] 'range keys from in-memory index tree'  (duration: 224.41558ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:47:44.178638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.298027ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-02-12T03:47:44.179003Z","caller":"traceutil/trace.go:171","msg":"trace[584964563] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1931; }","duration":"323.701927ms","start":"2026-02-12T03:47:43.855295Z","end":"2026-02-12T03:47:44.178997Z","steps":["trace[584964563] 'range keys from in-memory index tree'  (duration: 323.130674ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:47:44.179028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:47:43.855275Z","time spent":"323.745339ms","remote":"127.0.0.1:43628","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\" "}