{"level":"warn","ts":"2026-02-26T21:49:53.233863Z","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-26T21:49:53.233983Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.244: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.244:2380","--initial-cluster=instance=https://199.204.45.244:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.244:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.244: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-26T21:49:53.234076Z","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-26T21:49:53.23409Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.244:2380"]} {"level":"info","ts":"2026-02-26T21:49:53.234122Z","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-26T21:49:53.235201Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.244:2379"]} {"level":"info","ts":"2026-02-26T21:49:53.235311Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.244:2380"],"listen-peer-urls":["https://199.204.45.244:2380"],"advertise-client-urls":["https://199.204.45.244:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.244:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.244: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-26T21:49:53.257997Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"22.375172ms"} {"level":"info","ts":"2026-02-26T21:49:53.419867Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1686e9b1ea717edf","cluster-id":"71c60fe001ca5b3c"} {"level":"info","ts":"2026-02-26T21:49:53.420022Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf switched to configuration voters=()"} {"level":"info","ts":"2026-02-26T21:49:53.420076Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became follower at term 0"} {"level":"info","ts":"2026-02-26T21:49:53.420136Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1686e9b1ea717edf [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-26T21:49:53.420158Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became follower at term 1"} {"level":"info","ts":"2026-02-26T21:49:53.420215Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf switched to configuration voters=(1623241666065432287)"} {"level":"warn","ts":"2026-02-26T21:49:53.448856Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-26T21:49:53.452621Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-26T21:49:53.461487Z","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-26T21:49:53.468333Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1686e9b1ea717edf","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-26T21:49:53.468637Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1686e9b1ea717edf","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-26T21:49:53.468788Z","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-26T21:49:53.468906Z","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-26T21:49:53.468927Z","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-26T21:49:53.472402Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf switched to configuration voters=(1623241666065432287)"} {"level":"info","ts":"2026-02-26T21:49:53.472534Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"71c60fe001ca5b3c","local-member-id":"1686e9b1ea717edf","added-peer-id":"1686e9b1ea717edf","added-peer-peer-urls":["https://199.204.45.244:2380"]} {"level":"info","ts":"2026-02-26T21:49:53.474004Z","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-26T21:49:53.474154Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.244:2380"} {"level":"info","ts":"2026-02-26T21:49:53.474181Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.244:2380"} {"level":"info","ts":"2026-02-26T21:49:53.475051Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1686e9b1ea717edf","initial-advertise-peer-urls":["https://199.204.45.244:2380"],"listen-peer-urls":["https://199.204.45.244:2380"],"advertise-client-urls":["https://199.204.45.244:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.244:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-26T21:49:53.475102Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-26T21:49:54.42142Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf is starting a new election at term 1"} {"level":"info","ts":"2026-02-26T21:49:54.421493Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became pre-candidate at term 1"} {"level":"info","ts":"2026-02-26T21:49:54.421532Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf received MsgPreVoteResp from 1686e9b1ea717edf at term 1"} {"level":"info","ts":"2026-02-26T21:49:54.421553Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became candidate at term 2"} {"level":"info","ts":"2026-02-26T21:49:54.421565Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf received MsgVoteResp from 1686e9b1ea717edf at term 2"} {"level":"info","ts":"2026-02-26T21:49:54.421581Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became leader at term 2"} {"level":"info","ts":"2026-02-26T21:49:54.421602Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1686e9b1ea717edf elected leader 1686e9b1ea717edf at term 2"} {"level":"info","ts":"2026-02-26T21:49:54.503907Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-26T21:49:54.684879Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-26T21:49:54.684969Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-26T21:49:54.68524Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-26T21:49:54.685318Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-26T21:49:54.684865Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1686e9b1ea717edf","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.244:2379]}","request-path":"/0/members/1686e9b1ea717edf/attributes","cluster-id":"71c60fe001ca5b3c","publish-timeout":"7s"} {"level":"info","ts":"2026-02-26T21:49:54.688837Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-26T21:49:54.69223Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.244:2379"} {"level":"info","ts":"2026-02-26T21:49:54.779924Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"71c60fe001ca5b3c","local-member-id":"1686e9b1ea717edf","cluster-version":"3.5"} {"level":"info","ts":"2026-02-26T21:49:54.780068Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-26T21:49:54.780158Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-26T21:49:56.16675Z","caller":"traceutil/trace.go:171","msg":"trace[2145034947] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"109.580613ms","start":"2026-02-26T21:49:56.057129Z","end":"2026-02-26T21:49:56.16671Z","steps":["trace[2145034947] 'process raft request' (duration: 69.97899ms)","trace[2145034947] 'compare' (duration: 39.394121ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T21:49:56.709372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.364046ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-02-26T21:49:56.710062Z","caller":"traceutil/trace.go:171","msg":"trace[521254635] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"529.549596ms","start":"2026-02-26T21:49:56.18047Z","end":"2026-02-26T21:49:56.71002Z","steps":["trace[521254635] 'process raft request' (duration: 329.022342ms)","trace[521254635] 'compare' (duration: 199.223704ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T21:49:56.710196Z","caller":"traceutil/trace.go:171","msg":"trace[2015600669] linearizableReadLoop","detail":"{readStateIndex:14; appliedIndex:13; }","duration":"529.060502ms","start":"2026-02-26T21:49:56.181055Z","end":"2026-02-26T21:49:56.710116Z","steps":["trace[2015600669] 'read index received' (duration: 328.416778ms)","trace[2015600669] 'applied index is now lower than readState.Index' (duration: 200.640584ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T21:49:56.710306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:49:56.180446Z","time spent":"529.710017ms","remote":"127.0.0.1:54584","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":338,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-26T21:49:56.710589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"529.453855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-26T21:49:56.710663Z","caller":"traceutil/trace.go:171","msg":"trace[1278600138] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:13; }","duration":"529.599776ms","start":"2026-02-26T21:49:56.181051Z","end":"2026-02-26T21:49:56.710651Z","steps":["trace[1278600138] 'agreement among raft nodes before linearized reading' (duration: 529.326794ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:49:56.710716Z","caller":"traceutil/trace.go:171","msg":"trace[897360137] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"527.911223ms","start":"2026-02-26T21:49:56.182785Z","end":"2026-02-26T21:49:56.710696Z","steps":["trace[897360137] 'process raft request' (duration: 527.280199ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:49:56.710834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:49:56.18278Z","time spent":"528.011504ms","remote":"127.0.0.1:54976","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-26T21:49:56.710925Z","caller":"traceutil/trace.go:171","msg":"trace[1677695288] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"528.147485ms","start":"2026-02-26T21:49:56.182689Z","end":"2026-02-26T21:49:56.710837Z","steps":["trace[1677695288] 'process raft request' (duration: 527.288749ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:49:56.710733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:49:56.181011Z","time spent":"529.710847ms","remote":"127.0.0.1:54482","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-26T21:49:56.711112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:49:56.182677Z","time spent":"528.340127ms","remote":"127.0.0.1:55064","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-26T21:49:56.711354Z","caller":"traceutil/trace.go:171","msg":"trace[26991707] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"528.503878ms","start":"2026-02-26T21:49:56.182833Z","end":"2026-02-26T21:49:56.711337Z","steps":["trace[26991707] 'process raft request' (duration: 527.35983ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:49:56.711452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:49:56.182802Z","time spent":"528.589408ms","remote":"127.0.0.1:54922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":651,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-26T21:49:56.711461Z","caller":"traceutil/trace.go:171","msg":"trace[258621313] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"256.654834ms","start":"2026-02-26T21:49:56.454754Z","end":"2026-02-26T21:49:56.711409Z","steps":["trace[258621313] 'process raft request' (duration: 256.492753ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:49:56.711567Z","caller":"traceutil/trace.go:171","msg":"trace[2133870334] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"522.426244ms","start":"2026-02-26T21:49:56.188978Z","end":"2026-02-26T21:49:56.711404Z","steps":["trace[2133870334] 'process raft request' (duration: 522.180692ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:49:56.711802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.972546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-26T21:49:56.711883Z","caller":"traceutil/trace.go:171","msg":"trace[1840574259] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:20; }","duration":"377.079256ms","start":"2026-02-26T21:49:56.334761Z","end":"2026-02-26T21:49:56.71184Z","steps":["trace[1840574259] 'agreement among raft nodes before linearized reading' (duration: 376.893735ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:49:56.711909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.28657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-26T21:49:56.711928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:49:56.334741Z","time spent":"377.176467ms","remote":"127.0.0.1:54780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":26,"request content":"key:\"/registry/leases/kube-node-lease/instance\" "} {"level":"info","ts":"2026-02-26T21:49:56.711921Z","caller":"traceutil/trace.go:171","msg":"trace[447270055] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"528.456407ms","start":"2026-02-26T21:49:56.183432Z","end":"2026-02-26T21:49:56.711888Z","steps":["trace[447270055] 'process raft request' (duration: 527.55475ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:49:56.711984Z","caller":"traceutil/trace.go:171","msg":"trace[1303496918] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:20; }","duration":"453.407192ms","start":"2026-02-26T21:49:56.258536Z","end":"2026-02-26T21:49:56.711943Z","steps":["trace[1303496918] 'agreement among raft nodes before linearized reading' (duration: 453.299881ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:49:56.711974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:49:56.188965Z","time spent":"522.649737ms","remote":"127.0.0.1:54664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3479,"response count":0,"response size":36,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T21:49:56.712051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:49:56.258518Z","time spent":"453.521872ms","remote":"127.0.0.1:54780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":0,"response size":26,"request content":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" "} {"level":"info","ts":"2026-02-26T21:49:56.71198Z","caller":"traceutil/trace.go:171","msg":"trace[120007826] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"527.992585ms","start":"2026-02-26T21:49:56.183972Z","end":"2026-02-26T21:49:56.711964Z","steps":["trace[120007826] 'process raft request' (duration: 527.091408ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:49:56.7122Z","caller":"traceutil/trace.go:171","msg":"trace[855089434] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"529.234973ms","start":"2026-02-26T21:49:56.182928Z","end":"2026-02-26T21:49:56.712163Z","steps":["trace[855089434] 'process raft request' (duration: 527.898233ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:49:56.712198Z","caller":"traceutil/trace.go:171","msg":"trace[881364621] transaction","detail":"{read_only:false; number_of_response:0; response_revision:15; }","duration":"529.025651ms","start":"2026-02-26T21:49:56.183162Z","end":"2026-02-26T21:49:56.712187Z","steps":["trace[881364621] 'process raft request' (duration: 527.792022ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:49:56.712296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:49:56.183142Z","time spent":"529.106682ms","remote":"127.0.0.1:54584","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":26,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-26T21:49:56.712343Z","caller":"traceutil/trace.go:171","msg":"trace[989888911] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"527.535191ms","start":"2026-02-26T21:49:56.184765Z","end":"2026-02-26T21:49:56.712301Z","steps":["trace[989888911] 'process raft request' (duration: 526.322922ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:49:56.71249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:49:56.184755Z","time spent":"527.677832ms","remote":"127.0.0.1:55064","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-26T21:49:56.713153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.016272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-02-26T21:49:56.713304Z","caller":"traceutil/trace.go:171","msg":"trace[284290433] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:20; }","duration":"473.207903ms","start":"2026-02-26T21:49:56.240082Z","end":"2026-02-26T21:49:56.71329Z","steps":["trace[284290433] 'agreement among raft nodes before linearized reading' (duration: 471.236929ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:49:56.713478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:49:56.240063Z","time spent":"473.400614ms","remote":"127.0.0.1:54584","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":372,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-02-26T21:49:56.714862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:49:56.182898Z","time spent":"531.922722ms","remote":"127.0.0.1:55064","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-26T21:49:56.712204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:49:56.18396Z","time spent":"528.205736ms","remote":"127.0.0.1:55064","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":923,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-26T21:49:56.71212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:49:56.183419Z","time spent":"528.597429ms","remote":"127.0.0.1:55064","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-26T21:49:57.240238Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9142197962112601239,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-26T21:49:57.416677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.609594ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-02-26T21:49:57.417183Z","caller":"traceutil/trace.go:171","msg":"trace[825459023] linearizableReadLoop","detail":"{readStateIndex:32; appliedIndex:25; }","duration":"677.971413ms","start":"2026-02-26T21:49:56.739187Z","end":"2026-02-26T21:49:57.417159Z","steps":["trace[825459023] 'read index received' (duration: 520.812115ms)","trace[825459023] 'applied index is now lower than readState.Index' (duration: 157.158358ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T21:49:57.417275Z","caller":"traceutil/trace.go:171","msg":"trace[1500220292] transaction","detail":"{read_only:false; response_revision:23; number_of_response:1; }","duration":"699.241414ms","start":"2026-02-26T21:49:56.717987Z","end":"2026-02-26T21:49:57.417229Z","steps":["trace[1500220292] 'process raft request' (duration: 698.811741ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:49:57.417467Z","caller":"traceutil/trace.go:171","msg":"trace[562364288] transaction","detail":"{read_only:false; response_revision:27; number_of_response:1; }","duration":"697.813985ms","start":"2026-02-26T21:49:56.719641Z","end":"2026-02-26T21:49:57.417455Z","steps":["trace[562364288] 'process raft request' (duration: 697.457912ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:49:57.417518Z","caller":"traceutil/trace.go:171","msg":"trace[2121164336] transaction","detail":"{read_only:false; response_revision:24; number_of_response:1; }","duration":"699.343895ms","start":"2026-02-26T21:49:56.718129Z","end":"2026-02-26T21:49:57.417473Z","steps":["trace[2121164336] 'process raft request' (duration: 698.835081ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:49:57.4176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:49:56.717981Z","time spent":"699.516586ms","remote":"127.0.0.1:55064","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":956,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-26T21:49:57.417553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:49:56.719617Z","time spent":"697.886275ms","remote":"127.0.0.1:54780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-26T21:49:57.417727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:49:56.718119Z","time spent":"699.498477ms","remote":"127.0.0.1:54976","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":716,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-26T21:49:57.417812Z","caller":"traceutil/trace.go:171","msg":"trace[117629623] transaction","detail":"{read_only:false; response_revision:25; number_of_response:1; }","duration":"699.367177ms","start":"2026-02-26T21:49:56.718373Z","end":"2026-02-26T21:49:57.41774Z","steps":["trace[117629623] 'process raft request' (duration: 698.645681ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:49:57.417988Z","caller":"traceutil/trace.go:171","msg":"trace[456442320] transaction","detail":"{read_only:false; response_revision:28; number_of_response:1; }","duration":"698.054927ms","start":"2026-02-26T21:49:56.71992Z","end":"2026-02-26T21:49:57.417975Z","steps":["trace[456442320] 'process raft request' (duration: 697.20566ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:49:57.418006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:49:56.718367Z","time spent":"699.544058ms","remote":"127.0.0.1:55064","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":947,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-26T21:49:57.418055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:49:56.719873Z","time spent":"698.143617ms","remote":"127.0.0.1:55064","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1007,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-26T21:49:57.418175Z","caller":"traceutil/trace.go:171","msg":"trace[865786465] transaction","detail":"{read_only:false; response_revision:26; number_of_response:1; }","duration":"699.282765ms","start":"2026-02-26T21:49:56.718882Z","end":"2026-02-26T21:49:57.418165Z","steps":["trace[865786465] 'process raft request' (duration: 698.167027ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:49:57.418223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:49:56.718851Z","time spent":"699.349046ms","remote":"127.0.0.1:55064","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1007,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-26T21:49:57.418236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"440.241234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-26T21:49:57.41824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"697.346182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-26T21:49:57.418271Z","caller":"traceutil/trace.go:171","msg":"trace[1493505420] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:28; }","duration":"440.307154ms","start":"2026-02-26T21:49:56.977953Z","end":"2026-02-26T21:49:57.41826Z","steps":["trace[1493505420] 'agreement among raft nodes before linearized reading' (duration: 440.197363ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:49:57.418302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:49:56.977918Z","time spent":"440.378014ms","remote":"127.0.0.1:54894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":26,"request content":"key:\"/registry/priorityclasses/system-node-critical\" "} {"level":"info","ts":"2026-02-26T21:49:57.418305Z","caller":"traceutil/trace.go:171","msg":"trace[1564000293] range","detail":"{range_begin:/registry/configmaps/kube-system/extension-apiserver-authentication; range_end:; response_count:0; response_revision:28; }","duration":"697.451222ms","start":"2026-02-26T21:49:56.720838Z","end":"2026-02-26T21:49:57.418289Z","steps":["trace[1564000293] 'agreement among raft nodes before linearized reading' (duration: 697.270921ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:49:57.418274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"700.162442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-public/\" range_end:\"/registry/resourcequotas/kube-public0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-26T21:49:57.418297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.049517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-26T21:49:57.41835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:49:56.72083Z","time spent":"697.507893ms","remote":"127.0.0.1:54580","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":0,"response size":26,"request content":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" "} {"level":"info","ts":"2026-02-26T21:49:57.418382Z","caller":"traceutil/trace.go:171","msg":"trace[2129909752] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:28; }","duration":"202.134768ms","start":"2026-02-26T21:49:57.21623Z","end":"2026-02-26T21:49:57.418364Z","steps":["trace[2129909752] 'agreement among raft nodes before linearized reading' (duration: 202.010927ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:49:57.418385Z","caller":"traceutil/trace.go:171","msg":"trace[698388820] range","detail":"{range_begin:/registry/resourcequotas/kube-public/; range_end:/registry/resourcequotas/kube-public0; response_count:0; response_revision:28; }","duration":"700.326773ms","start":"2026-02-26T21:49:56.718028Z","end":"2026-02-26T21:49:57.418355Z","steps":["trace[698388820] 'agreement among raft nodes before linearized reading' (duration: 699.97983ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:49:57.418444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.738703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-26T21:49:57.418442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:49:56.718011Z","time spent":"700.419503ms","remote":"127.0.0.1:54558","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":26,"request content":"key:\"/registry/resourcequotas/kube-public/\" range_end:\"/registry/resourcequotas/kube-public0\" "} {"level":"info","ts":"2026-02-26T21:49:57.418483Z","caller":"traceutil/trace.go:171","msg":"trace[14792290] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:28; }","duration":"410.819733ms","start":"2026-02-26T21:49:57.007645Z","end":"2026-02-26T21:49:57.418465Z","steps":["trace[14792290] 'agreement among raft nodes before linearized reading' (duration: 410.777793ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:49:57.418511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:49:57.007605Z","time spent":"410.901284ms","remote":"127.0.0.1:54466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-26T21:49:57.418528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.767594ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-26T21:49:57.418577Z","caller":"traceutil/trace.go:171","msg":"trace[1376901512] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:28; }","duration":"438.842564ms","start":"2026-02-26T21:49:56.979722Z","end":"2026-02-26T21:49:57.418564Z","steps":["trace[1376901512] 'agreement among raft nodes before linearized reading' (duration: 438.749964ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:49:57.41861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:49:56.97971Z","time spent":"438.892714ms","remote":"127.0.0.1:54876","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":26,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" "} {"level":"warn","ts":"2026-02-26T21:49:57.418692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"699.766329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3491"} {"level":"info","ts":"2026-02-26T21:49:57.418729Z","caller":"traceutil/trace.go:171","msg":"trace[1965240582] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:28; }","duration":"699.812689ms","start":"2026-02-26T21:49:56.718905Z","end":"2026-02-26T21:49:57.418718Z","steps":["trace[1965240582] 'agreement among raft nodes before linearized reading' (duration: 699.717519ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:49:57.418759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:49:56.718897Z","time spent":"699.855099ms","remote":"127.0.0.1:54664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3513,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-02-26T21:49:57.419164Z","caller":"traceutil/trace.go:171","msg":"trace[1564084767] transaction","detail":"{read_only:false; response_revision:22; number_of_response:1; }","duration":"699.340655ms","start":"2026-02-26T21:49:56.717958Z","end":"2026-02-26T21:49:57.417298Z","steps":["trace[1564084767] 'process raft request' (duration: 541.979775ms)","trace[1564084767] 'compare' (duration: 156.316682ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T21:49:57.419399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:49:56.717946Z","time spent":"701.319759ms","remote":"127.0.0.1:55064","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-26T21:49:57.775026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.854755ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-02-26T21:49:57.77517Z","caller":"traceutil/trace.go:171","msg":"trace[1432590913] linearizableReadLoop","detail":"{readStateIndex:33; appliedIndex:32; }","duration":"337.346699ms","start":"2026-02-26T21:49:57.437798Z","end":"2026-02-26T21:49:57.775144Z","steps":["trace[1432590913] 'read index received' (duration: 166.308733ms)","trace[1432590913] 'applied index is now lower than readState.Index' (duration: 171.036346ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T21:49:57.775259Z","caller":"traceutil/trace.go:171","msg":"trace[981054854] transaction","detail":"{read_only:false; response_revision:29; number_of_response:1; }","duration":"338.014224ms","start":"2026-02-26T21:49:57.437194Z","end":"2026-02-26T21:49:57.775209Z","steps":["trace[981054854] 'process raft request' (duration: 166.896867ms)","trace[981054854] 'compare' (duration: 170.603983ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T21:49:57.775388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.565621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-26T21:49:57.775609Z","caller":"traceutil/trace.go:171","msg":"trace[1367165326] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:29; }","duration":"337.822272ms","start":"2026-02-26T21:49:57.437758Z","end":"2026-02-26T21:49:57.77558Z","steps":["trace[1367165326] 'agreement among raft nodes before linearized reading' (duration: 337.44539ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:49:57.775661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:49:57.437737Z","time spent":"337.910973ms","remote":"127.0.0.1:54890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":0,"response size":26,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" "} {"level":"warn","ts":"2026-02-26T21:49:57.775792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:49:57.437168Z","time spent":"338.336016ms","remote":"127.0.0.1:54584","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":338,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-26T21:49:57.781821Z","caller":"traceutil/trace.go:171","msg":"trace[1826990248] transaction","detail":"{read_only:false; response_revision:33; number_of_response:1; }","duration":"343.512894ms","start":"2026-02-26T21:49:57.438254Z","end":"2026-02-26T21:49:57.781766Z","steps":["trace[1826990248] 'process raft request' (duration: 342.409296ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:49:57.781926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:49:57.438152Z","time spent":"343.728685ms","remote":"127.0.0.1:55064","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":959,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-26T21:49:57.78233Z","caller":"traceutil/trace.go:171","msg":"trace[593312439] transaction","detail":"{read_only:false; response_revision:37; number_of_response:1; }","duration":"343.092701ms","start":"2026-02-26T21:49:57.438918Z","end":"2026-02-26T21:49:57.782011Z","steps":["trace[593312439] 'process raft request' (duration: 342.874329ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:49:57.782454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:49:57.438911Z","time spent":"343.490394ms","remote":"127.0.0.1:54894","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":429,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-26T21:49:57.782817Z","caller":"traceutil/trace.go:171","msg":"trace[1192012196] transaction","detail":"{read_only:false; response_revision:30; number_of_response:1; }","duration":"344.494861ms","start":"2026-02-26T21:49:57.437997Z","end":"2026-02-26T21:49:57.782492Z","steps":["trace[1192012196] 'process raft request' (duration: 342.389626ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:49:57.782908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:49:57.437983Z","time spent":"344.880274ms","remote":"127.0.0.1:55064","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":983,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-26T21:49:57.783226Z","caller":"traceutil/trace.go:171","msg":"trace[43427216] transaction","detail":"{read_only:false; response_revision:31; number_of_response:1; }","duration":"345.112735ms","start":"2026-02-26T21:49:57.438043Z","end":"2026-02-26T21:49:57.783156Z","steps":["trace[43427216] 'process raft request' (duration: 342.464316ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:49:57.783318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:49:57.438036Z","time spent":"345.226215ms","remote":"127.0.0.1:55064","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-26T21:49:57.783448Z","caller":"traceutil/trace.go:171","msg":"trace[1248757502] transaction","detail":"{read_only:false; response_revision:32; number_of_response:1; }","duration":"345.127965ms","start":"2026-02-26T21:49:57.43812Z","end":"2026-02-26T21:49:57.783248Z","steps":["trace[1248757502] 'process raft request' (duration: 342.472726ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:49:57.78357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:49:57.438097Z","time spent":"345.409737ms","remote":"127.0.0.1:55064","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":926,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-26T21:49:57.785134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.533239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-node-lease\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-26T21:49:57.78525Z","caller":"traceutil/trace.go:171","msg":"trace[1575381609] range","detail":"{range_begin:/registry/namespaces/kube-node-lease; range_end:; response_count:0; response_revision:37; }","duration":"296.69001ms","start":"2026-02-26T21:49:57.488519Z","end":"2026-02-26T21:49:57.785209Z","steps":["trace[1575381609] 'agreement among raft nodes before linearized reading' (duration: 293.915381ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:49:57.785248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.466823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-26T21:49:57.785533Z","caller":"traceutil/trace.go:171","msg":"trace[913138725] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:37; }","duration":"177.787745ms","start":"2026-02-26T21:49:57.607699Z","end":"2026-02-26T21:49:57.785486Z","steps":["trace[913138725] 'agreement among raft nodes before linearized reading' (duration: 174.380251ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:49:57.7859Z","caller":"traceutil/trace.go:171","msg":"trace[1817144197] transaction","detail":"{read_only:false; response_revision:34; number_of_response:1; }","duration":"347.26172ms","start":"2026-02-26T21:49:57.438297Z","end":"2026-02-26T21:49:57.785559Z","steps":["trace[1817144197] 'process raft request' (duration: 342.445935ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:49:57.785981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:49:57.438291Z","time spent":"347.652273ms","remote":"127.0.0.1:55064","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":959,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-26T21:49:57.786342Z","caller":"traceutil/trace.go:171","msg":"trace[176682009] transaction","detail":"{read_only:false; response_revision:35; number_of_response:1; }","duration":"347.784314ms","start":"2026-02-26T21:49:57.438527Z","end":"2026-02-26T21:49:57.786312Z","steps":["trace[176682009] 'process raft request' (duration: 342.276585ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:49:57.786466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:49:57.43852Z","time spent":"347.900894ms","remote":"127.0.0.1:54580","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3004,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-26T21:49:57.787863Z","caller":"traceutil/trace.go:171","msg":"trace[140219582] transaction","detail":"{read_only:false; response_revision:36; number_of_response:1; }","duration":"343.308663ms","start":"2026-02-26T21:49:57.438657Z","end":"2026-02-26T21:49:57.781966Z","steps":["trace[140219582] 'process raft request' (duration: 342.759798ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:49:57.788071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:49:57.43865Z","time spent":"349.255465ms","remote":"127.0.0.1:54976","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":713,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-26T21:49:58.081857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.814142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-edit\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-26T21:49:58.082032Z","caller":"traceutil/trace.go:171","msg":"trace[1944972730] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-edit; range_end:; response_count:0; response_revision:40; }","duration":"206.030484ms","start":"2026-02-26T21:49:57.875986Z","end":"2026-02-26T21:49:58.082017Z","steps":["trace[1944972730] 'range keys from in-memory index tree' (duration: 205.686721ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:49:58.082031Z","caller":"traceutil/trace.go:171","msg":"trace[1225514661] linearizableReadLoop","detail":"{readStateIndex:45; appliedIndex:44; }","duration":"204.849615ms","start":"2026-02-26T21:49:57.87715Z","end":"2026-02-26T21:49:58.081999Z","steps":["trace[1225514661] 'read index received' (duration: 176.225722ms)","trace[1225514661] 'applied index is now lower than readState.Index' (duration: 28.622253ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T21:49:58.082151Z","caller":"traceutil/trace.go:171","msg":"trace[1878447106] transaction","detail":"{read_only:false; response_revision:41; number_of_response:1; }","duration":"205.882123ms","start":"2026-02-26T21:49:57.876209Z","end":"2026-02-26T21:49:58.082091Z","steps":["trace[1878447106] 'process raft request' (duration: 177.058079ms)","trace[1878447106] 'compare' (duration: 28.523452ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T21:49:58.08263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.467179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/default/\" range_end:\"/registry/resourcequotas/default0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-26T21:49:58.082685Z","caller":"traceutil/trace.go:171","msg":"trace[735943783] range","detail":"{range_begin:/registry/resourcequotas/default/; range_end:/registry/resourcequotas/default0; response_count:0; response_revision:41; }","duration":"205.5689ms","start":"2026-02-26T21:49:57.877099Z","end":"2026-02-26T21:49:58.082668Z","steps":["trace[735943783] 'agreement among raft nodes before linearized reading' (duration: 204.977736ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:49:58.095287Z","caller":"traceutil/trace.go:171","msg":"trace[2051455941] transaction","detail":"{read_only:false; response_revision:42; number_of_response:1; }","duration":"217.997498ms","start":"2026-02-26T21:49:57.877253Z","end":"2026-02-26T21:49:58.095251Z","steps":["trace[2051455941] 'process raft request' (duration: 217.872947ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:49:58.095426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.513638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-26T21:49:58.095474Z","caller":"traceutil/trace.go:171","msg":"trace[1449345061] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:42; }","duration":"167.590231ms","start":"2026-02-26T21:49:57.927869Z","end":"2026-02-26T21:49:58.095459Z","steps":["trace[1449345061] 'agreement among raft nodes before linearized reading' (duration: 167.529049ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:49:58.344874Z","caller":"traceutil/trace.go:171","msg":"trace[200233472] transaction","detail":"{read_only:false; response_revision:46; number_of_response:1; }","duration":"175.510534ms","start":"2026-02-26T21:49:58.169334Z","end":"2026-02-26T21:49:58.344844Z","steps":["trace[200233472] 'process raft request' (duration: 175.351852ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:49:58.344888Z","caller":"traceutil/trace.go:171","msg":"trace[1331485426] transaction","detail":"{read_only:false; response_revision:45; number_of_response:1; }","duration":"178.760616ms","start":"2026-02-26T21:49:58.166062Z","end":"2026-02-26T21:49:58.344823Z","steps":["trace[1331485426] 'process raft request' (duration: 173.347328ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:49:58.344987Z","caller":"traceutil/trace.go:171","msg":"trace[6984434] linearizableReadLoop","detail":"{readStateIndex:52; appliedIndex:49; }","duration":"171.757087ms","start":"2026-02-26T21:49:58.173203Z","end":"2026-02-26T21:49:58.34496Z","steps":["trace[6984434] 'read index received' (duration: 166.258078ms)","trace[6984434] 'applied index is now lower than readState.Index' (duration: 5.497739ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T21:49:58.345163Z","caller":"traceutil/trace.go:171","msg":"trace[800617146] transaction","detail":"{read_only:false; response_revision:47; number_of_response:1; }","duration":"172.916605ms","start":"2026-02-26T21:49:58.172234Z","end":"2026-02-26T21:49:58.34515Z","steps":["trace[800617146] 'process raft request' (duration: 172.566902ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:49:58.345461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.049889ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:discovery\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-26T21:49:58.345578Z","caller":"traceutil/trace.go:171","msg":"trace[1085356855] range","detail":"{range_begin:/registry/clusterrolebindings/system:discovery; range_end:; response_count:0; response_revision:47; }","duration":"172.357561ms","start":"2026-02-26T21:49:58.173171Z","end":"2026-02-26T21:49:58.345529Z","steps":["trace[1085356855] 'agreement among raft nodes before linearized reading' (duration: 172.002959ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:49:58.865936Z","caller":"traceutil/trace.go:171","msg":"trace[1842552894] linearizableReadLoop","detail":"{readStateIndex:56; appliedIndex:53; }","duration":"430.028556ms","start":"2026-02-26T21:49:58.435881Z","end":"2026-02-26T21:49:58.865909Z","steps":["trace[1842552894] 'read index received' (duration: 351.742051ms)","trace[1842552894] 'applied index is now lower than readState.Index' (duration: 78.285455ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T21:49:58.865977Z","caller":"traceutil/trace.go:171","msg":"trace[1881617966] transaction","detail":"{read_only:false; response_revision:50; number_of_response:1; }","duration":"514.182812ms","start":"2026-02-26T21:49:58.35175Z","end":"2026-02-26T21:49:58.865932Z","steps":["trace[1881617966] 'process raft request' (duration: 514.06146ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:49:58.866073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.168887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/default/instance.1897ea4bea5c14be\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-26T21:49:58.866108Z","caller":"traceutil/trace.go:171","msg":"trace[1801065162] range","detail":"{range_begin:/registry/events/default/instance.1897ea4bea5c14be; range_end:; response_count:0; response_revision:51; }","duration":"430.261788ms","start":"2026-02-26T21:49:58.435836Z","end":"2026-02-26T21:49:58.866097Z","steps":["trace[1801065162] 'agreement among raft nodes before linearized reading' (duration: 430.181867ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:49:58.866149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:49:58.435819Z","time spent":"430.319158ms","remote":"127.0.0.1:54548","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":26,"request content":"key:\"/registry/events/default/instance.1897ea4bea5c14be\" "} {"level":"info","ts":"2026-02-26T21:49:58.86619Z","caller":"traceutil/trace.go:171","msg":"trace[1571474383] transaction","detail":"{read_only:false; response_revision:51; number_of_response:1; }","duration":"513.548057ms","start":"2026-02-26T21:49:58.35258Z","end":"2026-02-26T21:49:58.866128Z","steps":["trace[1571474383] 'process raft request' (duration: 513.286745ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:49:58.866271Z","caller":"traceutil/trace.go:171","msg":"trace[404000762] transaction","detail":"{read_only:false; response_revision:49; number_of_response:1; }","duration":"515.909905ms","start":"2026-02-26T21:49:58.350296Z","end":"2026-02-26T21:49:58.866206Z","steps":["trace[404000762] 'process raft request' (duration: 437.380438ms)","trace[404000762] 'compare' (duration: 77.967572ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T21:49:58.86629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:49:58.351721Z","time spent":"514.350253ms","remote":"127.0.0.1:54962","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1120,"response count":0,"response size":36,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T21:49:58.866415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:49:58.352565Z","time spent":"513.747098ms","remote":"127.0.0.1:54876","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-26T21:49:58.866503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:49:58.350277Z","time spent":"516.130156ms","remote":"127.0.0.1:54962","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":632,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-26T21:49:59.411917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.356471ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-02-26T21:49:59.412051Z","caller":"traceutil/trace.go:171","msg":"trace[588171330] transaction","detail":"{read_only:false; response_revision:52; number_of_response:1; }","duration":"540.215422ms","start":"2026-02-26T21:49:58.871809Z","end":"2026-02-26T21:49:59.412025Z","steps":["trace[588171330] 'process raft request' (duration: 291.66135ms)","trace[588171330] 'compare' (duration: 248.15ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T21:49:59.412113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:49:58.871782Z","time spent":"540.311834ms","remote":"127.0.0.1:54962","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":796,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-26T21:49:59.414693Z","caller":"traceutil/trace.go:171","msg":"trace[139468468] linearizableReadLoop","detail":"{readStateIndex:60; appliedIndex:56; }","duration":"399.784648ms","start":"2026-02-26T21:49:59.014891Z","end":"2026-02-26T21:49:59.414676Z","steps":["trace[139468468] 'read index received' (duration: 148.583488ms)","trace[139468468] 'applied index is now lower than readState.Index' (duration: 251.1973ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T21:49:59.414797Z","caller":"traceutil/trace.go:171","msg":"trace[578981176] transaction","detail":"{read_only:false; response_revision:53; number_of_response:1; }","duration":"542.6445ms","start":"2026-02-26T21:49:58.872143Z","end":"2026-02-26T21:49:59.414787Z","steps":["trace[578981176] 'process raft request' (duration: 542.349168ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:49:59.414862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:49:58.872125Z","time spent":"542.69434ms","remote":"127.0.0.1:54548","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":642,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-26T21:49:59.415333Z","caller":"traceutil/trace.go:171","msg":"trace[799962276] transaction","detail":"{read_only:false; response_revision:54; number_of_response:1; }","duration":"542.42619ms","start":"2026-02-26T21:49:58.872894Z","end":"2026-02-26T21:49:59.41532Z","steps":["trace[799962276] 'process raft request' (duration: 541.672014ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:49:59.415415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:49:58.872864Z","time spent":"542.49807ms","remote":"127.0.0.1:54962","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1059,"response count":0,"response size":36,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T21:49:59.415647Z","caller":"traceutil/trace.go:171","msg":"trace[1295224554] transaction","detail":"{read_only:false; response_revision:55; number_of_response:1; }","duration":"542.339259ms","start":"2026-02-26T21:49:58.873296Z","end":"2026-02-26T21:49:59.415635Z","steps":["trace[1295224554] 'process raft request' (duration: 541.330781ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:49:59.415696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:49:58.873283Z","time spent":"542.388349ms","remote":"127.0.0.1:54876","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":634,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-26T21:49:59.41583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.943247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-26T21:49:59.415864Z","caller":"traceutil/trace.go:171","msg":"trace[1570325399] range","detail":"{range_begin:/registry/limitranges/kube-system/; range_end:/registry/limitranges/kube-system0; response_count:0; response_revision:55; }","duration":"401.014557ms","start":"2026-02-26T21:49:59.014839Z","end":"2026-02-26T21:49:59.415853Z","steps":["trace[1570325399] 'agreement among raft nodes before linearized reading' (duration: 400.954647ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:49:59.415908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:49:59.0148Z","time spent":"401.101067ms","remote":"127.0.0.1:54624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":26,"request content":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" "} {"level":"warn","ts":"2026-02-26T21:49:59.416065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.00392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-26T21:49:59.416105Z","caller":"traceutil/trace.go:171","msg":"trace[958828858] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:55; }","duration":"400.069821ms","start":"2026-02-26T21:49:59.016026Z","end":"2026-02-26T21:49:59.416095Z","steps":["trace[958828858] 'agreement among raft nodes before linearized reading' (duration: 400.01483ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:49:59.416139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:49:59.016003Z","time spent":"400.129481ms","remote":"127.0.0.1:54466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-26T21:50:00.045064Z","caller":"traceutil/trace.go:171","msg":"trace[1417003445] transaction","detail":"{read_only:false; response_revision:90; number_of_response:1; }","duration":"163.001868ms","start":"2026-02-26T21:49:59.882035Z","end":"2026-02-26T21:50:00.045036Z","steps":["trace[1417003445] 'process raft request' (duration: 162.898217ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:50:00.045102Z","caller":"traceutil/trace.go:171","msg":"trace[651286074] transaction","detail":"{read_only:false; response_revision:88; number_of_response:1; }","duration":"163.328039ms","start":"2026-02-26T21:49:59.881742Z","end":"2026-02-26T21:50:00.04507Z","steps":["trace[651286074] 'process raft request' (duration: 105.504904ms)","trace[651286074] 'compare' (duration: 57.408663ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T21:50:00.045239Z","caller":"traceutil/trace.go:171","msg":"trace[1877693420] transaction","detail":"{read_only:false; response_revision:89; number_of_response:1; }","duration":"163.26374ms","start":"2026-02-26T21:49:59.881939Z","end":"2026-02-26T21:50:00.045203Z","steps":["trace[1877693420] 'process raft request' (duration: 162.933977ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:50:00.045544Z","caller":"traceutil/trace.go:171","msg":"trace[807151748] transaction","detail":"{read_only:false; response_revision:91; number_of_response:1; }","duration":"162.524644ms","start":"2026-02-26T21:49:59.882998Z","end":"2026-02-26T21:50:00.045523Z","steps":["trace[807151748] 'process raft request' (duration: 161.99563ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:50:00.56919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.41189ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:14"} {"level":"info","ts":"2026-02-26T21:50:00.569411Z","caller":"traceutil/trace.go:171","msg":"trace[1494270151] linearizableReadLoop","detail":"{readStateIndex:100; appliedIndex:99; }","duration":"450.14865ms","start":"2026-02-26T21:50:00.11917Z","end":"2026-02-26T21:50:00.569319Z","steps":["trace[1494270151] 'read index received' (duration: 176.379318ms)","trace[1494270151] 'applied index is now lower than readState.Index' (duration: 273.767472ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T21:50:00.56976Z","caller":"traceutil/trace.go:171","msg":"trace[1006532422] transaction","detail":"{read_only:false; response_revision:95; number_of_response:1; }","duration":"480.07891ms","start":"2026-02-26T21:50:00.089667Z","end":"2026-02-26T21:50:00.569746Z","steps":["trace[1006532422] 'process raft request' (duration: 205.972646ms)","trace[1006532422] 'compare' (duration: 273.102447ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T21:50:00.570006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:50:00.08963Z","time spent":"480.346103ms","remote":"127.0.0.1:54962","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1101,"response count":0,"response size":36,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T21:50:00.570023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.820955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-view\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-26T21:50:00.570207Z","caller":"traceutil/trace.go:171","msg":"trace[2142518416] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-view; range_end:; response_count:0; response_revision:95; }","duration":"451.068756ms","start":"2026-02-26T21:50:00.119108Z","end":"2026-02-26T21:50:00.570176Z","steps":["trace[2142518416] 'agreement among raft nodes before linearized reading' (duration: 450.624783ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:50:00.570326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:50:00.11908Z","time spent":"451.226867ms","remote":"127.0.0.1:54876","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":0,"response size":26,"request content":"key:\"/registry/clusterroles/system:aggregate-to-view\" "} {"level":"warn","ts":"2026-02-26T21:50:00.629718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"509.916909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/default/instance.1897ea4bea5c6054\" ","response":"range_response_count:1 size:648"} {"level":"warn","ts":"2026-02-26T21:50:00.629788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.758916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-26T21:50:00.629827Z","caller":"traceutil/trace.go:171","msg":"trace[528768189] range","detail":"{range_begin:/registry/events/default/instance.1897ea4bea5c6054; range_end:; response_count:1; response_revision:96; }","duration":"510.07761ms","start":"2026-02-26T21:50:00.119728Z","end":"2026-02-26T21:50:00.629806Z","steps":["trace[528768189] 'agreement among raft nodes before linearized reading' (duration: 509.809708ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:50:00.62987Z","caller":"traceutil/trace.go:171","msg":"trace[867094047] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:96; }","duration":"211.880817ms","start":"2026-02-26T21:50:00.417965Z","end":"2026-02-26T21:50:00.629846Z","steps":["trace[867094047] 'agreement among raft nodes before linearized reading' (duration: 211.712665ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:50:00.62983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.428971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:2917"} {"level":"warn","ts":"2026-02-26T21:50:00.629896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:50:00.119711Z","time spent":"510.169371ms","remote":"127.0.0.1:54548","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":670,"request content":"key:\"/registry/events/default/instance.1897ea4bea5c6054\" "} {"level":"info","ts":"2026-02-26T21:50:00.629921Z","caller":"traceutil/trace.go:171","msg":"trace[898144707] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:96; }","duration":"346.565342ms","start":"2026-02-26T21:50:00.283342Z","end":"2026-02-26T21:50:00.629907Z","steps":["trace[898144707] 'agreement among raft nodes before linearized reading' (duration: 346.420931ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:50:00.629977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:50:00.283318Z","time spent":"346.649423ms","remote":"127.0.0.1:54680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":2939,"request content":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" "} {"level":"info","ts":"2026-02-26T21:50:00.629793Z","caller":"traceutil/trace.go:171","msg":"trace[981308037] transaction","detail":"{read_only:false; response_revision:96; number_of_response:1; }","duration":"210.173145ms","start":"2026-02-26T21:50:00.41959Z","end":"2026-02-26T21:50:00.629763Z","steps":["trace[981308037] 'process raft request' (duration: 209.656682ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:50:00.876748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.740542ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-02-26T21:50:00.877027Z","caller":"traceutil/trace.go:171","msg":"trace[257888924] transaction","detail":"{read_only:false; response_revision:98; number_of_response:1; }","duration":"301.621567ms","start":"2026-02-26T21:50:00.575383Z","end":"2026-02-26T21:50:00.877005Z","steps":["trace[257888924] 'process raft request' (duration: 301.489776ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:50:00.877208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:50:00.575373Z","time spent":"301.738198ms","remote":"127.0.0.1:54962","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1043,"response count":0,"response size":36,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T21:50:00.877088Z","caller":"traceutil/trace.go:171","msg":"trace[162263945] transaction","detail":"{read_only:false; response_revision:97; number_of_response:1; }","duration":"302.663584ms","start":"2026-02-26T21:50:00.574364Z","end":"2026-02-26T21:50:00.877028Z","steps":["trace[162263945] 'process raft request' (duration: 159.53779ms)","trace[162263945] 'compare' (duration: 142.022947ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T21:50:00.877332Z","caller":"traceutil/trace.go:171","msg":"trace[1052111075] transaction","detail":"{read_only:false; response_revision:100; number_of_response:1; }","duration":"229.031578ms","start":"2026-02-26T21:50:00.64828Z","end":"2026-02-26T21:50:00.877312Z","steps":["trace[1052111075] 'process raft request' (duration: 228.918877ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:50:00.877461Z","caller":"traceutil/trace.go:171","msg":"trace[744533076] transaction","detail":"{read_only:false; response_revision:99; number_of_response:1; }","duration":"243.689691ms","start":"2026-02-26T21:50:00.633739Z","end":"2026-02-26T21:50:00.877429Z","steps":["trace[744533076] 'process raft request' (duration: 243.217567ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:50:00.877489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:50:00.574332Z","time spent":"303.068499ms","remote":"127.0.0.1:54876","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1917,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-26T21:50:01.022155Z","caller":"traceutil/trace.go:171","msg":"trace[1697726887] transaction","detail":"{read_only:false; response_revision:102; number_of_response:1; }","duration":"133.469896ms","start":"2026-02-26T21:50:00.888652Z","end":"2026-02-26T21:50:01.022122Z","steps":["trace[1697726887] 'process raft request' (duration: 91.31889ms)","trace[1697726887] 'compare' (duration: 41.931564ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T21:50:02.024977Z","caller":"traceutil/trace.go:171","msg":"trace[1806233099] transaction","detail":"{read_only:false; response_revision:163; number_of_response:1; }","duration":"134.763962ms","start":"2026-02-26T21:50:01.890175Z","end":"2026-02-26T21:50:02.024939Z","steps":["trace[1806233099] 'process raft request' (duration: 75.912751ms)","trace[1806233099] 'compare' (duration: 58.639129ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T21:50:02.181494Z","caller":"traceutil/trace.go:171","msg":"trace[2008890212] transaction","detail":"{read_only:false; response_revision:166; number_of_response:1; }","duration":"130.567329ms","start":"2026-02-26T21:50:02.050862Z","end":"2026-02-26T21:50:02.181429Z","steps":["trace[2008890212] 'process raft request' (duration: 95.606136ms)","trace[2008890212] 'compare' (duration: 34.680581ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T21:50:02.703232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.953849ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-26T21:50:02.703626Z","caller":"traceutil/trace.go:171","msg":"trace[800221152] transaction","detail":"{read_only:false; response_revision:185; number_of_response:1; }","duration":"162.914134ms","start":"2026-02-26T21:50:02.540677Z","end":"2026-02-26T21:50:02.703591Z","steps":["trace[800221152] 'process raft request' (duration: 30.498212ms)","trace[800221152] 'compare' (duration: 131.778197ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T21:50:02.887782Z","caller":"traceutil/trace.go:171","msg":"trace[1122082909] transaction","detail":"{read_only:false; response_revision:188; number_of_response:1; }","duration":"108.798358ms","start":"2026-02-26T21:50:02.778953Z","end":"2026-02-26T21:50:02.887751Z","steps":["trace[1122082909] 'process raft request' (duration: 49.806377ms)","trace[1122082909] 'compare' (duration: 58.86489ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T21:50:03.77049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.34787ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-26T21:50:03.770635Z","caller":"traceutil/trace.go:171","msg":"trace[2138434397] linearizableReadLoop","detail":"{readStateIndex:224; appliedIndex:223; }","duration":"152.703478ms","start":"2026-02-26T21:50:03.617909Z","end":"2026-02-26T21:50:03.770613Z","steps":["trace[2138434397] 'read index received' (duration: 11.083567ms)","trace[2138434397] 'applied index is now lower than readState.Index' (duration: 141.618491ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T21:50:03.770757Z","caller":"traceutil/trace.go:171","msg":"trace[1833684703] transaction","detail":"{read_only:false; response_revision:219; number_of_response:1; }","duration":"194.224907ms","start":"2026-02-26T21:50:03.576445Z","end":"2026-02-26T21:50:03.77067Z","steps":["trace[1833684703] 'process raft request' (duration: 52.588165ms)","trace[1833684703] 'compare' (duration: 141.155199ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T21:50:03.77079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.881049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T21:50:03.771126Z","caller":"traceutil/trace.go:171","msg":"trace[865118427] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:219; }","duration":"153.120233ms","start":"2026-02-26T21:50:03.617832Z","end":"2026-02-26T21:50:03.770952Z","steps":["trace[865118427] 'agreement among raft nodes before linearized reading' (duration: 152.84834ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:50:03.998435Z","caller":"traceutil/trace.go:171","msg":"trace[1450750136] transaction","detail":"{read_only:false; response_revision:223; number_of_response:1; }","duration":"144.22084ms","start":"2026-02-26T21:50:03.854177Z","end":"2026-02-26T21:50:03.998398Z","steps":["trace[1450750136] 'process raft request' (duration: 50.6108ms)","trace[1450750136] 'compare' (duration: 93.422989ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T21:50:04.267568Z","caller":"traceutil/trace.go:171","msg":"trace[1590768481] transaction","detail":"{read_only:false; response_revision:227; number_of_response:1; }","duration":"167.87076ms","start":"2026-02-26T21:50:04.099667Z","end":"2026-02-26T21:50:04.267538Z","steps":["trace[1590768481] 'process raft request' (duration: 167.740279ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:50:04.355353Z","caller":"traceutil/trace.go:171","msg":"trace[1697680074] linearizableReadLoop","detail":"{readStateIndex:234; appliedIndex:232; }","duration":"162.782034ms","start":"2026-02-26T21:50:04.192557Z","end":"2026-02-26T21:50:04.355339Z","steps":["trace[1697680074] 'read index received' (duration: 74.962168ms)","trace[1697680074] 'applied index is now lower than readState.Index' (duration: 87.818726ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T21:50:04.355507Z","caller":"traceutil/trace.go:171","msg":"trace[526256467] transaction","detail":"{read_only:false; response_revision:228; number_of_response:1; }","duration":"255.141883ms","start":"2026-02-26T21:50:04.100337Z","end":"2026-02-26T21:50:04.355479Z","steps":["trace[526256467] 'process raft request' (duration: 221.805452ms)","trace[526256467] 'compare' (duration: 33.040899ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T21:50:04.355577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.993546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T21:50:04.35544Z","caller":"traceutil/trace.go:171","msg":"trace[2033696917] transaction","detail":"{read_only:false; response_revision:229; number_of_response:1; }","duration":"247.882741ms","start":"2026-02-26T21:50:04.107549Z","end":"2026-02-26T21:50:04.355431Z","steps":["trace[2033696917] 'process raft request' (duration: 247.73179ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:50:04.355692Z","caller":"traceutil/trace.go:171","msg":"trace[936815360] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:229; }","duration":"163.203167ms","start":"2026-02-26T21:50:04.192468Z","end":"2026-02-26T21:50:04.355671Z","steps":["trace[936815360] 'agreement among raft nodes before linearized reading' (duration: 162.984226ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:50:04.705098Z","caller":"traceutil/trace.go:171","msg":"trace[1732452001] transaction","detail":"{read_only:false; response_revision:234; number_of_response:1; }","duration":"280.264605ms","start":"2026-02-26T21:50:04.424796Z","end":"2026-02-26T21:50:04.705061Z","steps":["trace[1732452001] 'process raft request' (duration: 193.736118ms)","trace[1732452001] 'compare' (duration: 86.340296ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T21:50:04.968267Z","caller":"traceutil/trace.go:171","msg":"trace[1493081670] transaction","detail":"{read_only:false; response_revision:238; number_of_response:1; }","duration":"196.359166ms","start":"2026-02-26T21:50:04.771879Z","end":"2026-02-26T21:50:04.968238Z","steps":["trace[1493081670] 'process raft request' (duration: 170.378887ms)","trace[1493081670] 'compare' (duration: 25.844558ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T21:50:05.248163Z","caller":"traceutil/trace.go:171","msg":"trace[715420644] transaction","detail":"{read_only:false; response_revision:243; number_of_response:1; }","duration":"180.399962ms","start":"2026-02-26T21:50:05.067722Z","end":"2026-02-26T21:50:05.248122Z","steps":["trace[715420644] 'process raft request' (duration: 157.02384ms)","trace[715420644] 'compare' (duration: 22.997809ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T21:50:05.403666Z","caller":"traceutil/trace.go:171","msg":"trace[727936234] transaction","detail":"{read_only:false; response_revision:247; number_of_response:1; }","duration":"102.770566ms","start":"2026-02-26T21:50:05.300863Z","end":"2026-02-26T21:50:05.403634Z","steps":["trace[727936234] 'process raft request' (duration: 69.953501ms)","trace[727936234] 'compare' (duration: 32.576114ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T21:50:05.770468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.941974ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-26T21:50:05.771155Z","caller":"traceutil/trace.go:171","msg":"trace[1215554461] transaction","detail":"{read_only:false; response_revision:251; number_of_response:1; }","duration":"280.963107ms","start":"2026-02-26T21:50:05.490152Z","end":"2026-02-26T21:50:05.771115Z","steps":["trace[1215554461] 'process raft request' (duration: 22.286404ms)","trace[1215554461] 'compare' (duration: 257.55425ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T21:50:13.97024Z","caller":"traceutil/trace.go:171","msg":"trace[155038080] linearizableReadLoop","detail":"{readStateIndex:415; appliedIndex:414; }","duration":"474.870941ms","start":"2026-02-26T21:50:13.495334Z","end":"2026-02-26T21:50:13.970205Z","steps":["trace[155038080] 'read index received' (duration: 474.633853ms)","trace[155038080] 'applied index is now lower than readState.Index' (duration: 235.628µs)"],"step_count":2} {"level":"warn","ts":"2026-02-26T21:50:13.970504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"475.070638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4369"} {"level":"info","ts":"2026-02-26T21:50:13.970558Z","caller":"traceutil/trace.go:171","msg":"trace[46499329] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:401; }","duration":"475.251964ms","start":"2026-02-26T21:50:13.495289Z","end":"2026-02-26T21:50:13.970541Z","steps":["trace[46499329] 'agreement among raft nodes before linearized reading' (duration: 475.054907ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:50:13.970607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:50:13.495268Z","time spent":"475.328277ms","remote":"127.0.0.1:54664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4391,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-02-26T21:50:13.970545Z","caller":"traceutil/trace.go:171","msg":"trace[526887112] transaction","detail":"{read_only:false; response_revision:401; number_of_response:1; }","duration":"479.141624ms","start":"2026-02-26T21:50:13.491311Z","end":"2026-02-26T21:50:13.970452Z","steps":["trace[526887112] 'process raft request' (duration: 478.699008ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:50:13.971264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:50:13.491284Z","time spent":"479.535528ms","remote":"127.0.0.1:54780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T21:50:14.865653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:50:14.012937Z","time spent":"852.70697ms","remote":"127.0.0.1:55058","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-02-26T21:50:19.5263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.344642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-02-26T21:50:19.526339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.082797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T21:50:19.526431Z","caller":"traceutil/trace.go:171","msg":"trace[579874611] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:427; }","duration":"171.565329ms","start":"2026-02-26T21:50:19.354841Z","end":"2026-02-26T21:50:19.526406Z","steps":["trace[579874611] 'range keys from in-memory index tree' (duration: 171.165447ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:50:19.526441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.535379ms","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-26T21:50:19.526462Z","caller":"traceutil/trace.go:171","msg":"trace[1721360375] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:427; }","duration":"265.289174ms","start":"2026-02-26T21:50:19.261144Z","end":"2026-02-26T21:50:19.526433Z","steps":["trace[1721360375] 'range keys from in-memory index tree' (duration: 264.917911ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:50:19.526522Z","caller":"traceutil/trace.go:171","msg":"trace[526617015] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:427; }","duration":"171.646602ms","start":"2026-02-26T21:50:19.354841Z","end":"2026-02-26T21:50:19.526487Z","steps":["trace[526617015] 'range keys from in-memory index tree' (duration: 171.386203ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:50:36.319932Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9142197962112602239,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-26T21:50:36.669434Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.044121671s","expected-duration":"1s"} {"level":"info","ts":"2026-02-26T21:50:36.67Z","caller":"traceutil/trace.go:171","msg":"trace[854932507] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"1.044782129s","start":"2026-02-26T21:50:35.625188Z","end":"2026-02-26T21:50:36.66997Z","steps":["trace[854932507] 'process raft request' (duration: 1.044612264s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:50:36.670193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:50:35.625172Z","time spent":"1.044916733s","remote":"127.0.0.1:54780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T21:50:36.684618Z","caller":"traceutil/trace.go:171","msg":"trace[1011003774] linearizableReadLoop","detail":"{readStateIndex:547; appliedIndex:545; }","duration":"865.243459ms","start":"2026-02-26T21:50:35.819346Z","end":"2026-02-26T21:50:36.684589Z","steps":["trace[1011003774] 'read index received' (duration: 850.485067ms)","trace[1011003774] 'applied index is now lower than readState.Index' (duration: 14.757122ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T21:50:36.684748Z","caller":"traceutil/trace.go:171","msg":"trace[720005875] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"1.055558168s","start":"2026-02-26T21:50:35.629179Z","end":"2026-02-26T21:50:36.684738Z","steps":["trace[720005875] 'process raft request' (duration: 1.054262672s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:50:36.684872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:50:35.62915Z","time spent":"1.055631141s","remote":"127.0.0.1:54780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T21:50:36.684949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"607.630836ms","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-26T21:50:36.685027Z","caller":"traceutil/trace.go:171","msg":"trace[829627289] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:528; }","duration":"607.767271ms","start":"2026-02-26T21:50:36.077242Z","end":"2026-02-26T21:50:36.685009Z","steps":["trace[829627289] 'agreement among raft nodes before linearized reading' (duration: 607.644037ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:50:36.685074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:50:36.077215Z","time spent":"607.852842ms","remote":"127.0.0.1:54780","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-26T21:50:36.685097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.521245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T21:50:36.685155Z","caller":"traceutil/trace.go:171","msg":"trace[251229600] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:528; }","duration":"423.64426ms","start":"2026-02-26T21:50:36.2615Z","end":"2026-02-26T21:50:36.685144Z","steps":["trace[251229600] 'agreement among raft nodes before linearized reading' (duration: 423.556697ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:50:36.685238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:50:36.261471Z","time spent":"423.759812ms","remote":"127.0.0.1:54466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-26T21:50:36.685623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"866.288477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.244\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-26T21:50:36.685668Z","caller":"traceutil/trace.go:171","msg":"trace[345696679] range","detail":"{range_begin:/registry/masterleases/199.204.45.244; range_end:; response_count:1; response_revision:528; }","duration":"866.334249ms","start":"2026-02-26T21:50:35.819325Z","end":"2026-02-26T21:50:36.685659Z","steps":["trace[345696679] 'agreement among raft nodes before linearized reading' (duration: 865.6648ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:50:36.685688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:50:35.819238Z","time spent":"866.445802ms","remote":"127.0.0.1:54504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.244\" "} {"level":"warn","ts":"2026-02-26T21:50:43.229268Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9142197962112602327,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-26T21:50:43.729972Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9142197962112602327,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-26T21:50:43.843548Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.119200056s","expected-duration":"1s"} {"level":"info","ts":"2026-02-26T21:50:43.844108Z","caller":"traceutil/trace.go:171","msg":"trace[968929072] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"1.119894494s","start":"2026-02-26T21:50:42.724186Z","end":"2026-02-26T21:50:43.84408Z","steps":["trace[968929072] 'process raft request' (duration: 1.11974143s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:50:43.844262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:50:42.724165Z","time spent":"1.119998736s","remote":"127.0.0.1:54780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T21:50:43.87594Z","caller":"traceutil/trace.go:171","msg":"trace[65414630] linearizableReadLoop","detail":"{readStateIndex:590; appliedIndex:588; }","duration":"1.14672238s","start":"2026-02-26T21:50:42.729186Z","end":"2026-02-26T21:50:43.875908Z","steps":["trace[65414630] 'read index received' (duration: 1.114718937s)","trace[65414630] 'applied index is now lower than readState.Index' (duration: 32.001893ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T21:50:43.876068Z","caller":"traceutil/trace.go:171","msg":"trace[2042505707] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"1.148373653s","start":"2026-02-26T21:50:42.727651Z","end":"2026-02-26T21:50:43.876025Z","steps":["trace[2042505707] 'process raft request' (duration: 1.148061614s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:50:43.876198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.146986017s","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-26T21:50:43.876251Z","caller":"traceutil/trace.go:171","msg":"trace[1599897187] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:569; }","duration":"1.14713121s","start":"2026-02-26T21:50:42.729109Z","end":"2026-02-26T21:50:43.87624Z","steps":["trace[1599897187] 'agreement among raft nodes before linearized reading' (duration: 1.146999867s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:50:43.876291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:50:42.72908Z","time spent":"1.147202622s","remote":"127.0.0.1:54780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-26T21:50:43.876295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:50:42.727625Z","time spent":"1.148552337s","remote":"127.0.0.1:54780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T21:50:43.876352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"653.874247ms","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-26T21:50:43.876416Z","caller":"traceutil/trace.go:171","msg":"trace[1969516748] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:569; }","duration":"653.99488ms","start":"2026-02-26T21:50:43.222406Z","end":"2026-02-26T21:50:43.8764Z","steps":["trace[1969516748] 'agreement among raft nodes before linearized reading' (duration: 653.868907ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:50:43.876389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"615.016718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-26T21:50:43.876453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:50:43.222381Z","time spent":"654.063561ms","remote":"127.0.0.1:54780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-26T21:50:43.876443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.015204399s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-hgcxp\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-02-26T21:50:43.876488Z","caller":"traceutil/trace.go:171","msg":"trace[1097369159] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:569; }","duration":"615.196202ms","start":"2026-02-26T21:50:43.261268Z","end":"2026-02-26T21:50:43.876464Z","steps":["trace[1097369159] 'agreement among raft nodes before linearized reading' (duration: 615.002717ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:50:43.876555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:50:43.261241Z","time spent":"615.305025ms","remote":"127.0.0.1:54466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-26T21:50:43.876559Z","caller":"traceutil/trace.go:171","msg":"trace[159760936] range","detail":"{range_begin:/registry/pods/kube-system/cilium-hgcxp; range_end:; response_count:1; response_revision:569; }","duration":"1.015380903s","start":"2026-02-26T21:50:42.861148Z","end":"2026-02-26T21:50:43.876529Z","steps":["trace[159760936] 'agreement among raft nodes before linearized reading' (duration: 1.015054925s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:50:43.87665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:50:42.861111Z","time spent":"1.015503957s","remote":"127.0.0.1:54680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16987,"request content":"key:\"/registry/pods/kube-system/cilium-hgcxp\" "} {"level":"info","ts":"2026-02-26T21:50:43.985366Z","caller":"traceutil/trace.go:171","msg":"trace[1279375263] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"103.464318ms","start":"2026-02-26T21:50:43.881843Z","end":"2026-02-26T21:50:43.985307Z","steps":["trace[1279375263] 'process raft request' (duration: 103.171791ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:50:44.845632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"584.046354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T21:50:44.845751Z","caller":"traceutil/trace.go:171","msg":"trace[1375126291] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:572; }","duration":"584.231349ms","start":"2026-02-26T21:50:44.261493Z","end":"2026-02-26T21:50:44.845724Z","steps":["trace[1375126291] 'range keys from in-memory index tree' (duration: 583.907201ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:50:44.845796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:50:44.261457Z","time spent":"584.329522ms","remote":"127.0.0.1:54466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-26T21:50:46.349499Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9142197962112602339,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-26T21:50:46.850183Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9142197962112602339,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-26T21:50:47.351337Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9142197962112602339,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-26T21:50:47.369489Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.548379497s","expected-duration":"1s"} {"level":"info","ts":"2026-02-26T21:50:47.36993Z","caller":"traceutil/trace.go:171","msg":"trace[691788658] linearizableReadLoop","detail":"{readStateIndex:594; appliedIndex:593; }","duration":"1.521018979s","start":"2026-02-26T21:50:45.848878Z","end":"2026-02-26T21:50:47.369897Z","steps":["trace[691788658] 'read index received' (duration: 1.520798533s)","trace[691788658] 'applied index is now lower than readState.Index' (duration: 218.456µs)"],"step_count":2} {"level":"warn","ts":"2026-02-26T21:50:47.369969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:50:45.820939Z","time spent":"1.549023552s","remote":"127.0.0.1:54504","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-02-26T21:50:47.370165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.521255705s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-26T21:50:47.370239Z","caller":"traceutil/trace.go:171","msg":"trace[750975407] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:572; }","duration":"1.521399789s","start":"2026-02-26T21:50:45.848821Z","end":"2026-02-26T21:50:47.370221Z","steps":["trace[750975407] 'agreement among raft nodes before linearized reading' (duration: 1.521228925s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:50:47.370242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.290181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-26T21:50:47.3703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:50:45.848799Z","time spent":"1.52148723s","remote":"127.0.0.1:54780","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-26T21:50:47.370333Z","caller":"traceutil/trace.go:171","msg":"trace[85054086] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:572; }","duration":"111.422084ms","start":"2026-02-26T21:50:47.258895Z","end":"2026-02-26T21:50:47.370317Z","steps":["trace[85054086] 'agreement among raft nodes before linearized reading' (duration: 111.318762ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:50:47.370179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.488060169s","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-26T21:50:47.370491Z","caller":"traceutil/trace.go:171","msg":"trace[265804347] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:572; }","duration":"1.488411228s","start":"2026-02-26T21:50:45.882054Z","end":"2026-02-26T21:50:47.370465Z","steps":["trace[265804347] 'agreement among raft nodes before linearized reading' (duration: 1.488036289s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:50:47.370582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:50:45.882028Z","time spent":"1.48851132s","remote":"127.0.0.1:54780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-26T21:50:47.37077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.380204132s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-02-26T21:50:47.37082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.473141128s","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-26T21:50:47.370854Z","caller":"traceutil/trace.go:171","msg":"trace[1965445174] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:572; }","duration":"1.473227691s","start":"2026-02-26T21:50:45.897616Z","end":"2026-02-26T21:50:47.370844Z","steps":["trace[1965445174] 'agreement among raft nodes before linearized reading' (duration: 1.473071337s)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:50:47.370829Z","caller":"traceutil/trace.go:171","msg":"trace[1383493563] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:572; }","duration":"1.380340805s","start":"2026-02-26T21:50:45.990472Z","end":"2026-02-26T21:50:47.370813Z","steps":["trace[1383493563] 'agreement among raft nodes before linearized reading' (duration: 1.380202382s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:50:47.370889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:50:45.89759Z","time spent":"1.473292533s","remote":"127.0.0.1:54780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-26T21:50:47.37092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:50:45.990448Z","time spent":"1.380454188s","remote":"127.0.0.1:54780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-26T21:50:47.737233Z","caller":"traceutil/trace.go:171","msg":"trace[1055129850] linearizableReadLoop","detail":"{readStateIndex:595; appliedIndex:594; }","duration":"363.960474ms","start":"2026-02-26T21:50:47.37324Z","end":"2026-02-26T21:50:47.737201Z","steps":["trace[1055129850] 'read index received' (duration: 362.057276ms)","trace[1055129850] 'applied index is now lower than readState.Index' (duration: 1.901868ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T21:50:47.7374Z","caller":"traceutil/trace.go:171","msg":"trace[967156931] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"365.214484ms","start":"2026-02-26T21:50:47.372117Z","end":"2026-02-26T21:50:47.737332Z","steps":["trace[967156931] 'process raft request' (duration: 363.185683ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:50:47.737486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.24452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T21:50:47.737565Z","caller":"traceutil/trace.go:171","msg":"trace[1524238667] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:573; }","duration":"364.361623ms","start":"2026-02-26T21:50:47.373187Z","end":"2026-02-26T21:50:47.737548Z","steps":["trace[1524238667] 'agreement among raft nodes before linearized reading' (duration: 364.191689ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:50:47.737604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:50:47.373164Z","time spent":"364.433455ms","remote":"127.0.0.1:54482","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-26T21:50:47.737622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:50:47.372085Z","time spent":"365.419349ms","remote":"127.0.0.1:54504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T21:50:48.100256Z","caller":"traceutil/trace.go:171","msg":"trace[810744264] linearizableReadLoop","detail":"{readStateIndex:599; appliedIndex:595; }","duration":"360.089292ms","start":"2026-02-26T21:50:47.740093Z","end":"2026-02-26T21:50:48.100182Z","steps":["trace[810744264] 'read index received' (duration: 358.75275ms)","trace[810744264] 'applied index is now lower than readState.Index' (duration: 1.335192ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T21:50:48.100527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.418882ms","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-26T21:50:48.100561Z","caller":"traceutil/trace.go:171","msg":"trace[1272851450] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:577; }","duration":"360.509894ms","start":"2026-02-26T21:50:47.740034Z","end":"2026-02-26T21:50:48.100544Z","steps":["trace[1272851450] 'agreement among raft nodes before linearized reading' (duration: 360.296969ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:50:48.100587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:50:47.740012Z","time spent":"360.568685ms","remote":"127.0.0.1:54654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":444,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "} {"level":"info","ts":"2026-02-26T21:50:48.101006Z","caller":"traceutil/trace.go:171","msg":"trace[1579065832] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"725.080042ms","start":"2026-02-26T21:50:47.375911Z","end":"2026-02-26T21:50:48.100991Z","steps":["trace[1579065832] 'process raft request' (duration: 722.895118ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:50:48.101083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:50:47.375879Z","time spent":"725.141884ms","remote":"127.0.0.1:54780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T21:50:48.101192Z","caller":"traceutil/trace.go:171","msg":"trace[1558565527] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"725.157334ms","start":"2026-02-26T21:50:47.376024Z","end":"2026-02-26T21:50:48.101181Z","steps":["trace[1558565527] 'process raft request' (duration: 724.041045ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:50:48.101233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:50:47.376016Z","time spent":"725.194455ms","remote":"127.0.0.1:54780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T21:50:48.101579Z","caller":"traceutil/trace.go:171","msg":"trace[1253235524] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"725.482522ms","start":"2026-02-26T21:50:47.376078Z","end":"2026-02-26T21:50:48.10156Z","steps":["trace[1253235524] 'process raft request' (duration: 724.040426ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:50:48.101626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:50:47.37607Z","time spent":"725.524523ms","remote":"127.0.0.1:54780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T21:50:48.101772Z","caller":"traceutil/trace.go:171","msg":"trace[52000181] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"725.463702ms","start":"2026-02-26T21:50:47.376296Z","end":"2026-02-26T21:50:48.10176Z","steps":["trace[52000181] 'process raft request' (duration: 723.851991ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:50:48.101802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:50:47.376288Z","time spent":"725.495932ms","remote":"127.0.0.1:54780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T21:50:49.49499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.523823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T21:50:49.495074Z","caller":"traceutil/trace.go:171","msg":"trace[2069044830] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:583; }","duration":"233.672347ms","start":"2026-02-26T21:50:49.261382Z","end":"2026-02-26T21:50:49.495054Z","steps":["trace[2069044830] 'range keys from in-memory index tree' (duration: 233.414611ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:50:50.172887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.92356ms","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-26T21:50:50.173076Z","caller":"traceutil/trace.go:171","msg":"trace[1712854350] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:603; }","duration":"136.151466ms","start":"2026-02-26T21:50:50.036902Z","end":"2026-02-26T21:50:50.173053Z","steps":["trace[1712854350] 'range keys from in-memory index tree' (duration: 135.89449ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:52:25.015363Z","caller":"traceutil/trace.go:171","msg":"trace[1818738735] linearizableReadLoop","detail":"{readStateIndex:1079; appliedIndex:1078; }","duration":"280.531723ms","start":"2026-02-26T21:52:24.734801Z","end":"2026-02-26T21:52:25.015333Z","steps":["trace[1818738735] 'read index received' (duration: 280.28153ms)","trace[1818738735] 'applied index is now lower than readState.Index' (duration: 248.873µs)"],"step_count":2} {"level":"info","ts":"2026-02-26T21:52:25.015497Z","caller":"traceutil/trace.go:171","msg":"trace[2052037623] transaction","detail":"{read_only:false; response_revision:1033; number_of_response:1; }","duration":"295.034471ms","start":"2026-02-26T21:52:24.720423Z","end":"2026-02-26T21:52:25.015458Z","steps":["trace[2052037623] 'process raft request' (duration: 294.686467ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:52:25.015706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.865798ms","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-26T21:52:25.015757Z","caller":"traceutil/trace.go:171","msg":"trace[1200927926] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1033; }","duration":"280.993499ms","start":"2026-02-26T21:52:24.734753Z","end":"2026-02-26T21:52:25.015746Z","steps":["trace[1200927926] 'agreement among raft nodes before linearized reading' (duration: 280.771936ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:52:25.606652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"646.273107ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-26T21:52:25.606744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"865.903217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-02-26T21:52:25.606924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"869.109319ms","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-26T21:52:25.607164Z","caller":"traceutil/trace.go:171","msg":"trace[388455185] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1033; }","duration":"866.304333ms","start":"2026-02-26T21:52:24.740792Z","end":"2026-02-26T21:52:25.607096Z","steps":["trace[388455185] 'agreement among raft nodes before linearized reading' (duration: 274.97433ms)","trace[388455185] 'range keys from in-memory index tree' (duration: 590.746424ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T21:52:25.607231Z","caller":"traceutil/trace.go:171","msg":"trace[81910926] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1033; }","duration":"869.446074ms","start":"2026-02-26T21:52:24.737753Z","end":"2026-02-26T21:52:25.607199Z","steps":["trace[81910926] 'agreement among raft nodes before linearized reading' (duration: 278.04285ms)","trace[81910926] 'range keys from in-memory index tree' (duration: 590.754584ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T21:52:25.608344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:52:24.73772Z","time spent":"870.588478ms","remote":"127.0.0.1:54780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-26T21:52:25.607387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:52:24.740768Z","time spent":"866.516857ms","remote":"127.0.0.1:54780","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-26T21:52:25.607565Z","caller":"traceutil/trace.go:171","msg":"trace[1019629495] linearizableReadLoop","detail":"{readStateIndex:1080; appliedIndex:1079; }","duration":"346.071331ms","start":"2026-02-26T21:52:25.261478Z","end":"2026-02-26T21:52:25.607549Z","steps":["trace[1019629495] 'read index received' (duration: 263.271236ms)","trace[1019629495] 'applied index is now lower than readState.Index' (duration: 82.798695ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T21:52:25.607632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.163272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T21:52:25.607679Z","caller":"traceutil/trace.go:171","msg":"trace[1162034714] transaction","detail":"{read_only:false; response_revision:1034; number_of_response:1; }","duration":"586.572501ms","start":"2026-02-26T21:52:25.021094Z","end":"2026-02-26T21:52:25.607667Z","steps":["trace[1162034714] 'process raft request' (duration: 503.639805ms)","trace[1162034714] 'compare' (duration: 82.081845ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T21:52:25.60766Z","caller":"traceutil/trace.go:171","msg":"trace[823838763] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:1033; }","duration":"646.646082ms","start":"2026-02-26T21:52:24.960325Z","end":"2026-02-26T21:52:25.606971Z","steps":["trace[823838763] 'agreement among raft nodes before linearized reading' (duration: 55.442151ms)","trace[823838763] 'count revisions from in-memory index tree' (duration: 590.798676ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T21:52:25.608947Z","caller":"traceutil/trace.go:171","msg":"trace[75475401] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1034; }","duration":"347.494809ms","start":"2026-02-26T21:52:25.261406Z","end":"2026-02-26T21:52:25.6089Z","steps":["trace[75475401] 'agreement among raft nodes before linearized reading' (duration: 346.186552ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:52:25.609625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:52:25.261376Z","time spent":"348.241618ms","remote":"127.0.0.1:54466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-26T21:52:25.60953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:52:25.021072Z","time spent":"588.374474ms","remote":"127.0.0.1:54780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T21:52:25.609562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:52:24.960237Z","time spent":"649.290986ms","remote":"127.0.0.1:55042","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":27,"request content":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true "}