{"level":"warn","ts":"2026-07-08T02:18:51.301326Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-08T02:18:51.301415Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.227: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.227:2380","--initial-cluster=instance=https://199.204.45.227:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.227:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.227: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-07-08T02:18:51.301471Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-08T02:18:51.301479Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.227:2380"]} {"level":"info","ts":"2026-07-08T02:18:51.301494Z","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-07-08T02:18:51.302203Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.227:2379"]} {"level":"info","ts":"2026-07-08T02:18:51.302275Z","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.227:2380"],"listen-peer-urls":["https://199.204.45.227:2380"],"advertise-client-urls":["https://199.204.45.227:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.227:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.227: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-07-08T02:18:51.304708Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.222454ms"} {"level":"info","ts":"2026-07-08T02:18:51.310266Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"572db18442eba1c2","cluster-id":"fb1028a037bf3cd6"} {"level":"info","ts":"2026-07-08T02:18:51.310325Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 switched to configuration voters=()"} {"level":"info","ts":"2026-07-08T02:18:51.310345Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became follower at term 0"} {"level":"info","ts":"2026-07-08T02:18:51.310361Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 572db18442eba1c2 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-08T02:18:51.310368Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became follower at term 1"} {"level":"info","ts":"2026-07-08T02:18:51.310395Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 switched to configuration voters=(6281872236868248002)"} {"level":"warn","ts":"2026-07-08T02:18:51.317924Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-08T02:18:51.320449Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-08T02:18:51.322627Z","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-07-08T02:18:51.326131Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"572db18442eba1c2","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-08T02:18:51.327201Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"572db18442eba1c2","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-08T02:18:51.329304Z","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-07-08T02:18:51.32942Z","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-07-08T02:18:51.329434Z","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-07-08T02:18:51.337261Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 switched to configuration voters=(6281872236868248002)"} {"level":"info","ts":"2026-07-08T02:18:51.337349Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"fb1028a037bf3cd6","local-member-id":"572db18442eba1c2","added-peer-id":"572db18442eba1c2","added-peer-peer-urls":["https://199.204.45.227:2380"]} {"level":"info","ts":"2026-07-08T02:18:51.338126Z","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-07-08T02:18:51.338334Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"572db18442eba1c2","initial-advertise-peer-urls":["https://199.204.45.227:2380"],"listen-peer-urls":["https://199.204.45.227:2380"],"advertise-client-urls":["https://199.204.45.227:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.227:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-08T02:18:51.338359Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-08T02:18:51.338459Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.227:2380"} {"level":"info","ts":"2026-07-08T02:18:51.338473Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.227:2380"} {"level":"info","ts":"2026-07-08T02:18:51.711725Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 is starting a new election at term 1"} {"level":"info","ts":"2026-07-08T02:18:51.711776Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-08T02:18:51.711799Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 received MsgPreVoteResp from 572db18442eba1c2 at term 1"} {"level":"info","ts":"2026-07-08T02:18:51.711825Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became candidate at term 2"} {"level":"info","ts":"2026-07-08T02:18:51.711831Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 received MsgVoteResp from 572db18442eba1c2 at term 2"} {"level":"info","ts":"2026-07-08T02:18:51.711839Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became leader at term 2"} {"level":"info","ts":"2026-07-08T02:18:51.711847Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 572db18442eba1c2 elected leader 572db18442eba1c2 at term 2"} {"level":"info","ts":"2026-07-08T02:18:51.715848Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"572db18442eba1c2","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.227:2379]}","request-path":"/0/members/572db18442eba1c2/attributes","cluster-id":"fb1028a037bf3cd6","publish-timeout":"7s"} {"level":"info","ts":"2026-07-08T02:18:51.71598Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-08T02:18:51.716047Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-08T02:18:51.716131Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-08T02:18:51.716857Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"fb1028a037bf3cd6","local-member-id":"572db18442eba1c2","cluster-version":"3.5"} {"level":"info","ts":"2026-07-08T02:18:51.716857Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-08T02:18:51.716888Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-08T02:18:51.716957Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-08T02:18:51.717002Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-08T02:18:51.718566Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.227:2379"} {"level":"info","ts":"2026-07-08T02:18:51.721114Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-08T02:18:54.393541Z","caller":"traceutil/trace.go:171","msg":"trace[1233941813] linearizableReadLoop","detail":"{readStateIndex:76; appliedIndex:75; }","duration":"193.151234ms","start":"2026-07-08T02:18:54.20034Z","end":"2026-07-08T02:18:54.393491Z","steps":["trace[1233941813] 'read index received' (duration: 192.822346ms)","trace[1233941813] 'applied index is now lower than readState.Index' (duration: 327.328µs)"],"step_count":2} {"level":"info","ts":"2026-07-08T02:18:54.393986Z","caller":"traceutil/trace.go:171","msg":"trace[672236111] transaction","detail":"{read_only:false; response_revision:72; number_of_response:1; }","duration":"195.323097ms","start":"2026-07-08T02:18:54.19858Z","end":"2026-07-08T02:18:54.393903Z","steps":["trace[672236111] 'process raft request' (duration: 194.670711ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:18:54.394144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.658186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-admin\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-08T02:18:54.394617Z","caller":"traceutil/trace.go:171","msg":"trace[1488104785] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-admin; range_end:; response_count:0; response_revision:72; }","duration":"194.307661ms","start":"2026-07-08T02:18:54.20028Z","end":"2026-07-08T02:18:54.394588Z","steps":["trace[1488104785] 'agreement among raft nodes before linearized reading' (duration: 193.467961ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:18:55.51025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"814.911976ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-07-08T02:18:55.511685Z","caller":"traceutil/trace.go:171","msg":"trace[635859744] linearizableReadLoop","detail":"{readStateIndex:77; appliedIndex:76; }","duration":"1.110407891s","start":"2026-07-08T02:18:54.401229Z","end":"2026-07-08T02:18:55.511637Z","steps":["trace[635859744] 'read index received' (duration: 293.448866ms)","trace[635859744] 'applied index is now lower than readState.Index' (duration: 816.410042ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T02:18:55.51216Z","caller":"traceutil/trace.go:171","msg":"trace[255513833] transaction","detail":"{read_only:false; response_revision:73; number_of_response:1; }","duration":"1.110288387s","start":"2026-07-08T02:18:54.400297Z","end":"2026-07-08T02:18:55.510586Z","steps":["trace[255513833] 'process raft request' (duration: 294.247814ms)","trace[255513833] 'compare' (duration: 814.582759ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T02:18:55.512647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.111400014s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/edit\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-08T02:18:55.512764Z","caller":"traceutil/trace.go:171","msg":"trace[1231496927] range","detail":"{range_begin:/registry/clusterroles/edit; range_end:; response_count:0; response_revision:73; }","duration":"1.111508567s","start":"2026-07-08T02:18:54.40119Z","end":"2026-07-08T02:18:55.512699Z","steps":["trace[1231496927] 'agreement among raft nodes before linearized reading' (duration: 1.110002992s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:18:55.512866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:18:54.401149Z","time spent":"1.111702582s","remote":"127.0.0.1:43730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":27,"request content":"key:\"/registry/clusterroles/edit\" "} {"level":"warn","ts":"2026-07-08T02:18:55.512719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:18:54.400279Z","time spent":"1.112084171s","remote":"127.0.0.1:43754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-08T02:18:55.516401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:18:55.079229Z","time spent":"437.162055ms","remote":"127.0.0.1:43432","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-07-08T02:18:55.942466Z","caller":"traceutil/trace.go:171","msg":"trace[1608199810] transaction","detail":"{read_only:false; response_revision:75; number_of_response:1; }","duration":"423.497846ms","start":"2026-07-08T02:18:55.518932Z","end":"2026-07-08T02:18:55.94243Z","steps":["trace[1608199810] 'process raft request' (duration: 423.419994ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:18:55.942499Z","caller":"traceutil/trace.go:171","msg":"trace[536471332] transaction","detail":"{read_only:false; response_revision:74; number_of_response:1; }","duration":"758.178835ms","start":"2026-07-08T02:18:55.184245Z","end":"2026-07-08T02:18:55.942424Z","steps":["trace[536471332] 'process raft request' (duration: 754.754472ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:18:55.942587Z","caller":"traceutil/trace.go:171","msg":"trace[1320500556] linearizableReadLoop","detail":"{readStateIndex:79; appliedIndex:78; }","duration":"430.74972ms","start":"2026-07-08T02:18:55.511791Z","end":"2026-07-08T02:18:55.94254Z","steps":["trace[1320500556] 'read index received' (duration: 427.157362ms)","trace[1320500556] 'applied index is now lower than readState.Index' (duration: 3.586578ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T02:18:55.942758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:18:55.184207Z","time spent":"758.423681ms","remote":"127.0.0.1:43562","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2905,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-08T02:18:55.942978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"532.147569ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-08T02:18:55.943034Z","caller":"traceutil/trace.go:171","msg":"trace[1834479033] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:75; }","duration":"532.254462ms","start":"2026-07-08T02:18:55.410765Z","end":"2026-07-08T02:18:55.943019Z","steps":["trace[1834479033] 'agreement among raft nodes before linearized reading' (duration: 531.955694ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:18:55.94313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:18:55.410741Z","time spent":"532.378164ms","remote":"127.0.0.1:43370","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-08T02:18:55.94325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:18:55.518913Z","time spent":"423.67423ms","remote":"127.0.0.1:43432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":592,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-08T02:18:55.943527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.640733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-view\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-08T02:18:55.943591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.380143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-08T02:18:55.943583Z","caller":"traceutil/trace.go:171","msg":"trace[823823776] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-view; range_end:; response_count:0; response_revision:75; }","duration":"424.743546ms","start":"2026-07-08T02:18:55.518824Z","end":"2026-07-08T02:18:55.943568Z","steps":["trace[823823776] 'agreement among raft nodes before linearized reading' (duration: 424.633793ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:18:55.943696Z","caller":"traceutil/trace.go:171","msg":"trace[650038981] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:75; }","duration":"131.500486ms","start":"2026-07-08T02:18:55.812171Z","end":"2026-07-08T02:18:55.943672Z","steps":["trace[650038981] 'agreement among raft nodes before linearized reading' (duration: 131.325432ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:18:55.943746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:18:55.518799Z","time spent":"424.93644ms","remote":"127.0.0.1:43730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":0,"response size":27,"request content":"key:\"/registry/clusterroles/system:aggregate-to-view\" "} {"level":"info","ts":"2026-07-08T02:19:10.144366Z","caller":"traceutil/trace.go:171","msg":"trace[2003960398] transaction","detail":"{read_only:false; response_revision:416; number_of_response:1; }","duration":"114.372289ms","start":"2026-07-08T02:19:10.029968Z","end":"2026-07-08T02:19:10.14434Z","steps":["trace[2003960398] 'process raft request' (duration: 114.206725ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:19:25.827976Z","caller":"traceutil/trace.go:171","msg":"trace[382935401] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"108.835406ms","start":"2026-07-08T02:19:25.719111Z","end":"2026-07-08T02:19:25.827947Z","steps":["trace[382935401] 'process raft request' (duration: 108.61086ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:19:26.659537Z","caller":"traceutil/trace.go:171","msg":"trace[1581082107] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"144.680533ms","start":"2026-07-08T02:19:26.514831Z","end":"2026-07-08T02:19:26.659512Z","steps":["trace[1581082107] 'process raft request' (duration: 144.57554ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:19:32.063733Z","caller":"traceutil/trace.go:171","msg":"trace[126416495] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"199.808568ms","start":"2026-07-08T02:19:31.863885Z","end":"2026-07-08T02:19:32.063693Z","steps":["trace[126416495] 'process raft request' (duration: 199.571012ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:19:32.589706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.430929ms","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-07-08T02:19:32.589856Z","caller":"traceutil/trace.go:171","msg":"trace[1615378717] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:532; }","duration":"370.606394ms","start":"2026-07-08T02:19:32.219225Z","end":"2026-07-08T02:19:32.589831Z","steps":["trace[1615378717] 'range keys from in-memory index tree' (duration: 370.356687ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:19:32.625262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.030729ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-07-08T02:19:32.62537Z","caller":"traceutil/trace.go:171","msg":"trace[936249112] linearizableReadLoop","detail":"{readStateIndex:553; appliedIndex:551; }","duration":"715.960873ms","start":"2026-07-08T02:19:31.90939Z","end":"2026-07-08T02:19:32.625351Z","steps":["trace[936249112] 'read index received' (duration: 154.140392ms)","trace[936249112] 'applied index is now lower than readState.Index' (duration: 561.818651ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T02:19:32.625522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"716.125366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T02:19:32.625555Z","caller":"traceutil/trace.go:171","msg":"trace[1963669974] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:532; }","duration":"716.221178ms","start":"2026-07-08T02:19:31.909321Z","end":"2026-07-08T02:19:32.625542Z","steps":["trace[1963669974] 'agreement among raft nodes before linearized reading' (duration: 716.148736ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:19:32.6256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:19:31.909292Z","time spent":"716.29525ms","remote":"127.0.0.1:43452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" "} {"level":"warn","ts":"2026-07-08T02:19:32.625768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.717152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-08T02:19:32.625911Z","caller":"traceutil/trace.go:171","msg":"trace[1087655355] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:532; }","duration":"360.952777ms","start":"2026-07-08T02:19:32.264928Z","end":"2026-07-08T02:19:32.625881Z","steps":["trace[1087655355] 'agreement among raft nodes before linearized reading' (duration: 360.64159ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:19:32.625971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:19:32.264902Z","time spent":"361.05875ms","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-08T02:19:39.22055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"440.551046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T02:19:39.220693Z","caller":"traceutil/trace.go:171","msg":"trace[887371857] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:638; }","duration":"440.780532ms","start":"2026-07-08T02:19:38.779882Z","end":"2026-07-08T02:19:39.220663Z","steps":["trace[887371857] 'range keys from in-memory index tree' (duration: 440.426602ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:19:39.22075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:19:38.779859Z","time spent":"440.880714ms","remote":"127.0.0.1:43370","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-08T02:19:39.263086Z","caller":"traceutil/trace.go:171","msg":"trace[725078052] linearizableReadLoop","detail":"{readStateIndex:665; appliedIndex:664; }","duration":"307.76589ms","start":"2026-07-08T02:19:38.955282Z","end":"2026-07-08T02:19:39.263048Z","steps":["trace[725078052] 'read index received' (duration: 306.889288ms)","trace[725078052] 'applied index is now lower than readState.Index' (duration: 875.002µs)"],"step_count":2} {"level":"info","ts":"2026-07-08T02:19:39.263169Z","caller":"traceutil/trace.go:171","msg":"trace[2145432669] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"354.976904ms","start":"2026-07-08T02:19:38.908137Z","end":"2026-07-08T02:19:39.263114Z","steps":["trace[2145432669] 'process raft request' (duration: 354.333398ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:19:39.263316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.002867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-nx25w\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-07-08T02:19:39.263411Z","caller":"traceutil/trace.go:171","msg":"trace[641292158] range","detail":"{range_begin:/registry/pods/kube-system/cilium-nx25w; range_end:; response_count:1; response_revision:639; }","duration":"308.16793ms","start":"2026-07-08T02:19:38.95522Z","end":"2026-07-08T02:19:39.263388Z","steps":["trace[641292158] 'agreement among raft nodes before linearized reading' (duration: 307.980586ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:19:39.263464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:19:38.955195Z","time spent":"308.259572ms","remote":"127.0.0.1:43562","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-nx25w\" "} {"level":"warn","ts":"2026-07-08T02:19:39.263685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:19:38.908092Z","time spent":"355.23976ms","remote":"127.0.0.1:43452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036257,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T02:19:39.415026Z","caller":"traceutil/trace.go:171","msg":"trace[1850066148] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"134.198999ms","start":"2026-07-08T02:19:39.280795Z","end":"2026-07-08T02:19:39.414994Z","steps":["trace[1850066148] 'process raft request' (duration: 74.997536ms)","trace[1850066148] 'compare' (duration: 58.917366ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T02:19:40.597627Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656053880757171030,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-08T02:19:40.694794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.060829223s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-07-08T02:19:40.694885Z","caller":"traceutil/trace.go:171","msg":"trace[1372813499] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:641; }","duration":"1.060989527s","start":"2026-07-08T02:19:39.633874Z","end":"2026-07-08T02:19:40.694864Z","steps":["trace[1372813499] 'range keys from in-memory index tree' (duration: 1.060621258s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:19:40.694933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:19:39.633851Z","time spent":"1.06107143s","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-08T02:19:40.694913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"912.739248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T02:19:40.6951Z","caller":"traceutil/trace.go:171","msg":"trace[594145425] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:641; }","duration":"912.957384ms","start":"2026-07-08T02:19:39.782097Z","end":"2026-07-08T02:19:40.695054Z","steps":["trace[594145425] 'range keys from in-memory index tree' (duration: 912.649066ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:19:40.695216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:19:39.782073Z","time spent":"913.101257ms","remote":"127.0.0.1:43370","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-08T02:19:40.755905Z","caller":"traceutil/trace.go:171","msg":"trace[10852424] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"898.991915ms","start":"2026-07-08T02:19:39.856878Z","end":"2026-07-08T02:19:40.75587Z","steps":["trace[10852424] 'process raft request' (duration: 889.793392ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:19:40.756083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:19:39.856853Z","time spent":"899.137978ms","remote":"127.0.0.1:43452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T02:19:42.697074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000496792s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-07-08T02:19:42.697185Z","caller":"traceutil/trace.go:171","msg":"trace[950632163] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000629737s","start":"2026-07-08T02:19:40.696528Z","end":"2026-07-08T02:19:42.697158Z","steps":["trace[950632163] 'agreement among raft nodes before linearized reading' (duration: 2.000492892s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:19:42.697246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:19:40.696489Z","time spent":"2.000744259s","remote":"127.0.0.1:43364","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/07/08 02:19:42 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-07-08T02:19:42.805799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"586.173191ms","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-07-08T02:19:42.80597Z","caller":"traceutil/trace.go:171","msg":"trace[1187553389] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:642; }","duration":"586.360275ms","start":"2026-07-08T02:19:42.21959Z","end":"2026-07-08T02:19:42.80595Z","steps":["trace[1187553389] 'range keys from in-memory index tree' (duration: 586.15174ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:19:42.806082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.963581409s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-08T02:19:42.806472Z","caller":"traceutil/trace.go:171","msg":"trace[565456850] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"2.854776816s","start":"2026-07-08T02:19:39.951651Z","end":"2026-07-08T02:19:42.806428Z","steps":["trace[565456850] 'process raft request' (duration: 890.714984ms)","trace[565456850] 'compare' (duration: 1.963397225s)"],"step_count":2} {"level":"warn","ts":"2026-07-08T02:19:42.807003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:19:39.951609Z","time spent":"2.85494989s","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T02:19:42.807063Z","caller":"traceutil/trace.go:171","msg":"trace[341869476] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"2.106956429s","start":"2026-07-08T02:19:40.700085Z","end":"2026-07-08T02:19:42.807042Z","steps":["trace[341869476] 'process raft request' (duration: 2.106119888s)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:19:42.807104Z","caller":"traceutil/trace.go:171","msg":"trace[533980106] linearizableReadLoop","detail":"{readStateIndex:669; appliedIndex:667; }","duration":"2.709522268s","start":"2026-07-08T02:19:40.097494Z","end":"2026-07-08T02:19:42.807017Z","steps":["trace[533980106] 'read index received' (duration: 648.436008ms)","trace[533980106] 'applied index is now lower than readState.Index' (duration: 2.061077539s)"],"step_count":2} {"level":"warn","ts":"2026-07-08T02:19:42.807266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:19:40.700063Z","time spent":"2.107073273s","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T02:19:42.807445Z","caller":"traceutil/trace.go:171","msg":"trace[4840622] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"1.973887278s","start":"2026-07-08T02:19:40.833541Z","end":"2026-07-08T02:19:42.807428Z","steps":["trace[4840622] 'process raft request' (duration: 1.97274077s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:19:42.807532Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:19:40.833484Z","time spent":"1.974000742s","remote":"127.0.0.1:43904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-08T02:19:42.836661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.739157345s","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-07-08T02:19:42.836786Z","caller":"traceutil/trace.go:171","msg":"trace[1029510843] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:645; }","duration":"2.739415502s","start":"2026-07-08T02:19:40.097349Z","end":"2026-07-08T02:19:42.836764Z","steps":["trace[1029510843] 'agreement among raft nodes before linearized reading' (duration: 2.709914669s)","trace[1029510843] 'range keys from in-memory index tree' (duration: 29.220737ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T02:19:42.836796Z","caller":"traceutil/trace.go:171","msg":"trace[1515249776] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"135.573852ms","start":"2026-07-08T02:19:42.701118Z","end":"2026-07-08T02:19:42.836692Z","steps":["trace[1515249776] 'process raft request' (duration: 135.378547ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:19:42.836877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:19:40.097324Z","time spent":"2.739542925s","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-08T02:19:42.836887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.402581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T02:19:42.836948Z","caller":"traceutil/trace.go:171","msg":"trace[1804667817] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:646; }","duration":"131.512503ms","start":"2026-07-08T02:19:42.705419Z","end":"2026-07-08T02:19:42.836931Z","steps":["trace[1804667817] 'agreement among raft nodes before linearized reading' (duration: 131.37087ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:19:42.837061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.147199994s","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-07-08T02:19:42.837145Z","caller":"traceutil/trace.go:171","msg":"trace[1735656199] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:646; }","duration":"2.147339147s","start":"2026-07-08T02:19:40.689783Z","end":"2026-07-08T02:19:42.837122Z","steps":["trace[1735656199] 'agreement among raft nodes before linearized reading' (duration: 2.147142672s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:19:42.837183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:19:40.689749Z","time spent":"2.147424229s","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-08T02:19:42.837259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.113795026s","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-07-08T02:19:42.837282Z","caller":"traceutil/trace.go:171","msg":"trace[1991300405] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:646; }","duration":"2.113831717s","start":"2026-07-08T02:19:40.723443Z","end":"2026-07-08T02:19:42.837275Z","steps":["trace[1991300405] 'agreement among raft nodes before linearized reading' (duration: 2.113782045s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:19:42.837305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:19:40.723434Z","time spent":"2.113866697s","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-08T02:19:44.658964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.227014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T02:19:44.659079Z","caller":"traceutil/trace.go:171","msg":"trace[819199076] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:0; response_revision:685; }","duration":"216.42784ms","start":"2026-07-08T02:19:44.442626Z","end":"2026-07-08T02:19:44.659054Z","steps":["trace[819199076] 'range keys from in-memory index tree' (duration: 216.127752ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:19:44.659237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.469628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T02:19:44.659345Z","caller":"traceutil/trace.go:171","msg":"trace[914593669] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:0; response_revision:685; }","duration":"415.620681ms","start":"2026-07-08T02:19:44.243712Z","end":"2026-07-08T02:19:44.659333Z","steps":["trace[914593669] 'range keys from in-memory index tree' (duration: 415.370516ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:19:44.659388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:19:44.243681Z","time spent":"415.694693ms","remote":"127.0.0.1:43402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" "} {"level":"info","ts":"2026-07-08T02:19:47.335882Z","caller":"traceutil/trace.go:171","msg":"trace[1313397406] transaction","detail":"{read_only:false; response_revision:728; number_of_response:1; }","duration":"165.176029ms","start":"2026-07-08T02:19:47.170685Z","end":"2026-07-08T02:19:47.335861Z","steps":["trace[1313397406] 'process raft request' (duration: 164.587375ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:19:55.109162Z","caller":"traceutil/trace.go:171","msg":"trace[1769080755] linearizableReadLoop","detail":"{readStateIndex:821; appliedIndex:820; }","duration":"199.165161ms","start":"2026-07-08T02:19:54.909976Z","end":"2026-07-08T02:19:55.109141Z","steps":["trace[1769080755] 'read index received' (duration: 199.09351ms)","trace[1769080755] 'applied index is now lower than readState.Index' (duration: 70.711µs)"],"step_count":2} {"level":"warn","ts":"2026-07-08T02:19:55.109333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.346586ms","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-07-08T02:19:55.109301Z","caller":"traceutil/trace.go:171","msg":"trace[1411486821] transaction","detail":"{read_only:false; response_revision:791; number_of_response:1; }","duration":"238.565546ms","start":"2026-07-08T02:19:54.870686Z","end":"2026-07-08T02:19:55.109252Z","steps":["trace[1411486821] 'process raft request' (duration: 238.31928ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:19:55.109363Z","caller":"traceutil/trace.go:171","msg":"trace[1470990611] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:791; }","duration":"199.418417ms","start":"2026-07-08T02:19:54.909937Z","end":"2026-07-08T02:19:55.109356Z","steps":["trace[1470990611] 'agreement among raft nodes before linearized reading' (duration: 199.304075ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:19:55.153822Z","caller":"traceutil/trace.go:171","msg":"trace[1073150549] transaction","detail":"{read_only:false; response_revision:792; number_of_response:1; }","duration":"112.831031ms","start":"2026-07-08T02:19:55.040958Z","end":"2026-07-08T02:19:55.153789Z","steps":["trace[1073150549] 'process raft request' (duration: 112.607216ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:19:55.153894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.016228ms","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-07-08T02:19:55.153931Z","caller":"traceutil/trace.go:171","msg":"trace[1510777919] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:792; }","duration":"225.13216ms","start":"2026-07-08T02:19:54.928789Z","end":"2026-07-08T02:19:55.153921Z","steps":["trace[1510777919] 'agreement among raft nodes before linearized reading' (duration: 224.951876ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:19:55.154092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.708991ms","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-07-08T02:19:55.154177Z","caller":"traceutil/trace.go:171","msg":"trace[1795580403] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:792; }","duration":"217.852914ms","start":"2026-07-08T02:19:54.936304Z","end":"2026-07-08T02:19:55.154157Z","steps":["trace[1795580403] 'agreement among raft nodes before linearized reading' (duration: 217.532056ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:19:58.953235Z","caller":"traceutil/trace.go:171","msg":"trace[886231934] transaction","detail":"{read_only:false; response_revision:812; number_of_response:1; }","duration":"800.51358ms","start":"2026-07-08T02:19:58.152628Z","end":"2026-07-08T02:19:58.953142Z","steps":["trace[886231934] 'process raft request' (duration: 800.306165ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:19:58.953441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:19:58.152581Z","time spent":"800.758125ms","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T02:20:33.738022Z","caller":"traceutil/trace.go:171","msg":"trace[1787573212] transaction","detail":"{read_only:false; response_revision:1023; number_of_response:1; }","duration":"326.280805ms","start":"2026-07-08T02:20:33.411706Z","end":"2026-07-08T02:20:33.737987Z","steps":["trace[1787573212] 'process raft request' (duration: 326.04909ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:20:33.738256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:20:33.411674Z","time spent":"326.46618ms","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T02:20:34.281799Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656053880757171885,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-08T02:20:34.76989Z","caller":"traceutil/trace.go:171","msg":"trace[32724119] transaction","detail":"{read_only:false; response_revision:1025; number_of_response:1; }","duration":"1.357490544s","start":"2026-07-08T02:20:33.412363Z","end":"2026-07-08T02:20:34.769853Z","steps":["trace[32724119] 'process raft request' (duration: 1.357396832s)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:20:34.769906Z","caller":"traceutil/trace.go:171","msg":"trace[1687774387] transaction","detail":"{read_only:false; response_revision:1024; number_of_response:1; }","duration":"1.357890963s","start":"2026-07-08T02:20:33.411966Z","end":"2026-07-08T02:20:34.769857Z","steps":["trace[1687774387] 'process raft request' (duration: 1.357569255s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:20:34.770134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:20:33.411948Z","time spent":"1.358068568s","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T02:20:34.770197Z","caller":"traceutil/trace.go:171","msg":"trace[978223863] transaction","detail":"{read_only:false; response_revision:1026; number_of_response:1; }","duration":"1.357537035s","start":"2026-07-08T02:20:33.412641Z","end":"2026-07-08T02:20:34.770178Z","steps":["trace[978223863] 'process raft request' (duration: 1.357164646s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:20:34.770325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:20:33.412634Z","time spent":"1.357602186s","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T02:20:34.770385Z","caller":"traceutil/trace.go:171","msg":"trace[910465177] linearizableReadLoop","detail":"{readStateIndex:1068; appliedIndex:1063; }","duration":"989.054246ms","start":"2026-07-08T02:20:33.781302Z","end":"2026-07-08T02:20:34.770357Z","steps":["trace[910465177] 'read index received' (duration: 988.080113ms)","trace[910465177] 'applied index is now lower than readState.Index' (duration: 972.753µs)"],"step_count":2} {"level":"warn","ts":"2026-07-08T02:20:34.77054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"989.2073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T02:20:34.770516Z","caller":"traceutil/trace.go:171","msg":"trace[232891177] transaction","detail":"{read_only:false; response_revision:1028; number_of_response:1; }","duration":"1.150347915s","start":"2026-07-08T02:20:33.620133Z","end":"2026-07-08T02:20:34.770481Z","steps":["trace[232891177] 'process raft request' (duration: 1.150163591s)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:20:34.770588Z","caller":"traceutil/trace.go:171","msg":"trace[1084005638] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1028; }","duration":"989.322102ms","start":"2026-07-08T02:20:33.781253Z","end":"2026-07-08T02:20:34.770576Z","steps":["trace[1084005638] 'agreement among raft nodes before linearized reading' (duration: 989.22175ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:20:34.770625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:20:33.781231Z","time spent":"989.386084ms","remote":"127.0.0.1:43370","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-08T02:20:34.770694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:20:33.620095Z","time spent":"1.150508749s","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T02:20:34.770612Z","caller":"traceutil/trace.go:171","msg":"trace[1409466015] transaction","detail":"{read_only:false; response_revision:1027; number_of_response:1; }","duration":"1.228893788s","start":"2026-07-08T02:20:33.541605Z","end":"2026-07-08T02:20:34.770499Z","steps":["trace[1409466015] 'process raft request' (duration: 1.228496278s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:20:34.770832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:20:33.412355Z","time spent":"1.357637247s","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T02:20:34.771116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:20:33.541575Z","time spent":"1.229250966s","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T02:21:01.396708Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656053880757172108,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-08T02:21:01.637784Z","caller":"traceutil/trace.go:171","msg":"trace[586387244] linearizableReadLoop","detail":"{readStateIndex:1156; appliedIndex:1155; }","duration":"742.033091ms","start":"2026-07-08T02:21:00.895727Z","end":"2026-07-08T02:21:01.63776Z","steps":["trace[586387244] 'read index received' (duration: 741.913808ms)","trace[586387244] 'applied index is now lower than readState.Index' (duration: 117.873µs)"],"step_count":2} {"level":"info","ts":"2026-07-08T02:21:01.637955Z","caller":"traceutil/trace.go:171","msg":"trace[1283453135] transaction","detail":"{read_only:false; response_revision:1111; number_of_response:1; }","duration":"758.147381ms","start":"2026-07-08T02:21:00.879741Z","end":"2026-07-08T02:21:01.637889Z","steps":["trace[1283453135] 'process raft request' (duration: 757.844424ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:21:01.638155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"726.381181ms","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-07-08T02:21:01.63847Z","caller":"traceutil/trace.go:171","msg":"trace[1945655208] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1111; }","duration":"726.74726ms","start":"2026-07-08T02:21:00.911711Z","end":"2026-07-08T02:21:01.638459Z","steps":["trace[1945655208] 'agreement among raft nodes before linearized reading' (duration: 726.189457ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:21:01.638506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:21:00.911693Z","time spent":"726.805312ms","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-08T02:21:01.63818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"742.42949ms","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-07-08T02:21:01.638608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.302167ms","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-07-08T02:21:01.638666Z","caller":"traceutil/trace.go:171","msg":"trace[1715378308] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1111; }","duration":"742.976093ms","start":"2026-07-08T02:21:00.895665Z","end":"2026-07-08T02:21:01.638642Z","steps":["trace[1715378308] 'agreement among raft nodes before linearized reading' (duration: 742.213445ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:21:01.638725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:21:00.895634Z","time spent":"743.076776ms","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-08T02:21:01.638728Z","caller":"traceutil/trace.go:171","msg":"trace[845310335] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1111; }","duration":"267.473681ms","start":"2026-07-08T02:21:01.371224Z","end":"2026-07-08T02:21:01.638698Z","steps":["trace[845310335] 'agreement among raft nodes before linearized reading' (duration: 266.827425ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:21:01.63823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.444195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T02:21:01.638849Z","caller":"traceutil/trace.go:171","msg":"trace[2082750660] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1111; }","duration":"328.163532ms","start":"2026-07-08T02:21:01.310665Z","end":"2026-07-08T02:21:01.638829Z","steps":["trace[2082750660] 'agreement among raft nodes before linearized reading' (duration: 327.434134ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:21:01.638274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"723.498711ms","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-07-08T02:21:01.638897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:21:01.310618Z","time spent":"328.262134ms","remote":"127.0.0.1:43498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":28,"request content":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true "} {"level":"info","ts":"2026-07-08T02:21:01.638896Z","caller":"traceutil/trace.go:171","msg":"trace[180795945] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1111; }","duration":"724.145867ms","start":"2026-07-08T02:21:00.914739Z","end":"2026-07-08T02:21:01.638884Z","steps":["trace[180795945] 'agreement among raft nodes before linearized reading' (duration: 723.44202ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:21:01.638938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:21:00.914726Z","time spent":"724.194058ms","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-08T02:21:01.639007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:21:00.879709Z","time spent":"758.635963ms","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T02:21:02.237232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"557.823187ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-08T02:21:02.237351Z","caller":"traceutil/trace.go:171","msg":"trace[1716008167] transaction","detail":"{read_only:false; response_revision:1112; number_of_response:1; }","duration":"593.653616ms","start":"2026-07-08T02:21:01.643678Z","end":"2026-07-08T02:21:02.237332Z","steps":["trace[1716008167] 'process raft request' (duration: 35.618244ms)","trace[1716008167] 'compare' (duration: 557.438398ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T02:21:02.237405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:21:01.643652Z","time spent":"593.729677ms","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T02:21:02.264221Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656053880757172112,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-08T02:21:02.287506Z","caller":"traceutil/trace.go:171","msg":"trace[2037366306] transaction","detail":"{read_only:false; response_revision:1113; number_of_response:1; }","duration":"643.297619ms","start":"2026-07-08T02:21:01.644175Z","end":"2026-07-08T02:21:02.287473Z","steps":["trace[2037366306] 'process raft request' (duration: 643.004422ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:21:02.287619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:21:01.644161Z","time spent":"643.392701ms","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T02:21:02.287667Z","caller":"traceutil/trace.go:171","msg":"trace[1100504649] transaction","detail":"{read_only:false; response_revision:1114; number_of_response:1; }","duration":"643.395611ms","start":"2026-07-08T02:21:01.644262Z","end":"2026-07-08T02:21:02.287658Z","steps":["trace[1100504649] 'process raft request' (duration: 643.065673ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:21:02.287823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:21:01.644256Z","time spent":"643.469593ms","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T02:21:02.287606Z","caller":"traceutil/trace.go:171","msg":"trace[1601628932] transaction","detail":"{read_only:false; response_revision:1115; number_of_response:1; }","duration":"641.951915ms","start":"2026-07-08T02:21:01.645627Z","end":"2026-07-08T02:21:02.287579Z","steps":["trace[1601628932] 'process raft request' (duration: 641.908824ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:21:02.288185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:21:01.645618Z","time spent":"642.523499ms","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T02:21:02.400883Z","caller":"traceutil/trace.go:171","msg":"trace[1613205819] linearizableReadLoop","detail":"{readStateIndex:1161; appliedIndex:1157; }","duration":"636.703608ms","start":"2026-07-08T02:21:01.764152Z","end":"2026-07-08T02:21:02.400856Z","steps":["trace[1613205819] 'read index received' (duration: 522.991043ms)","trace[1613205819] 'applied index is now lower than readState.Index' (duration: 113.710905ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T02:21:02.401078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"622.151056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T02:21:02.40111Z","caller":"traceutil/trace.go:171","msg":"trace[1577810436] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1115; }","duration":"622.237257ms","start":"2026-07-08T02:21:01.778863Z","end":"2026-07-08T02:21:02.4011Z","steps":["trace[1577810436] 'agreement among raft nodes before linearized reading' (duration: 622.132285ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:21:02.401144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:21:01.778851Z","time spent":"622.285698ms","remote":"127.0.0.1:43370","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-08T02:21:02.401128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"636.939594ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-08T02:21:02.401222Z","caller":"traceutil/trace.go:171","msg":"trace[597962892] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1115; }","duration":"637.103448ms","start":"2026-07-08T02:21:01.764096Z","end":"2026-07-08T02:21:02.4012Z","steps":["trace[597962892] 'agreement among raft nodes before linearized reading' (duration: 636.867302ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:21:02.401264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:21:01.76407Z","time spent":"637.185609ms","remote":"127.0.0.1:43592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":43,"response size":30,"request content":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true "} {"level":"warn","ts":"2026-07-08T02:21:02.40139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"522.208143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-07-08T02:21:02.401539Z","caller":"traceutil/trace.go:171","msg":"trace[457342932] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1115; }","duration":"522.422358ms","start":"2026-07-08T02:21:01.879082Z","end":"2026-07-08T02:21:02.401505Z","steps":["trace[457342932] 'agreement among raft nodes before linearized reading' (duration: 521.983538ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:21:02.401619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:21:01.879053Z","time spent":"522.551371ms","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-08T02:21:04.018393Z","caller":"traceutil/trace.go:171","msg":"trace[1060752989] linearizableReadLoop","detail":"{readStateIndex:1163; appliedIndex:1162; }","duration":"356.697004ms","start":"2026-07-08T02:21:03.661661Z","end":"2026-07-08T02:21:04.018358Z","steps":["trace[1060752989] 'read index received' (duration: 356.324234ms)","trace[1060752989] 'applied index is now lower than readState.Index' (duration: 371.48µs)"],"step_count":2} {"level":"warn","ts":"2026-07-08T02:21:04.01863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.92504ms","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":"warn","ts":"2026-07-08T02:21:04.018645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.663814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T02:21:04.018624Z","caller":"traceutil/trace.go:171","msg":"trace[1787538714] transaction","detail":"{read_only:false; response_revision:1117; number_of_response:1; }","duration":"373.198124ms","start":"2026-07-08T02:21:03.645362Z","end":"2026-07-08T02:21:04.01856Z","steps":["trace[1787538714] 'process raft request' (duration: 372.736282ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:21:04.018719Z","caller":"traceutil/trace.go:171","msg":"trace[551027226] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1117; }","duration":"238.757006ms","start":"2026-07-08T02:21:03.779943Z","end":"2026-07-08T02:21:04.0187Z","steps":["trace[551027226] 'agreement among raft nodes before linearized reading' (duration: 238.624793ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:21:04.018921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:21:03.645326Z","time spent":"373.424969ms","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T02:21:04.018672Z","caller":"traceutil/trace.go:171","msg":"trace[1883121457] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:1117; }","duration":"357.015692ms","start":"2026-07-08T02:21:03.661642Z","end":"2026-07-08T02:21:04.018658Z","steps":["trace[1883121457] 'agreement among raft nodes before linearized reading' (duration: 356.889829ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:21:04.019415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:21:03.661576Z","time spent":"357.821371ms","remote":"127.0.0.1:43896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-07-08T02:21:04.491262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.156331ms","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-07-08T02:21:04.491333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.470996ms","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-07-08T02:21:04.491359Z","caller":"traceutil/trace.go:171","msg":"trace[802381964] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1117; }","duration":"198.328185ms","start":"2026-07-08T02:21:04.293009Z","end":"2026-07-08T02:21:04.491338Z","steps":["trace[802381964] 'range keys from in-memory index tree' (duration: 197.899575ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:21:04.491402Z","caller":"traceutil/trace.go:171","msg":"trace[714361125] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1117; }","duration":"249.577197ms","start":"2026-07-08T02:21:04.241807Z","end":"2026-07-08T02:21:04.491384Z","steps":["trace[714361125] 'range keys from in-memory index tree' (duration: 249.329971ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:21:04.49164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.671558ms","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-07-08T02:21:04.491675Z","caller":"traceutil/trace.go:171","msg":"trace[511576434] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1117; }","duration":"199.740659ms","start":"2026-07-08T02:21:04.291926Z","end":"2026-07-08T02:21:04.491667Z","steps":["trace[511576434] 'range keys from in-memory index tree' (duration: 199.549085ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:21:04.491956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.948881ms","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-07-08T02:21:04.49205Z","caller":"traceutil/trace.go:171","msg":"trace[1051630632] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1117; }","duration":"199.085294ms","start":"2026-07-08T02:21:04.292944Z","end":"2026-07-08T02:21:04.492029Z","steps":["trace[1051630632] 'range keys from in-memory index tree' (duration: 198.746676ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:21:04.944938Z","caller":"traceutil/trace.go:171","msg":"trace[1532111211] transaction","detail":"{read_only:false; response_revision:1118; number_of_response:1; }","duration":"449.074321ms","start":"2026-07-08T02:21:04.495831Z","end":"2026-07-08T02:21:04.944906Z","steps":["trace[1532111211] 'process raft request' (duration: 448.815915ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:21:04.94522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:21:04.49581Z","time spent":"449.254436ms","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T02:21:04.951569Z","caller":"traceutil/trace.go:171","msg":"trace[1234233566] transaction","detail":"{read_only:false; response_revision:1119; number_of_response:1; }","duration":"454.120895ms","start":"2026-07-08T02:21:04.497417Z","end":"2026-07-08T02:21:04.951538Z","steps":["trace[1234233566] 'process raft request' (duration: 453.858888ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:21:04.951854Z","caller":"traceutil/trace.go:171","msg":"trace[1532720067] transaction","detail":"{read_only:false; response_revision:1120; number_of_response:1; }","duration":"454.37024ms","start":"2026-07-08T02:21:04.497457Z","end":"2026-07-08T02:21:04.951827Z","steps":["trace[1532720067] 'process raft request' (duration: 454.032202ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:21:04.951917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:21:04.497392Z","time spent":"454.272128ms","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T02:21:04.951973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:21:04.49741Z","time spent":"454.507574ms","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T02:21:04.952278Z","caller":"traceutil/trace.go:171","msg":"trace[1484863382] linearizableReadLoop","detail":"{readStateIndex:1168; appliedIndex:1163; }","duration":"175.081573ms","start":"2026-07-08T02:21:04.777174Z","end":"2026-07-08T02:21:04.952255Z","steps":["trace[1484863382] 'read index received' (duration: 167.597831ms)","trace[1484863382] 'applied index is now lower than readState.Index' (duration: 7.482812ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T02:21:04.952313Z","caller":"traceutil/trace.go:171","msg":"trace[1701221982] transaction","detail":"{read_only:false; response_revision:1122; number_of_response:1; }","duration":"453.255524ms","start":"2026-07-08T02:21:04.499039Z","end":"2026-07-08T02:21:04.952295Z","steps":["trace[1701221982] 'process raft request' (duration: 453.127461ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:21:04.952296Z","caller":"traceutil/trace.go:171","msg":"trace[622637618] transaction","detail":"{read_only:false; response_revision:1121; number_of_response:1; }","duration":"453.253494ms","start":"2026-07-08T02:21:04.499Z","end":"2026-07-08T02:21:04.952253Z","steps":["trace[622637618] 'process raft request' (duration: 452.67324ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:21:04.952403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:21:04.499027Z","time spent":"453.327805ms","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T02:21:04.952433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.243976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T02:21:04.952465Z","caller":"traceutil/trace.go:171","msg":"trace[1702683476] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1122; }","duration":"175.337269ms","start":"2026-07-08T02:21:04.777118Z","end":"2026-07-08T02:21:04.952456Z","steps":["trace[1702683476] 'agreement among raft nodes before linearized reading' (duration: 175.252947ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:21:04.952629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:21:04.498986Z","time spent":"453.469968ms","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T02:21:08.643074Z","caller":"traceutil/trace.go:171","msg":"trace[78825376] transaction","detail":"{read_only:false; response_revision:1132; number_of_response:1; }","duration":"608.808609ms","start":"2026-07-08T02:21:08.034216Z","end":"2026-07-08T02:21:08.643024Z","steps":["trace[78825376] 'process raft request' (duration: 608.513071ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:21:08.643315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:21:08.034171Z","time spent":"609.015223ms","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T02:21:09.27943Z","caller":"traceutil/trace.go:171","msg":"trace[341020060] linearizableReadLoop","detail":"{readStateIndex:1180; appliedIndex:1179; }","duration":"307.51904ms","start":"2026-07-08T02:21:08.971871Z","end":"2026-07-08T02:21:09.27939Z","steps":["trace[341020060] 'read index received' (duration: 307.290313ms)","trace[341020060] 'applied index is now lower than readState.Index' (duration: 227.287µs)"],"step_count":2} {"level":"info","ts":"2026-07-08T02:21:09.279561Z","caller":"traceutil/trace.go:171","msg":"trace[770236829] transaction","detail":"{read_only:false; response_revision:1133; number_of_response:1; }","duration":"308.375441ms","start":"2026-07-08T02:21:08.971141Z","end":"2026-07-08T02:21:09.279516Z","steps":["trace[770236829] 'process raft request' (duration: 307.997231ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:21:09.279756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.850308ms","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-07-08T02:21:09.279811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:21:08.971123Z","time spent":"308.547506ms","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T02:21:09.279831Z","caller":"traceutil/trace.go:171","msg":"trace[889715453] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1133; }","duration":"308.010102ms","start":"2026-07-08T02:21:08.971804Z","end":"2026-07-08T02:21:09.279815Z","steps":["trace[889715453] 'agreement among raft nodes before linearized reading' (duration: 307.792727ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:21:09.279886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:21:08.971774Z","time spent":"308.095024ms","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-08T02:21:09.289024Z","caller":"traceutil/trace.go:171","msg":"trace[1005711172] transaction","detail":"{read_only:false; response_revision:1134; number_of_response:1; }","duration":"313.981346ms","start":"2026-07-08T02:21:08.97502Z","end":"2026-07-08T02:21:09.289001Z","steps":["trace[1005711172] 'process raft request' (duration: 313.769621ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:21:09.289116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.650421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-07-08T02:21:09.289164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.730404ms","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-07-08T02:21:09.289266Z","caller":"traceutil/trace.go:171","msg":"trace[516012946] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1134; }","duration":"316.875656ms","start":"2026-07-08T02:21:08.97237Z","end":"2026-07-08T02:21:09.289245Z","steps":["trace[516012946] 'agreement among raft nodes before linearized reading' (duration: 316.62064ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:21:09.289195Z","caller":"traceutil/trace.go:171","msg":"trace[1108842659] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:1134; }","duration":"107.800895ms","start":"2026-07-08T02:21:09.181376Z","end":"2026-07-08T02:21:09.289177Z","steps":["trace[1108842659] 'agreement among raft nodes before linearized reading' (duration: 107.648721ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:21:09.289326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:21:08.972359Z","time spent":"316.956899ms","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-08T02:21:09.289336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.956685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-07-08T02:21:09.289439Z","caller":"traceutil/trace.go:171","msg":"trace[895047276] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1134; }","duration":"316.079958ms","start":"2026-07-08T02:21:08.97335Z","end":"2026-07-08T02:21:09.28943Z","steps":["trace[895047276] 'agreement among raft nodes before linearized reading' (duration: 315.76245ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:21:09.289486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:21:08.974999Z","time spent":"314.079919ms","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T02:21:09.289565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:21:08.97334Z","time spent":"316.217381ms","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-08T02:21:09.60171Z","caller":"traceutil/trace.go:171","msg":"trace[1532047475] transaction","detail":"{read_only:false; response_revision:1135; number_of_response:1; }","duration":"314.827719ms","start":"2026-07-08T02:21:09.286854Z","end":"2026-07-08T02:21:09.601681Z","steps":["trace[1532047475] 'process raft request' (duration: 272.190804ms)","trace[1532047475] 'compare' (duration: 42.409599ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T02:21:09.601924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:21:09.286818Z","time spent":"315.000153ms","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T02:21:09.602268Z","caller":"traceutil/trace.go:171","msg":"trace[1082098880] transaction","detail":"{read_only:false; response_revision:1136; number_of_response:1; }","duration":"309.270833ms","start":"2026-07-08T02:21:09.292946Z","end":"2026-07-08T02:21:09.602217Z","steps":["trace[1082098880] 'process raft request' (duration: 308.685409ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:21:09.602368Z","caller":"traceutil/trace.go:171","msg":"trace[627401353] transaction","detail":"{read_only:false; response_revision:1137; number_of_response:1; }","duration":"308.898873ms","start":"2026-07-08T02:21:09.293442Z","end":"2026-07-08T02:21:09.602341Z","steps":["trace[627401353] 'process raft request' (duration: 308.472303ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:21:09.602524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:21:09.293436Z","time spent":"309.003586ms","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T02:21:09.602669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:21:09.292924Z","time spent":"309.462299ms","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T02:21:26.025023Z","caller":"traceutil/trace.go:171","msg":"trace[1106220978] linearizableReadLoop","detail":"{readStateIndex:1291; appliedIndex:1290; }","duration":"341.627128ms","start":"2026-07-08T02:21:25.683366Z","end":"2026-07-08T02:21:26.024993Z","steps":["trace[1106220978] 'read index received' (duration: 341.369002ms)","trace[1106220978] 'applied index is now lower than readState.Index' (duration: 257.226µs)"],"step_count":2} {"level":"info","ts":"2026-07-08T02:21:26.025129Z","caller":"traceutil/trace.go:171","msg":"trace[1423097296] transaction","detail":"{read_only:false; response_revision:1239; number_of_response:1; }","duration":"374.836083ms","start":"2026-07-08T02:21:25.650254Z","end":"2026-07-08T02:21:26.02509Z","steps":["trace[1423097296] 'process raft request' (duration: 374.501875ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:21:26.025305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:21:25.650228Z","time spent":"374.992267ms","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T02:21:26.025343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.95796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-08T02:21:26.025332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.935215ms","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-07-08T02:21:26.025393Z","caller":"traceutil/trace.go:171","msg":"trace[1726866326] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1239; }","duration":"247.076254ms","start":"2026-07-08T02:21:25.778303Z","end":"2026-07-08T02:21:26.025379Z","steps":["trace[1726866326] 'agreement among raft nodes before linearized reading' (duration: 246.933221ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:21:26.02542Z","caller":"traceutil/trace.go:171","msg":"trace[38172884] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1239; }","duration":"342.10491ms","start":"2026-07-08T02:21:25.683293Z","end":"2026-07-08T02:21:26.025398Z","steps":["trace[38172884] 'agreement among raft nodes before linearized reading' (duration: 341.847014ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:21:26.02546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:21:25.683259Z","time spent":"342.194891ms","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-08T02:21:26.025454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.715498ms","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-07-08T02:21:26.025455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.8032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-07-08T02:21:26.02553Z","caller":"traceutil/trace.go:171","msg":"trace[1201748135] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1239; }","duration":"336.855511ms","start":"2026-07-08T02:21:25.688655Z","end":"2026-07-08T02:21:26.02551Z","steps":["trace[1201748135] 'agreement among raft nodes before linearized reading' (duration: 336.643846ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:21:26.025546Z","caller":"traceutil/trace.go:171","msg":"trace[1904706923] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1239; }","duration":"336.982745ms","start":"2026-07-08T02:21:25.688538Z","end":"2026-07-08T02:21:26.025521Z","steps":["trace[1904706923] 'agreement among raft nodes before linearized reading' (duration: 336.687388ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:21:26.025563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:21:25.688628Z","time spent":"336.928814ms","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-08T02:21:26.025594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:21:25.68848Z","time spent":"337.103907ms","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-08T02:21:27.281141Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656053880757172404,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-08T02:21:27.41818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:21:26.721724Z","time spent":"696.450785ms","remote":"127.0.0.1:43396","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-07-08T02:21:27.854521Z","caller":"traceutil/trace.go:171","msg":"trace[539853114] transaction","detail":"{read_only:false; response_revision:1244; number_of_response:1; }","duration":"943.106278ms","start":"2026-07-08T02:21:26.911406Z","end":"2026-07-08T02:21:27.854513Z","steps":["trace[539853114] 'process raft request' (duration: 942.988655ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:21:27.854531Z","caller":"traceutil/trace.go:171","msg":"trace[1995168827] transaction","detail":"{read_only:false; response_revision:1243; number_of_response:1; }","duration":"1.103207383s","start":"2026-07-08T02:21:26.751294Z","end":"2026-07-08T02:21:27.854501Z","steps":["trace[1995168827] 'process raft request' (duration: 1.098245972s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:21:27.85462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:21:26.911373Z","time spent":"943.19086ms","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T02:21:27.85469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:21:26.751269Z","time spent":"1.103334176s","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T02:21:27.854891Z","caller":"traceutil/trace.go:171","msg":"trace[1562631925] transaction","detail":"{read_only:false; response_revision:1245; number_of_response:1; }","duration":"435.121046ms","start":"2026-07-08T02:21:27.41976Z","end":"2026-07-08T02:21:27.854882Z","steps":["trace[1562631925] 'process raft request' (duration: 434.671495ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:21:27.854923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:21:27.419727Z","time spent":"435.178707ms","remote":"127.0.0.1:43396","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T02:21:27.854472Z","caller":"traceutil/trace.go:171","msg":"trace[1397398161] linearizableReadLoop","detail":"{readStateIndex:1297; appliedIndex:1294; }","duration":"1.073703547s","start":"2026-07-08T02:21:26.780754Z","end":"2026-07-08T02:21:27.854457Z","steps":["trace[1397398161] 'read index received' (duration: 637.258499ms)","trace[1397398161] 'applied index is now lower than readState.Index' (duration: 436.444478ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T02:21:27.855057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.074302252s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T02:21:27.855087Z","caller":"traceutil/trace.go:171","msg":"trace[465724669] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1245; }","duration":"1.074375044s","start":"2026-07-08T02:21:26.780704Z","end":"2026-07-08T02:21:27.855079Z","steps":["trace[465724669] 'agreement among raft nodes before linearized reading' (duration: 1.074272841s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:21:27.855111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:21:26.780676Z","time spent":"1.074430594s","remote":"127.0.0.1:43370","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-08T02:21:27.855164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"480.867975ms","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-07-08T02:21:27.855184Z","caller":"traceutil/trace.go:171","msg":"trace[1105204493] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1245; }","duration":"480.958107ms","start":"2026-07-08T02:21:27.37422Z","end":"2026-07-08T02:21:27.855178Z","steps":["trace[1105204493] 'agreement among raft nodes before linearized reading' (duration: 480.878825ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:21:27.855199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:21:27.374177Z","time spent":"481.019029ms","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-08T02:21:27.855258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.40042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T02:21:27.855271Z","caller":"traceutil/trace.go:171","msg":"trace[1117234148] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:1245; }","duration":"183.454221ms","start":"2026-07-08T02:21:27.671812Z","end":"2026-07-08T02:21:27.855266Z","steps":["trace[1117234148] 'agreement among raft nodes before linearized reading' (duration: 183.428911ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:21:27.855381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"475.915896ms","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-07-08T02:21:27.855403Z","caller":"traceutil/trace.go:171","msg":"trace[105247949] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1245; }","duration":"475.980827ms","start":"2026-07-08T02:21:27.379417Z","end":"2026-07-08T02:21:27.855398Z","steps":["trace[105247949] 'agreement among raft nodes before linearized reading' (duration: 475.894085ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:21:27.855421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:21:27.379379Z","time spent":"476.038539ms","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-07-08T02:21:42.149198Z","caller":"traceutil/trace.go:171","msg":"trace[1141867636] linearizableReadLoop","detail":"{readStateIndex:1345; appliedIndex:1344; }","duration":"218.574023ms","start":"2026-07-08T02:21:41.930576Z","end":"2026-07-08T02:21:42.14915Z","steps":["trace[1141867636] 'read index received' (duration: 218.186374ms)","trace[1141867636] 'applied index is now lower than readState.Index' (duration: 385.239µs)"],"step_count":2} {"level":"info","ts":"2026-07-08T02:21:42.149297Z","caller":"traceutil/trace.go:171","msg":"trace[278329762] transaction","detail":"{read_only:false; response_revision:1290; number_of_response:1; }","duration":"223.40854ms","start":"2026-07-08T02:21:41.925836Z","end":"2026-07-08T02:21:42.149244Z","steps":["trace[278329762] 'process raft request' (duration: 222.95967ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:21:42.149645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.891721ms","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-07-08T02:21:42.149718Z","caller":"traceutil/trace.go:171","msg":"trace[1333190618] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1290; }","duration":"219.035134ms","start":"2026-07-08T02:21:41.930664Z","end":"2026-07-08T02:21:42.149699Z","steps":["trace[1333190618] 'agreement among raft nodes before linearized reading' (duration: 218.740827ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:21:42.149684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.057774ms","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-07-08T02:21:42.149818Z","caller":"traceutil/trace.go:171","msg":"trace[57933791] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1290; }","duration":"219.267809ms","start":"2026-07-08T02:21:41.930521Z","end":"2026-07-08T02:21:42.149789Z","steps":["trace[57933791] 'agreement among raft nodes before linearized reading' (duration: 218.88312ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:21:48.394371Z","caller":"traceutil/trace.go:171","msg":"trace[19101788] transaction","detail":"{read_only:false; response_revision:1344; number_of_response:1; }","duration":"220.446558ms","start":"2026-07-08T02:21:48.173898Z","end":"2026-07-08T02:21:48.394345Z","steps":["trace[19101788] 'process raft request' (duration: 220.178061ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:21:48.39469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.388149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-07-08T02:21:48.39478Z","caller":"traceutil/trace.go:171","msg":"trace[2031529721] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1344; }","duration":"197.573112ms","start":"2026-07-08T02:21:48.197186Z","end":"2026-07-08T02:21:48.394759Z","steps":["trace[2031529721] 'agreement among raft nodes before linearized reading' (duration: 197.259385ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:21:48.39547Z","caller":"traceutil/trace.go:171","msg":"trace[1962107750] linearizableReadLoop","detail":"{readStateIndex:1401; appliedIndex:1400; }","duration":"196.989389ms","start":"2026-07-08T02:21:48.197275Z","end":"2026-07-08T02:21:48.394264Z","steps":["trace[1962107750] 'read index received' (duration: 196.769213ms)","trace[1962107750] 'applied index is now lower than readState.Index' (duration: 218.546µs)"],"step_count":2} {"level":"warn","ts":"2026-07-08T02:21:49.007701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"531.227157ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-08T02:21:49.007936Z","caller":"traceutil/trace.go:171","msg":"trace[644616665] transaction","detail":"{read_only:false; response_revision:1345; number_of_response:1; }","duration":"712.638218ms","start":"2026-07-08T02:21:48.295265Z","end":"2026-07-08T02:21:49.007903Z","steps":["trace[644616665] 'process raft request' (duration: 181.103464ms)","trace[644616665] 'compare' (duration: 530.822737ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T02:21:49.00799Z","caller":"traceutil/trace.go:171","msg":"trace[1999932961] transaction","detail":"{read_only:false; response_revision:1346; number_of_response:1; }","duration":"606.845851ms","start":"2026-07-08T02:21:48.401134Z","end":"2026-07-08T02:21:49.00798Z","steps":["trace[1999932961] 'process raft request' (duration: 606.754259ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:21:49.008099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:21:48.401118Z","time spent":"606.927433ms","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T02:21:49.0081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:21:48.295235Z","time spent":"712.813912ms","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T02:21:49.008238Z","caller":"traceutil/trace.go:171","msg":"trace[917702821] linearizableReadLoop","detail":"{readStateIndex:1402; appliedIndex:1401; }","duration":"612.699193ms","start":"2026-07-08T02:21:48.395522Z","end":"2026-07-08T02:21:49.008221Z","steps":["trace[917702821] 'read index received' (duration: 80.864131ms)","trace[917702821] 'applied index is now lower than readState.Index' (duration: 531.833422ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T02:21:49.008465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"733.72314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-07-08T02:21:49.008518Z","caller":"traceutil/trace.go:171","msg":"trace[389086728] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1346; }","duration":"733.819343ms","start":"2026-07-08T02:21:48.274684Z","end":"2026-07-08T02:21:49.008504Z","steps":["trace[389086728] 'agreement among raft nodes before linearized reading' (duration: 733.601006ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:21:49.008553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:21:48.274645Z","time spent":"733.900845ms","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-08T02:21:49.008614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"637.214329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-07-08T02:21:49.008687Z","caller":"traceutil/trace.go:171","msg":"trace[2053507893] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1346; }","duration":"637.296811ms","start":"2026-07-08T02:21:48.371365Z","end":"2026-07-08T02:21:49.008662Z","steps":["trace[2053507893] 'agreement among raft nodes before linearized reading' (duration: 637.167168ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:21:49.008717Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:21:48.371353Z","time spent":"637.358103ms","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-08T02:21:49.008777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"710.500847ms","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-07-08T02:21:49.008859Z","caller":"traceutil/trace.go:171","msg":"trace[1272596832] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1346; }","duration":"710.539848ms","start":"2026-07-08T02:21:48.298268Z","end":"2026-07-08T02:21:49.008808Z","steps":["trace[1272596832] 'agreement among raft nodes before linearized reading' (duration: 710.440685ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:21:49.008927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:21:48.298211Z","time spent":"710.702371ms","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-08T02:21:49.010157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"638.141991ms","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-07-08T02:21:49.010191Z","caller":"traceutil/trace.go:171","msg":"trace[1582863778] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1346; }","duration":"638.196383ms","start":"2026-07-08T02:21:48.371987Z","end":"2026-07-08T02:21:49.010183Z","steps":["trace[1582863778] 'agreement among raft nodes before linearized reading' (duration: 636.948993ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:21:49.010369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:21:48.371977Z","time spent":"638.237123ms","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-08T02:21:49.290316Z","caller":"traceutil/trace.go:171","msg":"trace[316284273] transaction","detail":"{read_only:false; response_revision:1348; number_of_response:1; }","duration":"275.817021ms","start":"2026-07-08T02:21:49.014473Z","end":"2026-07-08T02:21:49.29029Z","steps":["trace[316284273] 'process raft request' (duration: 275.635057ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:21:49.290606Z","caller":"traceutil/trace.go:171","msg":"trace[1482535954] transaction","detail":"{read_only:false; response_revision:1349; number_of_response:1; }","duration":"275.959044ms","start":"2026-07-08T02:21:49.01464Z","end":"2026-07-08T02:21:49.290599Z","steps":["trace[1482535954] 'process raft request' (duration: 275.612136ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:21:49.292637Z","caller":"traceutil/trace.go:171","msg":"trace[2077107063] transaction","detail":"{read_only:false; response_revision:1350; number_of_response:1; }","duration":"277.501172ms","start":"2026-07-08T02:21:49.015096Z","end":"2026-07-08T02:21:49.292597Z","steps":["trace[2077107063] 'process raft request' (duration: 275.531554ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:21:50.5287Z","caller":"traceutil/trace.go:171","msg":"trace[2091365530] transaction","detail":"{read_only:false; response_revision:1351; number_of_response:1; }","duration":"125.697739ms","start":"2026-07-08T02:21:50.402966Z","end":"2026-07-08T02:21:50.528664Z","steps":["trace[2091365530] 'process raft request' (duration: 125.481284ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:21:50.983877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.279557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T02:21:50.983967Z","caller":"traceutil/trace.go:171","msg":"trace[1692327421] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:1351; }","duration":"373.440021ms","start":"2026-07-08T02:21:50.61051Z","end":"2026-07-08T02:21:50.98395Z","steps":["trace[1692327421] 'count revisions from in-memory index tree' (duration: 373.190274ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:21:50.983998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:21:50.610488Z","time spent":"373.501832ms","remote":"127.0.0.1:58018","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true "} {"level":"info","ts":"2026-07-08T02:21:51.479703Z","caller":"traceutil/trace.go:171","msg":"trace[1261431627] linearizableReadLoop","detail":"{readStateIndex:1411; appliedIndex:1410; }","duration":"184.409043ms","start":"2026-07-08T02:21:51.295258Z","end":"2026-07-08T02:21:51.479667Z","steps":["trace[1261431627] 'read index received' (duration: 184.097716ms)","trace[1261431627] 'applied index is now lower than readState.Index' (duration: 309.727µs)"],"step_count":2} {"level":"info","ts":"2026-07-08T02:21:51.479808Z","caller":"traceutil/trace.go:171","msg":"trace[2092679577] transaction","detail":"{read_only:false; response_revision:1354; number_of_response:1; }","duration":"359.997084ms","start":"2026-07-08T02:21:51.119769Z","end":"2026-07-08T02:21:51.479766Z","steps":["trace[2092679577] 'process raft request' (duration: 359.616905ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:21:51.480049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:21:51.119739Z","time spent":"360.182949ms","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":457,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T02:21:51.480095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.791472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-07-08T02:21:51.480154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.799889ms","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-07-08T02:21:51.48015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.218977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T02:21:51.480204Z","caller":"traceutil/trace.go:171","msg":"trace[387931264] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1354; }","duration":"183.983103ms","start":"2026-07-08T02:21:51.296208Z","end":"2026-07-08T02:21:51.480191Z","steps":["trace[387931264] 'agreement among raft nodes before linearized reading' (duration: 183.723847ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:21:51.480207Z","caller":"traceutil/trace.go:171","msg":"trace[1783326106] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1354; }","duration":"184.968257ms","start":"2026-07-08T02:21:51.295215Z","end":"2026-07-08T02:21:51.480183Z","steps":["trace[1783326106] 'agreement among raft nodes before linearized reading' (duration: 184.627979ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:21:51.480241Z","caller":"traceutil/trace.go:171","msg":"trace[1952831074] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1354; }","duration":"141.383811ms","start":"2026-07-08T02:21:51.338835Z","end":"2026-07-08T02:21:51.480219Z","steps":["trace[1952831074] 'agreement among raft nodes before linearized reading' (duration: 141.220777ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:21:51.48054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.786649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-07-08T02:21:51.480595Z","caller":"traceutil/trace.go:171","msg":"trace[968227381] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1354; }","duration":"183.84994ms","start":"2026-07-08T02:21:51.296729Z","end":"2026-07-08T02:21:51.480579Z","steps":["trace[968227381] 'agreement among raft nodes before linearized reading' (duration: 183.626255ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:21:52.104891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.236977ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-08T02:21:52.105041Z","caller":"traceutil/trace.go:171","msg":"trace[1429766576] transaction","detail":"{read_only:false; response_revision:1356; number_of_response:1; }","duration":"617.569912ms","start":"2026-07-08T02:21:51.487454Z","end":"2026-07-08T02:21:52.105024Z","steps":["trace[1429766576] 'process raft request' (duration: 152.07492ms)","trace[1429766576] 'compare' (duration: 465.093902ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T02:21:52.105083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:21:51.487427Z","time spent":"617.638424ms","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T02:21:52.105564Z","caller":"traceutil/trace.go:171","msg":"trace[1163540303] linearizableReadLoop","detail":"{readStateIndex:1414; appliedIndex:1412; }","duration":"507.355588ms","start":"2026-07-08T02:21:51.597969Z","end":"2026-07-08T02:21:52.105325Z","steps":["trace[1163540303] 'read index received' (duration: 41.382904ms)","trace[1163540303] 'applied index is now lower than readState.Index' (duration: 465.969214ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T02:21:52.105945Z","caller":"traceutil/trace.go:171","msg":"trace[660418802] transaction","detail":"{read_only:false; response_revision:1357; number_of_response:1; }","duration":"617.357687ms","start":"2026-07-08T02:21:51.488538Z","end":"2026-07-08T02:21:52.105896Z","steps":["trace[660418802] 'process raft request' (duration: 616.449075ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:21:52.106277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:21:51.488507Z","time spent":"617.545841ms","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T02:21:52.478987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.707956ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-07-08T02:21:52.479135Z","caller":"traceutil/trace.go:171","msg":"trace[2123002367] linearizableReadLoop","detail":"{readStateIndex:1415; appliedIndex:1414; }","duration":"373.239745ms","start":"2026-07-08T02:21:52.10587Z","end":"2026-07-08T02:21:52.47911Z","steps":["trace[2123002367] 'read index received' (duration: 74.602µs)","trace[2123002367] 'applied index is now lower than readState.Index' (duration: 373.162963ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T02:21:52.479526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"881.541546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-08T02:21:52.480228Z","caller":"traceutil/trace.go:171","msg":"trace[161239616] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1357; }","duration":"882.297255ms","start":"2026-07-08T02:21:51.597894Z","end":"2026-07-08T02:21:52.480192Z","steps":["trace[161239616] 'agreement among raft nodes before linearized reading' (duration: 507.758848ms)","trace[161239616] 'count revisions from in-memory index tree' (duration: 373.805599ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T02:21:52.480436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:21:51.597861Z","time spent":"882.55456ms","remote":"127.0.0.1:43816","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":30,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"warn","ts":"2026-07-08T02:21:52.479637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"700.022162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-08T02:21:52.479648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.768822ms","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-07-08T02:21:52.480745Z","caller":"traceutil/trace.go:171","msg":"trace[1361439570] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1357; }","duration":"701.099708ms","start":"2026-07-08T02:21:51.779535Z","end":"2026-07-08T02:21:52.480634Z","steps":["trace[1361439570] 'agreement among raft nodes before linearized reading' (duration: 700.060883ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:21:52.480971Z","caller":"traceutil/trace.go:171","msg":"trace[1681152873] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1357; }","duration":"260.93294ms","start":"2026-07-08T02:21:52.219863Z","end":"2026-07-08T02:21:52.480796Z","steps":["trace[1681152873] 'range keys from in-memory index tree' (duration: 259.754972ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:21:52.481139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:21:51.779503Z","time spent":"701.461317ms","remote":"127.0.0.1:43370","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-08T02:21:52.806726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.151999ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-08T02:21:52.806864Z","caller":"traceutil/trace.go:171","msg":"trace[151039666] transaction","detail":"{read_only:false; response_revision:1359; number_of_response:1; }","duration":"271.29142ms","start":"2026-07-08T02:21:52.535547Z","end":"2026-07-08T02:21:52.806838Z","steps":["trace[151039666] 'process raft request' (duration: 95.920156ms)","trace[151039666] 'compare' (duration: 174.973615ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T02:21:52.848147Z","caller":"traceutil/trace.go:171","msg":"trace[1012968374] transaction","detail":"{read_only:false; response_revision:1360; number_of_response:1; }","duration":"121.649611ms","start":"2026-07-08T02:21:52.726449Z","end":"2026-07-08T02:21:52.848099Z","steps":["trace[1012968374] 'process raft request' (duration: 121.385154ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:21:57.890447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.155307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T02:21:57.890573Z","caller":"traceutil/trace.go:171","msg":"trace[1840790927] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1402; }","duration":"109.361302ms","start":"2026-07-08T02:21:57.781183Z","end":"2026-07-08T02:21:57.890545Z","steps":["trace[1840790927] 'range keys from in-memory index tree' (duration: 109.037754ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:21:57.890723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.4261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-07-08T02:21:57.890855Z","caller":"traceutil/trace.go:171","msg":"trace[47909373] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1402; }","duration":"378.636654ms","start":"2026-07-08T02:21:57.512175Z","end":"2026-07-08T02:21:57.890811Z","steps":["trace[47909373] 'range keys from in-memory index tree' (duration: 378.170074ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:21:57.890922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:21:57.512139Z","time spent":"378.767118ms","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-07-08T02:21:57.890987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.561727ms","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-07-08T02:21:57.891111Z","caller":"traceutil/trace.go:171","msg":"trace[624700070] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1402; }","duration":"351.743042ms","start":"2026-07-08T02:21:57.539331Z","end":"2026-07-08T02:21:57.891074Z","steps":["trace[624700070] 'range keys from in-memory index tree' (duration: 351.217889ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:21:57.891155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:21:57.539297Z","time spent":"351.848574ms","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-08T02:21:58.578704Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656053880757172755,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-08T02:21:58.86996Z","caller":"traceutil/trace.go:171","msg":"trace[443240292] transaction","detail":"{read_only:false; response_revision:1403; number_of_response:1; }","duration":"972.43075ms","start":"2026-07-08T02:21:57.897467Z","end":"2026-07-08T02:21:58.869897Z","steps":["trace[443240292] 'process raft request' (duration: 972.051181ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:21:58.870168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:21:57.897443Z","time spent":"972.620165ms","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T02:21:58.931242Z","caller":"traceutil/trace.go:171","msg":"trace[179378390] transaction","detail":"{read_only:false; response_revision:1404; number_of_response:1; }","duration":"1.033027891s","start":"2026-07-08T02:21:57.898181Z","end":"2026-07-08T02:21:58.931209Z","steps":["trace[179378390] 'process raft request' (duration: 1.029248869s)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:21:58.931373Z","caller":"traceutil/trace.go:171","msg":"trace[296019587] linearizableReadLoop","detail":"{readStateIndex:1463; appliedIndex:1461; }","duration":"853.412683ms","start":"2026-07-08T02:21:58.077926Z","end":"2026-07-08T02:21:58.931338Z","steps":["trace[296019587] 'read index received' (duration: 791.845009ms)","trace[296019587] 'applied index is now lower than readState.Index' (duration: 61.564754ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T02:21:58.931796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:21:57.898172Z","time spent":"1.033188315s","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":494,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T02:21:58.931788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"797.379564ms","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-07-08T02:21:58.931895Z","caller":"traceutil/trace.go:171","msg":"trace[1856883948] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1405; }","duration":"797.551368ms","start":"2026-07-08T02:21:58.134317Z","end":"2026-07-08T02:21:58.931869Z","steps":["trace[1856883948] 'agreement among raft nodes before linearized reading' (duration: 797.291222ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:21:58.931893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"565.056778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-08T02:21:58.931972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:21:58.134288Z","time spent":"797.668981ms","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-08T02:21:58.932007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"854.142571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:533"} {"level":"info","ts":"2026-07-08T02:21:58.932003Z","caller":"traceutil/trace.go:171","msg":"trace[2108476146] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1405; }","duration":"565.257373ms","start":"2026-07-08T02:21:58.366718Z","end":"2026-07-08T02:21:58.931976Z","steps":["trace[2108476146] 'agreement among raft nodes before linearized reading' (duration: 565.046468ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:21:58.932058Z","caller":"traceutil/trace.go:171","msg":"trace[541873068] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1405; }","duration":"854.304925ms","start":"2026-07-08T02:21:58.077738Z","end":"2026-07-08T02:21:58.932043Z","steps":["trace[541873068] 'agreement among raft nodes before linearized reading' (duration: 854.202663ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:21:58.932079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:21:58.366687Z","time spent":"565.379407ms","remote":"127.0.0.1:32868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-07-08T02:21:58.932106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:21:58.077707Z","time spent":"854.389466ms","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":556,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-07-08T02:21:58.932184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"797.750293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-07-08T02:21:58.932233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.328796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-08T02:21:58.932242Z","caller":"traceutil/trace.go:171","msg":"trace[2122917776] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1405; }","duration":"797.816835ms","start":"2026-07-08T02:21:58.134411Z","end":"2026-07-08T02:21:58.932228Z","steps":["trace[2122917776] 'agreement among raft nodes before linearized reading' (duration: 797.687791ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:21:58.932264Z","caller":"traceutil/trace.go:171","msg":"trace[1810957241] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:1405; }","duration":"307.4946ms","start":"2026-07-08T02:21:58.62476Z","end":"2026-07-08T02:21:58.932255Z","steps":["trace[1810957241] 'agreement among raft nodes before linearized reading' (duration: 307.433409ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:21:58.932283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:21:58.134403Z","time spent":"797.871146ms","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-08T02:21:58.932307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:21:58.624734Z","time spent":"307.561332ms","remote":"127.0.0.1:43876","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":5,"response size":30,"request content":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true "} {"level":"warn","ts":"2026-07-08T02:21:58.931909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.12872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-07-08T02:21:58.932397Z","caller":"traceutil/trace.go:171","msg":"trace[1138204442] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1405; }","duration":"429.689864ms","start":"2026-07-08T02:21:58.502691Z","end":"2026-07-08T02:21:58.932381Z","steps":["trace[1138204442] 'agreement among raft nodes before linearized reading' (duration: 429.046299ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:21:58.932443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:21:58.502651Z","time spent":"429.778446ms","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":555,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-07-08T02:24:58.279811Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656053880757174776,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-08T02:24:58.68574Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.070987526s","expected-duration":"1s"} {"level":"info","ts":"2026-07-08T02:24:58.686233Z","caller":"traceutil/trace.go:171","msg":"trace[892718013] linearizableReadLoop","detail":"{readStateIndex:2320; appliedIndex:2319; }","duration":"906.445205ms","start":"2026-07-08T02:24:57.779744Z","end":"2026-07-08T02:24:58.68619Z","steps":["trace[892718013] 'read index received' (duration: 906.201809ms)","trace[892718013] 'applied index is now lower than readState.Index' (duration: 242.206µs)"],"step_count":2} {"level":"warn","ts":"2026-07-08T02:24:58.686369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"906.597168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T02:24:58.686405Z","caller":"traceutil/trace.go:171","msg":"trace[1113439465] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2225; }","duration":"906.710741ms","start":"2026-07-08T02:24:57.779683Z","end":"2026-07-08T02:24:58.686394Z","steps":["trace[1113439465] 'agreement among raft nodes before linearized reading' (duration: 906.620589ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:24:58.686443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:24:57.77966Z","time spent":"906.773393ms","remote":"127.0.0.1:43370","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-08T02:24:58.686517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"646.383667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-07-08T02:24:58.686539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"860.87572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-08T02:24:58.686588Z","caller":"traceutil/trace.go:171","msg":"trace[1412657005] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:2225; }","duration":"646.54022ms","start":"2026-07-08T02:24:58.040033Z","end":"2026-07-08T02:24:58.686573Z","steps":["trace[1412657005] 'agreement among raft nodes before linearized reading' (duration: 646.371356ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:24:58.686618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"691.339137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-07-08T02:24:58.686629Z","caller":"traceutil/trace.go:171","msg":"trace[1161383672] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2225; }","duration":"861.029153ms","start":"2026-07-08T02:24:57.825569Z","end":"2026-07-08T02:24:58.686599Z","steps":["trace[1161383672] 'agreement among raft nodes before linearized reading' (duration: 860.787897ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:24:58.686638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"697.067576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-07-08T02:24:58.686692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:24:57.825544Z","time spent":"861.140676ms","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-08T02:24:58.686694Z","caller":"traceutil/trace.go:171","msg":"trace[1251165183] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2225; }","duration":"691.41947ms","start":"2026-07-08T02:24:57.995252Z","end":"2026-07-08T02:24:58.686672Z","steps":["trace[1251165183] 'agreement among raft nodes before linearized reading' (duration: 691.241205ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:24:58.686709Z","caller":"traceutil/trace.go:171","msg":"trace[1470092140] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2225; }","duration":"697.178679ms","start":"2026-07-08T02:24:57.98951Z","end":"2026-07-08T02:24:58.686688Z","steps":["trace[1470092140] 'agreement among raft nodes before linearized reading' (duration: 696.960074ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:24:58.686727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:24:57.995219Z","time spent":"691.502651ms","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":555,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-07-08T02:24:58.686747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:24:57.989487Z","time spent":"697.25178ms","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-08T02:24:58.686747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.244244ms","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-07-08T02:24:58.686782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"485.028934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-07-08T02:24:58.686641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:24:58.040009Z","time spent":"646.615833ms","remote":"127.0.0.1:43802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":30,"request content":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true "} {"level":"info","ts":"2026-07-08T02:24:58.686795Z","caller":"traceutil/trace.go:171","msg":"trace[1163051083] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2225; }","duration":"470.336307ms","start":"2026-07-08T02:24:58.216444Z","end":"2026-07-08T02:24:58.68678Z","steps":["trace[1163051083] 'agreement among raft nodes before linearized reading' (duration: 470.232435ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:24:58.686819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.121987ms","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-07-08T02:24:58.686823Z","caller":"traceutil/trace.go:171","msg":"trace[1941823065] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:2225; }","duration":"485.133216ms","start":"2026-07-08T02:24:58.201679Z","end":"2026-07-08T02:24:58.686812Z","steps":["trace[1941823065] 'agreement among raft nodes before linearized reading' (duration: 485.026123ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:24:58.686833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:24:58.21642Z","time spent":"470.406288ms","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-08T02:24:58.686845Z","caller":"traceutil/trace.go:171","msg":"trace[694937969] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2225; }","duration":"457.199269ms","start":"2026-07-08T02:24:58.22964Z","end":"2026-07-08T02:24:58.686839Z","steps":["trace[694937969] 'agreement among raft nodes before linearized reading' (duration: 457.026055ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:24:58.68686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:24:58.201649Z","time spent":"485.202728ms","remote":"127.0.0.1:43592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":45,"response size":30,"request content":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true "} {"level":"warn","ts":"2026-07-08T02:24:58.686867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:24:58.229613Z","time spent":"457.24931ms","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-08T02:24:58.686618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"692.714322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-07-08T02:24:58.686936Z","caller":"traceutil/trace.go:171","msg":"trace[2130901910] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2225; }","duration":"693.092102ms","start":"2026-07-08T02:24:57.993832Z","end":"2026-07-08T02:24:58.686924Z","steps":["trace[2130901910] 'agreement among raft nodes before linearized reading' (duration: 692.592639ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:24:58.686966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:24:57.993806Z","time spent":"693.153523ms","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-08T02:24:58.686348Z","caller":"traceutil/trace.go:171","msg":"trace[2122901832] transaction","detail":"{read_only:false; response_revision:2225; number_of_response:1; }","duration":"1.071686883s","start":"2026-07-08T02:24:57.614609Z","end":"2026-07-08T02:24:58.686296Z","steps":["trace[2122901832] 'process raft request' (duration: 1.071407456s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:24:58.687099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:24:57.614572Z","time spent":"1.072447512s","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T02:25:49.699515Z","caller":"traceutil/trace.go:171","msg":"trace[1147436402] linearizableReadLoop","detail":"{readStateIndex:2589; appliedIndex:2588; }","duration":"156.541267ms","start":"2026-07-08T02:25:49.542942Z","end":"2026-07-08T02:25:49.699483Z","steps":["trace[1147436402] 'read index received' (duration: 156.322382ms)","trace[1147436402] 'applied index is now lower than readState.Index' (duration: 216.615µs)"],"step_count":2} {"level":"info","ts":"2026-07-08T02:25:49.699597Z","caller":"traceutil/trace.go:171","msg":"trace[1589800126] transaction","detail":"{read_only:false; response_revision:2483; number_of_response:1; }","duration":"219.747381ms","start":"2026-07-08T02:25:49.479798Z","end":"2026-07-08T02:25:49.699545Z","steps":["trace[1589800126] 'process raft request' (duration: 219.464094ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:25:49.699982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.009279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:534"} {"level":"info","ts":"2026-07-08T02:25:49.700405Z","caller":"traceutil/trace.go:171","msg":"trace[1563733198] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2483; }","duration":"157.504242ms","start":"2026-07-08T02:25:49.542878Z","end":"2026-07-08T02:25:49.700382Z","steps":["trace[1563733198] 'agreement among raft nodes before linearized reading' (duration: 156.751043ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:25:55.142984Z","caller":"traceutil/trace.go:171","msg":"trace[1567826095] transaction","detail":"{read_only:false; response_revision:2516; number_of_response:1; }","duration":"112.431068ms","start":"2026-07-08T02:25:55.030524Z","end":"2026-07-08T02:25:55.142955Z","steps":["trace[1567826095] 'process raft request' (duration: 103.43851ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:25:55.150866Z","caller":"traceutil/trace.go:171","msg":"trace[1015393067] transaction","detail":"{read_only:false; response_revision:2517; number_of_response:1; }","duration":"119.704194ms","start":"2026-07-08T02:25:55.031122Z","end":"2026-07-08T02:25:55.150827Z","steps":["trace[1015393067] 'process raft request' (duration: 119.12209ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:25:55.151027Z","caller":"traceutil/trace.go:171","msg":"trace[740959431] transaction","detail":"{read_only:false; response_revision:2518; number_of_response:1; }","duration":"119.175351ms","start":"2026-07-08T02:25:55.031827Z","end":"2026-07-08T02:25:55.151002Z","steps":["trace[740959431] 'process raft request' (duration: 118.925355ms)"],"step_count":1}