{"level":"warn","ts":"2026-03-01T21:12:13.514009Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-01T21:12:13.514126Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.235: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.235:2380","--initial-cluster=instance=https://199.204.45.235:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.235:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.235: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-03-01T21:12:13.514217Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-01T21:12:13.514231Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.235:2380"]}
{"level":"info","ts":"2026-03-01T21:12:13.514258Z","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-03-01T21:12:13.515065Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.235:2379"]}
{"level":"info","ts":"2026-03-01T21:12:13.515155Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.235:2380"],"listen-peer-urls":["https://199.204.45.235:2380"],"advertise-client-urls":["https://199.204.45.235:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.235:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.235: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-03-01T21:12:13.519873Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.480417ms"}
{"level":"info","ts":"2026-03-01T21:12:13.532297Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"aab6040abcf11","cluster-id":"2bae7d3d8857c059"}
{"level":"info","ts":"2026-03-01T21:12:13.532424Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 switched to configuration voters=()"}
{"level":"info","ts":"2026-03-01T21:12:13.532467Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became follower at term 0"}
{"level":"info","ts":"2026-03-01T21:12:13.532483Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft aab6040abcf11 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-03-01T21:12:13.532496Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became follower at term 1"}
{"level":"info","ts":"2026-03-01T21:12:13.532545Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 switched to configuration voters=(3003179657318161)"}
{"level":"warn","ts":"2026-03-01T21:12:13.540174Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-03-01T21:12:13.543798Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-03-01T21:12:13.546191Z","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-03-01T21:12:13.55176Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"aab6040abcf11","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-03-01T21:12:13.553409Z","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-03-01T21:12:13.553515Z","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-03-01T21:12:13.553529Z","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-03-01T21:12:13.558427Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"aab6040abcf11","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-03-01T21:12:13.558656Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 switched to configuration voters=(3003179657318161)"}
{"level":"info","ts":"2026-03-01T21:12:13.558825Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"2bae7d3d8857c059","local-member-id":"aab6040abcf11","added-peer-id":"aab6040abcf11","added-peer-peer-urls":["https://199.204.45.235:2380"]}
{"level":"info","ts":"2026-03-01T21:12:13.560032Z","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-03-01T21:12:13.560201Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.235:2380"}
{"level":"info","ts":"2026-03-01T21:12:13.560237Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.235:2380"}
{"level":"info","ts":"2026-03-01T21:12:13.560434Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"aab6040abcf11","initial-advertise-peer-urls":["https://199.204.45.235:2380"],"listen-peer-urls":["https://199.204.45.235:2380"],"advertise-client-urls":["https://199.204.45.235:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.235:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-03-01T21:12:13.560481Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-03-01T21:12:13.733189Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 is starting a new election at term 1"}
{"level":"info","ts":"2026-03-01T21:12:13.733307Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became pre-candidate at term 1"}
{"level":"info","ts":"2026-03-01T21:12:13.733338Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 received MsgPreVoteResp from aab6040abcf11 at term 1"}
{"level":"info","ts":"2026-03-01T21:12:13.733569Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became candidate at term 2"}
{"level":"info","ts":"2026-03-01T21:12:13.733583Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 received MsgVoteResp from aab6040abcf11 at term 2"}
{"level":"info","ts":"2026-03-01T21:12:13.733608Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became leader at term 2"}
{"level":"info","ts":"2026-03-01T21:12:13.733769Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: aab6040abcf11 elected leader aab6040abcf11 at term 2"}
{"level":"info","ts":"2026-03-01T21:12:13.73579Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-01T21:12:13.737445Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"aab6040abcf11","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.235:2379]}","request-path":"/0/members/aab6040abcf11/attributes","cluster-id":"2bae7d3d8857c059","publish-timeout":"7s"}
{"level":"info","ts":"2026-03-01T21:12:13.737465Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-01T21:12:13.737654Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-01T21:12:13.738026Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"2bae7d3d8857c059","local-member-id":"aab6040abcf11","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-01T21:12:13.74264Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-01T21:12:13.742838Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-01T21:12:13.742952Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-03-01T21:12:13.743046Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-03-01T21:12:13.744447Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-03-01T21:12:13.74564Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.235:2379"}
{"level":"warn","ts":"2026-03-01T21:12:19.417023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"864.942173ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14920879299759038026 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/default/instance.1898d3fbff592f90\" mod_revision:239 > success:<request_put:<key:\"/registry/events/default/instance.1898d3fbff592f90\" value_size:568 lease:5697507262904262147 >> failure:<request_range:<key:\"/registry/events/default/instance.1898d3fbff592f90\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-01T21:12:19.417206Z","caller":"traceutil/trace.go:171","msg":"trace[1854507312] linearizableReadLoop","detail":"{readStateIndex:249; appliedIndex:248; }","duration":"1.080447245s","start":"2026-03-01T21:12:18.336734Z","end":"2026-03-01T21:12:19.417182Z","steps":["trace[1854507312] 'read index received'  (duration: 214.458079ms)","trace[1854507312] 'applied index is now lower than readState.Index'  (duration: 865.987446ms)"],"step_count":2}
{"level":"info","ts":"2026-03-01T21:12:19.417231Z","caller":"traceutil/trace.go:171","msg":"trace[2088201997] transaction","detail":"{read_only:false; response_revision:243; number_of_response:1; }","duration":"1.090577799s","start":"2026-03-01T21:12:18.326627Z","end":"2026-03-01T21:12:19.417204Z","steps":["trace[2088201997] 'process raft request'  (duration: 224.701524ms)","trace[2088201997] 'compare'  (duration: 864.76931ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-01T21:12:19.417389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.08064508s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3709"}
{"level":"warn","ts":"2026-03-01T21:12:19.41739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:12:18.326614Z","time spent":"1.090679821s","remote":"127.0.0.1:37304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":636,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/events/default/instance.1898d3fbff592f90\" mod_revision:239 > success:<request_put:<key:\"/registry/events/default/instance.1898d3fbff592f90\" value_size:568 lease:5697507262904262147 >> failure:<request_range:<key:\"/registry/events/default/instance.1898d3fbff592f90\" > >"}
{"level":"info","ts":"2026-03-01T21:12:19.417443Z","caller":"traceutil/trace.go:171","msg":"trace[297908585] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:243; }","duration":"1.080732992s","start":"2026-03-01T21:12:18.336693Z","end":"2026-03-01T21:12:19.417426Z","steps":["trace[297908585] 'agreement among raft nodes before linearized reading'  (duration: 1.080606289s)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T21:12:19.417495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:12:18.33668Z","time spent":"1.080801634s","remote":"127.0.0.1:37384","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3730,"request content":"key:\"/registry/minions/instance\" "}
{"level":"warn","ts":"2026-03-01T21:12:20.442594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"739.785771ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14920879299759038027 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/kube-system/kube-scheduler-instance\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/kube-scheduler-instance\" value_size:2847 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-03-01T21:12:20.4427Z","caller":"traceutil/trace.go:171","msg":"trace[1631389840] linearizableReadLoop","detail":"{readStateIndex:250; appliedIndex:249; }","duration":"1.02542438s","start":"2026-03-01T21:12:19.417258Z","end":"2026-03-01T21:12:20.442683Z","steps":["trace[1631389840] 'read index received'  (duration: 285.357972ms)","trace[1631389840] 'applied index is now lower than readState.Index'  (duration: 740.064888ms)"],"step_count":2}
{"level":"info","ts":"2026-03-01T21:12:20.442758Z","caller":"traceutil/trace.go:171","msg":"trace[1263876357] transaction","detail":"{read_only:false; response_revision:244; number_of_response:1; }","duration":"1.356283701s","start":"2026-03-01T21:12:19.086422Z","end":"2026-03-01T21:12:20.442705Z","steps":["trace[1263876357] 'process raft request'  (duration: 616.322996ms)","trace[1263876357] 'compare'  (duration: 739.320091ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-01T21:12:20.442965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:12:19.086391Z","time spent":"1.356470385s","remote":"127.0.0.1:37394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2905,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-scheduler-instance\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/kube-scheduler-instance\" value_size:2847 >> failure:<>"}
{"level":"warn","ts":"2026-03-01T21:12:20.443396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.097275577s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"}
{"level":"info","ts":"2026-03-01T21:12:20.443535Z","caller":"traceutil/trace.go:171","msg":"trace[327108631] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:244; }","duration":"2.0973966s","start":"2026-03-01T21:12:18.346068Z","end":"2026-03-01T21:12:20.443465Z","steps":["trace[327108631] 'agreement among raft nodes before linearized reading'  (duration: 2.096660334s)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T21:12:20.443582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:12:18.346005Z","time spent":"2.097567284s","remote":"127.0.0.1:37344","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":372,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"info","ts":"2026-03-01T21:12:20.619284Z","caller":"traceutil/trace.go:171","msg":"trace[1809900443] transaction","detail":"{read_only:false; response_revision:245; number_of_response:1; }","duration":"1.191318006s","start":"2026-03-01T21:12:19.427942Z","end":"2026-03-01T21:12:20.61926Z","steps":["trace[1809900443] 'process raft request'  (duration: 1.182656836s)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T21:12:20.619419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:12:19.427929Z","time spent":"1.191418718s","remote":"127.0.0.1:37384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4003,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:210 > success:<request_put:<key:\"/registry/minions/instance\" value_size:3969 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"info","ts":"2026-03-01T21:12:20.619572Z","caller":"traceutil/trace.go:171","msg":"trace[1708297531] linearizableReadLoop","detail":"{readStateIndex:251; appliedIndex:250; }","duration":"176.826524ms","start":"2026-03-01T21:12:20.442715Z","end":"2026-03-01T21:12:20.619542Z","steps":["trace[1708297531] 'read index received'  (duration: 167.900079ms)","trace[1708297531] 'applied index is now lower than readState.Index'  (duration: 8.923825ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-01T21:12:20.619643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"982.208223ms","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-03-01T21:12:20.619675Z","caller":"traceutil/trace.go:171","msg":"trace[388422588] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:245; }","duration":"982.289225ms","start":"2026-03-01T21:12:19.637378Z","end":"2026-03-01T21:12:20.619667Z","steps":["trace[388422588] 'agreement among raft nodes before linearized reading'  (duration: 982.234733ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T21:12:20.619696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:12:19.637352Z","time spent":"982.339216ms","remote":"127.0.0.1:37480","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":"warn","ts":"2026-03-01T21:12:20.619698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"681.79089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-01T21:12:20.619726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"707.389661ms","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-03-01T21:12:20.619797Z","caller":"traceutil/trace.go:171","msg":"trace[142958174] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:245; }","duration":"707.515154ms","start":"2026-03-01T21:12:19.912261Z","end":"2026-03-01T21:12:20.619776Z","steps":["trace[142958174] 'agreement among raft nodes before linearized reading'  (duration: 707.33613ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T21:12:20.619794Z","caller":"traceutil/trace.go:171","msg":"trace[811399776] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:245; }","duration":"681.937014ms","start":"2026-03-01T21:12:19.937831Z","end":"2026-03-01T21:12:20.619768Z","steps":["trace[811399776] 'agreement among raft nodes before linearized reading'  (duration: 681.727109ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T21:12:20.619838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:12:19.912237Z","time spent":"707.592325ms","remote":"127.0.0.1:37480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-03-01T21:12:20.619843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:12:19.937824Z","time spent":"682.010595ms","remote":"127.0.0.1:37480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":26,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-03-01T21:12:20.619726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.197973991s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/default/instance.1898d3fbff58b5e1\" ","response":"range_response_count:1 size:657"}
{"level":"info","ts":"2026-03-01T21:12:20.619945Z","caller":"traceutil/trace.go:171","msg":"trace[1169593904] range","detail":"{range_begin:/registry/events/default/instance.1898d3fbff58b5e1; range_end:; response_count:1; response_revision:245; }","duration":"1.198247336s","start":"2026-03-01T21:12:19.421689Z","end":"2026-03-01T21:12:20.619937Z","steps":["trace[1169593904] 'agreement among raft nodes before linearized reading'  (duration: 1.197976661s)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T21:12:20.619972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:12:19.421669Z","time spent":"1.198295278s","remote":"127.0.0.1:37304","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":678,"request content":"key:\"/registry/events/default/instance.1898d3fbff58b5e1\" "}
{"level":"info","ts":"2026-03-01T21:12:20.619995Z","caller":"traceutil/trace.go:171","msg":"trace[1620124296] transaction","detail":"{read_only:false; response_revision:246; number_of_response:1; }","duration":"135.854388ms","start":"2026-03-01T21:12:20.484099Z","end":"2026-03-01T21:12:20.619953Z","steps":["trace[1620124296] 'process raft request'  (duration: 135.105522ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T21:12:20.620166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"977.095691ms","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-03-01T21:12:20.620209Z","caller":"traceutil/trace.go:171","msg":"trace[390637005] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:245; }","duration":"977.164122ms","start":"2026-03-01T21:12:19.643037Z","end":"2026-03-01T21:12:20.620201Z","steps":["trace[390637005] 'agreement among raft nodes before linearized reading'  (duration: 976.531919ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T21:12:20.620227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:12:19.643019Z","time spent":"977.203914ms","remote":"127.0.0.1:37480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-01T21:12:32.660611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.950785ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14920879299759038410 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/replicasets/kube-system/coredns-7c96b6546b\" mod_revision:438 > success:<request_put:<key:\"/registry/replicasets/kube-system/coredns-7c96b6546b\" value_size:3744 >> failure:<request_range:<key:\"/registry/replicasets/kube-system/coredns-7c96b6546b\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-01T21:12:32.660718Z","caller":"traceutil/trace.go:171","msg":"trace[1999387951] transaction","detail":"{read_only:false; response_revision:447; number_of_response:1; }","duration":"212.189729ms","start":"2026-03-01T21:12:32.448513Z","end":"2026-03-01T21:12:32.660703Z","steps":["trace[1999387951] 'process raft request'  (duration: 57.04422ms)","trace[1999387951] 'compare'  (duration: 154.837243ms)"],"step_count":2}
{"level":"info","ts":"2026-03-01T21:12:32.68851Z","caller":"traceutil/trace.go:171","msg":"trace[1180944144] transaction","detail":"{read_only:false; response_revision:448; number_of_response:1; }","duration":"210.586074ms","start":"2026-03-01T21:12:32.477898Z","end":"2026-03-01T21:12:32.688484Z","steps":["trace[1180944144] 'process raft request'  (duration: 210.430671ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T21:12:47.231523Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.024634951s","expected-duration":"1s"}
{"level":"info","ts":"2026-03-01T21:12:47.232031Z","caller":"traceutil/trace.go:171","msg":"trace[1747684058] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"1.025228375s","start":"2026-03-01T21:12:46.206776Z","end":"2026-03-01T21:12:47.232005Z","steps":["trace[1747684058] 'process raft request'  (duration: 1.02503573s)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T21:12:47.232195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:12:46.206756Z","time spent":"1.025338618s","remote":"127.0.0.1:37384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4567,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:419 > success:<request_put:<key:\"/registry/minions/instance\" value_size:4533 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"info","ts":"2026-03-01T21:12:47.275871Z","caller":"traceutil/trace.go:171","msg":"trace[939647986] linearizableReadLoop","detail":"{readStateIndex:539; appliedIndex:537; }","duration":"493.058243ms","start":"2026-03-01T21:12:46.782767Z","end":"2026-03-01T21:12:47.275825Z","steps":["trace[939647986] 'read index received'  (duration: 449.067289ms)","trace[939647986] 'applied index is now lower than readState.Index'  (duration: 43.989934ms)"],"step_count":2}
{"level":"info","ts":"2026-03-01T21:12:47.276098Z","caller":"traceutil/trace.go:171","msg":"trace[1208429062] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"820.714664ms","start":"2026-03-01T21:12:46.455359Z","end":"2026-03-01T21:12:47.276073Z","steps":["trace[1208429062] 'process raft request'  (duration: 820.251534ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T21:12:47.276246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:12:46.455319Z","time spent":"820.847627ms","remote":"127.0.0.1:37480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:459 > 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-03-01T21:12:47.276322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.501263ms","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-03-01T21:12:47.276416Z","caller":"traceutil/trace.go:171","msg":"trace[1709626348] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:518; }","duration":"493.659547ms","start":"2026-03-01T21:12:46.782704Z","end":"2026-03-01T21:12:47.276363Z","steps":["trace[1709626348] 'agreement among raft nodes before linearized reading'  (duration: 493.498053ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T21:12:47.276498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:12:46.782677Z","time spent":"493.807349ms","remote":"127.0.0.1:37480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-03-01T21:12:47.276566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"485.510888ms","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-03-01T21:12:47.276615Z","caller":"traceutil/trace.go:171","msg":"trace[1049178081] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:518; }","duration":"485.705242ms","start":"2026-03-01T21:12:46.7909Z","end":"2026-03-01T21:12:47.276605Z","steps":["trace[1049178081] 'agreement among raft nodes before linearized reading'  (duration: 485.58654ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T21:12:47.276661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:12:46.790874Z","time spent":"485.780214ms","remote":"127.0.0.1:37480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-03-01T21:12:47.276759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"480.012288ms","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-03-01T21:12:47.276763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.114098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-01T21:12:47.276837Z","caller":"traceutil/trace.go:171","msg":"trace[1976598030] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:518; }","duration":"154.20768ms","start":"2026-03-01T21:12:47.122619Z","end":"2026-03-01T21:12:47.276826Z","steps":["trace[1976598030] 'agreement among raft nodes before linearized reading'  (duration: 154.111327ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T21:12:47.276881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.503173ms","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-03-01T21:12:47.276957Z","caller":"traceutil/trace.go:171","msg":"trace[1973445394] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:518; }","duration":"482.608256ms","start":"2026-03-01T21:12:46.794341Z","end":"2026-03-01T21:12:47.276949Z","steps":["trace[1973445394] 'agreement among raft nodes before linearized reading'  (duration: 482.515654ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T21:12:47.277012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:12:46.794325Z","time spent":"482.677038ms","remote":"127.0.0.1:37480","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-03-01T21:12:47.276804Z","caller":"traceutil/trace.go:171","msg":"trace[34459369] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:518; }","duration":"480.07589ms","start":"2026-03-01T21:12:46.796721Z","end":"2026-03-01T21:12:47.276797Z","steps":["trace[34459369] 'agreement among raft nodes before linearized reading'  (duration: 480.014199ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T21:12:47.277126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:12:46.796709Z","time spent":"480.410517ms","remote":"127.0.0.1:37480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-03-01T21:12:53.46718Z","caller":"traceutil/trace.go:171","msg":"trace[1670584460] linearizableReadLoop","detail":"{readStateIndex:559; appliedIndex:558; }","duration":"151.325427ms","start":"2026-03-01T21:12:53.315829Z","end":"2026-03-01T21:12:53.467155Z","steps":["trace[1670584460] 'read index received'  (duration: 151.03674ms)","trace[1670584460] 'applied index is now lower than readState.Index'  (duration: 287.347µs)"],"step_count":2}
{"level":"info","ts":"2026-03-01T21:12:53.467311Z","caller":"traceutil/trace.go:171","msg":"trace[1747895099] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"180.522906ms","start":"2026-03-01T21:12:53.286748Z","end":"2026-03-01T21:12:53.467271Z","steps":["trace[1747895099] 'process raft request'  (duration: 180.23175ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T21:12:53.467433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.587702ms","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-03-01T21:12:53.467532Z","caller":"traceutil/trace.go:171","msg":"trace[2035912057] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:536; }","duration":"151.702734ms","start":"2026-03-01T21:12:53.315767Z","end":"2026-03-01T21:12:53.46747Z","steps":["trace[2035912057] 'agreement among raft nodes before linearized reading'  (duration: 151.582522ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T21:12:53.467589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.963042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"warn","ts":"2026-03-01T21:12:53.467671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.715381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"warn","ts":"2026-03-01T21:12:53.467703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.729523ms","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-03-01T21:12:53.467724Z","caller":"traceutil/trace.go:171","msg":"trace[1473893682] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:536; }","duration":"144.828113ms","start":"2026-03-01T21:12:53.322881Z","end":"2026-03-01T21:12:53.467709Z","steps":["trace[1473893682] 'agreement among raft nodes before linearized reading'  (duration: 144.69476ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T21:12:53.467749Z","caller":"traceutil/trace.go:171","msg":"trace[1004201038] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:536; }","duration":"148.285639ms","start":"2026-03-01T21:12:53.319428Z","end":"2026-03-01T21:12:53.467714Z","steps":["trace[1004201038] 'agreement among raft nodes before linearized reading'  (duration: 147.937171ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T21:12:53.46777Z","caller":"traceutil/trace.go:171","msg":"trace[1594436568] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:536; }","duration":"145.845925ms","start":"2026-03-01T21:12:53.321906Z","end":"2026-03-01T21:12:53.467752Z","steps":["trace[1594436568] 'agreement among raft nodes before linearized reading'  (duration: 145.723093ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T21:12:54.069565Z","caller":"traceutil/trace.go:171","msg":"trace[1619590668] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"596.322347ms","start":"2026-03-01T21:12:53.473211Z","end":"2026-03-01T21:12:54.069533Z","steps":["trace[1619590668] 'process raft request'  (duration: 596.100912ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T21:12:54.069766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:12:53.473178Z","time spent":"596.487201ms","remote":"127.0.0.1:37480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:529 > 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-03-01T21:12:54.075403Z","caller":"traceutil/trace.go:171","msg":"trace[1982098752] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"602.003751ms","start":"2026-03-01T21:12:53.473372Z","end":"2026-03-01T21:12:54.075375Z","steps":["trace[1982098752] 'process raft request'  (duration: 601.776846ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T21:12:54.075543Z","caller":"traceutil/trace.go:171","msg":"trace[2034732665] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"602.017381ms","start":"2026-03-01T21:12:53.473501Z","end":"2026-03-01T21:12:54.075519Z","steps":["trace[2034732665] 'process raft request'  (duration: 601.780246ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T21:12:54.075625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:12:53.473335Z","time spent":"602.177756ms","remote":"127.0.0.1:37480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":37,"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-03-01T21:12:54.075645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:12:53.473486Z","time spent":"602.104983ms","remote":"127.0.0.1:37480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":37,"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":"info","ts":"2026-03-01T21:12:54.076024Z","caller":"traceutil/trace.go:171","msg":"trace[204112558] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"601.02229ms","start":"2026-03-01T21:12:53.474983Z","end":"2026-03-01T21:12:54.076005Z","steps":["trace[204112558] 'process raft request'  (duration: 600.337235ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T21:12:54.076105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:12:53.474958Z","time spent":"601.109452ms","remote":"127.0.0.1:37480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:530 > 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-03-01T21:12:56.781637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.245853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"}
{"level":"info","ts":"2026-03-01T21:12:56.78176Z","caller":"traceutil/trace.go:171","msg":"trace[1743798392] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:550; }","duration":"135.425697ms","start":"2026-03-01T21:12:56.646311Z","end":"2026-03-01T21:12:56.781737Z","steps":["trace[1743798392] 'range keys from in-memory index tree'  (duration: 135.118101ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T21:12:56.892092Z","caller":"traceutil/trace.go:171","msg":"trace[811564743] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"104.606052ms","start":"2026-03-01T21:12:56.787449Z","end":"2026-03-01T21:12:56.892056Z","steps":["trace[811564743] 'process raft request'  (duration: 104.367547ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T21:13:13.257473Z","caller":"traceutil/trace.go:171","msg":"trace[967219468] transaction","detail":"{read_only:false; response_revision:723; number_of_response:1; }","duration":"234.797769ms","start":"2026-03-01T21:13:13.022642Z","end":"2026-03-01T21:13:13.257439Z","steps":["trace[967219468] 'process raft request'  (duration: 234.586195ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T21:13:15.713127Z","caller":"traceutil/trace.go:171","msg":"trace[1642892826] transaction","detail":"{read_only:false; response_revision:728; number_of_response:1; }","duration":"441.946356ms","start":"2026-03-01T21:13:15.271149Z","end":"2026-03-01T21:13:15.713096Z","steps":["trace[1642892826] 'process raft request'  (duration: 441.777242ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T21:13:15.713314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:13:15.271134Z","time spent":"442.085049ms","remote":"127.0.0.1:37480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:723 > 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-03-01T21:13:16.358561Z","caller":"traceutil/trace.go:171","msg":"trace[749110136] linearizableReadLoop","detail":"{readStateIndex:757; appliedIndex:756; }","duration":"112.298388ms","start":"2026-03-01T21:13:16.246232Z","end":"2026-03-01T21:13:16.358531Z","steps":["trace[749110136] 'read index received'  (duration: 112.078093ms)","trace[749110136] 'applied index is now lower than readState.Index'  (duration: 218.715µs)"],"step_count":2}
{"level":"info","ts":"2026-03-01T21:13:16.358655Z","caller":"traceutil/trace.go:171","msg":"trace[1047402558] transaction","detail":"{read_only:false; response_revision:729; number_of_response:1; }","duration":"112.992344ms","start":"2026-03-01T21:13:16.245608Z","end":"2026-03-01T21:13:16.358601Z","steps":["trace[1047402558] 'process raft request'  (duration: 112.738228ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T21:13:16.358964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.702357ms","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-03-01T21:13:16.359034Z","caller":"traceutil/trace.go:171","msg":"trace[787834715] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:729; }","duration":"112.834219ms","start":"2026-03-01T21:13:16.246182Z","end":"2026-03-01T21:13:16.359016Z","steps":["trace[787834715] 'agreement among raft nodes before linearized reading'  (duration: 112.513472ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T21:13:16.742739Z","caller":"traceutil/trace.go:171","msg":"trace[1964363060] transaction","detail":"{read_only:false; response_revision:732; number_of_response:1; }","duration":"378.652819ms","start":"2026-03-01T21:13:16.364051Z","end":"2026-03-01T21:13:16.742704Z","steps":["trace[1964363060] 'process raft request'  (duration: 378.599278ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T21:13:16.742853Z","caller":"traceutil/trace.go:171","msg":"trace[520860920] transaction","detail":"{read_only:false; response_revision:731; number_of_response:1; }","duration":"379.09344ms","start":"2026-03-01T21:13:16.363714Z","end":"2026-03-01T21:13:16.742807Z","steps":["trace[520860920] 'process raft request'  (duration: 378.740492ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T21:13:16.74296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:13:16.364045Z","time spent":"378.804683ms","remote":"127.0.0.1:37480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:725 > 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-03-01T21:13:16.743205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:13:16.363683Z","time spent":"379.368365ms","remote":"127.0.0.1:37480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:727 > 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-03-01T21:13:17.710703Z","caller":"traceutil/trace.go:171","msg":"trace[880506291] linearizableReadLoop","detail":"{readStateIndex:762; appliedIndex:761; }","duration":"417.843545ms","start":"2026-03-01T21:13:17.292838Z","end":"2026-03-01T21:13:17.710682Z","steps":["trace[880506291] 'read index received'  (duration: 417.694702ms)","trace[880506291] 'applied index is now lower than readState.Index'  (duration: 147.273µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-01T21:13:17.710729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:13:17.190482Z","time spent":"520.237276ms","remote":"127.0.0.1:37268","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-03-01T21:13:17.710833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.972409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-01T21:13:17.710863Z","caller":"traceutil/trace.go:171","msg":"trace[1789895404] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:733; }","duration":"418.078712ms","start":"2026-03-01T21:13:17.292774Z","end":"2026-03-01T21:13:17.710852Z","steps":["trace[1789895404] 'agreement among raft nodes before linearized reading'  (duration: 417.988659ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T21:13:17.710893Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:13:17.292747Z","time spent":"418.138253ms","remote":"127.0.0.1:37680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":26,"request content":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true "}
{"level":"warn","ts":"2026-03-01T21:13:42.802865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.479318ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14920879299759039201 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:782 > 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-03-01T21:13:42.803334Z","caller":"traceutil/trace.go:171","msg":"trace[539091398] transaction","detail":"{read_only:false; response_revision:810; number_of_response:1; }","duration":"191.345086ms","start":"2026-03-01T21:13:42.61196Z","end":"2026-03-01T21:13:42.803305Z","steps":["trace[539091398] 'process raft request'  (duration: 38.326176ms)","trace[539091398] 'compare'  (duration: 152.341904ms)"],"step_count":2}
{"level":"info","ts":"2026-03-01T21:13:42.803545Z","caller":"traceutil/trace.go:171","msg":"trace[115829405] linearizableReadLoop","detail":"{readStateIndex:844; appliedIndex:843; }","duration":"187.323583ms","start":"2026-03-01T21:13:42.616144Z","end":"2026-03-01T21:13:42.803468Z","steps":["trace[115829405] 'read index received'  (duration: 34.075509ms)","trace[115829405] 'applied index is now lower than readState.Index'  (duration: 153.242844ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-01T21:13:42.869274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.099648ms","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-03-01T21:13:42.869383Z","caller":"traceutil/trace.go:171","msg":"trace[338758693] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:810; }","duration":"253.271332ms","start":"2026-03-01T21:13:42.616083Z","end":"2026-03-01T21:13:42.869354Z","steps":["trace[338758693] 'agreement among raft nodes before linearized reading'  (duration: 187.555209ms)","trace[338758693] 'range keys from in-memory index tree'  (duration: 65.428906ms)"],"step_count":2}
{"level":"info","ts":"2026-03-01T21:13:43.920672Z","caller":"traceutil/trace.go:171","msg":"trace[1030227956] transaction","detail":"{read_only:false; response_revision:812; number_of_response:1; }","duration":"956.670938ms","start":"2026-03-01T21:13:42.963974Z","end":"2026-03-01T21:13:43.920645Z","steps":["trace[1030227956] 'process raft request'  (duration: 956.474453ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T21:13:43.920857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:13:42.96395Z","time spent":"956.804282ms","remote":"127.0.0.1:37480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:807 > 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-03-01T21:13:43.927296Z","caller":"traceutil/trace.go:171","msg":"trace[867908230] transaction","detail":"{read_only:false; response_revision:813; number_of_response:1; }","duration":"963.246239ms","start":"2026-03-01T21:13:42.964004Z","end":"2026-03-01T21:13:43.92725Z","steps":["trace[867908230] 'process raft request'  (duration: 963.084046ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T21:13:43.927614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:13:42.963987Z","time spent":"963.414423ms","remote":"127.0.0.1:37480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:806 > 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-03-01T21:13:44.205266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.439826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-01T21:13:44.205385Z","caller":"traceutil/trace.go:171","msg":"trace[679940336] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:814; }","duration":"103.62966ms","start":"2026-03-01T21:13:44.101728Z","end":"2026-03-01T21:13:44.205358Z","steps":["trace[679940336] 'range keys from in-memory index tree'  (duration: 103.350104ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T21:13:45.076005Z","caller":"traceutil/trace.go:171","msg":"trace[1873648051] transaction","detail":"{read_only:false; response_revision:816; number_of_response:1; }","duration":"107.624611ms","start":"2026-03-01T21:13:44.968349Z","end":"2026-03-01T21:13:45.075974Z","steps":["trace[1873648051] 'process raft request'  (duration: 107.490698ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T21:13:45.602587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"499.719888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-01T21:13:45.602622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.134349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-01T21:13:45.60272Z","caller":"traceutil/trace.go:171","msg":"trace[306524314] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:816; }","duration":"499.930032ms","start":"2026-03-01T21:13:45.102758Z","end":"2026-03-01T21:13:45.602688Z","steps":["trace[306524314] 'range keys from in-memory index tree'  (duration: 499.568394ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T21:13:45.602785Z","caller":"traceutil/trace.go:171","msg":"trace[594937564] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:816; }","duration":"309.400456ms","start":"2026-03-01T21:13:45.293359Z","end":"2026-03-01T21:13:45.602759Z","steps":["trace[594937564] 'count revisions from in-memory index tree'  (duration: 308.956516ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T21:13:45.602811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:13:45.102736Z","time spent":"500.058925ms","remote":"127.0.0.1:37248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-01T21:13:45.602845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:13:45.29333Z","time spent":"309.501798ms","remote":"127.0.0.1:37654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":26,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "}
{"level":"info","ts":"2026-03-01T21:13:46.43847Z","caller":"traceutil/trace.go:171","msg":"trace[1543743981] transaction","detail":"{read_only:false; response_revision:817; number_of_response:1; }","duration":"505.837218ms","start":"2026-03-01T21:13:45.932605Z","end":"2026-03-01T21:13:46.438442Z","steps":["trace[1543743981] 'process raft request'  (duration: 505.588552ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T21:13:46.438657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:13:45.932442Z","time spent":"506.116643ms","remote":"127.0.0.1:37480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:812 > 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-03-01T21:13:46.648115Z","caller":"traceutil/trace.go:171","msg":"trace[1788273321] linearizableReadLoop","detail":"{readStateIndex:853; appliedIndex:851; }","duration":"654.059747ms","start":"2026-03-01T21:13:45.994022Z","end":"2026-03-01T21:13:46.648082Z","steps":["trace[1788273321] 'read index received'  (duration: 444.370962ms)","trace[1788273321] 'applied index is now lower than readState.Index'  (duration: 209.686555ms)"],"step_count":2}
{"level":"info","ts":"2026-03-01T21:13:46.648167Z","caller":"traceutil/trace.go:171","msg":"trace[513243959] transaction","detail":"{read_only:false; response_revision:818; number_of_response:1; }","duration":"712.470143ms","start":"2026-03-01T21:13:45.935657Z","end":"2026-03-01T21:13:46.648127Z","steps":["trace[513243959] 'process raft request'  (duration: 687.610505ms)","trace[513243959] 'compare'  (duration: 24.595162ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-01T21:13:46.648328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"654.274362ms","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":"warn","ts":"2026-03-01T21:13:46.648356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"545.197648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-01T21:13:46.648396Z","caller":"traceutil/trace.go:171","msg":"trace[1272257779] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:818; }","duration":"654.389855ms","start":"2026-03-01T21:13:45.99399Z","end":"2026-03-01T21:13:46.64838Z","steps":["trace[1272257779] 'agreement among raft nodes before linearized reading'  (duration: 654.19174ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T21:13:46.648343Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:13:45.935641Z","time spent":"712.606326ms","remote":"127.0.0.1:37480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:813 > 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-03-01T21:13:46.648404Z","caller":"traceutil/trace.go:171","msg":"trace[757214886] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:818; }","duration":"545.32625ms","start":"2026-03-01T21:13:46.103063Z","end":"2026-03-01T21:13:46.648389Z","steps":["trace[757214886] 'agreement among raft nodes before linearized reading'  (duration: 545.221848ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T21:13:46.64843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:13:45.993976Z","time spent":"654.449336ms","remote":"127.0.0.1:37480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-03-01T21:13:46.648442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:13:46.103026Z","time spent":"545.406702ms","remote":"127.0.0.1:37248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-01T21:13:47.201335Z","caller":"traceutil/trace.go:171","msg":"trace[1798388520] transaction","detail":"{read_only:false; response_revision:819; number_of_response:1; }","duration":"547.661405ms","start":"2026-03-01T21:13:46.653646Z","end":"2026-03-01T21:13:47.201308Z","steps":["trace[1798388520] 'process raft request'  (duration: 506.830621ms)","trace[1798388520] 'compare'  (duration: 40.685021ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-01T21:13:47.201503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:13:46.653627Z","time spent":"547.782388ms","remote":"127.0.0.1:37480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:815 > 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-03-01T21:13:47.955851Z","caller":"traceutil/trace.go:171","msg":"trace[1795837990] linearizableReadLoop","detail":"{readStateIndex:855; appliedIndex:853; }","duration":"874.513589ms","start":"2026-03-01T21:13:47.081293Z","end":"2026-03-01T21:13:47.955806Z","steps":["trace[1795837990] 'read index received'  (duration: 79.207212ms)","trace[1795837990] 'applied index is now lower than readState.Index'  (duration: 795.304167ms)"],"step_count":2}
{"level":"info","ts":"2026-03-01T21:13:47.955931Z","caller":"traceutil/trace.go:171","msg":"trace[1144846386] transaction","detail":"{read_only:false; response_revision:820; number_of_response:1; }","duration":"1.301953524s","start":"2026-03-01T21:13:46.653939Z","end":"2026-03-01T21:13:47.955893Z","steps":["trace[1144846386] 'process raft request'  (duration: 1.243761693s)","trace[1144846386] 'compare'  (duration: 57.595298ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-01T21:13:47.956108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:13:46.653928Z","time spent":"1.302081067s","remote":"127.0.0.1:37480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:814 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-03-01T21:13:47.95616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"874.867197ms","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-03-01T21:13:47.956179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"853.046378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-01T21:13:47.956212Z","caller":"traceutil/trace.go:171","msg":"trace[895070237] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:820; }","duration":"874.951469ms","start":"2026-03-01T21:13:47.081244Z","end":"2026-03-01T21:13:47.956196Z","steps":["trace[895070237] 'agreement among raft nodes before linearized reading'  (duration: 874.749395ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T21:13:47.956237Z","caller":"traceutil/trace.go:171","msg":"trace[1695758749] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:820; }","duration":"853.170981ms","start":"2026-03-01T21:13:47.10305Z","end":"2026-03-01T21:13:47.956221Z","steps":["trace[1695758749] 'agreement among raft nodes before linearized reading'  (duration: 852.996687ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T21:13:47.956246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:13:47.081224Z","time spent":"875.0149ms","remote":"127.0.0.1:37480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-01T21:13:47.956289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:13:47.103035Z","time spent":"853.245332ms","remote":"127.0.0.1:37248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-01T21:13:47.956616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"766.233172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.235\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-03-01T21:13:47.956681Z","caller":"traceutil/trace.go:171","msg":"trace[1424886511] range","detail":"{range_begin:/registry/masterleases/199.204.45.235; range_end:; response_count:1; response_revision:820; }","duration":"766.354345ms","start":"2026-03-01T21:13:47.190305Z","end":"2026-03-01T21:13:47.956659Z","steps":["trace[1424886511] 'agreement among raft nodes before linearized reading'  (duration: 766.17081ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T21:13:47.95674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:13:47.19026Z","time spent":"766.464407ms","remote":"127.0.0.1:37268","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.235\" "}
{"level":"info","ts":"2026-03-01T21:14:00.808533Z","caller":"traceutil/trace.go:171","msg":"trace[1022418959] transaction","detail":"{read_only:false; response_revision:875; number_of_response:1; }","duration":"129.201874ms","start":"2026-03-01T21:14:00.679307Z","end":"2026-03-01T21:14:00.808509Z","steps":["trace[1022418959] 'process raft request'  (duration: 128.947869ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T21:14:01.001931Z","caller":"traceutil/trace.go:171","msg":"trace[1474600178] transaction","detail":"{read_only:false; response_revision:882; number_of_response:1; }","duration":"165.529565ms","start":"2026-03-01T21:14:00.836366Z","end":"2026-03-01T21:14:01.001895Z","steps":["trace[1474600178] 'process raft request'  (duration: 165.479264ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T21:14:01.002437Z","caller":"traceutil/trace.go:171","msg":"trace[1643851978] transaction","detail":"{read_only:false; response_revision:881; number_of_response:1; }","duration":"167.054709ms","start":"2026-03-01T21:14:00.835347Z","end":"2026-03-01T21:14:01.002402Z","steps":["trace[1643851978] 'process raft request'  (duration: 166.441465ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T21:14:01.002196Z","caller":"traceutil/trace.go:171","msg":"trace[587475555] transaction","detail":"{read_only:false; response_revision:880; number_of_response:1; }","duration":"167.233545ms","start":"2026-03-01T21:14:00.834924Z","end":"2026-03-01T21:14:01.002157Z","steps":["trace[587475555] 'process raft request'  (duration: 166.330904ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T21:14:01.226389Z","caller":"traceutil/trace.go:171","msg":"trace[222033965] transaction","detail":"{read_only:false; response_revision:883; number_of_response:1; }","duration":"215.858756ms","start":"2026-03-01T21:14:01.010505Z","end":"2026-03-01T21:14:01.226364Z","steps":["trace[222033965] 'process raft request'  (duration: 215.631081ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T21:14:01.409811Z","caller":"traceutil/trace.go:171","msg":"trace[15466613] linearizableReadLoop","detail":"{readStateIndex:923; appliedIndex:921; }","duration":"306.695944ms","start":"2026-03-01T21:14:01.103093Z","end":"2026-03-01T21:14:01.409789Z","steps":["trace[15466613] 'read index received'  (duration: 122.988003ms)","trace[15466613] 'applied index is now lower than readState.Index'  (duration: 183.706871ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-01T21:14:01.409994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.879648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-01T21:14:01.410028Z","caller":"traceutil/trace.go:171","msg":"trace[40333981] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:884; }","duration":"306.97749ms","start":"2026-03-01T21:14:01.103041Z","end":"2026-03-01T21:14:01.410019Z","steps":["trace[40333981] 'agreement among raft nodes before linearized reading'  (duration: 306.866468ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T21:14:01.410055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:14:01.103017Z","time spent":"307.032682ms","remote":"127.0.0.1:37248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-01T21:14:01.41003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.216687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-01T21:14:01.410118Z","caller":"traceutil/trace.go:171","msg":"trace[563533329] range","detail":"{range_begin:/registry/limitranges/kube-system/; range_end:/registry/limitranges/kube-system0; response_count:0; response_revision:884; }","duration":"175.35689ms","start":"2026-03-01T21:14:01.234744Z","end":"2026-03-01T21:14:01.410101Z","steps":["trace[563533329] 'agreement among raft nodes before linearized reading'  (duration: 175.202937ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T21:14:01.410447Z","caller":"traceutil/trace.go:171","msg":"trace[1008064765] transaction","detail":"{read_only:false; response_revision:884; number_of_response:1; }","duration":"398.984715ms","start":"2026-03-01T21:14:01.010887Z","end":"2026-03-01T21:14:01.409872Z","steps":["trace[1008064765] 'process raft request'  (duration: 398.775ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T21:14:01.41088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:14:01.010879Z","time spent":"399.808073ms","remote":"127.0.0.1:37650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9632,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/deployments/kube-system/ceph-csi-rbd-provisioner\" mod_revision:0 > success:<request_put:<key:\"/registry/deployments/kube-system/ceph-csi-rbd-provisioner\" value_size:9566 >> failure:<>"}
{"level":"info","ts":"2026-03-01T21:14:01.645927Z","caller":"traceutil/trace.go:171","msg":"trace[1581968841] transaction","detail":"{read_only:false; response_revision:885; number_of_response:1; }","duration":"232.698451ms","start":"2026-03-01T21:14:01.413193Z","end":"2026-03-01T21:14:01.645891Z","steps":["trace[1581968841] 'process raft request'  (duration: 206.481862ms)","trace[1581968841] 'compare'  (duration: 26.043896ms)"],"step_count":2}
{"level":"info","ts":"2026-03-01T21:14:01.706291Z","caller":"traceutil/trace.go:171","msg":"trace[1943799045] transaction","detail":"{read_only:false; response_revision:886; number_of_response:1; }","duration":"291.905965ms","start":"2026-03-01T21:14:01.414331Z","end":"2026-03-01T21:14:01.706237Z","steps":["trace[1943799045] 'process raft request'  (duration: 291.563517ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T21:14:01.706302Z","caller":"traceutil/trace.go:171","msg":"trace[414209869] transaction","detail":"{read_only:false; response_revision:888; number_of_response:1; }","duration":"286.174185ms","start":"2026-03-01T21:14:01.420089Z","end":"2026-03-01T21:14:01.706263Z","steps":["trace[414209869] 'process raft request'  (duration: 286.087353ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T21:14:01.706544Z","caller":"traceutil/trace.go:171","msg":"trace[334089334] transaction","detail":"{read_only:false; response_revision:887; number_of_response:1; }","duration":"289.808969ms","start":"2026-03-01T21:14:01.416718Z","end":"2026-03-01T21:14:01.706527Z","steps":["trace[334089334] 'process raft request'  (duration: 289.388088ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T21:14:01.767989Z","caller":"traceutil/trace.go:171","msg":"trace[1463915109] transaction","detail":"{read_only:false; response_revision:889; number_of_response:1; }","duration":"115.297357ms","start":"2026-03-01T21:14:01.652583Z","end":"2026-03-01T21:14:01.76788Z","steps":["trace[1463915109] 'process raft request'  (duration: 114.713393ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T21:14:01.767946Z","caller":"traceutil/trace.go:171","msg":"trace[1481440095] transaction","detail":"{read_only:false; response_revision:890; number_of_response:1; }","duration":"110.747832ms","start":"2026-03-01T21:14:01.65717Z","end":"2026-03-01T21:14:01.767918Z","steps":["trace[1481440095] 'process raft request'  (duration: 110.682161ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T21:14:01.85057Z","caller":"traceutil/trace.go:171","msg":"trace[1034267730] transaction","detail":"{read_only:false; response_revision:891; number_of_response:1; }","duration":"135.666262ms","start":"2026-03-01T21:14:01.71485Z","end":"2026-03-01T21:14:01.850516Z","steps":["trace[1034267730] 'process raft request'  (duration: 135.357065ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T21:14:01.850656Z","caller":"traceutil/trace.go:171","msg":"trace[184300335] transaction","detail":"{read_only:false; response_revision:893; number_of_response:1; }","duration":"117.438665ms","start":"2026-03-01T21:14:01.733187Z","end":"2026-03-01T21:14:01.850625Z","steps":["trace[184300335] 'process raft request'  (duration: 117.294452ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T21:14:01.850664Z","caller":"traceutil/trace.go:171","msg":"trace[1920510045] transaction","detail":"{read_only:false; response_revision:892; number_of_response:1; }","duration":"132.913719ms","start":"2026-03-01T21:14:01.717711Z","end":"2026-03-01T21:14:01.850625Z","steps":["trace[1920510045] 'process raft request'  (duration: 132.667094ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T21:14:01.921583Z","caller":"traceutil/trace.go:171","msg":"trace[1455000112] transaction","detail":"{read_only:false; response_revision:894; number_of_response:1; }","duration":"152.351544ms","start":"2026-03-01T21:14:01.769201Z","end":"2026-03-01T21:14:01.921553Z","steps":["trace[1455000112] 'process raft request'  (duration: 143.810839ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T21:14:01.921612Z","caller":"traceutil/trace.go:171","msg":"trace[1232533694] linearizableReadLoop","detail":"{readStateIndex:936; appliedIndex:930; }","duration":"145.830665ms","start":"2026-03-01T21:14:01.775754Z","end":"2026-03-01T21:14:01.921585Z","steps":["trace[1232533694] 'read index received'  (duration: 74.424242ms)","trace[1232533694] 'applied index is now lower than readState.Index'  (duration: 71.405003ms)"],"step_count":2}
{"level":"info","ts":"2026-03-01T21:14:01.921694Z","caller":"traceutil/trace.go:171","msg":"trace[761794160] transaction","detail":"{read_only:false; response_revision:896; number_of_response:1; }","duration":"146.49572ms","start":"2026-03-01T21:14:01.775151Z","end":"2026-03-01T21:14:01.921646Z","steps":["trace[761794160] 'process raft request'  (duration: 146.394428ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T21:14:01.921673Z","caller":"traceutil/trace.go:171","msg":"trace[1626345434] transaction","detail":"{read_only:false; response_revision:895; number_of_response:1; }","duration":"152.324233ms","start":"2026-03-01T21:14:01.769295Z","end":"2026-03-01T21:14:01.921619Z","steps":["trace[1626345434] 'process raft request'  (duration: 152.215121ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T21:14:01.921947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.159292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-c22w2\" ","response":"range_response_count:1 size:9127"}
{"level":"info","ts":"2026-03-01T21:14:01.921994Z","caller":"traceutil/trace.go:171","msg":"trace[451879556] range","detail":"{range_begin:/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-c22w2; range_end:; response_count:1; response_revision:896; }","duration":"146.262315ms","start":"2026-03-01T21:14:01.775717Z","end":"2026-03-01T21:14:01.921979Z","steps":["trace[451879556] 'agreement among raft nodes before linearized reading'  (duration: 146.010159ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T21:14:02.041695Z","caller":"traceutil/trace.go:171","msg":"trace[1174406124] transaction","detail":"{read_only:false; response_revision:900; number_of_response:1; }","duration":"106.817783ms","start":"2026-03-01T21:14:01.934842Z","end":"2026-03-01T21:14:02.04166Z","steps":["trace[1174406124] 'process raft request'  (duration: 106.584518ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T21:14:02.098833Z","caller":"traceutil/trace.go:171","msg":"trace[2115673945] transaction","detail":"{read_only:false; response_revision:902; number_of_response:1; }","duration":"144.118796ms","start":"2026-03-01T21:14:01.954669Z","end":"2026-03-01T21:14:02.098788Z","steps":["trace[2115673945] 'process raft request'  (duration: 143.89264ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T21:14:02.098983Z","caller":"traceutil/trace.go:171","msg":"trace[1115152286] transaction","detail":"{read_only:false; response_revision:903; number_of_response:1; }","duration":"141.791053ms","start":"2026-03-01T21:14:01.957111Z","end":"2026-03-01T21:14:02.098902Z","steps":["trace[1115152286] 'process raft request'  (duration: 141.543347ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T21:14:02.09881Z","caller":"traceutil/trace.go:171","msg":"trace[689530629] transaction","detail":"{read_only:false; response_revision:901; number_of_response:1; }","duration":"148.528637ms","start":"2026-03-01T21:14:01.95021Z","end":"2026-03-01T21:14:02.098739Z","steps":["trace[689530629] 'process raft request'  (duration: 148.172418ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T21:14:07.1641Z","caller":"traceutil/trace.go:171","msg":"trace[381600079] transaction","detail":"{read_only:false; response_revision:934; number_of_response:1; }","duration":"162.961086ms","start":"2026-03-01T21:14:07.001096Z","end":"2026-03-01T21:14:07.164057Z","steps":["trace[381600079] 'process raft request'  (duration: 162.787252ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T21:14:09.260512Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14920879299759039493,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-01T21:14:09.761088Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14920879299759039493,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-01T21:14:10.262246Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14920879299759039493,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-01T21:14:10.642541Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.416698696s","expected-duration":"1s"}
{"level":"warn","ts":"2026-03-01T21:14:11.658776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"891.008183ms","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-03-01T21:14:11.658957Z","caller":"traceutil/trace.go:171","msg":"trace[500170644] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:937; }","duration":"891.173296ms","start":"2026-03-01T21:14:10.76773Z","end":"2026-03-01T21:14:11.658903Z","steps":["trace[500170644] 'range keys from in-memory index tree'  (duration: 890.986952ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T21:14:11.659811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.016923038s","expected-duration":"100ms","prefix":"","request":"header:<ID:14920879299759039494 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:932 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-01T21:14:11.660044Z","caller":"traceutil/trace.go:171","msg":"trace[1642712584] linearizableReadLoop","detail":"{readStateIndex:981; appliedIndex:979; }","duration":"2.899889739s","start":"2026-03-01T21:14:08.760137Z","end":"2026-03-01T21:14:11.660027Z","steps":["trace[1642712584] 'read index received'  (duration: 1.882639123s)","trace[1642712584] 'applied index is now lower than readState.Index'  (duration: 1.017249476s)"],"step_count":2}
{"level":"info","ts":"2026-03-01T21:14:11.660198Z","caller":"traceutil/trace.go:171","msg":"trace[1539136393] transaction","detail":"{read_only:false; response_revision:939; number_of_response:1; }","duration":"2.226883018s","start":"2026-03-01T21:14:09.43324Z","end":"2026-03-01T21:14:11.660123Z","steps":["trace[1539136393] 'process raft request'  (duration: 2.226685763s)"],"step_count":1}
{"level":"info","ts":"2026-03-01T21:14:11.660257Z","caller":"traceutil/trace.go:171","msg":"trace[144204839] transaction","detail":"{read_only:false; response_revision:938; number_of_response:1; }","duration":"3.434493994s","start":"2026-03-01T21:14:08.225745Z","end":"2026-03-01T21:14:11.660239Z","steps":["trace[144204839] 'process raft request'  (duration: 2.417011303s)","trace[144204839] 'compare'  (duration: 1.016480928s)"],"step_count":2}
{"level":"warn","ts":"2026-03-01T21:14:11.660391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:14:09.433206Z","time spent":"2.227089302s","remote":"127.0.0.1:37480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:853 > 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-03-01T21:14:11.660431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:14:08.225727Z","time spent":"3.434583346s","remote":"127.0.0.1:37480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:932 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-03-01T21:14:11.660251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.900118124s","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-03-01T21:14:11.660672Z","caller":"traceutil/trace.go:171","msg":"trace[71595201] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:939; }","duration":"2.900578054s","start":"2026-03-01T21:14:08.76008Z","end":"2026-03-01T21:14:11.660658Z","steps":["trace[71595201] 'agreement among raft nodes before linearized reading'  (duration: 2.900039263s)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T21:14:11.660719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:14:08.760052Z","time spent":"2.900652896s","remote":"127.0.0.1:37480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-03-01T21:14:11.661036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.169605197s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-01T21:14:11.661028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.558814403s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-01T21:14:11.661076Z","caller":"traceutil/trace.go:171","msg":"trace[528415276] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:939; }","duration":"2.169684519s","start":"2026-03-01T21:14:09.491381Z","end":"2026-03-01T21:14:11.661066Z","steps":["trace[528415276] 'agreement among raft nodes before linearized reading'  (duration: 2.169615168s)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T21:14:11.661106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:14:09.491359Z","time spent":"2.169739671s","remote":"127.0.0.1:37364","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":26,"request content":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true "}
{"level":"info","ts":"2026-03-01T21:14:11.661116Z","caller":"traceutil/trace.go:171","msg":"trace[1428225111] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:939; }","duration":"1.558964027s","start":"2026-03-01T21:14:10.10213Z","end":"2026-03-01T21:14:11.661094Z","steps":["trace[1428225111] 'agreement among raft nodes before linearized reading'  (duration: 1.558811983s)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T21:14:11.661162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:14:10.102103Z","time spent":"1.55905034s","remote":"127.0.0.1:37248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-01T21:14:11.661368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.91353082s","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-03-01T21:14:11.661399Z","caller":"traceutil/trace.go:171","msg":"trace[1771831431] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:939; }","duration":"1.913600802s","start":"2026-03-01T21:14:09.747787Z","end":"2026-03-01T21:14:11.661388Z","steps":["trace[1771831431] 'agreement among raft nodes before linearized reading'  (duration: 1.913451759s)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T21:14:11.661431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:14:09.747764Z","time spent":"1.913661254s","remote":"127.0.0.1:37480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-03-01T21:14:11.661459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.460608848s","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-03-01T21:14:11.66149Z","caller":"traceutil/trace.go:171","msg":"trace[1267255525] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:939; }","duration":"1.46068289s","start":"2026-03-01T21:14:10.200797Z","end":"2026-03-01T21:14:11.66148Z","steps":["trace[1267255525] 'agreement among raft nodes before linearized reading'  (duration: 1.460546847s)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T21:14:11.661517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:14:10.200762Z","time spent":"1.460748782s","remote":"127.0.0.1:37480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":512,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-03-01T21:14:11.662059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.321342595s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-01T21:14:11.662091Z","caller":"traceutil/trace.go:171","msg":"trace[1678816339] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:939; }","duration":"2.321420047s","start":"2026-03-01T21:14:09.340662Z","end":"2026-03-01T21:14:11.662082Z","steps":["trace[1678816339] 'agreement among raft nodes before linearized reading'  (duration: 2.321358696s)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T21:14:11.662119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:14:09.340639Z","time spent":"2.321473269s","remote":"127.0.0.1:37332","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":6,"response size":28,"request content":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true "}
{"level":"warn","ts":"2026-03-01T21:14:11.666572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.491770716s","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-03-01T21:14:11.666629Z","caller":"traceutil/trace.go:171","msg":"trace[1416125085] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:939; }","duration":"2.498113005s","start":"2026-03-01T21:14:09.168501Z","end":"2026-03-01T21:14:11.666614Z","steps":["trace[1416125085] 'agreement among raft nodes before linearized reading'  (duration: 2.491770726s)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T21:14:11.666671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:14:09.168478Z","time spent":"2.498174966s","remote":"127.0.0.1:37480","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-03-01T21:14:11.825234Z","caller":"traceutil/trace.go:171","msg":"trace[947717429] transaction","detail":"{read_only:false; response_revision:942; number_of_response:1; }","duration":"158.001774ms","start":"2026-03-01T21:14:11.667205Z","end":"2026-03-01T21:14:11.825206Z","steps":["trace[947717429] 'process raft request'  (duration: 157.942163ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T21:14:11.825303Z","caller":"traceutil/trace.go:171","msg":"trace[1379986989] transaction","detail":"{read_only:false; response_revision:941; number_of_response:1; }","duration":"159.265741ms","start":"2026-03-01T21:14:11.665987Z","end":"2026-03-01T21:14:11.825252Z","steps":["trace[1379986989] 'process raft request'  (duration: 158.964764ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T21:14:11.825548Z","caller":"traceutil/trace.go:171","msg":"trace[2137062129] transaction","detail":"{read_only:false; response_revision:943; number_of_response:1; }","duration":"156.085111ms","start":"2026-03-01T21:14:11.669435Z","end":"2026-03-01T21:14:11.82552Z","steps":["trace[2137062129] 'process raft request'  (duration: 155.740163ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T21:14:11.825673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.478324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-01T21:14:11.825729Z","caller":"traceutil/trace.go:171","msg":"trace[2123168649] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:943; }","duration":"158.584146ms","start":"2026-03-01T21:14:11.66713Z","end":"2026-03-01T21:14:11.825715Z","steps":["trace[2123168649] 'agreement among raft nodes before linearized reading'  (duration: 158.470614ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T21:14:11.825532Z","caller":"traceutil/trace.go:171","msg":"trace[1787224528] linearizableReadLoop","detail":"{readStateIndex:983; appliedIndex:981; }","duration":"158.299301ms","start":"2026-03-01T21:14:11.667164Z","end":"2026-03-01T21:14:11.825463Z","steps":["trace[1787224528] 'read index received'  (duration: 66.758452ms)","trace[1787224528] 'applied index is now lower than readState.Index'  (duration: 91.538558ms)"],"step_count":2}
{"level":"info","ts":"2026-03-01T21:14:23.840007Z","caller":"traceutil/trace.go:171","msg":"trace[507412780] transaction","detail":"{read_only:false; response_revision:972; number_of_response:1; }","duration":"123.365493ms","start":"2026-03-01T21:14:23.716602Z","end":"2026-03-01T21:14:23.839968Z","steps":["trace[507412780] 'process raft request'  (duration: 123.012715ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T21:14:25.539706Z","caller":"traceutil/trace.go:171","msg":"trace[272251616] transaction","detail":"{read_only:false; response_revision:989; number_of_response:1; }","duration":"193.521419ms","start":"2026-03-01T21:14:25.346154Z","end":"2026-03-01T21:14:25.539676Z","steps":["trace[272251616] 'process raft request'  (duration: 193.283664ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T21:14:26.601178Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14920879299759039630,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-01T21:14:26.846253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.149088ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14920879299759039632 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:976 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-01T21:14:26.846514Z","caller":"traceutil/trace.go:171","msg":"trace[1922886129] linearizableReadLoop","detail":"{readStateIndex:1041; appliedIndex:1038; }","duration":"746.182059ms","start":"2026-03-01T21:14:26.100309Z","end":"2026-03-01T21:14:26.846491Z","steps":["trace[1922886129] 'read index received'  (duration: 508.787326ms)","trace[1922886129] 'applied index is now lower than readState.Index'  (duration: 237.393393ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-01T21:14:26.846661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"746.349393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-01T21:14:26.84662Z","caller":"traceutil/trace.go:171","msg":"trace[1425278332] transaction","detail":"{read_only:false; response_revision:994; number_of_response:1; }","duration":"792.462315ms","start":"2026-03-01T21:14:26.054109Z","end":"2026-03-01T21:14:26.846572Z","steps":["trace[1425278332] 'process raft request'  (duration: 554.875248ms)","trace[1425278332] 'compare'  (duration: 236.990984ms)"],"step_count":2}
{"level":"info","ts":"2026-03-01T21:14:26.846643Z","caller":"traceutil/trace.go:171","msg":"trace[1120529196] transaction","detail":"{read_only:false; response_revision:995; number_of_response:1; }","duration":"792.324043ms","start":"2026-03-01T21:14:26.054282Z","end":"2026-03-01T21:14:26.846606Z","steps":["trace[1120529196] 'process raft request'  (duration: 792.100398ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T21:14:26.846704Z","caller":"traceutil/trace.go:171","msg":"trace[765836746] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:996; }","duration":"746.443775ms","start":"2026-03-01T21:14:26.100248Z","end":"2026-03-01T21:14:26.846691Z","steps":["trace[765836746] 'agreement among raft nodes before linearized reading'  (duration: 746.310752ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T21:14:26.846745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:14:26.100221Z","time spent":"746.515027ms","remote":"127.0.0.1:37248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-01T21:14:26.846825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:14:26.054101Z","time spent":"792.615858ms","remote":"127.0.0.1:37480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:976 > 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-03-01T21:14:26.846832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:14:26.054273Z","time spent":"792.460476ms","remote":"127.0.0.1:37480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:974 > 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-03-01T21:14:26.846976Z","caller":"traceutil/trace.go:171","msg":"trace[360612419] transaction","detail":"{read_only:false; response_revision:996; number_of_response:1; }","duration":"782.268984ms","start":"2026-03-01T21:14:26.064695Z","end":"2026-03-01T21:14:26.846964Z","steps":["trace[360612419] 'process raft request'  (duration: 781.744812ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T21:14:26.847048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:14:26.064685Z","time spent":"782.325715ms","remote":"127.0.0.1:37304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":887,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-6f6497f79c-wr6zr.1898d41b0fa10d76\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-6f6497f79c-wr6zr.1898d41b0fa10d76\" value_size:782 lease:5697507262904263591 >> failure:<>"}
{"level":"info","ts":"2026-03-01T21:14:28.086202Z","caller":"traceutil/trace.go:171","msg":"trace[323182952] transaction","detail":"{read_only:false; response_revision:1001; number_of_response:1; }","duration":"143.801787ms","start":"2026-03-01T21:14:27.942371Z","end":"2026-03-01T21:14:28.086172Z","steps":["trace[323182952] 'process raft request'  (duration: 143.537482ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T21:14:28.822715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"605.9723ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14920879299759039651 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:992 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-01T21:14:28.822955Z","caller":"traceutil/trace.go:171","msg":"trace[180252117] linearizableReadLoop","detail":"{readStateIndex:1049; appliedIndex:1047; }","duration":"722.452824ms","start":"2026-03-01T21:14:28.100479Z","end":"2026-03-01T21:14:28.822932Z","steps":["trace[180252117] 'read index received'  (duration: 116.112137ms)","trace[180252117] 'applied index is now lower than readState.Index'  (duration: 606.327777ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-01T21:14:28.823034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"722.548116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-01T21:14:28.82307Z","caller":"traceutil/trace.go:171","msg":"trace[2035240129] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1003; }","duration":"722.598587ms","start":"2026-03-01T21:14:28.10046Z","end":"2026-03-01T21:14:28.823059Z","steps":["trace[2035240129] 'agreement among raft nodes before linearized reading'  (duration: 722.538406ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T21:14:28.823103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:14:28.100452Z","time spent":"722.643738ms","remote":"127.0.0.1:37248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-01T21:14:28.823136Z","caller":"traceutil/trace.go:171","msg":"trace[1747886203] transaction","detail":"{read_only:false; response_revision:1002; number_of_response:1; }","duration":"731.114333ms","start":"2026-03-01T21:14:28.091977Z","end":"2026-03-01T21:14:28.823091Z","steps":["trace[1747886203] 'process raft request'  (duration: 124.653423ms)","trace[1747886203] 'compare'  (duration: 605.848147ms)"],"step_count":2}
{"level":"info","ts":"2026-03-01T21:14:28.823336Z","caller":"traceutil/trace.go:171","msg":"trace[1517450018] transaction","detail":"{read_only:false; response_revision:1003; number_of_response:1; }","duration":"730.476808ms","start":"2026-03-01T21:14:28.092846Z","end":"2026-03-01T21:14:28.823323Z","steps":["trace[1517450018] 'process raft request'  (duration: 730.014688ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T21:14:28.823383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:14:28.091947Z","time spent":"731.313106ms","remote":"127.0.0.1:37480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:992 > 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-03-01T21:14:28.823412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:14:28.092829Z","time spent":"730.549209ms","remote":"127.0.0.1:37480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:993 > 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-03-01T21:14:29.326649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.802067ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14920879299759039657 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:995 > 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-03-01T21:14:29.326897Z","caller":"traceutil/trace.go:171","msg":"trace[1789290605] linearizableReadLoop","detail":"{readStateIndex:1051; appliedIndex:1049; }","duration":"223.886318ms","start":"2026-03-01T21:14:29.102992Z","end":"2026-03-01T21:14:29.326879Z","steps":["trace[1789290605] 'read index received'  (duration: 114.927749ms)","trace[1789290605] 'applied index is now lower than readState.Index'  (duration: 108.957199ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-01T21:14:29.326972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.065062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-01T21:14:29.326999Z","caller":"traceutil/trace.go:171","msg":"trace[1763699348] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1005; }","duration":"224.139304ms","start":"2026-03-01T21:14:29.10285Z","end":"2026-03-01T21:14:29.326989Z","steps":["trace[1763699348] 'agreement among raft nodes before linearized reading'  (duration: 224.084493ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T21:14:29.327075Z","caller":"traceutil/trace.go:171","msg":"trace[1004881692] transaction","detail":"{read_only:false; response_revision:1004; number_of_response:1; }","duration":"458.012371ms","start":"2026-03-01T21:14:28.869025Z","end":"2026-03-01T21:14:29.327037Z","steps":["trace[1004881692] 'process raft request'  (duration: 348.720064ms)","trace[1004881692] 'compare'  (duration: 108.50395ms)"],"step_count":2}
{"level":"info","ts":"2026-03-01T21:14:29.327234Z","caller":"traceutil/trace.go:171","msg":"trace[1961262896] transaction","detail":"{read_only:false; response_revision:1005; number_of_response:1; }","duration":"457.132312ms","start":"2026-03-01T21:14:28.870091Z","end":"2026-03-01T21:14:29.327223Z","steps":["trace[1961262896] 'process raft request'  (duration: 456.696602ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T21:14:29.327265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:14:28.869005Z","time spent":"458.159383ms","remote":"127.0.0.1:37480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:995 > 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-03-01T21:14:29.327293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:14:28.870071Z","time spent":"457.192143ms","remote":"127.0.0.1:37480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:994 > 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-03-01T21:14:30.202563Z","caller":"traceutil/trace.go:171","msg":"trace[1777485245] transaction","detail":"{read_only:false; response_revision:1006; number_of_response:1; }","duration":"106.856904ms","start":"2026-03-01T21:14:30.095578Z","end":"2026-03-01T21:14:30.202435Z","steps":["trace[1777485245] 'process raft request'  (duration: 106.696331ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T21:14:30.202606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.010197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-01T21:14:30.202948Z","caller":"traceutil/trace.go:171","msg":"trace[930926755] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1006; }","duration":"101.410296ms","start":"2026-03-01T21:14:30.101522Z","end":"2026-03-01T21:14:30.202933Z","steps":["trace[930926755] 'agreement among raft nodes before linearized reading'  (duration: 101.018117ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T21:14:30.203149Z","caller":"traceutil/trace.go:171","msg":"trace[1658656975] linearizableReadLoop","detail":"{readStateIndex:1052; appliedIndex:1051; }","duration":"100.825232ms","start":"2026-03-01T21:14:30.101583Z","end":"2026-03-01T21:14:30.202408Z","steps":["trace[1658656975] 'read index received'  (duration: 100.657569ms)","trace[1658656975] 'applied index is now lower than readState.Index'  (duration: 166.643µs)"],"step_count":2}
{"level":"info","ts":"2026-03-01T21:14:31.467733Z","caller":"traceutil/trace.go:171","msg":"trace[472143721] transaction","detail":"{read_only:false; response_revision:1009; number_of_response:1; }","duration":"130.59466ms","start":"2026-03-01T21:14:31.337104Z","end":"2026-03-01T21:14:31.467699Z","steps":["trace[472143721] 'process raft request'  (duration: 130.326664ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T21:14:31.470141Z","caller":"traceutil/trace.go:171","msg":"trace[1901970278] transaction","detail":"{read_only:false; response_revision:1010; number_of_response:1; }","duration":"132.624594ms","start":"2026-03-01T21:14:31.3375Z","end":"2026-03-01T21:14:31.470125Z","steps":["trace[1901970278] 'process raft request'  (duration: 132.547072ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T21:14:38.218371Z","caller":"traceutil/trace.go:171","msg":"trace[1933126131] transaction","detail":"{read_only:false; response_revision:1067; number_of_response:1; }","duration":"710.287192ms","start":"2026-03-01T21:14:37.508046Z","end":"2026-03-01T21:14:38.218333Z","steps":["trace[1933126131] 'process raft request'  (duration: 710.086788ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T21:14:38.218592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:14:37.508024Z","time spent":"710.449815ms","remote":"127.0.0.1:37480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:1059 > 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-03-01T21:14:38.467622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.897737ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14920879299759039779 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:1060 > 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-03-01T21:14:38.467728Z","caller":"traceutil/trace.go:171","msg":"trace[642287616] linearizableReadLoop","detail":"{readStateIndex:1116; appliedIndex:1114; }","duration":"504.862059ms","start":"2026-03-01T21:14:37.962851Z","end":"2026-03-01T21:14:38.467713Z","steps":["trace[642287616] 'read index received'  (duration: 255.292723ms)","trace[642287616] 'applied index is now lower than readState.Index'  (duration: 249.568396ms)"],"step_count":2}
{"level":"info","ts":"2026-03-01T21:14:38.468173Z","caller":"traceutil/trace.go:171","msg":"trace[96117047] transaction","detail":"{read_only:false; response_revision:1068; number_of_response:1; }","duration":"959.384888ms","start":"2026-03-01T21:14:37.508776Z","end":"2026-03-01T21:14:38.46816Z","steps":["trace[96117047] 'process raft request'  (duration: 792.865487ms)","trace[96117047] 'compare'  (duration: 165.736314ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-01T21:14:38.468161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"505.283448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:621"}
{"level":"warn","ts":"2026-03-01T21:14:38.468248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:14:37.508754Z","time spent":"959.44939ms","remote":"127.0.0.1:37480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:1060 > 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-03-01T21:14:38.468255Z","caller":"traceutil/trace.go:171","msg":"trace[380761642] range","detail":"{range_begin:/registry/configmaps/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1068; }","duration":"505.453102ms","start":"2026-03-01T21:14:37.962777Z","end":"2026-03-01T21:14:38.46823Z","steps":["trace[380761642] 'agreement among raft nodes before linearized reading'  (duration: 505.145056ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T21:14:38.468336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:14:37.962746Z","time spent":"505.580164ms","remote":"127.0.0.1:37334","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":1,"response size":642,"request content":"key:\"/registry/configmaps/kube-system/rbd.csi.ceph.com-kube-system\" "}
{"level":"warn","ts":"2026-03-01T21:14:38.46884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.979274ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"warn","ts":"2026-03-01T21:14:38.468912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.324846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-01T21:14:38.469181Z","caller":"traceutil/trace.go:171","msg":"trace[1381027627] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1068; }","duration":"366.610992ms","start":"2026-03-01T21:14:38.10254Z","end":"2026-03-01T21:14:38.469151Z","steps":["trace[1381027627] 'agreement among raft nodes before linearized reading'  (duration: 365.576229ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T21:14:38.469259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:14:38.102526Z","time spent":"366.717525ms","remote":"127.0.0.1:37248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-01T21:14:38.469285Z","caller":"traceutil/trace.go:171","msg":"trace[556692061] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1068; }","duration":"232.350822ms","start":"2026-03-01T21:14:38.23678Z","end":"2026-03-01T21:14:38.469131Z","steps":["trace[556692061] 'agreement among raft nodes before linearized reading'  (duration: 231.34628ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T21:14:40.830263Z","caller":"traceutil/trace.go:171","msg":"trace[1469420504] transaction","detail":"{read_only:false; response_revision:1082; number_of_response:1; }","duration":"194.303555ms","start":"2026-03-01T21:14:40.635928Z","end":"2026-03-01T21:14:40.830232Z","steps":["trace[1469420504] 'process raft request'  (duration: 182.813776ms)","trace[1469420504] 'compare'  (duration: 11.345456ms)"],"step_count":2}
{"level":"info","ts":"2026-03-01T21:14:41.052059Z","caller":"traceutil/trace.go:171","msg":"trace[344505547] transaction","detail":"{read_only:false; response_revision:1083; number_of_response:1; }","duration":"122.458193ms","start":"2026-03-01T21:14:40.929571Z","end":"2026-03-01T21:14:41.052029Z","steps":["trace[344505547] 'process raft request'  (duration: 121.854609ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T21:14:41.30923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.684654ms","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-03-01T21:14:41.309336Z","caller":"traceutil/trace.go:171","msg":"trace[1452560557] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:1084; }","duration":"154.876108ms","start":"2026-03-01T21:14:41.154435Z","end":"2026-03-01T21:14:41.309311Z","steps":["trace[1452560557] 'count revisions from in-memory index tree'  (duration: 154.590642ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T21:14:43.189809Z","caller":"traceutil/trace.go:171","msg":"trace[1227470738] transaction","detail":"{read_only:false; response_revision:1092; number_of_response:1; }","duration":"105.73097ms","start":"2026-03-01T21:14:43.084056Z","end":"2026-03-01T21:14:43.189787Z","steps":["trace[1227470738] 'process raft request'  (duration: 105.587107ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T21:16:05.815988Z","caller":"traceutil/trace.go:171","msg":"trace[3680364] transaction","detail":"{read_only:false; response_revision:1469; number_of_response:1; }","duration":"130.286656ms","start":"2026-03-01T21:16:05.685677Z","end":"2026-03-01T21:16:05.815964Z","steps":["trace[3680364] 'process raft request'  (duration: 130.110572ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T21:17:50.580631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.08587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-03-01T21:17:50.580746Z","caller":"traceutil/trace.go:171","msg":"trace[1534316128] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1973; }","duration":"166.277624ms","start":"2026-03-01T21:17:50.414444Z","end":"2026-03-01T21:17:50.580722Z","steps":["trace[1534316128] 'range keys from in-memory index tree'  (duration: 165.806873ms)"],"step_count":1}