{"level":"warn","ts":"2026-02-09T18:55:06.626981Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-09T18:55:06.627133Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.153: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.153:2380","--initial-cluster=instance=https://199.204.45.153:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.153:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.153:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-02-09T18:55:06.62724Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-09T18:55:06.627268Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.153:2380"]} {"level":"info","ts":"2026-02-09T18:55:06.627342Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-02-09T18:55:06.633802Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.153:2379"]} {"level":"info","ts":"2026-02-09T18:55:06.633918Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":2,"max-cpu-available":2,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.153:2380"],"listen-peer-urls":["https://199.204.45.153:2380"],"advertise-client-urls":["https://199.204.45.153:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.153:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.153:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-02-09T18:55:06.641978Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.603917ms"} {"level":"info","ts":"2026-02-09T18:55:06.6575Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"355195d5aae85944","cluster-id":"e424441517bc0b32"} {"level":"info","ts":"2026-02-09T18:55:06.657636Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 switched to configuration voters=()"} {"level":"info","ts":"2026-02-09T18:55:06.657661Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became follower at term 0"} {"level":"info","ts":"2026-02-09T18:55:06.657755Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 355195d5aae85944 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-09T18:55:06.657768Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became follower at term 1"} {"level":"info","ts":"2026-02-09T18:55:06.657833Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 switched to configuration voters=(3842016702051670340)"} {"level":"warn","ts":"2026-02-09T18:55:06.665031Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-09T18:55:06.67162Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-09T18:55:06.674355Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-02-09T18:55:06.677714Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"355195d5aae85944","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-09T18:55:06.67807Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"355195d5aae85944","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-09T18:55:06.678911Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-02-09T18:55:06.67894Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-02-09T18:55:06.678948Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-02-09T18:55:06.679841Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 switched to configuration voters=(3842016702051670340)"} {"level":"info","ts":"2026-02-09T18:55:06.680069Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e424441517bc0b32","local-member-id":"355195d5aae85944","added-peer-id":"355195d5aae85944","added-peer-peer-urls":["https://199.204.45.153:2380"]} {"level":"info","ts":"2026-02-09T18:55:06.701707Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-02-09T18:55:06.701823Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.153:2380"} {"level":"info","ts":"2026-02-09T18:55:06.702767Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.153:2380"} {"level":"info","ts":"2026-02-09T18:55:06.702984Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"355195d5aae85944","initial-advertise-peer-urls":["https://199.204.45.153:2380"],"listen-peer-urls":["https://199.204.45.153:2380"],"advertise-client-urls":["https://199.204.45.153:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.153:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-09T18:55:06.70301Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-09T18:55:07.558541Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 is starting a new election at term 1"} {"level":"info","ts":"2026-02-09T18:55:07.558587Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-09T18:55:07.558686Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 received MsgPreVoteResp from 355195d5aae85944 at term 1"} {"level":"info","ts":"2026-02-09T18:55:07.558751Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became candidate at term 2"} {"level":"info","ts":"2026-02-09T18:55:07.558762Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 received MsgVoteResp from 355195d5aae85944 at term 2"} {"level":"info","ts":"2026-02-09T18:55:07.558771Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became leader at term 2"} {"level":"info","ts":"2026-02-09T18:55:07.558807Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 355195d5aae85944 elected leader 355195d5aae85944 at term 2"} {"level":"info","ts":"2026-02-09T18:55:07.560002Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-09T18:55:07.561493Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"355195d5aae85944","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.153:2379]}","request-path":"/0/members/355195d5aae85944/attributes","cluster-id":"e424441517bc0b32","publish-timeout":"7s"} {"level":"info","ts":"2026-02-09T18:55:07.561624Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-09T18:55:07.561916Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-09T18:55:07.562101Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-09T18:55:07.562115Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-09T18:55:07.564099Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e424441517bc0b32","local-member-id":"355195d5aae85944","cluster-version":"3.5"} {"level":"info","ts":"2026-02-09T18:55:07.564218Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-09T18:55:07.564968Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-09T18:55:07.565745Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.153:2379"} {"level":"info","ts":"2026-02-09T18:55:07.571575Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-02-09T18:55:23.935132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"610.721847ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-09T18:55:23.935197Z","caller":"traceutil/trace.go:171","msg":"trace[237896570] linearizableReadLoop","detail":"{readStateIndex:388; appliedIndex:387; }","duration":"341.02706ms","start":"2026-02-09T18:55:23.59416Z","end":"2026-02-09T18:55:23.935187Z","steps":["trace[237896570] 'read index received' (duration: 25.251µs)","trace[237896570] 'applied index is now lower than readState.Index' (duration: 341.000889ms)"],"step_count":2} {"level":"warn","ts":"2026-02-09T18:55:23.935262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.104932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4034"} {"level":"info","ts":"2026-02-09T18:55:23.935274Z","caller":"traceutil/trace.go:171","msg":"trace[2041877780] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:376; }","duration":"341.140792ms","start":"2026-02-09T18:55:23.594129Z","end":"2026-02-09T18:55:23.93527Z","steps":["trace[2041877780] 'agreement among raft nodes before linearized reading' (duration: 341.088711ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:55:23.93529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:55:23.594116Z","time spent":"341.169613ms","remote":"127.0.0.1:37438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":4057,"request content":"key:\"/registry/deployments/kube-system/coredns\" "} {"level":"info","ts":"2026-02-09T18:55:23.93544Z","caller":"traceutil/trace.go:171","msg":"trace[1583674558] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"690.799271ms","start":"2026-02-09T18:55:23.244635Z","end":"2026-02-09T18:55:23.935434Z","steps":["trace[1583674558] 'process raft request' (duration: 79.447701ms)","trace[1583674558] 'compare' (duration: 610.534394ms)"],"step_count":2} {"level":"warn","ts":"2026-02-09T18:55:23.935468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:55:23.24462Z","time spent":"690.833302ms","remote":"127.0.0.1:37274","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-09T18:55:24.662761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.504248ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-09T18:55:24.66285Z","caller":"traceutil/trace.go:171","msg":"trace[1908583126] linearizableReadLoop","detail":"{readStateIndex:389; appliedIndex:388; }","duration":"431.069331ms","start":"2026-02-09T18:55:24.231766Z","end":"2026-02-09T18:55:24.662835Z","steps":["trace[1908583126] 'read index received' (duration: 146.367509ms)","trace[1908583126] 'applied index is now lower than readState.Index' (duration: 284.700722ms)"],"step_count":2} {"level":"warn","ts":"2026-02-09T18:55:24.662916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.154743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-02-09T18:55:24.662939Z","caller":"traceutil/trace.go:171","msg":"trace[258651976] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:377; }","duration":"431.178454ms","start":"2026-02-09T18:55:24.231753Z","end":"2026-02-09T18:55:24.662931Z","steps":["trace[258651976] 'agreement among raft nodes before linearized reading' (duration: 431.123892ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:55:24.662972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:55:24.231701Z","time spent":"431.263545ms","remote":"127.0.0.1:37274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-09T18:55:24.663069Z","caller":"traceutil/trace.go:171","msg":"trace[1306746187] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"715.377164ms","start":"2026-02-09T18:55:23.947665Z","end":"2026-02-09T18:55:24.663042Z","steps":["trace[1306746187] 'process raft request' (duration: 430.52387ms)","trace[1306746187] 'compare' (duration: 284.219191ms)"],"step_count":2} {"level":"warn","ts":"2026-02-09T18:55:24.663196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:55:23.947651Z","time spent":"715.477977ms","remote":"127.0.0.1:37438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4158,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-09T18:55:25.375168Z","caller":"traceutil/trace.go:171","msg":"trace[312364575] transaction","detail":"{read_only:false; response_revision:411; number_of_response:1; }","duration":"113.631635ms","start":"2026-02-09T18:55:25.261486Z","end":"2026-02-09T18:55:25.375118Z","steps":["trace[312364575] 'process raft request' (duration: 113.250807ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T18:55:38.905112Z","caller":"traceutil/trace.go:171","msg":"trace[386107886] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"170.74812ms","start":"2026-02-09T18:55:38.734345Z","end":"2026-02-09T18:55:38.905093Z","steps":["trace[386107886] 'process raft request' (duration: 170.641388ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T18:55:40.077989Z","caller":"traceutil/trace.go:171","msg":"trace[1617013612] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"349.046128ms","start":"2026-02-09T18:55:39.728928Z","end":"2026-02-09T18:55:40.077974Z","steps":["trace[1617013612] 'process raft request' (duration: 336.593867ms)","trace[1617013612] 'compare' (duration: 11.879098ms)"],"step_count":2} {"level":"warn","ts":"2026-02-09T18:55:40.078115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:55:39.728912Z","time spent":"349.124939ms","remote":"127.0.0.1:37274","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-02-09T18:55:40.452048Z","caller":"traceutil/trace.go:171","msg":"trace[1954854341] linearizableReadLoop","detail":"{readStateIndex:497; appliedIndex:496; }","duration":"331.805246ms","start":"2026-02-09T18:55:40.120228Z","end":"2026-02-09T18:55:40.452033Z","steps":["trace[1954854341] 'read index received' (duration: 331.674963ms)","trace[1954854341] 'applied index is now lower than readState.Index' (duration: 129.573µs)"],"step_count":2} {"level":"info","ts":"2026-02-09T18:55:40.452121Z","caller":"traceutil/trace.go:171","msg":"trace[191023311] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"371.071557ms","start":"2026-02-09T18:55:40.081044Z","end":"2026-02-09T18:55:40.452115Z","steps":["trace[191023311] 'process raft request' (duration: 370.900473ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:55:40.452183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:55:40.081031Z","time spent":"371.102538ms","remote":"127.0.0.1:37274","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-09T18:55:40.452373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.152003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-09T18:55:40.452391Z","caller":"traceutil/trace.go:171","msg":"trace[560463909] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:481; }","duration":"332.204984ms","start":"2026-02-09T18:55:40.120181Z","end":"2026-02-09T18:55:40.452386Z","steps":["trace[560463909] 'agreement among raft nodes before linearized reading' (duration: 332.175674ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:55:40.452404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:55:40.120162Z","time spent":"332.239215ms","remote":"127.0.0.1:37004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-09T18:55:45.559294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.689599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-09T18:55:45.559352Z","caller":"traceutil/trace.go:171","msg":"trace[1791460244] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:495; }","duration":"436.78133ms","start":"2026-02-09T18:55:45.122557Z","end":"2026-02-09T18:55:45.559339Z","steps":["trace[1791460244] 'range keys from in-memory index tree' (duration: 436.635528ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:55:45.559378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:55:45.122543Z","time spent":"436.828382ms","remote":"127.0.0.1:36992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-09T18:55:45.559659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.613108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-09T18:55:45.559681Z","caller":"traceutil/trace.go:171","msg":"trace[1308683091] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:495; }","duration":"227.658899ms","start":"2026-02-09T18:55:45.332015Z","end":"2026-02-09T18:55:45.559674Z","steps":["trace[1308683091] 'range keys from in-memory index tree' (duration: 227.492086ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T18:55:45.776559Z","caller":"traceutil/trace.go:171","msg":"trace[1212685669] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"213.953373ms","start":"2026-02-09T18:55:45.562526Z","end":"2026-02-09T18:55:45.776479Z","steps":["trace[1212685669] 'process raft request' (duration: 213.817861ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T18:55:45.776622Z","caller":"traceutil/trace.go:171","msg":"trace[1124520961] linearizableReadLoop","detail":"{readStateIndex:513; appliedIndex:513; }","duration":"209.748165ms","start":"2026-02-09T18:55:45.566842Z","end":"2026-02-09T18:55:45.776591Z","steps":["trace[1124520961] 'read index received' (duration: 209.736854ms)","trace[1124520961] 'applied index is now lower than readState.Index' (duration: 9.501µs)"],"step_count":2} {"level":"warn","ts":"2026-02-09T18:55:45.776792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.930408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-09T18:55:45.776815Z","caller":"traceutil/trace.go:171","msg":"trace[709814795] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:496; }","duration":"209.98745ms","start":"2026-02-09T18:55:45.566821Z","end":"2026-02-09T18:55:45.776809Z","steps":["trace[709814795] 'agreement among raft nodes before linearized reading' (duration: 209.880088ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:55:45.947399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.1799ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-09T18:55:45.947885Z","caller":"traceutil/trace.go:171","msg":"trace[2020262237] linearizableReadLoop","detail":"{readStateIndex:514; appliedIndex:513; }","duration":"171.180479ms","start":"2026-02-09T18:55:45.776675Z","end":"2026-02-09T18:55:45.947855Z","steps":["trace[2020262237] 'read index received' (duration: 42.661122ms)","trace[2020262237] 'applied index is now lower than readState.Index' (duration: 128.516837ms)"],"step_count":2} {"level":"info","ts":"2026-02-09T18:55:45.947904Z","caller":"traceutil/trace.go:171","msg":"trace[325051966] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"165.737685ms","start":"2026-02-09T18:55:45.782147Z","end":"2026-02-09T18:55:45.947885Z","steps":["trace[325051966] 'process raft request' (duration: 165.342356ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:55:45.94812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.182546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-n9hxv\" ","response":"range_response_count:1 size:16656"} {"level":"info","ts":"2026-02-09T18:55:45.948155Z","caller":"traceutil/trace.go:171","msg":"trace[138618170] range","detail":"{range_begin:/registry/pods/kube-system/cilium-n9hxv; range_end:; response_count:1; response_revision:497; }","duration":"377.238837ms","start":"2026-02-09T18:55:45.570904Z","end":"2026-02-09T18:55:45.948142Z","steps":["trace[138618170] 'agreement among raft nodes before linearized reading' (duration: 377.133015ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:55:45.948183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:55:45.570886Z","time spent":"377.289398ms","remote":"127.0.0.1:37188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16679,"request content":"key:\"/registry/pods/kube-system/cilium-n9hxv\" "} {"level":"info","ts":"2026-02-09T18:55:48.080502Z","caller":"traceutil/trace.go:171","msg":"trace[614295915] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"412.185096ms","start":"2026-02-09T18:55:47.668293Z","end":"2026-02-09T18:55:48.080478Z","steps":["trace[614295915] 'process raft request' (duration: 412.061224ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:55:48.080638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:55:47.668279Z","time spent":"412.289998ms","remote":"127.0.0.1:37188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4613,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-09T18:55:48.08153Z","caller":"traceutil/trace.go:171","msg":"trace[2064736516] linearizableReadLoop","detail":"{readStateIndex:536; appliedIndex:536; }","duration":"301.109615ms","start":"2026-02-09T18:55:47.780408Z","end":"2026-02-09T18:55:48.081518Z","steps":["trace[2064736516] 'read index received' (duration: 301.105075ms)","trace[2064736516] 'applied index is now lower than readState.Index' (duration: 3.57µs)"],"step_count":2} {"level":"warn","ts":"2026-02-09T18:55:48.081633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.221278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-09T18:55:48.081674Z","caller":"traceutil/trace.go:171","msg":"trace[33176736] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:518; }","duration":"301.287579ms","start":"2026-02-09T18:55:47.780373Z","end":"2026-02-09T18:55:48.081661Z","steps":["trace[33176736] 'agreement among raft nodes before linearized reading' (duration: 301.215667ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:55:48.081705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:55:47.780359Z","time spent":"301.33868ms","remote":"127.0.0.1:37274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-09T18:55:48.084441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.972569ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-09T18:55:48.084495Z","caller":"traceutil/trace.go:171","msg":"trace[130977487] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:520; }","duration":"131.06255ms","start":"2026-02-09T18:55:47.953419Z","end":"2026-02-09T18:55:48.084481Z","steps":["trace[130977487] 'agreement among raft nodes before linearized reading' (duration: 130.961388ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T18:55:48.084738Z","caller":"traceutil/trace.go:171","msg":"trace[2069286513] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"149.140408ms","start":"2026-02-09T18:55:47.935589Z","end":"2026-02-09T18:55:48.084729Z","steps":["trace[2069286513] 'process raft request' (duration: 148.699689ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T18:55:48.084818Z","caller":"traceutil/trace.go:171","msg":"trace[933942620] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"146.121205ms","start":"2026-02-09T18:55:47.938691Z","end":"2026-02-09T18:55:48.084812Z","steps":["trace[933942620] 'process raft request' (duration: 145.669695ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:55:59.154363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.74101ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-09T18:55:59.154446Z","caller":"traceutil/trace.go:171","msg":"trace[612893816] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"291.147757ms","start":"2026-02-09T18:55:58.863285Z","end":"2026-02-09T18:55:59.154433Z","steps":["trace[612893816] 'process raft request' (duration: 131.278235ms)","trace[612893816] 'compare' (duration: 159.505335ms)"],"step_count":2} {"level":"warn","ts":"2026-02-09T18:55:59.527521Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6432437982621706111,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-09T18:56:00.122189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.201514ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-09T18:56:00.122367Z","caller":"traceutil/trace.go:171","msg":"trace[2081583410] linearizableReadLoop","detail":"{readStateIndex:681; appliedIndex:677; }","duration":"1.095548183s","start":"2026-02-09T18:55:59.026801Z","end":"2026-02-09T18:56:00.12235Z","steps":["trace[2081583410] 'read index received' (duration: 742.041233ms)","trace[2081583410] 'applied index is now lower than readState.Index' (duration: 353.50599ms)"],"step_count":2} {"level":"info","ts":"2026-02-09T18:56:00.122524Z","caller":"traceutil/trace.go:171","msg":"trace[1717264655] transaction","detail":"{read_only:false; response_revision:655; number_of_response:1; }","duration":"1.256958687s","start":"2026-02-09T18:55:58.865559Z","end":"2026-02-09T18:56:00.122517Z","steps":["trace[1717264655] 'process raft request' (duration: 903.343865ms)","trace[1717264655] 'compare' (duration: 353.102992ms)"],"step_count":2} {"level":"warn","ts":"2026-02-09T18:56:00.122561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:55:58.865548Z","time spent":"1.256992998s","remote":"127.0.0.1:37282","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1614,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-09T18:56:00.122718Z","caller":"traceutil/trace.go:171","msg":"trace[775286283] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"1.256102588s","start":"2026-02-09T18:55:58.866611Z","end":"2026-02-09T18:56:00.122713Z","steps":["trace[775286283] 'process raft request' (duration: 1.255649879s)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:56:00.122744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:55:58.866604Z","time spent":"1.256125679s","remote":"127.0.0.1:37162","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1019,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-09T18:56:00.122894Z","caller":"traceutil/trace.go:171","msg":"trace[1447275492] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"1.253921464s","start":"2026-02-09T18:55:58.868968Z","end":"2026-02-09T18:56:00.122889Z","steps":["trace[1447275492] 'process raft request' (duration: 1.253328132s)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:56:00.12292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:55:58.868959Z","time spent":"1.253946494s","remote":"127.0.0.1:37474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3866,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-09T18:56:00.122977Z","caller":"traceutil/trace.go:171","msg":"trace[1116667139] transaction","detail":"{read_only:false; response_revision:658; number_of_response:1; }","duration":"1.251019922s","start":"2026-02-09T18:55:58.871952Z","end":"2026-02-09T18:56:00.122972Z","steps":["trace[1116667139] 'process raft request' (duration: 1.250372148s)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:56:00.123006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:55:58.871946Z","time spent":"1.251039922s","remote":"127.0.0.1:37474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3830,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-09T18:56:00.123113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.096310339s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-02-09T18:56:00.123127Z","caller":"traceutil/trace.go:171","msg":"trace[656602596] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:658; }","duration":"1.096348539s","start":"2026-02-09T18:55:59.026773Z","end":"2026-02-09T18:56:00.123121Z","steps":["trace[656602596] 'agreement among raft nodes before linearized reading' (duration: 1.096278787s)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:56:00.123142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:55:59.026759Z","time spent":"1.096378739s","remote":"127.0.0.1:37274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-09T18:56:00.123217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"994.250665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-09T18:56:00.123229Z","caller":"traceutil/trace.go:171","msg":"trace[1722088324] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:658; }","duration":"994.285716ms","start":"2026-02-09T18:55:59.128939Z","end":"2026-02-09T18:56:00.123225Z","steps":["trace[1722088324] 'agreement among raft nodes before linearized reading' (duration: 994.266336ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:56:00.12324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:55:59.128925Z","time spent":"994.312136ms","remote":"127.0.0.1:37004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-09T18:56:00.123494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"494.905955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-09T18:56:00.123512Z","caller":"traceutil/trace.go:171","msg":"trace[379015523] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:658; }","duration":"494.959287ms","start":"2026-02-09T18:55:59.628549Z","end":"2026-02-09T18:56:00.123508Z","steps":["trace[379015523] 'agreement among raft nodes before linearized reading' (duration: 494.873515ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:56:00.123525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:55:59.628527Z","time spent":"494.994867ms","remote":"127.0.0.1:37274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-09T18:56:00.123619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"961.425748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-n9hxv\" ","response":"range_response_count:1 size:18250"} {"level":"info","ts":"2026-02-09T18:56:00.123632Z","caller":"traceutil/trace.go:171","msg":"trace[2013383824] range","detail":"{range_begin:/registry/pods/kube-system/cilium-n9hxv; range_end:; response_count:1; response_revision:658; }","duration":"961.486889ms","start":"2026-02-09T18:55:59.162141Z","end":"2026-02-09T18:56:00.123627Z","steps":["trace[2013383824] 'agreement among raft nodes before linearized reading' (duration: 961.437358ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:56:00.123643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:55:59.162126Z","time spent":"961.515301ms","remote":"127.0.0.1:37188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":18273,"request content":"key:\"/registry/pods/kube-system/cilium-n9hxv\" "} {"level":"warn","ts":"2026-02-09T18:56:00.12375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"963.685026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4206"} {"level":"info","ts":"2026-02-09T18:56:00.123762Z","caller":"traceutil/trace.go:171","msg":"trace[674218478] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:658; }","duration":"963.738107ms","start":"2026-02-09T18:55:59.160021Z","end":"2026-02-09T18:56:00.123759Z","steps":["trace[674218478] 'agreement among raft nodes before linearized reading' (duration: 963.682876ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:56:00.123774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:55:59.159997Z","time spent":"963.774658ms","remote":"127.0.0.1:37438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":4229,"request content":"key:\"/registry/deployments/kube-system/coredns\" "} {"level":"info","ts":"2026-02-09T18:56:00.467033Z","caller":"traceutil/trace.go:171","msg":"trace[1469789387] transaction","detail":"{read_only:false; response_revision:659; number_of_response:1; }","duration":"287.861178ms","start":"2026-02-09T18:56:00.179159Z","end":"2026-02-09T18:56:00.46702Z","steps":["trace[1469789387] 'process raft request' (duration: 285.168441ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T18:56:00.467356Z","caller":"traceutil/trace.go:171","msg":"trace[2073663497] linearizableReadLoop","detail":"{readStateIndex:682; appliedIndex:681; }","duration":"284.155011ms","start":"2026-02-09T18:56:00.182651Z","end":"2026-02-09T18:56:00.466806Z","steps":["trace[2073663497] 'read index received' (duration: 281.669569ms)","trace[2073663497] 'applied index is now lower than readState.Index' (duration: 2.484532ms)"],"step_count":2} {"level":"warn","ts":"2026-02-09T18:56:00.46752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.843755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-5dd5756b68-fkldw\" ","response":"range_response_count:1 size:4812"} {"level":"info","ts":"2026-02-09T18:56:00.467545Z","caller":"traceutil/trace.go:171","msg":"trace[306202942] range","detail":"{range_begin:/registry/pods/kube-system/coredns-5dd5756b68-fkldw; range_end:; response_count:1; response_revision:659; }","duration":"284.906906ms","start":"2026-02-09T18:56:00.18263Z","end":"2026-02-09T18:56:00.467537Z","steps":["trace[306202942] 'agreement among raft nodes before linearized reading' (duration: 284.768353ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:56:00.886742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.060074ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-09T18:56:00.886964Z","caller":"traceutil/trace.go:171","msg":"trace[1577678770] linearizableReadLoop","detail":"{readStateIndex:685; appliedIndex:682; }","duration":"419.568161ms","start":"2026-02-09T18:56:00.467381Z","end":"2026-02-09T18:56:00.886949Z","steps":["trace[1577678770] 'read index received' (duration: 173.329983ms)","trace[1577678770] 'applied index is now lower than readState.Index' (duration: 246.237398ms)"],"step_count":2} {"level":"info","ts":"2026-02-09T18:56:00.887582Z","caller":"traceutil/trace.go:171","msg":"trace[1672046789] transaction","detail":"{read_only:false; response_revision:660; number_of_response:1; }","duration":"700.617606ms","start":"2026-02-09T18:56:00.186956Z","end":"2026-02-09T18:56:00.887574Z","steps":["trace[1672046789] 'process raft request' (duration: 453.640113ms)","trace[1672046789] 'compare' (duration: 245.900281ms)"],"step_count":2} {"level":"warn","ts":"2026-02-09T18:56:00.887631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:56:00.186928Z","time spent":"700.680278ms","remote":"127.0.0.1:37274","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-09T18:56:00.887862Z","caller":"traceutil/trace.go:171","msg":"trace[1947459800] transaction","detail":"{read_only:false; response_revision:661; number_of_response:1; }","duration":"657.560456ms","start":"2026-02-09T18:56:00.230294Z","end":"2026-02-09T18:56:00.887854Z","steps":["trace[1947459800] 'process raft request' (duration: 656.558755ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:56:00.887889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:56:00.230257Z","time spent":"657.617017ms","remote":"127.0.0.1:37188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18047,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-09T18:56:00.88795Z","caller":"traceutil/trace.go:171","msg":"trace[1770219527] transaction","detail":"{read_only:false; response_revision:662; number_of_response:1; }","duration":"651.838226ms","start":"2026-02-09T18:56:00.236107Z","end":"2026-02-09T18:56:00.887945Z","steps":["trace[1770219527] 'process raft request' (duration: 650.799635ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:56:00.887974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:56:00.236098Z","time spent":"651.862206ms","remote":"127.0.0.1:37274","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-09T18:56:00.8881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.231258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.153\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-09T18:56:00.888114Z","caller":"traceutil/trace.go:171","msg":"trace[984667402] range","detail":"{range_begin:/registry/masterleases/199.204.45.153; range_end:; response_count:1; response_revision:662; }","duration":"467.292399ms","start":"2026-02-09T18:56:00.420816Z","end":"2026-02-09T18:56:00.888109Z","steps":["trace[984667402] 'agreement among raft nodes before linearized reading' (duration: 467.216198ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:56:00.888129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:56:00.420791Z","time spent":"467.33343ms","remote":"127.0.0.1:37046","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.153\" "} {"level":"warn","ts":"2026-02-09T18:56:00.888226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"652.143894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-09T18:56:00.888238Z","caller":"traceutil/trace.go:171","msg":"trace[1934255374] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:662; }","duration":"652.162154ms","start":"2026-02-09T18:56:00.236072Z","end":"2026-02-09T18:56:00.888234Z","steps":["trace[1934255374] 'agreement among raft nodes before linearized reading' (duration: 652.123373ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:56:00.888249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:56:00.236068Z","time spent":"652.177544ms","remote":"127.0.0.1:37274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-09T18:56:00.892938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"656.912814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-02-09T18:56:00.892972Z","caller":"traceutil/trace.go:171","msg":"trace[631786434] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:662; }","duration":"656.953554ms","start":"2026-02-09T18:56:00.236009Z","end":"2026-02-09T18:56:00.892962Z","steps":["trace[631786434] 'agreement among raft nodes before linearized reading' (duration: 652.291186ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:56:00.892987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:56:00.236006Z","time spent":"656.978065ms","remote":"127.0.0.1:37274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-09T18:56:00.89308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"657.095028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-09T18:56:00.893092Z","caller":"traceutil/trace.go:171","msg":"trace[1566447636] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:662; }","duration":"657.131688ms","start":"2026-02-09T18:56:00.235956Z","end":"2026-02-09T18:56:00.893088Z","steps":["trace[1566447636] 'agreement among raft nodes before linearized reading' (duration: 657.109087ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:56:00.893132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:56:00.235944Z","time spent":"657.183729ms","remote":"127.0.0.1:37004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-09T18:56:00.928906Z","caller":"traceutil/trace.go:171","msg":"trace[1252530364] transaction","detail":"{read_only:false; response_revision:665; number_of_response:1; }","duration":"356.037513ms","start":"2026-02-09T18:56:00.572853Z","end":"2026-02-09T18:56:00.92889Z","steps":["trace[1252530364] 'process raft request' (duration: 356.001303ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:56:00.929043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:56:00.572829Z","time spent":"356.133695ms","remote":"127.0.0.1:37274","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-02-09T18:56:00.929432Z","caller":"traceutil/trace.go:171","msg":"trace[1637202097] transaction","detail":"{read_only:false; response_revision:663; number_of_response:1; }","duration":"457.546585ms","start":"2026-02-09T18:56:00.471877Z","end":"2026-02-09T18:56:00.929423Z","steps":["trace[1637202097] 'process raft request' (duration: 456.842441ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:56:00.929467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:56:00.471857Z","time spent":"457.590626ms","remote":"127.0.0.1:37188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4809,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-09T18:56:00.92961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.900262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-09T18:56:00.931878Z","caller":"traceutil/trace.go:171","msg":"trace[1674984905] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:665; }","duration":"327.234601ms","start":"2026-02-09T18:56:00.604623Z","end":"2026-02-09T18:56:00.931857Z","steps":["trace[1674984905] 'agreement among raft nodes before linearized reading' (duration: 324.78672ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:56:00.931941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:56:00.604607Z","time spent":"327.321063ms","remote":"127.0.0.1:37274","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":"info","ts":"2026-02-09T18:56:00.92966Z","caller":"traceutil/trace.go:171","msg":"trace[1670318169] transaction","detail":"{read_only:false; response_revision:664; number_of_response:1; }","duration":"451.838236ms","start":"2026-02-09T18:56:00.477816Z","end":"2026-02-09T18:56:00.929654Z","steps":["trace[1670318169] 'process raft request' (duration: 451.004079ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:56:00.932178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:56:00.477809Z","time spent":"454.304218ms","remote":"127.0.0.1:37438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4164,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-09T18:56:01.02526Z","caller":"traceutil/trace.go:171","msg":"trace[1067494365] transaction","detail":"{read_only:false; response_revision:669; number_of_response:1; }","duration":"102.131044ms","start":"2026-02-09T18:56:00.923109Z","end":"2026-02-09T18:56:01.02524Z","steps":["trace[1067494365] 'process raft request' (duration: 102.103514ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T18:56:01.025505Z","caller":"traceutil/trace.go:171","msg":"trace[1993322102] transaction","detail":"{read_only:false; response_revision:667; number_of_response:1; }","duration":"109.650522ms","start":"2026-02-09T18:56:00.915848Z","end":"2026-02-09T18:56:01.025498Z","steps":["trace[1993322102] 'process raft request' (duration: 109.297615ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T18:56:01.025687Z","caller":"traceutil/trace.go:171","msg":"trace[1587904776] transaction","detail":"{read_only:false; response_revision:668; number_of_response:1; }","duration":"103.054223ms","start":"2026-02-09T18:56:00.922627Z","end":"2026-02-09T18:56:01.025682Z","steps":["trace[1587904776] 'process raft request' (duration: 102.562433ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T18:56:01.025922Z","caller":"traceutil/trace.go:171","msg":"trace[788724248] transaction","detail":"{read_only:false; response_revision:666; number_of_response:1; }","duration":"114.259238ms","start":"2026-02-09T18:56:00.911654Z","end":"2026-02-09T18:56:01.025914Z","steps":["trace[788724248] 'process raft request' (duration: 113.37423ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T18:56:05.20297Z","caller":"traceutil/trace.go:171","msg":"trace[1857010704] transaction","detail":"{read_only:false; response_revision:690; number_of_response:1; }","duration":"107.883663ms","start":"2026-02-09T18:56:05.094861Z","end":"2026-02-09T18:56:05.202745Z","steps":["trace[1857010704] 'process raft request' (duration: 101.31601ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T18:56:05.204195Z","caller":"traceutil/trace.go:171","msg":"trace[2047423230] transaction","detail":"{read_only:false; response_revision:691; number_of_response:1; }","duration":"109.076908ms","start":"2026-02-09T18:56:05.095103Z","end":"2026-02-09T18:56:05.20418Z","steps":["trace[2047423230] 'process raft request' (duration: 106.455545ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T18:56:07.275622Z","caller":"traceutil/trace.go:171","msg":"trace[1943336829] linearizableReadLoop","detail":"{readStateIndex:718; appliedIndex:717; }","duration":"151.894519ms","start":"2026-02-09T18:56:07.12371Z","end":"2026-02-09T18:56:07.275604Z","steps":["trace[1943336829] 'read index received' (duration: 151.696275ms)","trace[1943336829] 'applied index is now lower than readState.Index' (duration: 197.434µs)"],"step_count":2} {"level":"warn","ts":"2026-02-09T18:56:07.276068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.73711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-02-09T18:56:07.276095Z","caller":"traceutil/trace.go:171","msg":"trace[1229822828] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:693; }","duration":"133.793921ms","start":"2026-02-09T18:56:07.142293Z","end":"2026-02-09T18:56:07.276087Z","steps":["trace[1229822828] 'agreement among raft nodes before linearized reading' (duration: 133.678358ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:56:07.276185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.475942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-09T18:56:07.276202Z","caller":"traceutil/trace.go:171","msg":"trace[1791435482] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:693; }","duration":"152.519062ms","start":"2026-02-09T18:56:07.123677Z","end":"2026-02-09T18:56:07.276196Z","steps":["trace[1791435482] 'agreement among raft nodes before linearized reading' (duration: 152.492041ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T18:56:07.278553Z","caller":"traceutil/trace.go:171","msg":"trace[1865169221] transaction","detail":"{read_only:false; response_revision:693; number_of_response:1; }","duration":"254.884754ms","start":"2026-02-09T18:56:07.021059Z","end":"2026-02-09T18:56:07.275943Z","steps":["trace[1865169221] 'process raft request' (duration: 253.552296ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T18:56:15.20767Z","caller":"traceutil/trace.go:171","msg":"trace[617489088] transaction","detail":"{read_only:false; response_revision:721; number_of_response:1; }","duration":"157.938133ms","start":"2026-02-09T18:56:15.049704Z","end":"2026-02-09T18:56:15.207642Z","steps":["trace[617489088] 'process raft request' (duration: 157.440643ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T18:56:27.441481Z","caller":"traceutil/trace.go:171","msg":"trace[499141061] transaction","detail":"{read_only:false; response_revision:754; number_of_response:1; }","duration":"166.153339ms","start":"2026-02-09T18:56:27.275305Z","end":"2026-02-09T18:56:27.441459Z","steps":["trace[499141061] 'process raft request' (duration: 165.69519ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T18:56:29.695654Z","caller":"traceutil/trace.go:171","msg":"trace[1460310468] transaction","detail":"{read_only:false; response_revision:759; number_of_response:1; }","duration":"242.095094ms","start":"2026-02-09T18:56:29.453542Z","end":"2026-02-09T18:56:29.695637Z","steps":["trace[1460310468] 'process raft request' (duration: 241.972482ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T18:56:29.725077Z","caller":"traceutil/trace.go:171","msg":"trace[964144548] linearizableReadLoop","detail":"{readStateIndex:790; appliedIndex:789; }","duration":"269.426619ms","start":"2026-02-09T18:56:29.45558Z","end":"2026-02-09T18:56:29.725007Z","steps":["trace[964144548] 'read index received' (duration: 240.047032ms)","trace[964144548] 'applied index is now lower than readState.Index' (duration: 29.377337ms)"],"step_count":2} {"level":"info","ts":"2026-02-09T18:56:29.727159Z","caller":"traceutil/trace.go:171","msg":"trace[836505749] transaction","detail":"{read_only:false; response_revision:760; number_of_response:1; }","duration":"272.396899ms","start":"2026-02-09T18:56:29.454749Z","end":"2026-02-09T18:56:29.727146Z","steps":["trace[836505749] 'process raft request' (duration: 268.343556ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:56:29.727563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.956011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-02-09T18:56:29.727615Z","caller":"traceutil/trace.go:171","msg":"trace[145836343] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:760; }","duration":"272.036762ms","start":"2026-02-09T18:56:29.455567Z","end":"2026-02-09T18:56:29.727603Z","steps":["trace[145836343] 'agreement among raft nodes before linearized reading' (duration: 271.887949ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:56:29.727808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.615311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-09T18:56:29.727858Z","caller":"traceutil/trace.go:171","msg":"trace[1405935070] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:760; }","duration":"263.680142ms","start":"2026-02-09T18:56:29.46416Z","end":"2026-02-09T18:56:29.72784Z","steps":["trace[1405935070] 'agreement among raft nodes before linearized reading' (duration: 263.520709ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:56:29.728061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.421777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-09T18:56:29.728083Z","caller":"traceutil/trace.go:171","msg":"trace[606342365] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:760; }","duration":"263.463968ms","start":"2026-02-09T18:56:29.464612Z","end":"2026-02-09T18:56:29.728076Z","steps":["trace[606342365] 'agreement among raft nodes before linearized reading' (duration: 263.381606ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:56:31.079952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.646913ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-09T18:56:31.080065Z","caller":"traceutil/trace.go:171","msg":"trace[218023911] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:763; }","duration":"142.780805ms","start":"2026-02-09T18:56:30.937267Z","end":"2026-02-09T18:56:31.080048Z","steps":["trace[218023911] 'range keys from in-memory index tree' (duration: 142.630422ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:56:31.092355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.13475ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-09T18:56:31.092418Z","caller":"traceutil/trace.go:171","msg":"trace[1931663743] linearizableReadLoop","detail":"{readStateIndex:795; appliedIndex:794; }","duration":"366.557208ms","start":"2026-02-09T18:56:30.725851Z","end":"2026-02-09T18:56:31.092408Z","steps":["trace[1931663743] 'read index received' (duration: 135.255394ms)","trace[1931663743] 'applied index is now lower than readState.Index' (duration: 231.300954ms)"],"step_count":2} {"level":"info","ts":"2026-02-09T18:56:31.09246Z","caller":"traceutil/trace.go:171","msg":"trace[877423733] transaction","detail":"{read_only:false; response_revision:764; number_of_response:1; }","duration":"441.495964ms","start":"2026-02-09T18:56:30.650929Z","end":"2026-02-09T18:56:31.092425Z","steps":["trace[877423733] 'process raft request' (duration: 210.228601ms)","trace[877423733] 'compare' (duration: 219.376872ms)","trace[877423733] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/masterleases/199.204.45.153; req_size:118; } (duration: 11.686927ms)"],"step_count":3} {"level":"warn","ts":"2026-02-09T18:56:31.092517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.66301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-09T18:56:31.092541Z","caller":"traceutil/trace.go:171","msg":"trace[1280223479] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:764; }","duration":"366.724731ms","start":"2026-02-09T18:56:30.725809Z","end":"2026-02-09T18:56:31.092534Z","steps":["trace[1280223479] 'agreement among raft nodes before linearized reading' (duration: 366.66151ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:56:31.092567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:56:30.725789Z","time spent":"366.769832ms","remote":"127.0.0.1:37244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":28,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"warn","ts":"2026-02-09T18:56:31.092572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:56:30.650909Z","time spent":"441.602937ms","remote":"127.0.0.1:37046","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-02-09T18:56:31.953507Z","caller":"traceutil/trace.go:171","msg":"trace[1553943124] linearizableReadLoop","detail":"{readStateIndex:796; appliedIndex:795; }","duration":"211.088244ms","start":"2026-02-09T18:56:31.742386Z","end":"2026-02-09T18:56:31.953474Z","steps":["trace[1553943124] 'read index received' (duration: 210.732876ms)","trace[1553943124] 'applied index is now lower than readState.Index' (duration: 352.558µs)"],"step_count":2} {"level":"warn","ts":"2026-02-09T18:56:31.953707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.304399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-02-09T18:56:31.953779Z","caller":"traceutil/trace.go:171","msg":"trace[947785939] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:765; }","duration":"211.40719ms","start":"2026-02-09T18:56:31.742363Z","end":"2026-02-09T18:56:31.95377Z","steps":["trace[947785939] 'agreement among raft nodes before linearized reading' (duration: 211.222016ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T18:56:31.95402Z","caller":"traceutil/trace.go:171","msg":"trace[994207945] transaction","detail":"{read_only:false; response_revision:765; number_of_response:1; }","duration":"214.740498ms","start":"2026-02-09T18:56:31.739271Z","end":"2026-02-09T18:56:31.954011Z","steps":["trace[994207945] 'process raft request' (duration: 213.798298ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T18:56:32.426916Z","caller":"traceutil/trace.go:171","msg":"trace[1078714416] transaction","detail":"{read_only:false; response_revision:768; number_of_response:1; }","duration":"470.003139ms","start":"2026-02-09T18:56:31.956897Z","end":"2026-02-09T18:56:32.4269Z","steps":["trace[1078714416] 'process raft request' (duration: 469.978299ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:56:32.427025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:56:31.956881Z","time spent":"470.09146ms","remote":"127.0.0.1:37274","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-09T18:56:32.427229Z","caller":"traceutil/trace.go:171","msg":"trace[1038134099] transaction","detail":"{read_only:false; response_revision:766; number_of_response:1; }","duration":"641.378243ms","start":"2026-02-09T18:56:31.785843Z","end":"2026-02-09T18:56:32.427221Z","steps":["trace[1038134099] 'process raft request' (duration: 544.222788ms)","trace[1038134099] 'compare' (duration: 96.698426ms)"],"step_count":2} {"level":"warn","ts":"2026-02-09T18:56:32.427266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:56:31.785824Z","time spent":"641.421215ms","remote":"127.0.0.1:37274","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-09T18:56:32.427342Z","caller":"traceutil/trace.go:171","msg":"trace[1266223106] transaction","detail":"{read_only:false; response_revision:767; number_of_response:1; }","duration":"627.473761ms","start":"2026-02-09T18:56:31.799863Z","end":"2026-02-09T18:56:32.427337Z","steps":["trace[1266223106] 'process raft request' (duration: 626.980531ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:56:32.427373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:56:31.799854Z","time spent":"627.500821ms","remote":"127.0.0.1:37274","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-09T18:56:32.427441Z","caller":"traceutil/trace.go:171","msg":"trace[1605029241] linearizableReadLoop","detail":"{readStateIndex:798; appliedIndex:796; }","duration":"473.884717ms","start":"2026-02-09T18:56:31.95355Z","end":"2026-02-09T18:56:32.427435Z","steps":["trace[1605029241] 'read index received' (duration: 376.525947ms)","trace[1605029241] 'applied index is now lower than readState.Index' (duration: 97.35657ms)"],"step_count":2} {"level":"warn","ts":"2026-02-09T18:56:32.427517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"676.442497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-09T18:56:32.427533Z","caller":"traceutil/trace.go:171","msg":"trace[640436973] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:768; }","duration":"676.490129ms","start":"2026-02-09T18:56:31.751038Z","end":"2026-02-09T18:56:32.427528Z","steps":["trace[640436973] 'agreement among raft nodes before linearized reading' (duration: 676.416637ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:56:32.427554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:56:31.75103Z","time spent":"676.520079ms","remote":"127.0.0.1:37274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-09T18:56:32.427707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"673.550049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-09T18:56:32.427726Z","caller":"traceutil/trace.go:171","msg":"trace[600839806] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:768; }","duration":"673.579709ms","start":"2026-02-09T18:56:31.754139Z","end":"2026-02-09T18:56:32.427719Z","steps":["trace[600839806] 'agreement among raft nodes before linearized reading' (duration: 673.530388ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:56:32.427741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:56:31.754133Z","time spent":"673.60464ms","remote":"127.0.0.1:37274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-09T18:56:32.702155Z","caller":"traceutil/trace.go:171","msg":"trace[918200340] transaction","detail":"{read_only:false; response_revision:769; number_of_response:1; }","duration":"268.085122ms","start":"2026-02-09T18:56:32.434045Z","end":"2026-02-09T18:56:32.70213Z","steps":["trace[918200340] 'process raft request' (duration: 262.949168ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T18:56:32.70607Z","caller":"traceutil/trace.go:171","msg":"trace[1138648779] transaction","detail":"{read_only:false; response_revision:770; number_of_response:1; }","duration":"259.262713ms","start":"2026-02-09T18:56:32.446792Z","end":"2026-02-09T18:56:32.706054Z","steps":["trace[1138648779] 'process raft request' (duration: 258.899875ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T18:56:46.613851Z","caller":"traceutil/trace.go:171","msg":"trace[1210043570] linearizableReadLoop","detail":"{readStateIndex:899; appliedIndex:898; }","duration":"110.185671ms","start":"2026-02-09T18:56:46.503645Z","end":"2026-02-09T18:56:46.613831Z","steps":["trace[1210043570] 'read index received' (duration: 71.152697ms)","trace[1210043570] 'applied index is now lower than readState.Index' (duration: 39.032084ms)"],"step_count":2} {"level":"warn","ts":"2026-02-09T18:56:46.614017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.351724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-09T18:56:46.614047Z","caller":"traceutil/trace.go:171","msg":"trace[80118486] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:863; }","duration":"110.397305ms","start":"2026-02-09T18:56:46.50364Z","end":"2026-02-09T18:56:46.614037Z","steps":["trace[80118486] 'agreement among raft nodes before linearized reading' (duration: 110.274312ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T18:56:46.614148Z","caller":"traceutil/trace.go:171","msg":"trace[951095338] transaction","detail":"{read_only:false; response_revision:863; number_of_response:1; }","duration":"112.511788ms","start":"2026-02-09T18:56:46.501617Z","end":"2026-02-09T18:56:46.614129Z","steps":["trace[951095338] 'process raft request' (duration: 112.11194ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:56:51.167023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.198775ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-09T18:56:51.167097Z","caller":"traceutil/trace.go:171","msg":"trace[1031165775] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:877; }","duration":"245.280427ms","start":"2026-02-09T18:56:50.921806Z","end":"2026-02-09T18:56:51.167087Z","steps":["trace[1031165775] 'range keys from in-memory index tree' (duration: 245.189525ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T18:56:51.168829Z","caller":"traceutil/trace.go:171","msg":"trace[933179287] linearizableReadLoop","detail":"{readStateIndex:916; appliedIndex:914; }","duration":"349.64751ms","start":"2026-02-09T18:56:50.819174Z","end":"2026-02-09T18:56:51.168821Z","steps":["trace[933179287] 'read index received' (duration: 342.046306ms)","trace[933179287] 'applied index is now lower than readState.Index' (duration: 7.600764ms)"],"step_count":2} {"level":"info","ts":"2026-02-09T18:56:51.169614Z","caller":"traceutil/trace.go:171","msg":"trace[143807382] transaction","detail":"{read_only:false; response_revision:878; number_of_response:1; }","duration":"505.493229ms","start":"2026-02-09T18:56:50.664114Z","end":"2026-02-09T18:56:51.169607Z","steps":["trace[143807382] 'process raft request' (duration: 497.16545ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:56:51.169998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:56:50.664105Z","time spent":"505.848677ms","remote":"127.0.0.1:37274","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-09T18:56:51.170193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.989281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-09T18:56:51.170214Z","caller":"traceutil/trace.go:171","msg":"trace[1821311816] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:879; }","duration":"333.021111ms","start":"2026-02-09T18:56:50.837188Z","end":"2026-02-09T18:56:51.170209Z","steps":["trace[1821311816] 'agreement among raft nodes before linearized reading' (duration: 332.95845ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:56:51.170229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:56:50.837182Z","time spent":"333.043491ms","remote":"127.0.0.1:37274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-09T18:56:51.169657Z","caller":"traceutil/trace.go:171","msg":"trace[744394499] transaction","detail":"{read_only:false; response_revision:879; number_of_response:1; }","duration":"502.123831ms","start":"2026-02-09T18:56:50.667529Z","end":"2026-02-09T18:56:51.169653Z","steps":["trace[744394499] 'process raft request' (duration: 501.09137ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:56:51.170442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:56:50.667514Z","time spent":"502.910037ms","remote":"127.0.0.1:37274","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-09T18:56:51.169739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.559528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-09T18:56:51.170476Z","caller":"traceutil/trace.go:171","msg":"trace[2075892466] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:879; }","duration":"351.323084ms","start":"2026-02-09T18:56:50.819149Z","end":"2026-02-09T18:56:51.170472Z","steps":["trace[2075892466] 'agreement among raft nodes before linearized reading' (duration: 350.522108ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:56:51.17049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:56:50.819134Z","time spent":"351.350755ms","remote":"127.0.0.1:37274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-09T18:56:53.092936Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6432437982621706660,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-09T18:56:53.322221Z","caller":"traceutil/trace.go:171","msg":"trace[1743322130] linearizableReadLoop","detail":"{readStateIndex:919; appliedIndex:918; }","duration":"741.689555ms","start":"2026-02-09T18:56:52.580518Z","end":"2026-02-09T18:56:53.322207Z","steps":["trace[1743322130] 'read index received' (duration: 741.567763ms)","trace[1743322130] 'applied index is now lower than readState.Index' (duration: 121.262µs)"],"step_count":2} {"level":"info","ts":"2026-02-09T18:56:53.322441Z","caller":"traceutil/trace.go:171","msg":"trace[617673945] transaction","detail":"{read_only:false; response_revision:882; number_of_response:1; }","duration":"818.320664ms","start":"2026-02-09T18:56:52.504115Z","end":"2026-02-09T18:56:53.322436Z","steps":["trace[617673945] 'process raft request' (duration: 818.010717ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:56:53.32251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:56:52.504095Z","time spent":"818.362464ms","remote":"127.0.0.1:37274","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-02-09T18:56:53.322649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"742.128514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-09T18:56:53.322664Z","caller":"traceutil/trace.go:171","msg":"trace[512711499] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:882; }","duration":"742.169434ms","start":"2026-02-09T18:56:52.580491Z","end":"2026-02-09T18:56:53.32266Z","steps":["trace[512711499] 'agreement among raft nodes before linearized reading' (duration: 742.108573ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:56:53.322678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:56:52.580478Z","time spent":"742.196715ms","remote":"127.0.0.1:37082","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":95,"response size":30,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"warn","ts":"2026-02-09T18:56:53.322757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"693.29694ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-09T18:56:53.322771Z","caller":"traceutil/trace.go:171","msg":"trace[1140883268] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:882; }","duration":"693.31008ms","start":"2026-02-09T18:56:52.629455Z","end":"2026-02-09T18:56:53.322765Z","steps":["trace[1140883268] 'agreement among raft nodes before linearized reading' (duration: 693.28914ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:56:53.322782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:56:52.629417Z","time spent":"693.362612ms","remote":"127.0.0.1:37274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":7,"response size":30,"request content":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true "} {"level":"warn","ts":"2026-02-09T18:56:53.322917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.676129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-09T18:56:53.322932Z","caller":"traceutil/trace.go:171","msg":"trace[1666996085] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:882; }","duration":"132.69973ms","start":"2026-02-09T18:56:53.190229Z","end":"2026-02-09T18:56:53.322928Z","steps":["trace[1666996085] 'agreement among raft nodes before linearized reading' (duration: 132.637548ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:56:53.32301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.826872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-09T18:56:53.323021Z","caller":"traceutil/trace.go:171","msg":"trace[2028700268] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:882; }","duration":"132.876063ms","start":"2026-02-09T18:56:53.190142Z","end":"2026-02-09T18:56:53.323018Z","steps":["trace[2028700268] 'agreement among raft nodes before linearized reading' (duration: 132.838453ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:56:53.323098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.958649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-09T18:56:53.32311Z","caller":"traceutil/trace.go:171","msg":"trace[1899786994] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:882; }","duration":"145.989079ms","start":"2026-02-09T18:56:53.177118Z","end":"2026-02-09T18:56:53.323107Z","steps":["trace[1899786994] 'agreement among raft nodes before linearized reading' (duration: 145.954088ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:56:53.323188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.691283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-09T18:56:53.323258Z","caller":"traceutil/trace.go:171","msg":"trace[601425473] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:882; }","duration":"146.781265ms","start":"2026-02-09T18:56:53.176473Z","end":"2026-02-09T18:56:53.323254Z","steps":["trace[601425473] 'agreement among raft nodes before linearized reading' (duration: 146.687173ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:56:53.323327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.518264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-09T18:56:53.323338Z","caller":"traceutil/trace.go:171","msg":"trace[652176709] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:882; }","duration":"159.556235ms","start":"2026-02-09T18:56:53.163779Z","end":"2026-02-09T18:56:53.323335Z","steps":["trace[652176709] 'agreement among raft nodes before linearized reading' (duration: 159.538244ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:56:53.323477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"660.853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-02-09T18:56:53.323492Z","caller":"traceutil/trace.go:171","msg":"trace[1945066699] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:882; }","duration":"660.909882ms","start":"2026-02-09T18:56:52.662578Z","end":"2026-02-09T18:56:53.323488Z","steps":["trace[1945066699] 'agreement among raft nodes before linearized reading' (duration: 660.849621ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:56:53.323506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:56:52.662569Z","time spent":"660.932512ms","remote":"127.0.0.1:37274","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":"info","ts":"2026-02-09T18:56:53.651031Z","caller":"traceutil/trace.go:171","msg":"trace[1246796721] transaction","detail":"{read_only:false; response_revision:884; number_of_response:1; }","duration":"319.310204ms","start":"2026-02-09T18:56:53.33171Z","end":"2026-02-09T18:56:53.65102Z","steps":["trace[1246796721] 'process raft request' (duration: 318.978258ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:56:53.65111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:56:53.331696Z","time spent":"319.373865ms","remote":"127.0.0.1:37274","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-02-09T18:56:53.651179Z","caller":"traceutil/trace.go:171","msg":"trace[1848190255] transaction","detail":"{read_only:false; response_revision:885; number_of_response:1; }","duration":"319.414336ms","start":"2026-02-09T18:56:53.331758Z","end":"2026-02-09T18:56:53.651173Z","steps":["trace[1848190255] 'process raft request' (duration: 319.016648ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:56:53.651218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:56:53.331755Z","time spent":"319.449107ms","remote":"127.0.0.1:37274","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-09T18:56:53.651277Z","caller":"traceutil/trace.go:171","msg":"trace[2002352388] transaction","detail":"{read_only:false; response_revision:886; number_of_response:1; }","duration":"319.490818ms","start":"2026-02-09T18:56:53.331782Z","end":"2026-02-09T18:56:53.651272Z","steps":["trace[2002352388] 'process raft request' (duration: 319.011339ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:56:53.651303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:56:53.331779Z","time spent":"319.512949ms","remote":"127.0.0.1:37274","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-09T18:56:53.651374Z","caller":"traceutil/trace.go:171","msg":"trace[1754973179] transaction","detail":"{read_only:false; response_revision:887; number_of_response:1; }","duration":"311.984995ms","start":"2026-02-09T18:56:53.339385Z","end":"2026-02-09T18:56:53.65137Z","steps":["trace[1754973179] 'process raft request' (duration: 311.423154ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:56:53.6514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:56:53.339375Z","time spent":"312.013136ms","remote":"127.0.0.1:37274","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-09T18:56:54.076187Z","caller":"traceutil/trace.go:171","msg":"trace[1308158613] transaction","detail":"{read_only:false; response_revision:888; number_of_response:1; }","duration":"106.878573ms","start":"2026-02-09T18:56:53.969289Z","end":"2026-02-09T18:56:54.076168Z","steps":["trace[1308158613] 'process raft request' (duration: 106.72552ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T18:56:55.509555Z","caller":"traceutil/trace.go:171","msg":"trace[2117879574] transaction","detail":"{read_only:false; response_revision:889; number_of_response:1; }","duration":"101.717608ms","start":"2026-02-09T18:56:55.407817Z","end":"2026-02-09T18:56:55.509535Z","steps":["trace[2117879574] 'process raft request' (duration: 101.611316ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:56:55.7698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.317754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-02-09T18:56:55.770181Z","caller":"traceutil/trace.go:171","msg":"trace[279111660] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:889; }","duration":"113.741703ms","start":"2026-02-09T18:56:55.656419Z","end":"2026-02-09T18:56:55.77016Z","steps":["trace[279111660] 'range keys from in-memory index tree' (duration: 113.071899ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:56:55.770425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.438637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-02-09T18:56:55.770527Z","caller":"traceutil/trace.go:171","msg":"trace[1303319264] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:889; }","duration":"112.597701ms","start":"2026-02-09T18:56:55.657909Z","end":"2026-02-09T18:56:55.770507Z","steps":["trace[1303319264] 'range keys from in-memory index tree' (duration: 112.212392ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:56:55.77094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.001909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-02-09T18:56:55.771044Z","caller":"traceutil/trace.go:171","msg":"trace[1387184475] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:889; }","duration":"115.124151ms","start":"2026-02-09T18:56:55.655908Z","end":"2026-02-09T18:56:55.771032Z","steps":["trace[1387184475] 'range keys from in-memory index tree' (duration: 114.699453ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:56:55.77492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.0565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-09T18:56:55.775105Z","caller":"traceutil/trace.go:171","msg":"trace[2039833176] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:889; }","duration":"119.272695ms","start":"2026-02-09T18:56:55.655812Z","end":"2026-02-09T18:56:55.775085Z","steps":["trace[2039833176] 'range keys from in-memory index tree' (duration: 115.236774ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T18:56:55.932951Z","caller":"traceutil/trace.go:171","msg":"trace[660670937] transaction","detail":"{read_only:false; response_revision:890; number_of_response:1; }","duration":"152.532833ms","start":"2026-02-09T18:56:55.7804Z","end":"2026-02-09T18:56:55.932933Z","steps":["trace[660670937] 'process raft request' (duration: 150.94024ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T18:56:55.968392Z","caller":"traceutil/trace.go:171","msg":"trace[1486553505] transaction","detail":"{read_only:false; response_revision:891; number_of_response:1; }","duration":"187.780409ms","start":"2026-02-09T18:56:55.780601Z","end":"2026-02-09T18:56:55.968381Z","steps":["trace[1486553505] 'process raft request' (duration: 187.530114ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T18:56:55.968494Z","caller":"traceutil/trace.go:171","msg":"trace[1339071588] transaction","detail":"{read_only:false; response_revision:892; number_of_response:1; }","duration":"186.099164ms","start":"2026-02-09T18:56:55.782387Z","end":"2026-02-09T18:56:55.968487Z","steps":["trace[1339071588] 'process raft request' (duration: 185.805638ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T18:56:55.968515Z","caller":"traceutil/trace.go:171","msg":"trace[952599301] transaction","detail":"{read_only:false; response_revision:893; number_of_response:1; }","duration":"184.358069ms","start":"2026-02-09T18:56:55.784153Z","end":"2026-02-09T18:56:55.968511Z","steps":["trace[952599301] 'process raft request' (duration: 184.066724ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T18:57:03.903242Z","caller":"traceutil/trace.go:171","msg":"trace[1827659577] transaction","detail":"{read_only:false; response_revision:910; number_of_response:1; }","duration":"367.979824ms","start":"2026-02-09T18:57:03.535243Z","end":"2026-02-09T18:57:03.903223Z","steps":["trace[1827659577] 'process raft request' (duration: 367.849291ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:57:03.903357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:57:03.535235Z","time spent":"368.052156ms","remote":"127.0.0.1:37274","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-02-09T18:57:03.905277Z","caller":"traceutil/trace.go:171","msg":"trace[1647896268] transaction","detail":"{read_only:false; response_revision:911; number_of_response:1; }","duration":"369.908753ms","start":"2026-02-09T18:57:03.535358Z","end":"2026-02-09T18:57:03.905267Z","steps":["trace[1647896268] 'process raft request' (duration: 369.853202ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:57:03.905351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:57:03.535353Z","time spent":"369.946054ms","remote":"127.0.0.1:37274","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-09T18:57:05.593423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.418677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-09T18:57:05.593471Z","caller":"traceutil/trace.go:171","msg":"trace[1210781772] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:916; }","duration":"473.491739ms","start":"2026-02-09T18:57:05.119968Z","end":"2026-02-09T18:57:05.59346Z","steps":["trace[1210781772] 'range keys from in-memory index tree' (duration: 473.373727ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:57:05.593456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"823.297544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-09T18:57:05.593493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:57:05.119955Z","time spent":"473.53374ms","remote":"127.0.0.1:37004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-09T18:57:05.593505Z","caller":"traceutil/trace.go:171","msg":"trace[1002403470] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:916; }","duration":"823.381085ms","start":"2026-02-09T18:57:04.77011Z","end":"2026-02-09T18:57:05.593492Z","steps":["trace[1002403470] 'count revisions from in-memory index tree' (duration: 823.254982ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:57:05.593529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:57:04.770099Z","time spent":"823.424536ms","remote":"127.0.0.1:44464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true "} {"level":"warn","ts":"2026-02-09T18:57:05.593638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"787.72654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-02-09T18:57:05.593648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.26203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-09T18:57:05.593653Z","caller":"traceutil/trace.go:171","msg":"trace[1314226385] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:916; }","duration":"787.75095ms","start":"2026-02-09T18:57:04.805897Z","end":"2026-02-09T18:57:05.593648Z","steps":["trace[1314226385] 'count revisions from in-memory index tree' (duration: 787.705319ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T18:57:05.593665Z","caller":"traceutil/trace.go:171","msg":"trace[1987747091] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:916; }","duration":"312.30808ms","start":"2026-02-09T18:57:05.281352Z","end":"2026-02-09T18:57:05.59366Z","steps":["trace[1987747091] 'count revisions from in-memory index tree' (duration: 312.205299ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:57:05.593668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:57:04.805892Z","time spent":"787.77177ms","remote":"127.0.0.1:37522","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":23,"response size":30,"request content":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true "} {"level":"warn","ts":"2026-02-09T18:57:05.593679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:57:05.281334Z","time spent":"312.341152ms","remote":"127.0.0.1:37438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":3,"response size":30,"request content":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true "} {"level":"warn","ts":"2026-02-09T18:57:05.593754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"727.048095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-09T18:57:05.593769Z","caller":"traceutil/trace.go:171","msg":"trace[2065319854] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:916; }","duration":"727.071345ms","start":"2026-02-09T18:57:04.866692Z","end":"2026-02-09T18:57:05.593764Z","steps":["trace[2065319854] 'count revisions from in-memory index tree' (duration: 727.023695ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:57:05.593782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:57:04.866687Z","time spent":"727.091256ms","remote":"127.0.0.1:37086","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true "} {"level":"info","ts":"2026-02-09T18:57:06.143458Z","caller":"traceutil/trace.go:171","msg":"trace[782450241] linearizableReadLoop","detail":"{readStateIndex:959; appliedIndex:958; }","duration":"124.639244ms","start":"2026-02-09T18:57:06.018798Z","end":"2026-02-09T18:57:06.143437Z","steps":["trace[782450241] 'read index received' (duration: 69.247209ms)","trace[782450241] 'applied index is now lower than readState.Index' (duration: 55.391215ms)"],"step_count":2} {"level":"info","ts":"2026-02-09T18:57:06.143667Z","caller":"traceutil/trace.go:171","msg":"trace[140076007] transaction","detail":"{read_only:false; response_revision:919; number_of_response:1; }","duration":"145.652782ms","start":"2026-02-09T18:57:05.998005Z","end":"2026-02-09T18:57:06.143658Z","steps":["trace[140076007] 'process raft request' (duration: 90.030121ms)","trace[140076007] 'compare' (duration: 55.320905ms)"],"step_count":2} {"level":"warn","ts":"2026-02-09T18:57:06.143893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.080344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-02-09T18:57:06.143918Z","caller":"traceutil/trace.go:171","msg":"trace[493710382] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:919; }","duration":"125.137486ms","start":"2026-02-09T18:57:06.018774Z","end":"2026-02-09T18:57:06.143912Z","steps":["trace[493710382] 'agreement among raft nodes before linearized reading' (duration: 125.004252ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:57:06.144054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.193696ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-09T18:57:06.144074Z","caller":"traceutil/trace.go:171","msg":"trace[91050265] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:919; }","duration":"125.224967ms","start":"2026-02-09T18:57:06.018843Z","end":"2026-02-09T18:57:06.144068Z","steps":["trace[91050265] 'agreement among raft nodes before linearized reading' (duration: 125.162285ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:57:08.501059Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6432437982621706772,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-09T18:57:08.542538Z","caller":"traceutil/trace.go:171","msg":"trace[691246419] linearizableReadLoop","detail":"{readStateIndex:962; appliedIndex:961; }","duration":"541.757128ms","start":"2026-02-09T18:57:08.000767Z","end":"2026-02-09T18:57:08.542524Z","steps":["trace[691246419] 'read index received' (duration: 541.627895ms)","trace[691246419] 'applied index is now lower than readState.Index' (duration: 128.713µs)"],"step_count":2} {"level":"info","ts":"2026-02-09T18:57:08.54274Z","caller":"traceutil/trace.go:171","msg":"trace[380379691] transaction","detail":"{read_only:false; response_revision:922; number_of_response:1; }","duration":"547.887183ms","start":"2026-02-09T18:57:07.994848Z","end":"2026-02-09T18:57:08.542735Z","steps":["trace[380379691] 'process raft request' (duration: 547.587677ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:57:08.542797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:57:07.994836Z","time spent":"547.919304ms","remote":"127.0.0.1:37274","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-09T18:57:08.542927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.566704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-02-09T18:57:08.542981Z","caller":"traceutil/trace.go:171","msg":"trace[2066859463] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:922; }","duration":"393.679867ms","start":"2026-02-09T18:57:08.149288Z","end":"2026-02-09T18:57:08.542968Z","steps":["trace[2066859463] 'agreement among raft nodes before linearized reading' (duration: 393.506893ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:57:08.543011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:57:08.149276Z","time spent":"393.729048ms","remote":"127.0.0.1:37274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-09T18:57:08.543065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"542.295029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-09T18:57:08.543085Z","caller":"traceutil/trace.go:171","msg":"trace[67549417] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:922; }","duration":"542.32411ms","start":"2026-02-09T18:57:08.000754Z","end":"2026-02-09T18:57:08.543078Z","steps":["trace[67549417] 'agreement among raft nodes before linearized reading' (duration: 542.247078ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:57:08.5431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:57:08.000749Z","time spent":"542.34898ms","remote":"127.0.0.1:37274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-09T18:57:08.543213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.345202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-09T18:57:08.543228Z","caller":"traceutil/trace.go:171","msg":"trace[237339362] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:922; }","duration":"340.384353ms","start":"2026-02-09T18:57:08.20284Z","end":"2026-02-09T18:57:08.543224Z","steps":["trace[237339362] 'agreement among raft nodes before linearized reading' (duration: 340.343882ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:57:08.54324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:57:08.202829Z","time spent":"340.408113ms","remote":"127.0.0.1:37274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-09T18:57:08.543291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.316329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-02-09T18:57:08.543304Z","caller":"traceutil/trace.go:171","msg":"trace[1151341958] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:922; }","duration":"335.33957ms","start":"2026-02-09T18:57:08.207959Z","end":"2026-02-09T18:57:08.543299Z","steps":["trace[1151341958] 'agreement among raft nodes before linearized reading' (duration: 335.30766ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:57:08.543315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:57:08.207953Z","time spent":"335.359331ms","remote":"127.0.0.1:37274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-02-09T18:57:09.167048Z","caller":"traceutil/trace.go:171","msg":"trace[107838963] transaction","detail":"{read_only:false; response_revision:923; number_of_response:1; }","duration":"620.482009ms","start":"2026-02-09T18:57:08.546538Z","end":"2026-02-09T18:57:09.16702Z","steps":["trace[107838963] 'process raft request' (duration: 620.386547ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:57:09.16715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:57:08.546521Z","time spent":"620.578221ms","remote":"127.0.0.1:37274","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-09T18:57:09.951997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.066578ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-09T18:57:09.952175Z","caller":"traceutil/trace.go:171","msg":"trace[1905192351] linearizableReadLoop","detail":"{readStateIndex:966; appliedIndex:963; }","duration":"828.515158ms","start":"2026-02-09T18:57:09.123649Z","end":"2026-02-09T18:57:09.952164Z","steps":["trace[1905192351] 'read index received' (duration: 43.375175ms)","trace[1905192351] 'applied index is now lower than readState.Index' (duration: 785.139313ms)"],"step_count":2} {"level":"info","ts":"2026-02-09T18:57:09.952188Z","caller":"traceutil/trace.go:171","msg":"trace[382552723] transaction","detail":"{read_only:false; response_revision:924; number_of_response:1; }","duration":"1.402941768s","start":"2026-02-09T18:57:08.549216Z","end":"2026-02-09T18:57:09.952158Z","steps":["trace[382552723] 'process raft request' (duration: 1.137657406s)","trace[382552723] 'compare' (duration: 264.858983ms)"],"step_count":2} {"level":"warn","ts":"2026-02-09T18:57:09.952312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:57:08.549206Z","time spent":"1.40303816s","remote":"127.0.0.1:37274","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-09T18:57:09.952335Z","caller":"traceutil/trace.go:171","msg":"trace[1451750285] transaction","detail":"{read_only:false; response_revision:925; number_of_response:1; }","duration":"1.402026558s","start":"2026-02-09T18:57:08.550301Z","end":"2026-02-09T18:57:09.952327Z","steps":["trace[1451750285] 'process raft request' (duration: 1.401767623s)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:57:09.952377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:57:08.550287Z","time spent":"1.402068719s","remote":"127.0.0.1:37274","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-09T18:57:09.952477Z","caller":"traceutil/trace.go:171","msg":"trace[866467552] transaction","detail":"{read_only:false; response_revision:926; number_of_response:1; }","duration":"1.401491467s","start":"2026-02-09T18:57:08.550975Z","end":"2026-02-09T18:57:09.952467Z","steps":["trace[866467552] 'process raft request' (duration: 1.401161871s)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:57:09.952522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:57:08.550967Z","time spent":"1.401526858s","remote":"127.0.0.1:37274","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-02-09T18:57:09.952663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"829.018658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-09T18:57:09.9527Z","caller":"traceutil/trace.go:171","msg":"trace[1171014520] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:926; }","duration":"829.054419ms","start":"2026-02-09T18:57:09.123635Z","end":"2026-02-09T18:57:09.952689Z","steps":["trace[1171014520] 'agreement among raft nodes before linearized reading' (duration: 828.995448ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:57:09.952728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:57:09.123578Z","time spent":"829.144381ms","remote":"127.0.0.1:37004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-09T18:57:11.367544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.906668ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-09T18:57:11.367663Z","caller":"traceutil/trace.go:171","msg":"trace[174094215] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:926; }","duration":"445.03661ms","start":"2026-02-09T18:57:10.922609Z","end":"2026-02-09T18:57:11.367646Z","steps":["trace[174094215] 'range keys from in-memory index tree' (duration: 444.891277ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:57:11.368012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.761193ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-09T18:57:11.368702Z","caller":"traceutil/trace.go:171","msg":"trace[342885946] linearizableReadLoop","detail":"{readStateIndex:969; appliedIndex:967; }","duration":"497.078276ms","start":"2026-02-09T18:57:10.8716Z","end":"2026-02-09T18:57:11.368678Z","steps":["trace[342885946] 'read index received' (duration: 89.608609ms)","trace[342885946] 'applied index is now lower than readState.Index' (duration: 407.468297ms)"],"step_count":2} {"level":"info","ts":"2026-02-09T18:57:11.368933Z","caller":"traceutil/trace.go:171","msg":"trace[564668591] transaction","detail":"{read_only:false; response_revision:927; number_of_response:1; }","duration":"815.908185ms","start":"2026-02-09T18:57:10.55301Z","end":"2026-02-09T18:57:11.368918Z","steps":["trace[564668591] 'process raft request' (duration: 408.188103ms)","trace[564668591] 'compare' (duration: 406.66358ms)"],"step_count":2} {"level":"warn","ts":"2026-02-09T18:57:11.369981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:57:10.552992Z","time spent":"816.853954ms","remote":"127.0.0.1:37274","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-09T18:57:11.369216Z","caller":"traceutil/trace.go:171","msg":"trace[1866061440] transaction","detail":"{read_only:false; response_revision:928; number_of_response:1; }","duration":"611.473851ms","start":"2026-02-09T18:57:10.757733Z","end":"2026-02-09T18:57:11.369207Z","steps":["trace[1866061440] 'process raft request' (duration: 610.342857ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:57:11.373843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:57:10.757714Z","time spent":"615.830551ms","remote":"127.0.0.1:37046","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-09T18:57:11.369401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"497.794381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-09T18:57:11.374616Z","caller":"traceutil/trace.go:171","msg":"trace[2004737971] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:928; }","duration":"502.782225ms","start":"2026-02-09T18:57:10.871545Z","end":"2026-02-09T18:57:11.374327Z","steps":["trace[2004737971] 'agreement among raft nodes before linearized reading' (duration: 497.74615ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:57:11.374731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:57:10.871503Z","time spent":"503.169643ms","remote":"127.0.0.1:37302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true "} {"level":"warn","ts":"2026-02-09T18:57:11.369683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.610835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-09T18:57:11.37532Z","caller":"traceutil/trace.go:171","msg":"trace[1279664781] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:928; }","duration":"254.240542ms","start":"2026-02-09T18:57:11.121033Z","end":"2026-02-09T18:57:11.375273Z","steps":["trace[1279664781] 'agreement among raft nodes before linearized reading' (duration: 248.597394ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:57:11.369785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.992099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-02-09T18:57:11.3767Z","caller":"traceutil/trace.go:171","msg":"trace[1419652769] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:928; }","duration":"204.896603ms","start":"2026-02-09T18:57:11.171748Z","end":"2026-02-09T18:57:11.376644Z","steps":["trace[1419652769] 'agreement among raft nodes before linearized reading' (duration: 197.955688ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T18:57:11.539317Z","caller":"traceutil/trace.go:171","msg":"trace[1467710575] linearizableReadLoop","detail":"{readStateIndex:970; appliedIndex:969; }","duration":"156.543655ms","start":"2026-02-09T18:57:11.38275Z","end":"2026-02-09T18:57:11.539294Z","steps":["trace[1467710575] 'read index received' (duration: 88.058996ms)","trace[1467710575] 'applied index is now lower than readState.Index' (duration: 68.483689ms)"],"step_count":2} {"level":"warn","ts":"2026-02-09T18:57:11.539449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.679877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"info","ts":"2026-02-09T18:57:11.539479Z","caller":"traceutil/trace.go:171","msg":"trace[80561703] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:929; }","duration":"156.724878ms","start":"2026-02-09T18:57:11.382746Z","end":"2026-02-09T18:57:11.53947Z","steps":["trace[80561703] 'agreement among raft nodes before linearized reading' (duration: 156.630076ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T18:57:11.539767Z","caller":"traceutil/trace.go:171","msg":"trace[1164941108] transaction","detail":"{read_only:false; response_revision:929; number_of_response:1; }","duration":"157.495505ms","start":"2026-02-09T18:57:11.382259Z","end":"2026-02-09T18:57:11.539754Z","steps":["trace[1164941108] 'process raft request' (duration: 88.593608ms)","trace[1164941108] 'compare' (duration: 68.356585ms)"],"step_count":2} {"level":"warn","ts":"2026-02-09T18:57:13.491143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.615835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-09T18:57:13.49119Z","caller":"traceutil/trace.go:171","msg":"trace[502824877] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:944; }","duration":"108.715298ms","start":"2026-02-09T18:57:13.382464Z","end":"2026-02-09T18:57:13.491179Z","steps":["trace[502824877] 'range keys from in-memory index tree' (duration: 108.491163ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T18:57:13.608468Z","caller":"traceutil/trace.go:171","msg":"trace[1436452096] transaction","detail":"{read_only:false; response_revision:945; number_of_response:1; }","duration":"113.819164ms","start":"2026-02-09T18:57:13.494635Z","end":"2026-02-09T18:57:13.608454Z","steps":["trace[1436452096] 'process raft request' (duration: 113.512557ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:57:14.599745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"631.0735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-09T18:57:14.599805Z","caller":"traceutil/trace.go:171","msg":"trace[2103951817] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:946; }","duration":"631.168031ms","start":"2026-02-09T18:57:13.968623Z","end":"2026-02-09T18:57:14.599791Z","steps":["trace[2103951817] 'range keys from in-memory index tree' (duration: 630.951907ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:57:14.599829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:57:13.968613Z","time spent":"631.211253ms","remote":"127.0.0.1:37274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-09T18:57:14.599926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"630.017619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-09T18:57:14.600013Z","caller":"traceutil/trace.go:171","msg":"trace[1506287370] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:946; }","duration":"630.132261ms","start":"2026-02-09T18:57:13.969863Z","end":"2026-02-09T18:57:14.599995Z","steps":["trace[1506287370] 'range keys from in-memory index tree' (duration: 629.855625ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:57:14.600052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:57:13.969854Z","time spent":"630.189401ms","remote":"127.0.0.1:37274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-09T18:57:14.600244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"477.572378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-09T18:57:14.600275Z","caller":"traceutil/trace.go:171","msg":"trace[796731452] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:946; }","duration":"477.63638ms","start":"2026-02-09T18:57:14.122628Z","end":"2026-02-09T18:57:14.600265Z","steps":["trace[796731452] 'range keys from in-memory index tree' (duration: 477.504097ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:57:14.600315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"635.452121ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-02-09T18:57:14.600325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:57:14.122607Z","time spent":"477.710971ms","remote":"127.0.0.1:37004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-09T18:57:14.600338Z","caller":"traceutil/trace.go:171","msg":"trace[1590211735] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:946; }","duration":"635.516312ms","start":"2026-02-09T18:57:13.964813Z","end":"2026-02-09T18:57:14.60033Z","steps":["trace[1590211735] 'range keys from in-memory index tree' (duration: 635.366009ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:57:14.600357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:57:13.964796Z","time spent":"635.556114ms","remote":"127.0.0.1:37274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-02-09T18:57:14.703214Z","caller":"traceutil/trace.go:171","msg":"trace[905006913] transaction","detail":"{read_only:false; response_revision:947; number_of_response:1; }","duration":"496.145986ms","start":"2026-02-09T18:57:14.207051Z","end":"2026-02-09T18:57:14.703197Z","steps":["trace[905006913] 'process raft request' (duration: 496.025114ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:57:14.703336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:57:14.20703Z","time spent":"496.245669ms","remote":"127.0.0.1:37274","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-09T18:57:15.47094Z","caller":"traceutil/trace.go:171","msg":"trace[1052552836] transaction","detail":"{read_only:false; response_revision:950; number_of_response:1; }","duration":"860.223189ms","start":"2026-02-09T18:57:14.610703Z","end":"2026-02-09T18:57:15.470926Z","steps":["trace[1052552836] 'process raft request' (duration: 860.199199ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:57:15.471046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:57:14.610692Z","time spent":"860.295ms","remote":"127.0.0.1:37274","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-02-09T18:57:15.471252Z","caller":"traceutil/trace.go:171","msg":"trace[1359121777] transaction","detail":"{read_only:false; response_revision:948; number_of_response:1; }","duration":"862.596858ms","start":"2026-02-09T18:57:14.608645Z","end":"2026-02-09T18:57:15.471242Z","steps":["trace[1359121777] 'process raft request' (duration: 813.637358ms)","trace[1359121777] 'compare' (duration: 48.249516ms)"],"step_count":2} {"level":"warn","ts":"2026-02-09T18:57:15.471287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:57:14.608628Z","time spent":"862.639819ms","remote":"127.0.0.1:37274","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-09T18:57:15.47135Z","caller":"traceutil/trace.go:171","msg":"trace[1448909816] transaction","detail":"{read_only:false; response_revision:949; number_of_response:1; }","duration":"861.522596ms","start":"2026-02-09T18:57:14.609823Z","end":"2026-02-09T18:57:15.471345Z","steps":["trace[1448909816] 'process raft request' (duration: 861.022405ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:57:15.4714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:57:14.609814Z","time spent":"861.566646ms","remote":"127.0.0.1:37274","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-02-09T18:57:15.475597Z","caller":"traceutil/trace.go:171","msg":"trace[1571257641] linearizableReadLoop","detail":"{readStateIndex:993; appliedIndex:988; }","duration":"352.160195ms","start":"2026-02-09T18:57:15.123429Z","end":"2026-02-09T18:57:15.475589Z","steps":["trace[1571257641] 'read index received' (duration: 298.865823ms)","trace[1571257641] 'applied index is now lower than readState.Index' (duration: 53.293682ms)"],"step_count":2} {"level":"warn","ts":"2026-02-09T18:57:15.47566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.218126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-09T18:57:15.475676Z","caller":"traceutil/trace.go:171","msg":"trace[211349031] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:952; }","duration":"352.287467ms","start":"2026-02-09T18:57:15.123384Z","end":"2026-02-09T18:57:15.475672Z","steps":["trace[211349031] 'agreement among raft nodes before linearized reading' (duration: 352.238356ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:57:15.475695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:57:15.123365Z","time spent":"352.325618ms","remote":"127.0.0.1:37004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-09T18:57:15.47588Z","caller":"traceutil/trace.go:171","msg":"trace[1667516859] transaction","detail":"{read_only:false; response_revision:951; number_of_response:1; }","duration":"666.102151ms","start":"2026-02-09T18:57:14.809772Z","end":"2026-02-09T18:57:15.475874Z","steps":["trace[1667516859] 'process raft request' (duration: 665.741144ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:57:15.475929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:57:14.809746Z","time spent":"666.152992ms","remote":"127.0.0.1:37274","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-02-09T18:57:15.47747Z","caller":"traceutil/trace.go:171","msg":"trace[312057715] transaction","detail":"{read_only:false; response_revision:952; number_of_response:1; }","duration":"654.786906ms","start":"2026-02-09T18:57:14.821487Z","end":"2026-02-09T18:57:15.476274Z","steps":["trace[312057715] 'process raft request' (duration: 654.076541ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:57:15.477618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:57:14.821459Z","time spent":"656.078522ms","remote":"127.0.0.1:37178","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5378,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-09T18:57:17.653714Z","caller":"traceutil/trace.go:171","msg":"trace[1824757168] transaction","detail":"{read_only:false; response_revision:960; number_of_response:1; }","duration":"118.202354ms","start":"2026-02-09T18:57:17.535493Z","end":"2026-02-09T18:57:17.653696Z","steps":["trace[1824757168] 'process raft request' (duration: 116.08071ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T18:57:17.655669Z","caller":"traceutil/trace.go:171","msg":"trace[1448742660] transaction","detail":"{read_only:false; response_revision:961; number_of_response:1; }","duration":"118.064322ms","start":"2026-02-09T18:57:17.537591Z","end":"2026-02-09T18:57:17.655656Z","steps":["trace[1448742660] 'process raft request' (duration: 117.949199ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:57:20.881682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.219917ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-09T18:57:20.881744Z","caller":"traceutil/trace.go:171","msg":"trace[2009030926] transaction","detail":"{read_only:false; response_revision:990; number_of_response:1; }","duration":"259.734265ms","start":"2026-02-09T18:57:20.622Z","end":"2026-02-09T18:57:20.881734Z","steps":["trace[2009030926] 'process raft request' (duration: 68.401606ms)","trace[2009030926] 'compare' (duration: 191.149796ms)"],"step_count":2} {"level":"warn","ts":"2026-02-09T18:57:21.402128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.118147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-09T18:57:21.402201Z","caller":"traceutil/trace.go:171","msg":"trace[1594875911] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:0; response_revision:990; }","duration":"310.220108ms","start":"2026-02-09T18:57:21.091967Z","end":"2026-02-09T18:57:21.402187Z","steps":["trace[1594875911] 'range keys from in-memory index tree' (duration: 310.071856ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:57:21.402224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:57:21.091953Z","time spent":"310.26552ms","remote":"127.0.0.1:37274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-02-09T18:57:21.402329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.575615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-09T18:57:21.402343Z","caller":"traceutil/trace.go:171","msg":"trace[1771664710] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:0; response_revision:990; }","duration":"239.610576ms","start":"2026-02-09T18:57:21.162727Z","end":"2026-02-09T18:57:21.402338Z","steps":["trace[1771664710] 'range keys from in-memory index tree' (duration: 239.529895ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:57:21.402447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.710483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/ceph-csi-rbd-provisioner-5d8ff44fc9-wqrqf\" ","response":"range_response_count:1 size:11610"} {"level":"info","ts":"2026-02-09T18:57:21.402459Z","caller":"traceutil/trace.go:171","msg":"trace[1664064341] range","detail":"{range_begin:/registry/pods/kube-system/ceph-csi-rbd-provisioner-5d8ff44fc9-wqrqf; range_end:; response_count:1; response_revision:990; }","duration":"232.737964ms","start":"2026-02-09T18:57:21.169717Z","end":"2026-02-09T18:57:21.402455Z","steps":["trace[1664064341] 'range keys from in-memory index tree' (duration: 232.636042ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:57:21.402527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.380293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-09T18:57:21.402538Z","caller":"traceutil/trace.go:171","msg":"trace[1214892653] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:990; }","duration":"195.422685ms","start":"2026-02-09T18:57:21.207112Z","end":"2026-02-09T18:57:21.402534Z","steps":["trace[1214892653] 'range keys from in-memory index tree' (duration: 195.324692ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T18:57:21.544493Z","caller":"traceutil/trace.go:171","msg":"trace[248913927] transaction","detail":"{read_only:false; response_revision:991; number_of_response:1; }","duration":"130.040081ms","start":"2026-02-09T18:57:21.414436Z","end":"2026-02-09T18:57:21.544476Z","steps":["trace[248913927] 'process raft request' (duration: 129.896768ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T18:57:21.838604Z","caller":"traceutil/trace.go:171","msg":"trace[2125671475] linearizableReadLoop","detail":"{readStateIndex:1036; appliedIndex:1034; }","duration":"396.54935ms","start":"2026-02-09T18:57:21.442039Z","end":"2026-02-09T18:57:21.838588Z","steps":["trace[2125671475] 'read index received' (duration: 102.943517ms)","trace[2125671475] 'applied index is now lower than readState.Index' (duration: 293.605173ms)"],"step_count":2} {"level":"info","ts":"2026-02-09T18:57:21.838745Z","caller":"traceutil/trace.go:171","msg":"trace[938070239] transaction","detail":"{read_only:false; response_revision:992; number_of_response:1; }","duration":"417.502286ms","start":"2026-02-09T18:57:21.421237Z","end":"2026-02-09T18:57:21.83874Z","steps":["trace[938070239] 'process raft request' (duration: 417.21034ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:57:21.838799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:57:21.421219Z","time spent":"417.546157ms","remote":"127.0.0.1:37274","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":493,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-09T18:57:21.839163Z","caller":"traceutil/trace.go:171","msg":"trace[1037597845] transaction","detail":"{read_only:false; response_revision:993; number_of_response:1; }","duration":"417.539908ms","start":"2026-02-09T18:57:21.421618Z","end":"2026-02-09T18:57:21.839158Z","steps":["trace[1037597845] 'process raft request' (duration: 416.905435ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:57:21.839195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:57:21.421612Z","time spent":"417.561408ms","remote":"127.0.0.1:37188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12527,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-09T18:57:21.839248Z","caller":"traceutil/trace.go:171","msg":"trace[1892225092] transaction","detail":"{read_only:false; response_revision:994; number_of_response:1; }","duration":"319.450811ms","start":"2026-02-09T18:57:21.519794Z","end":"2026-02-09T18:57:21.839245Z","steps":["trace[1892225092] 'process raft request' (duration: 318.776897ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:57:21.839276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:57:21.519777Z","time spent":"319.488513ms","remote":"127.0.0.1:37274","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-09T18:57:21.839361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.319396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-09T18:57:21.839378Z","caller":"traceutil/trace.go:171","msg":"trace[110949423] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:0; response_revision:994; }","duration":"397.358046ms","start":"2026-02-09T18:57:21.442014Z","end":"2026-02-09T18:57:21.839372Z","steps":["trace[110949423] 'agreement among raft nodes before linearized reading' (duration: 397.329695ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:57:21.839392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:57:21.442002Z","time spent":"397.386907ms","remote":"127.0.0.1:37274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-02-09T18:57:21.843074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.039477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-09T18:57:21.843096Z","caller":"traceutil/trace.go:171","msg":"trace[484098680] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:995; }","duration":"300.090347ms","start":"2026-02-09T18:57:21.543Z","end":"2026-02-09T18:57:21.84309Z","steps":["trace[484098680] 'agreement among raft nodes before linearized reading' (duration: 300.007435ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:57:21.843111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:57:21.542988Z","time spent":"300.120069ms","remote":"127.0.0.1:37274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-09T18:57:21.843182Z","caller":"traceutil/trace.go:171","msg":"trace[386799523] transaction","detail":"{read_only:false; response_revision:995; number_of_response:1; }","duration":"287.7241ms","start":"2026-02-09T18:57:21.555453Z","end":"2026-02-09T18:57:21.843178Z","steps":["trace[386799523] 'process raft request' (duration: 287.515896ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:57:21.84327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.778201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-09T18:57:21.843282Z","caller":"traceutil/trace.go:171","msg":"trace[2086427492] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:995; }","duration":"158.806862ms","start":"2026-02-09T18:57:21.684471Z","end":"2026-02-09T18:57:21.843278Z","steps":["trace[2086427492] 'agreement among raft nodes before linearized reading' (duration: 158.769261ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:57:21.84335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.113523ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-02-09T18:57:21.843362Z","caller":"traceutil/trace.go:171","msg":"trace[2052688370] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:995; }","duration":"165.142214ms","start":"2026-02-09T18:57:21.678216Z","end":"2026-02-09T18:57:21.843358Z","steps":["trace[2052688370] 'agreement among raft nodes before linearized reading' (duration: 165.110203ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:57:21.843437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.385992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-09T18:57:21.843462Z","caller":"traceutil/trace.go:171","msg":"trace[1975620704] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:995; }","duration":"169.420623ms","start":"2026-02-09T18:57:21.674025Z","end":"2026-02-09T18:57:21.843445Z","steps":["trace[1975620704] 'agreement among raft nodes before linearized reading' (duration: 169.384083ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:57:21.84354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.320899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-09T18:57:21.843552Z","caller":"traceutil/trace.go:171","msg":"trace[1732696684] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:995; }","duration":"179.35761ms","start":"2026-02-09T18:57:21.664191Z","end":"2026-02-09T18:57:21.843548Z","steps":["trace[1732696684] 'agreement among raft nodes before linearized reading' (duration: 179.324959ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:57:21.843622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.183816ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:527"} {"level":"info","ts":"2026-02-09T18:57:21.843634Z","caller":"traceutil/trace.go:171","msg":"trace[1181261183] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:995; }","duration":"295.216896ms","start":"2026-02-09T18:57:21.548413Z","end":"2026-02-09T18:57:21.84363Z","steps":["trace[1181261183] 'agreement among raft nodes before linearized reading' (duration: 295.180555ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T18:57:29.067348Z","caller":"traceutil/trace.go:171","msg":"trace[1297889147] transaction","detail":"{read_only:false; response_revision:1040; number_of_response:1; }","duration":"646.302307ms","start":"2026-02-09T18:57:28.42102Z","end":"2026-02-09T18:57:29.067322Z","steps":["trace[1297889147] 'process raft request' (duration: 646.158564ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:57:29.067497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:57:28.421006Z","time spent":"646.4134ms","remote":"127.0.0.1:37104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":606,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-09T18:57:29.495003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.957967ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-09T18:57:29.495074Z","caller":"traceutil/trace.go:171","msg":"trace[161637572] linearizableReadLoop","detail":"{readStateIndex:1085; appliedIndex:1084; }","duration":"337.856215ms","start":"2026-02-09T18:57:29.157209Z","end":"2026-02-09T18:57:29.495065Z","steps":["trace[161637572] 'read index received' (duration: 31.061µs)","trace[161637572] 'applied index is now lower than readState.Index' (duration: 337.824434ms)"],"step_count":2} {"level":"info","ts":"2026-02-09T18:57:29.495126Z","caller":"traceutil/trace.go:171","msg":"trace[24791171] transaction","detail":"{read_only:false; response_revision:1041; number_of_response:1; }","duration":"403.596057ms","start":"2026-02-09T18:57:29.091525Z","end":"2026-02-09T18:57:29.495121Z","steps":["trace[24791171] 'process raft request' (duration: 30.027367ms)","trace[24791171] 'compare' (duration: 372.718513ms)"],"step_count":2} {"level":"warn","ts":"2026-02-09T18:57:29.495153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:57:29.091514Z","time spent":"403.624607ms","remote":"127.0.0.1:37274","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":514,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-09T18:57:29.495255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.047239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-09T18:57:29.495268Z","caller":"traceutil/trace.go:171","msg":"trace[615049785] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1041; }","duration":"338.08799ms","start":"2026-02-09T18:57:29.157175Z","end":"2026-02-09T18:57:29.495263Z","steps":["trace[615049785] 'agreement among raft nodes before linearized reading' (duration: 338.063489ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T18:57:29.49528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:57:29.157159Z","time spent":"338.11867ms","remote":"127.0.0.1:37004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-09T19:00:32.969003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.391553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-09T19:00:32.969599Z","caller":"traceutil/trace.go:171","msg":"trace[270759770] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1905; }","duration":"180.054119ms","start":"2026-02-09T19:00:32.789525Z","end":"2026-02-09T19:00:32.969579Z","steps":["trace[270759770] 'range keys from in-memory index tree' (duration: 179.23495ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T19:00:33.169665Z","caller":"traceutil/trace.go:171","msg":"trace[1568343717] transaction","detail":"{read_only:false; response_revision:1906; number_of_response:1; }","duration":"194.508139ms","start":"2026-02-09T19:00:32.975138Z","end":"2026-02-09T19:00:33.169647Z","steps":["trace[1568343717] 'process raft request' (duration: 194.381006ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T19:00:33.170677Z","caller":"traceutil/trace.go:171","msg":"trace[635844593] transaction","detail":"{read_only:false; response_revision:1907; number_of_response:1; }","duration":"194.447459ms","start":"2026-02-09T19:00:32.976211Z","end":"2026-02-09T19:00:33.170658Z","steps":["trace[635844593] 'process raft request' (duration: 194.142382ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T19:00:33.171063Z","caller":"traceutil/trace.go:171","msg":"trace[118655498] transaction","detail":"{read_only:false; response_revision:1908; number_of_response:1; }","duration":"193.677952ms","start":"2026-02-09T19:00:32.977375Z","end":"2026-02-09T19:00:33.171053Z","steps":["trace[118655498] 'process raft request' (duration: 193.075959ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T19:00:33.171257Z","caller":"traceutil/trace.go:171","msg":"trace[2003689817] transaction","detail":"{read_only:false; response_revision:1909; number_of_response:1; }","duration":"192.738853ms","start":"2026-02-09T19:00:32.978511Z","end":"2026-02-09T19:00:33.17125Z","steps":["trace[2003689817] 'process raft request' (duration: 191.989047ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T19:00:36.923917Z","caller":"traceutil/trace.go:171","msg":"trace[1316340393] transaction","detail":"{read_only:false; response_revision:1919; number_of_response:1; }","duration":"153.721486ms","start":"2026-02-09T19:00:36.770172Z","end":"2026-02-09T19:00:36.923893Z","steps":["trace[1316340393] 'process raft request' (duration: 153.536082ms)"],"step_count":1}