{"level":"warn","ts":"2026-02-27T20:25:39.330563Z","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-27T20:25:39.330693Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.67: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.67:2380","--initial-cluster=instance=https://199.204.45.67:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.67:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.67: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-27T20:25:39.330794Z","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-27T20:25:39.330811Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.67:2380"]} {"level":"info","ts":"2026-02-27T20:25:39.33084Z","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-27T20:25:39.332149Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.67:2379"]} {"level":"info","ts":"2026-02-27T20:25:39.332283Z","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.67:2380"],"listen-peer-urls":["https://199.204.45.67:2380"],"advertise-client-urls":["https://199.204.45.67:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.67:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.67: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-27T20:25:39.337689Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.937508ms"} {"level":"info","ts":"2026-02-27T20:25:39.346747Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"cddd08233fdda28a","cluster-id":"72e3bf4964adc703"} {"level":"info","ts":"2026-02-27T20:25:39.346848Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cddd08233fdda28a switched to configuration voters=()"} {"level":"info","ts":"2026-02-27T20:25:39.346893Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cddd08233fdda28a became follower at term 0"} {"level":"info","ts":"2026-02-27T20:25:39.346938Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft cddd08233fdda28a [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-27T20:25:39.346966Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cddd08233fdda28a became follower at term 1"} {"level":"info","ts":"2026-02-27T20:25:39.347059Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cddd08233fdda28a switched to configuration voters=(14834021695116649098)"} {"level":"warn","ts":"2026-02-27T20:25:39.354679Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-27T20:25:39.356043Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-27T20:25:39.357172Z","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-27T20:25:39.359655Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"cddd08233fdda28a","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-27T20:25:39.359804Z","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-27T20:25:39.359881Z","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-27T20:25:39.359892Z","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-27T20:25:39.360066Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"cddd08233fdda28a","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-27T20:25:39.360776Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cddd08233fdda28a switched to configuration voters=(14834021695116649098)"} {"level":"info","ts":"2026-02-27T20:25:39.361262Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"72e3bf4964adc703","local-member-id":"cddd08233fdda28a","added-peer-id":"cddd08233fdda28a","added-peer-peer-urls":["https://199.204.45.67:2380"]} {"level":"info","ts":"2026-02-27T20:25:39.363822Z","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-27T20:25:39.363959Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.67:2380"} {"level":"info","ts":"2026-02-27T20:25:39.364014Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.67:2380"} {"level":"info","ts":"2026-02-27T20:25:39.364135Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"cddd08233fdda28a","initial-advertise-peer-urls":["https://199.204.45.67:2380"],"listen-peer-urls":["https://199.204.45.67:2380"],"advertise-client-urls":["https://199.204.45.67:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.67:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-27T20:25:39.36419Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-27T20:25:40.048126Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cddd08233fdda28a is starting a new election at term 1"} {"level":"info","ts":"2026-02-27T20:25:40.048179Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cddd08233fdda28a became pre-candidate at term 1"} {"level":"info","ts":"2026-02-27T20:25:40.048211Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cddd08233fdda28a received MsgPreVoteResp from cddd08233fdda28a at term 1"} {"level":"info","ts":"2026-02-27T20:25:40.048229Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cddd08233fdda28a became candidate at term 2"} {"level":"info","ts":"2026-02-27T20:25:40.04824Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cddd08233fdda28a received MsgVoteResp from cddd08233fdda28a at term 2"} {"level":"info","ts":"2026-02-27T20:25:40.048255Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cddd08233fdda28a became leader at term 2"} {"level":"info","ts":"2026-02-27T20:25:40.048274Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: cddd08233fdda28a elected leader cddd08233fdda28a at term 2"} {"level":"info","ts":"2026-02-27T20:25:40.194626Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-27T20:25:40.34013Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"cddd08233fdda28a","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.67:2379]}","request-path":"/0/members/cddd08233fdda28a/attributes","cluster-id":"72e3bf4964adc703","publish-timeout":"7s"} {"level":"info","ts":"2026-02-27T20:25:40.340132Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-27T20:25:40.340157Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-27T20:25:40.340602Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-27T20:25:40.340631Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-27T20:25:40.34108Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"72e3bf4964adc703","local-member-id":"cddd08233fdda28a","cluster-version":"3.5"} {"level":"info","ts":"2026-02-27T20:25:40.341306Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-27T20:25:40.341371Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-27T20:25:40.344129Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.67:2379"} {"level":"info","ts":"2026-02-27T20:25:40.345178Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-27T20:25:41.949934Z","caller":"traceutil/trace.go:171","msg":"trace[788278726] linearizableReadLoop","detail":"{readStateIndex:5; appliedIndex:4; }","duration":"356.349336ms","start":"2026-02-27T20:25:41.593556Z","end":"2026-02-27T20:25:41.949906Z","steps":["trace[788278726] 'read index received' (duration: 356.180204ms)","trace[788278726] 'applied index is now lower than readState.Index' (duration: 167.872µs)"],"step_count":2} {"level":"info","ts":"2026-02-27T20:25:41.950005Z","caller":"traceutil/trace.go:171","msg":"trace[456519081] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"358.549767ms","start":"2026-02-27T20:25:41.591422Z","end":"2026-02-27T20:25:41.949972Z","steps":["trace[456519081] 'process raft request' (duration: 358.284334ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:25:41.95018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.590448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-27T20:25:41.950288Z","caller":"traceutil/trace.go:171","msg":"trace[1448544700] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:2; }","duration":"356.730239ms","start":"2026-02-27T20:25:41.593543Z","end":"2026-02-27T20:25:41.950273Z","steps":["trace[1448544700] 'agreement among raft nodes before linearized reading' (duration: 356.505167ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:25:41.950332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:25:41.593538Z","time spent":"356.78133ms","remote":"127.0.0.1:33806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":27,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"warn","ts":"2026-02-27T20:25:41.95081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:25:41.591401Z","time spent":"358.674908ms","remote":"127.0.0.1:33478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":100,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-27T20:25:42.450947Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11712345995282158460,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-27T20:25:42.45153Z","caller":"traceutil/trace.go:171","msg":"trace[2059425194] linearizableReadLoop","detail":"{readStateIndex:13; appliedIndex:5; }","duration":"501.483768ms","start":"2026-02-27T20:25:41.950024Z","end":"2026-02-27T20:25:42.451508Z","steps":["trace[2059425194] 'read index received' (duration: 501.126165ms)","trace[2059425194] 'applied index is now lower than readState.Index' (duration: 356.543µs)"],"step_count":2} {"level":"info","ts":"2026-02-27T20:25:42.451803Z","caller":"traceutil/trace.go:171","msg":"trace[398027412] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"778.32896ms","start":"2026-02-27T20:25:41.673441Z","end":"2026-02-27T20:25:42.45177Z","steps":["trace[398027412] 'process raft request' (duration: 777.918577ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:25:42.451937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"780.512231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.67\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-27T20:25:42.451963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"806.157156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-27T20:25:42.45204Z","caller":"traceutil/trace.go:171","msg":"trace[953340671] range","detail":"{range_begin:/registry/masterleases/199.204.45.67; range_end:; response_count:0; response_revision:10; }","duration":"780.656212ms","start":"2026-02-27T20:25:41.671363Z","end":"2026-02-27T20:25:42.452019Z","steps":["trace[953340671] 'agreement among raft nodes before linearized reading' (duration: 780.328389ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:25:42.452022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"499.105665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3170"} {"level":"warn","ts":"2026-02-27T20:25:42.452066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"778.858655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-27T20:25:42.452063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"727.862575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-27T20:25:42.452094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:25:41.671349Z","time spent":"780.735293ms","remote":"127.0.0.1:33452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":0,"response size":27,"request content":"key:\"/registry/masterleases/199.204.45.67\" "} {"level":"info","ts":"2026-02-27T20:25:42.452113Z","caller":"traceutil/trace.go:171","msg":"trace[283408295] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:10; }","duration":"778.931556ms","start":"2026-02-27T20:25:41.673167Z","end":"2026-02-27T20:25:42.452098Z","steps":["trace[283408295] 'agreement among raft nodes before linearized reading' (duration: 778.840125ms)"],"step_count":1} {"level":"info","ts":"2026-02-27T20:25:42.452115Z","caller":"traceutil/trace.go:171","msg":"trace[1743707462] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:10; }","duration":"499.257507ms","start":"2026-02-27T20:25:41.952834Z","end":"2026-02-27T20:25:42.452091Z","steps":["trace[1743707462] 'agreement among raft nodes before linearized reading' (duration: 499.055545ms)"],"step_count":1} {"level":"info","ts":"2026-02-27T20:25:42.452138Z","caller":"traceutil/trace.go:171","msg":"trace[1237309639] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"727.942596ms","start":"2026-02-27T20:25:41.724173Z","end":"2026-02-27T20:25:42.452116Z","steps":["trace[1237309639] 'agreement among raft nodes before linearized reading' (duration: 727.794614ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:25:42.452147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:25:41.673159Z","time spent":"778.981116ms","remote":"127.0.0.1:33508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"warn","ts":"2026-02-27T20:25:42.452161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:25:41.952815Z","time spent":"499.337827ms","remote":"127.0.0.1:33580","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3193,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-02-27T20:25:42.452183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:25:41.724156Z","time spent":"728.016466ms","remote":"127.0.0.1:33528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-02-27T20:25:42.452238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"854.470141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-27T20:25:42.452302Z","caller":"traceutil/trace.go:171","msg":"trace[844771136] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:10; }","duration":"854.561361ms","start":"2026-02-27T20:25:41.597726Z","end":"2026-02-27T20:25:42.452288Z","steps":["trace[844771136] 'agreement among raft nodes before linearized reading' (duration: 854.42464ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:25:42.452337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:25:41.597721Z","time spent":"854.609502ms","remote":"127.0.0.1:33602","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":27,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" "} {"level":"info","ts":"2026-02-27T20:25:42.452283Z","caller":"traceutil/trace.go:171","msg":"trace[110905935] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"778.652303ms","start":"2026-02-27T20:25:41.673463Z","end":"2026-02-27T20:25:42.452115Z","steps":["trace[110905935] 'process raft request' (duration: 777.918336ms)"],"step_count":1} {"level":"info","ts":"2026-02-27T20:25:42.452041Z","caller":"traceutil/trace.go:171","msg":"trace[761444184] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"806.366488ms","start":"2026-02-27T20:25:41.645658Z","end":"2026-02-27T20:25:42.452024Z","steps":["trace[761444184] 'agreement among raft nodes before linearized reading' (duration: 806.107645ms)"],"step_count":1} {"level":"info","ts":"2026-02-27T20:25:42.452431Z","caller":"traceutil/trace.go:171","msg":"trace[33794137] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"763.086564ms","start":"2026-02-27T20:25:41.689329Z","end":"2026-02-27T20:25:42.452416Z","steps":["trace[33794137] 'process raft request' (duration: 762.144085ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:25:42.452491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:25:41.645641Z","time spent":"806.818793ms","remote":"127.0.0.1:33528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-02-27T20:25:42.452505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:25:41.689316Z","time spent":"763.153034ms","remote":"127.0.0.1:33580","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3158,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-27T20:25:42.452518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"779.37326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-27T20:25:42.452557Z","caller":"traceutil/trace.go:171","msg":"trace[296042122] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"779.436081ms","start":"2026-02-27T20:25:41.673109Z","end":"2026-02-27T20:25:42.452545Z","steps":["trace[296042122] 'agreement among raft nodes before linearized reading' (duration: 779.37915ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:25:42.452588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:25:41.673099Z","time spent":"779.480821ms","remote":"127.0.0.1:33528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-02-27T20:25:42.452598Z","caller":"traceutil/trace.go:171","msg":"trace[838053750] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"779.316199ms","start":"2026-02-27T20:25:41.673271Z","end":"2026-02-27T20:25:42.452587Z","steps":["trace[838053750] 'process raft request' (duration: 777.937026ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:25:42.452554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"715.89762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-27T20:25:42.452655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:25:41.673261Z","time spent":"779.36811ms","remote":"127.0.0.1:33858","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-27T20:25:42.452661Z","caller":"traceutil/trace.go:171","msg":"trace[1896925695] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:10; }","duration":"716.025021ms","start":"2026-02-27T20:25:41.736624Z","end":"2026-02-27T20:25:42.452649Z","steps":["trace[1896925695] 'agreement among raft nodes before linearized reading' (duration: 715.90995ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:25:42.452696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:25:41.73661Z","time spent":"716.076531ms","remote":"127.0.0.1:33528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":30,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/default\" "} {"level":"warn","ts":"2026-02-27T20:25:42.452431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"858.766143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3170"} {"level":"info","ts":"2026-02-27T20:25:42.452802Z","caller":"traceutil/trace.go:171","msg":"trace[1418087120] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"779.39103ms","start":"2026-02-27T20:25:41.6734Z","end":"2026-02-27T20:25:42.452791Z","steps":["trace[1418087120] 'process raft request' (duration: 777.926356ms)"],"step_count":1} {"level":"info","ts":"2026-02-27T20:25:42.452805Z","caller":"traceutil/trace.go:171","msg":"trace[1635337964] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:10; }","duration":"859.152666ms","start":"2026-02-27T20:25:41.593639Z","end":"2026-02-27T20:25:42.452791Z","steps":["trace[1635337964] 'agreement among raft nodes before linearized reading' (duration: 858.762453ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:25:42.452845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:25:41.593626Z","time spent":"859.208237ms","remote":"127.0.0.1:33580","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3193,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-02-27T20:25:42.452926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:25:41.673347Z","time spent":"779.482121ms","remote":"127.0.0.1:33942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-27T20:25:42.45319Z","caller":"traceutil/trace.go:171","msg":"trace[1642492276] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"767.88299ms","start":"2026-02-27T20:25:41.685265Z","end":"2026-02-27T20:25:42.453148Z","steps":["trace[1642492276] 'process raft request' (duration: 766.182273ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:25:42.453261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:25:41.685248Z","time spent":"767.97274ms","remote":"127.0.0.1:33666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-27T20:25:42.453377Z","caller":"traceutil/trace.go:171","msg":"trace[1709192969] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"779.688563ms","start":"2026-02-27T20:25:41.673676Z","end":"2026-02-27T20:25:42.453365Z","steps":["trace[1709192969] 'process raft request' (duration: 777.748184ms)"],"step_count":1} {"level":"info","ts":"2026-02-27T20:25:42.453432Z","caller":"traceutil/trace.go:171","msg":"trace[225363539] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"779.801694ms","start":"2026-02-27T20:25:41.673619Z","end":"2026-02-27T20:25:42.453421Z","steps":["trace[225363539] 'process raft request' (duration: 777.783175ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:25:42.453446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:25:41.673671Z","time spent":"779.735443ms","remote":"127.0.0.1:33942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-27T20:25:42.453486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:25:41.673589Z","time spent":"779.868455ms","remote":"127.0.0.1:33942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-27T20:25:42.45196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:25:41.673409Z","time spent":"778.459811ms","remote":"127.0.0.1:33942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-27T20:25:42.454799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:25:41.673456Z","time spent":"778.922095ms","remote":"127.0.0.1:33942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-27T20:25:46.581432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.384005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/expand-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-27T20:25:46.581549Z","caller":"traceutil/trace.go:171","msg":"trace[160903675] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/expand-controller; range_end:; response_count:0; response_revision:316; }","duration":"105.569426ms","start":"2026-02-27T20:25:46.475951Z","end":"2026-02-27T20:25:46.581521Z","steps":["trace[160903675] 'range keys from in-memory index tree' (duration: 105.210523ms)"],"step_count":1} {"level":"info","ts":"2026-02-27T20:25:47.601277Z","caller":"traceutil/trace.go:171","msg":"trace[1068834595] transaction","detail":"{read_only:false; response_revision:325; number_of_response:1; }","duration":"174.807595ms","start":"2026-02-27T20:25:47.426447Z","end":"2026-02-27T20:25:47.601255Z","steps":["trace[1068834595] 'process raft request' (duration: 174.678904ms)"],"step_count":1} {"level":"info","ts":"2026-02-27T20:25:49.421247Z","caller":"traceutil/trace.go:171","msg":"trace[1230056465] transaction","detail":"{read_only:false; response_revision:339; number_of_response:1; }","duration":"178.711082ms","start":"2026-02-27T20:25:49.242477Z","end":"2026-02-27T20:25:49.421188Z","steps":["trace[1230056465] 'process raft request' (duration: 178.428039ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:25:49.421414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.588348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cronjob-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-27T20:25:49.421494Z","caller":"traceutil/trace.go:171","msg":"trace[1270028492] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cronjob-controller; range_end:; response_count:0; response_revision:339; }","duration":"144.700338ms","start":"2026-02-27T20:25:49.276772Z","end":"2026-02-27T20:25:49.421472Z","steps":["trace[1270028492] 'agreement among raft nodes before linearized reading' (duration: 144.558847ms)"],"step_count":1} {"level":"info","ts":"2026-02-27T20:25:49.421705Z","caller":"traceutil/trace.go:171","msg":"trace[2045425069] linearizableReadLoop","detail":"{readStateIndex:352; appliedIndex:351; }","duration":"144.86973ms","start":"2026-02-27T20:25:49.276805Z","end":"2026-02-27T20:25:49.421675Z","steps":["trace[2045425069] 'read index received' (duration: 144.029533ms)","trace[2045425069] 'applied index is now lower than readState.Index' (duration: 287.822µs)"],"step_count":2} {"level":"info","ts":"2026-02-27T20:25:49.554728Z","caller":"traceutil/trace.go:171","msg":"trace[2005874277] transaction","detail":"{read_only:false; response_revision:340; number_of_response:1; }","duration":"127.372495ms","start":"2026-02-27T20:25:49.427303Z","end":"2026-02-27T20:25:49.554676Z","steps":["trace[2005874277] 'process raft request' (duration: 109.157952ms)","trace[2005874277] 'compare' (duration: 17.988231ms)"],"step_count":2} {"level":"info","ts":"2026-02-27T20:25:49.828215Z","caller":"traceutil/trace.go:171","msg":"trace[1489925558] linearizableReadLoop","detail":"{readStateIndex:357; appliedIndex:356; }","duration":"151.904573ms","start":"2026-02-27T20:25:49.676267Z","end":"2026-02-27T20:25:49.828171Z","steps":["trace[1489925558] 'read index received' (duration: 151.764611ms)","trace[1489925558] 'applied index is now lower than readState.Index' (duration: 138.492µs)"],"step_count":2} {"level":"warn","ts":"2026-02-27T20:25:49.828418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.113305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-02-27T20:25:49.828462Z","caller":"traceutil/trace.go:171","msg":"trace[25526468] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:344; }","duration":"152.220995ms","start":"2026-02-27T20:25:49.67623Z","end":"2026-02-27T20:25:49.828451Z","steps":["trace[25526468] 'agreement among raft nodes before linearized reading' (duration: 152.076504ms)"],"step_count":1} {"level":"info","ts":"2026-02-27T20:25:49.828593Z","caller":"traceutil/trace.go:171","msg":"trace[1777775482] transaction","detail":"{read_only:false; response_revision:344; number_of_response:1; }","duration":"169.002795ms","start":"2026-02-27T20:25:49.659336Z","end":"2026-02-27T20:25:49.828339Z","steps":["trace[1777775482] 'process raft request' (duration: 168.691972ms)"],"step_count":1} {"level":"info","ts":"2026-02-27T20:25:49.943607Z","caller":"traceutil/trace.go:171","msg":"trace[2005913664] linearizableReadLoop","detail":"{readStateIndex:358; appliedIndex:357; }","duration":"115.293427ms","start":"2026-02-27T20:25:49.828281Z","end":"2026-02-27T20:25:49.943575Z","steps":["trace[2005913664] 'read index received' (duration: 61.666179ms)","trace[2005913664] 'applied index is now lower than readState.Index' (duration: 53.625988ms)"],"step_count":2} {"level":"info","ts":"2026-02-27T20:25:49.943678Z","caller":"traceutil/trace.go:171","msg":"trace[1069140396] transaction","detail":"{read_only:false; response_revision:345; number_of_response:1; }","duration":"206.934533ms","start":"2026-02-27T20:25:49.736713Z","end":"2026-02-27T20:25:49.943648Z","steps":["trace[1069140396] 'process raft request' (duration: 153.332446ms)","trace[1069140396] 'compare' (duration: 53.378615ms)"],"step_count":2} {"level":"warn","ts":"2026-02-27T20:25:49.943931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.432901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-02-27T20:25:49.944016Z","caller":"traceutil/trace.go:171","msg":"trace[1848355273] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:345; }","duration":"167.581192ms","start":"2026-02-27T20:25:49.776385Z","end":"2026-02-27T20:25:49.943967Z","steps":["trace[1848355273] 'agreement among raft nodes before linearized reading' (duration: 167.34902ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:25:49.943999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.370658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"warn","ts":"2026-02-27T20:25:49.944041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.967003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"info","ts":"2026-02-27T20:25:49.944084Z","caller":"traceutil/trace.go:171","msg":"trace[663278068] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:345; }","duration":"115.533499ms","start":"2026-02-27T20:25:49.828529Z","end":"2026-02-27T20:25:49.944063Z","steps":["trace[663278068] 'agreement among raft nodes before linearized reading' (duration: 115.336417ms)"],"step_count":1} {"level":"info","ts":"2026-02-27T20:25:49.944142Z","caller":"traceutil/trace.go:171","msg":"trace[678356580] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:345; }","duration":"217.133605ms","start":"2026-02-27T20:25:49.726982Z","end":"2026-02-27T20:25:49.944115Z","steps":["trace[678356580] 'agreement among raft nodes before linearized reading' (duration: 216.926943ms)"],"step_count":1} {"level":"info","ts":"2026-02-27T20:25:50.104538Z","caller":"traceutil/trace.go:171","msg":"trace[29081561] linearizableReadLoop","detail":"{readStateIndex:361; appliedIndex:359; }","duration":"127.923613ms","start":"2026-02-27T20:25:49.976578Z","end":"2026-02-27T20:25:50.104502Z","steps":["trace[29081561] 'read index received' (duration: 38.642274ms)","trace[29081561] 'applied index is now lower than readState.Index' (duration: 89.280309ms)"],"step_count":2} {"level":"info","ts":"2026-02-27T20:25:50.104585Z","caller":"traceutil/trace.go:171","msg":"trace[331968405] transaction","detail":"{read_only:false; response_revision:348; number_of_response:1; }","duration":"147.842839ms","start":"2026-02-27T20:25:49.956698Z","end":"2026-02-27T20:25:50.104541Z","steps":["trace[331968405] 'process raft request' (duration: 144.960344ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:25:50.104705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.113075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-02-27T20:25:50.104751Z","caller":"traceutil/trace.go:171","msg":"trace[643396953] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:348; }","duration":"128.198975ms","start":"2026-02-27T20:25:49.97654Z","end":"2026-02-27T20:25:50.104739Z","steps":["trace[643396953] 'agreement among raft nodes before linearized reading' (duration: 128.098144ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:25:50.337457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.668964ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-27T20:25:50.33772Z","caller":"traceutil/trace.go:171","msg":"trace[835291958] linearizableReadLoop","detail":"{readStateIndex:364; appliedIndex:362; }","duration":"105.155749ms","start":"2026-02-27T20:25:50.232541Z","end":"2026-02-27T20:25:50.337697Z","steps":["trace[835291958] 'read index received' (duration: 53.394712ms)","trace[835291958] 'applied index is now lower than readState.Index' (duration: 51.759747ms)"],"step_count":2} {"level":"info","ts":"2026-02-27T20:25:50.33766Z","caller":"traceutil/trace.go:171","msg":"trace[1262102923] transaction","detail":"{read_only:false; response_revision:350; number_of_response:1; }","duration":"133.986032ms","start":"2026-02-27T20:25:50.203647Z","end":"2026-02-27T20:25:50.337633Z","steps":["trace[1262102923] 'process raft request' (duration: 28.865294ms)","trace[1262102923] 'compare' (duration: 104.541683ms)"],"step_count":2} {"level":"warn","ts":"2026-02-27T20:25:50.337867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.32661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-02-27T20:25:50.337854Z","caller":"traceutil/trace.go:171","msg":"trace[278283553] transaction","detail":"{read_only:false; response_revision:351; number_of_response:1; }","duration":"133.817851ms","start":"2026-02-27T20:25:50.204012Z","end":"2026-02-27T20:25:50.33783Z","steps":["trace[278283553] 'process raft request' (duration: 133.573919ms)"],"step_count":1} {"level":"info","ts":"2026-02-27T20:25:50.337902Z","caller":"traceutil/trace.go:171","msg":"trace[125611024] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:351; }","duration":"105.401421ms","start":"2026-02-27T20:25:50.232492Z","end":"2026-02-27T20:25:50.337893Z","steps":["trace[125611024] 'agreement among raft nodes before linearized reading' (duration: 105.32639ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:25:50.559105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.609145ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-27T20:25:50.559384Z","caller":"traceutil/trace.go:171","msg":"trace[178964617] transaction","detail":"{read_only:false; response_revision:360; number_of_response:1; }","duration":"187.425206ms","start":"2026-02-27T20:25:50.371928Z","end":"2026-02-27T20:25:50.559353Z","steps":["trace[178964617] 'process raft request' (duration: 74.495038ms)","trace[178964617] 'compare' (duration: 112.497414ms)"],"step_count":2} {"level":"info","ts":"2026-02-27T20:25:50.559512Z","caller":"traceutil/trace.go:171","msg":"trace[1458485393] linearizableReadLoop","detail":"{readStateIndex:373; appliedIndex:365; }","duration":"187.169323ms","start":"2026-02-27T20:25:50.372315Z","end":"2026-02-27T20:25:50.559484Z","steps":["trace[1458485393] 'read index received' (duration: 55.435949ms)","trace[1458485393] 'applied index is now lower than readState.Index' (duration: 131.730724ms)"],"step_count":2} {"level":"info","ts":"2026-02-27T20:25:50.559578Z","caller":"traceutil/trace.go:171","msg":"trace[904688024] transaction","detail":"{read_only:false; response_revision:361; number_of_response:1; }","duration":"126.477527ms","start":"2026-02-27T20:25:50.433078Z","end":"2026-02-27T20:25:50.559555Z","steps":["trace[904688024] 'process raft request' (duration: 126.264206ms)"],"step_count":1} {"level":"info","ts":"2026-02-27T20:25:50.559749Z","caller":"traceutil/trace.go:171","msg":"trace[2080249916] transaction","detail":"{read_only:false; response_revision:362; number_of_response:1; }","duration":"126.445977ms","start":"2026-02-27T20:25:50.433291Z","end":"2026-02-27T20:25:50.559737Z","steps":["trace[2080249916] 'process raft request' (duration: 126.133564ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:25:50.559679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.330174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-proxy-95w7m\" ","response":"range_response_count:1 size:3439"} {"level":"info","ts":"2026-02-27T20:25:50.559828Z","caller":"traceutil/trace.go:171","msg":"trace[242332275] range","detail":"{range_begin:/registry/pods/kube-system/kube-proxy-95w7m; range_end:; response_count:1; response_revision:362; }","duration":"187.581137ms","start":"2026-02-27T20:25:50.372225Z","end":"2026-02-27T20:25:50.559806Z","steps":["trace[242332275] 'agreement among raft nodes before linearized reading' (duration: 187.298894ms)"],"step_count":1} {"level":"info","ts":"2026-02-27T20:25:50.56008Z","caller":"traceutil/trace.go:171","msg":"trace[452559918] transaction","detail":"{read_only:false; response_revision:363; number_of_response:1; }","duration":"124.669631ms","start":"2026-02-27T20:25:50.435394Z","end":"2026-02-27T20:25:50.560064Z","steps":["trace[452559918] 'process raft request' (duration: 124.149056ms)"],"step_count":1} {"level":"info","ts":"2026-02-27T20:25:50.56013Z","caller":"traceutil/trace.go:171","msg":"trace[1163065824] transaction","detail":"{read_only:false; response_revision:365; number_of_response:1; }","duration":"122.32421ms","start":"2026-02-27T20:25:50.437797Z","end":"2026-02-27T20:25:50.560121Z","steps":["trace[1163065824] 'process raft request' (duration: 122.23092ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:25:50.560209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.138226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-02-27T20:25:50.560254Z","caller":"traceutil/trace.go:171","msg":"trace[817163377] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:365; }","duration":"133.225647ms","start":"2026-02-27T20:25:50.427017Z","end":"2026-02-27T20:25:50.560242Z","steps":["trace[817163377] 'agreement among raft nodes before linearized reading' (duration: 133.141796ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:25:50.560213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.929564ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-02-27T20:25:50.560352Z","caller":"traceutil/trace.go:171","msg":"trace[491949418] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"124.677021ms","start":"2026-02-27T20:25:50.435662Z","end":"2026-02-27T20:25:50.560339Z","steps":["trace[491949418] 'process raft request' (duration: 124.109846ms)"],"step_count":1} {"level":"info","ts":"2026-02-27T20:25:50.560369Z","caller":"traceutil/trace.go:171","msg":"trace[1300607764] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:365; }","duration":"184.104665ms","start":"2026-02-27T20:25:50.376247Z","end":"2026-02-27T20:25:50.560352Z","steps":["trace[1300607764] 'agreement among raft nodes before linearized reading' (duration: 183.831453ms)"],"step_count":1} {"level":"info","ts":"2026-02-27T20:25:50.769096Z","caller":"traceutil/trace.go:171","msg":"trace[855423796] transaction","detail":"{read_only:false; response_revision:367; number_of_response:1; }","duration":"199.582183ms","start":"2026-02-27T20:25:50.569477Z","end":"2026-02-27T20:25:50.769059Z","steps":["trace[855423796] 'process raft request' (duration: 175.238157ms)","trace[855423796] 'compare' (duration: 23.996862ms)"],"step_count":2} {"level":"info","ts":"2026-02-27T20:25:50.769199Z","caller":"traceutil/trace.go:171","msg":"trace[878984824] transaction","detail":"{read_only:false; response_revision:368; number_of_response:1; }","duration":"199.302401ms","start":"2026-02-27T20:25:50.569866Z","end":"2026-02-27T20:25:50.769169Z","steps":["trace[878984824] 'process raft request' (duration: 198.996278ms)"],"step_count":1} {"level":"info","ts":"2026-02-27T20:25:50.769304Z","caller":"traceutil/trace.go:171","msg":"trace[26738853] linearizableReadLoop","detail":"{readStateIndex:385; appliedIndex:378; }","duration":"188.964769ms","start":"2026-02-27T20:25:50.580321Z","end":"2026-02-27T20:25:50.769285Z","steps":["trace[26738853] 'read index received' (duration: 55.056336ms)","trace[26738853] 'applied index is now lower than readState.Index' (duration: 133.907553ms)"],"step_count":2} {"level":"info","ts":"2026-02-27T20:25:50.769386Z","caller":"traceutil/trace.go:171","msg":"trace[455915321] transaction","detail":"{read_only:false; response_revision:369; number_of_response:1; }","duration":"199.35299ms","start":"2026-02-27T20:25:50.569999Z","end":"2026-02-27T20:25:50.769352Z","steps":["trace[455915321] 'process raft request' (duration: 199.092208ms)"],"step_count":1} {"level":"info","ts":"2026-02-27T20:25:50.769457Z","caller":"traceutil/trace.go:171","msg":"trace[868813217] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"198.018439ms","start":"2026-02-27T20:25:50.571428Z","end":"2026-02-27T20:25:50.769446Z","steps":["trace[868813217] 'process raft request' (duration: 197.771597ms)"],"step_count":1} {"level":"info","ts":"2026-02-27T20:25:50.769416Z","caller":"traceutil/trace.go:171","msg":"trace[269140805] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"199.25534ms","start":"2026-02-27T20:25:50.570148Z","end":"2026-02-27T20:25:50.769404Z","steps":["trace[269140805] 'process raft request' (duration: 199.012927ms)"],"step_count":1} {"level":"info","ts":"2026-02-27T20:25:50.769675Z","caller":"traceutil/trace.go:171","msg":"trace[803388276] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"191.688753ms","start":"2026-02-27T20:25:50.577963Z","end":"2026-02-27T20:25:50.769652Z","steps":["trace[803388276] 'process raft request' (duration: 191.279199ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:25:50.769758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.420023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-02-27T20:25:50.769806Z","caller":"traceutil/trace.go:171","msg":"trace[263003216] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:372; }","duration":"189.496044ms","start":"2026-02-27T20:25:50.5803Z","end":"2026-02-27T20:25:50.769796Z","steps":["trace[263003216] 'agreement among raft nodes before linearized reading' (duration: 189.404133ms)"],"step_count":1} {"level":"info","ts":"2026-02-27T20:25:50.797844Z","caller":"traceutil/trace.go:171","msg":"trace[130725282] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"158.938893ms","start":"2026-02-27T20:25:50.638889Z","end":"2026-02-27T20:25:50.797828Z","steps":["trace[130725282] 'process raft request' (duration: 158.847183ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:25:50.797951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.284165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-02-27T20:25:50.798049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.328425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-27T20:25:50.798139Z","caller":"traceutil/trace.go:171","msg":"trace[1215793951] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:373; }","duration":"161.451656ms","start":"2026-02-27T20:25:50.63667Z","end":"2026-02-27T20:25:50.798122Z","steps":["trace[1215793951] 'agreement among raft nodes before linearized reading' (duration: 161.240954ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:25:50.798219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.712733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" ","response":"range_response_count:1 size:185"} {"level":"info","ts":"2026-02-27T20:25:50.798298Z","caller":"traceutil/trace.go:171","msg":"trace[492132106] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/kube-proxy; range_end:; response_count:1; response_revision:373; }","duration":"217.808733ms","start":"2026-02-27T20:25:50.580479Z","end":"2026-02-27T20:25:50.798288Z","steps":["trace[492132106] 'agreement among raft nodes before linearized reading' (duration: 217.689532ms)"],"step_count":1} {"level":"info","ts":"2026-02-27T20:25:50.798562Z","caller":"traceutil/trace.go:171","msg":"trace[291211871] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:373; }","duration":"152.395596ms","start":"2026-02-27T20:25:50.645591Z","end":"2026-02-27T20:25:50.797987Z","steps":["trace[291211871] 'agreement among raft nodes before linearized reading' (duration: 152.265815ms)"],"step_count":1} {"level":"info","ts":"2026-02-27T20:25:51.081924Z","caller":"traceutil/trace.go:171","msg":"trace[1491748086] transaction","detail":"{read_only:false; response_revision:387; number_of_response:1; }","duration":"103.367177ms","start":"2026-02-27T20:25:50.978532Z","end":"2026-02-27T20:25:51.081899Z","steps":["trace[1491748086] 'process raft request' (duration: 73.96456ms)","trace[1491748086] 'compare' (duration: 29.287436ms)"],"step_count":2} {"level":"warn","ts":"2026-02-27T20:25:58.927476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.91435ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-27T20:25:58.927587Z","caller":"traceutil/trace.go:171","msg":"trace[816334500] linearizableReadLoop","detail":"{readStateIndex:435; appliedIndex:434; }","duration":"168.710559ms","start":"2026-02-27T20:25:58.758858Z","end":"2026-02-27T20:25:58.927568Z","steps":["trace[816334500] 'read index received' (duration: 57.571247ms)","trace[816334500] 'applied index is now lower than readState.Index' (duration: 111.137982ms)"],"step_count":2} {"level":"warn","ts":"2026-02-27T20:25:58.927805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.933661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:7294"} {"level":"info","ts":"2026-02-27T20:25:58.927857Z","caller":"traceutil/trace.go:171","msg":"trace[1391862501] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:419; }","duration":"169.017893ms","start":"2026-02-27T20:25:58.758827Z","end":"2026-02-27T20:25:58.927845Z","steps":["trace[1391862501] 'agreement among raft nodes before linearized reading' (duration: 168.832511ms)"],"step_count":1} {"level":"info","ts":"2026-02-27T20:25:58.927613Z","caller":"traceutil/trace.go:171","msg":"trace[1946718070] transaction","detail":"{read_only:false; response_revision:419; number_of_response:1; }","duration":"197.697471ms","start":"2026-02-27T20:25:58.729891Z","end":"2026-02-27T20:25:58.927588Z","steps":["trace[1946718070] 'process raft request' (duration: 86.609329ms)","trace[1946718070] 'compare' (duration: 110.722449ms)"],"step_count":2} {"level":"warn","ts":"2026-02-27T20:25:59.129325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.196101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4195"} {"level":"info","ts":"2026-02-27T20:25:59.129421Z","caller":"traceutil/trace.go:171","msg":"trace[1660365275] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:432; }","duration":"108.310683ms","start":"2026-02-27T20:25:59.021074Z","end":"2026-02-27T20:25:59.129385Z","steps":["trace[1660365275] 'agreement among raft nodes before linearized reading' (duration: 108.156592ms)"],"step_count":1} {"level":"info","ts":"2026-02-27T20:25:59.129866Z","caller":"traceutil/trace.go:171","msg":"trace[882510025] transaction","detail":"{read_only:false; response_revision:432; number_of_response:1; }","duration":"104.884455ms","start":"2026-02-27T20:25:59.024965Z","end":"2026-02-27T20:25:59.12985Z","steps":["trace[882510025] 'process raft request' (duration: 104.143449ms)"],"step_count":1} {"level":"info","ts":"2026-02-27T20:26:11.333455Z","caller":"traceutil/trace.go:171","msg":"trace[1393755218] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"123.071415ms","start":"2026-02-27T20:26:11.210367Z","end":"2026-02-27T20:26:11.333439Z","steps":["trace[1393755218] 'process raft request' (duration: 122.978884ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:26:12.427355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.532867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-27T20:26:12.427441Z","caller":"traceutil/trace.go:171","msg":"trace[206468450] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:511; }","duration":"223.652048ms","start":"2026-02-27T20:26:12.203766Z","end":"2026-02-27T20:26:12.427418Z","steps":["trace[206468450] 'range keys from in-memory index tree' (duration: 223.469496ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:26:12.427497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"730.101307ms","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-27T20:26:12.427579Z","caller":"traceutil/trace.go:171","msg":"trace[781851462] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:511; }","duration":"730.225598ms","start":"2026-02-27T20:26:11.697332Z","end":"2026-02-27T20:26:12.427557Z","steps":["trace[781851462] 'range keys from in-memory index tree' (duration: 729.983086ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:26:12.427618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:26:11.697312Z","time spent":"730.297488ms","remote":"127.0.0.1:33672","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-27T20:26:13.290377Z","caller":"traceutil/trace.go:171","msg":"trace[2011571169] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"214.026546ms","start":"2026-02-27T20:26:13.076331Z","end":"2026-02-27T20:26:13.290357Z","steps":["trace[2011571169] 'process raft request' (duration: 213.554402ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:26:15.050836Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11712345995282159436,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-27T20:26:15.219598Z","caller":"traceutil/trace.go:171","msg":"trace[548307476] linearizableReadLoop","detail":"{readStateIndex:539; appliedIndex:538; }","duration":"669.596928ms","start":"2026-02-27T20:26:14.549981Z","end":"2026-02-27T20:26:15.219577Z","steps":["trace[548307476] 'read index received' (duration: 669.402606ms)","trace[548307476] 'applied index is now lower than readState.Index' (duration: 193.452µs)"],"step_count":2} {"level":"info","ts":"2026-02-27T20:26:15.219864Z","caller":"traceutil/trace.go:171","msg":"trace[1825660710] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"775.341618ms","start":"2026-02-27T20:26:14.444509Z","end":"2026-02-27T20:26:15.21985Z","steps":["trace[1825660710] 'process raft request' (duration: 774.959215ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:26:15.219959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:26:14.444479Z","time spent":"775.419368ms","remote":"127.0.0.1:33672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-27T20:26:15.220131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"670.155942ms","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-27T20:26:15.220162Z","caller":"traceutil/trace.go:171","msg":"trace[1896619014] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:519; }","duration":"670.217442ms","start":"2026-02-27T20:26:14.549934Z","end":"2026-02-27T20:26:15.220151Z","steps":["trace[1896619014] 'agreement among raft nodes before linearized reading' (duration: 670.166422ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:26:15.220188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:26:14.549917Z","time spent":"670.265063ms","remote":"127.0.0.1:33672","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-27T20:26:15.366503Z","caller":"traceutil/trace.go:171","msg":"trace[140985670] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"141.215444ms","start":"2026-02-27T20:26:15.225247Z","end":"2026-02-27T20:26:15.366462Z","steps":["trace[140985670] 'process raft request' (duration: 140.604909ms)"],"step_count":1} {"level":"info","ts":"2026-02-27T20:26:19.727687Z","caller":"traceutil/trace.go:171","msg":"trace[355386332] linearizableReadLoop","detail":"{readStateIndex:574; appliedIndex:573; }","duration":"492.913648ms","start":"2026-02-27T20:26:19.234741Z","end":"2026-02-27T20:26:19.727655Z","steps":["trace[355386332] 'read index received' (duration: 492.627436ms)","trace[355386332] 'applied index is now lower than readState.Index' (duration: 284.732µs)"],"step_count":2} {"level":"info","ts":"2026-02-27T20:26:19.727861Z","caller":"traceutil/trace.go:171","msg":"trace[446168912] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"588.429216ms","start":"2026-02-27T20:26:19.139414Z","end":"2026-02-27T20:26:19.727843Z","steps":["trace[446168912] 'process raft request' (duration: 588.043113ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:26:19.727993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:26:19.139397Z","time spent":"588.503646ms","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-27T20:26:19.728056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.012718ms","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-27T20:26:19.728108Z","caller":"traceutil/trace.go:171","msg":"trace[1184279468] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:553; }","duration":"351.115659ms","start":"2026-02-27T20:26:19.376979Z","end":"2026-02-27T20:26:19.728095Z","steps":["trace[1184279468] 'agreement among raft nodes before linearized reading' (duration: 350.980178ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:26:19.728136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:26:19.376958Z","time spent":"351.1742ms","remote":"127.0.0.1:33672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-27T20:26:19.728283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.489543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-27T20:26:19.728302Z","caller":"traceutil/trace.go:171","msg":"trace[1748962202] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:553; }","duration":"343.548043ms","start":"2026-02-27T20:26:19.384749Z","end":"2026-02-27T20:26:19.728297Z","steps":["trace[1748962202] 'agreement among raft nodes before linearized reading' (duration: 343.499473ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:26:19.728314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:26:19.38472Z","time spent":"343.591093ms","remote":"127.0.0.1:33672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-27T20:26:19.728319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.188196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-27T20:26:19.728476Z","caller":"traceutil/trace.go:171","msg":"trace[43119686] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:553; }","duration":"341.362537ms","start":"2026-02-27T20:26:19.387098Z","end":"2026-02-27T20:26:19.72846Z","steps":["trace[43119686] 'agreement among raft nodes before linearized reading' (duration: 341.107285ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:26:19.728942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:26:19.38709Z","time spent":"341.78012ms","remote":"127.0.0.1:33672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-27T20:26:19.728668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.879945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-02-27T20:26:19.729165Z","caller":"traceutil/trace.go:171","msg":"trace[157117501] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:553; }","duration":"494.422899ms","start":"2026-02-27T20:26:19.234712Z","end":"2026-02-27T20:26:19.729135Z","steps":["trace[157117501] 'agreement among raft nodes before linearized reading' (duration: 493.559193ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:26:19.729322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:26:19.234697Z","time spent":"494.608841ms","remote":"127.0.0.1:33672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-27T20:26:20.669483Z","caller":"traceutil/trace.go:171","msg":"trace[1278656341] linearizableReadLoop","detail":"{readStateIndex:578; appliedIndex:575; }","duration":"467.005013ms","start":"2026-02-27T20:26:20.202455Z","end":"2026-02-27T20:26:20.66946Z","steps":["trace[1278656341] 'read index received' (duration: 466.744131ms)","trace[1278656341] 'applied index is now lower than readState.Index' (duration: 258.302µs)"],"step_count":2} {"level":"info","ts":"2026-02-27T20:26:20.669495Z","caller":"traceutil/trace.go:171","msg":"trace[1767524328] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"935.696896ms","start":"2026-02-27T20:26:19.733771Z","end":"2026-02-27T20:26:20.669468Z","steps":["trace[1767524328] 'process raft request' (duration: 935.484804ms)"],"step_count":1} {"level":"info","ts":"2026-02-27T20:26:20.669548Z","caller":"traceutil/trace.go:171","msg":"trace[889586047] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"935.598965ms","start":"2026-02-27T20:26:19.733943Z","end":"2026-02-27T20:26:20.669542Z","steps":["trace[889586047] 'process raft request' (duration: 935.440513ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:26:20.66968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:26:19.733688Z","time spent":"935.899427ms","remote":"127.0.0.1:33672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-27T20:26:20.669688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:26:19.733762Z","time spent":"935.806597ms","remote":"127.0.0.1:33672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-27T20:26:20.669725Z","caller":"traceutil/trace.go:171","msg":"trace[1862361499] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"934.986241ms","start":"2026-02-27T20:26:19.734704Z","end":"2026-02-27T20:26:20.66969Z","steps":["trace[1862361499] 'process raft request' (duration: 934.715959ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:26:20.669831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.384266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-27T20:26:20.66986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:26:19.734679Z","time spent":"935.106201ms","remote":"127.0.0.1:33672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-27T20:26:20.669865Z","caller":"traceutil/trace.go:171","msg":"trace[1482716108] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:557; }","duration":"467.448996ms","start":"2026-02-27T20:26:20.202403Z","end":"2026-02-27T20:26:20.669852Z","steps":["trace[1482716108] 'agreement among raft nodes before linearized reading' (duration: 467.400165ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:26:20.669898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:26:20.202384Z","time spent":"467.507987ms","remote":"127.0.0.1:33398","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-27T20:26:22.225458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.473533ms","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-27T20:26:22.225523Z","caller":"traceutil/trace.go:171","msg":"trace[1236707523] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:557; }","duration":"453.578836ms","start":"2026-02-27T20:26:21.771929Z","end":"2026-02-27T20:26:22.225508Z","steps":["trace[1236707523] 'range keys from in-memory index tree' (duration: 453.295079ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:26:22.225558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:26:21.771908Z","time spent":"453.642148ms","remote":"127.0.0.1:33672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-27T20:26:24.387526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.123459455s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.67\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-02-27T20:26:24.387578Z","caller":"traceutil/trace.go:171","msg":"trace[1767457819] range","detail":"{range_begin:/registry/masterleases/199.204.45.67; range_end:; response_count:1; response_revision:558; }","duration":"1.123560309s","start":"2026-02-27T20:26:23.264005Z","end":"2026-02-27T20:26:24.387565Z","steps":["trace[1767457819] 'range keys from in-memory index tree' (duration: 1.123313199s)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:26:24.3876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:26:23.263979Z","time spent":"1.123616901s","remote":"127.0.0.1:33452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.67\" "} {"level":"warn","ts":"2026-02-27T20:26:24.387729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.714090662s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-27T20:26:24.387784Z","caller":"traceutil/trace.go:171","msg":"trace[1721406163] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:558; }","duration":"1.714208687s","start":"2026-02-27T20:26:22.67356Z","end":"2026-02-27T20:26:24.387769Z","steps":["trace[1721406163] 'range keys from in-memory index tree' (duration: 1.713959936s)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:26:24.38782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:26:22.673542Z","time spent":"1.71427062s","remote":"127.0.0.1:33672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-27T20:26:24.387849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.714003108s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-27T20:26:24.387928Z","caller":"traceutil/trace.go:171","msg":"trace[162234338] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:558; }","duration":"1.714127794s","start":"2026-02-27T20:26:22.673784Z","end":"2026-02-27T20:26:24.387911Z","steps":["trace[162234338] 'range keys from in-memory index tree' (duration: 1.713846322s)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:26:24.38795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.051107ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-27T20:26:24.387967Z","caller":"traceutil/trace.go:171","msg":"trace[395495718] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:559; }","duration":"185.068158ms","start":"2026-02-27T20:26:24.202894Z","end":"2026-02-27T20:26:24.387962Z","steps":["trace[395495718] 'agreement among raft nodes before linearized reading' (duration: 185.006615ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:26:24.38797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:26:22.673756Z","time spent":"1.714204936s","remote":"127.0.0.1:33672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-27T20:26:24.387949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.713415064s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-02-27T20:26:24.387888Z","caller":"traceutil/trace.go:171","msg":"trace[2024319208] linearizableReadLoop","detail":"{readStateIndex:580; appliedIndex:579; }","duration":"184.967504ms","start":"2026-02-27T20:26:24.202912Z","end":"2026-02-27T20:26:24.38788Z","steps":["trace[2024319208] 'read index received' (duration: 175.276599ms)","trace[2024319208] 'applied index is now lower than readState.Index' (duration: 9.690295ms)"],"step_count":2} {"level":"info","ts":"2026-02-27T20:26:24.388027Z","caller":"traceutil/trace.go:171","msg":"trace[2015403117] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:558; }","duration":"1.713513268s","start":"2026-02-27T20:26:22.674495Z","end":"2026-02-27T20:26:24.388009Z","steps":["trace[2015403117] 'range keys from in-memory index tree' (duration: 1.713296s)"],"step_count":1} {"level":"info","ts":"2026-02-27T20:26:24.388052Z","caller":"traceutil/trace.go:171","msg":"trace[2087879913] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"791.472979ms","start":"2026-02-27T20:26:23.596563Z","end":"2026-02-27T20:26:24.388036Z","steps":["trace[2087879913] 'process raft request' (duration: 781.611817ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:26:24.388079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:26:22.67449Z","time spent":"1.713579471s","remote":"127.0.0.1:33672","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-27T20:26:24.388104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:26:23.596534Z","time spent":"791.533622ms","remote":"127.0.0.1:33672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-27T20:26:24.388289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.825268ms","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-27T20:26:24.388431Z","caller":"traceutil/trace.go:171","msg":"trace[1250621454] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:559; }","duration":"143.952983ms","start":"2026-02-27T20:26:24.244445Z","end":"2026-02-27T20:26:24.388398Z","steps":["trace[1250621454] 'agreement among raft nodes before linearized reading' (duration: 143.724764ms)"],"step_count":1} {"level":"info","ts":"2026-02-27T20:26:25.64598Z","caller":"traceutil/trace.go:171","msg":"trace[757504765] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"176.862671ms","start":"2026-02-27T20:26:25.469034Z","end":"2026-02-27T20:26:25.645897Z","steps":["trace[757504765] 'process raft request' (duration: 176.099271ms)"],"step_count":1} {"level":"info","ts":"2026-02-27T20:26:26.58391Z","caller":"traceutil/trace.go:171","msg":"trace[364089673] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"242.934386ms","start":"2026-02-27T20:26:26.340955Z","end":"2026-02-27T20:26:26.58389Z","steps":["trace[364089673] 'process raft request' (duration: 242.812241ms)"],"step_count":1} {"level":"info","ts":"2026-02-27T20:26:26.58391Z","caller":"traceutil/trace.go:171","msg":"trace[1847166062] linearizableReadLoop","detail":"{readStateIndex:611; appliedIndex:610; }","duration":"150.311929ms","start":"2026-02-27T20:26:26.433572Z","end":"2026-02-27T20:26:26.583884Z","steps":["trace[1847166062] 'read index received' (duration: 150.299098ms)","trace[1847166062] 'applied index is now lower than readState.Index' (duration: 11.471µs)"],"step_count":2} {"level":"warn","ts":"2026-02-27T20:26:26.584395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.759576ms","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-27T20:26:26.584564Z","caller":"traceutil/trace.go:171","msg":"trace[2000197097] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:589; }","duration":"150.989436ms","start":"2026-02-27T20:26:26.433529Z","end":"2026-02-27T20:26:26.584519Z","steps":["trace[2000197097] 'agreement among raft nodes before linearized reading' (duration: 150.436194ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:26:26.588507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.21283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-27T20:26:26.588542Z","caller":"traceutil/trace.go:171","msg":"trace[1902921546] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:590; }","duration":"154.267703ms","start":"2026-02-27T20:26:26.434264Z","end":"2026-02-27T20:26:26.588532Z","steps":["trace[1902921546] 'agreement among raft nodes before linearized reading' (duration: 154.166929ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:26:26.588537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.754111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-02-27T20:26:26.588585Z","caller":"traceutil/trace.go:171","msg":"trace[1269777676] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:590; }","duration":"154.818974ms","start":"2026-02-27T20:26:26.433751Z","end":"2026-02-27T20:26:26.58857Z","steps":["trace[1269777676] 'agreement among raft nodes before linearized reading' (duration: 154.669608ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:26:26.588698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.651078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-27T20:26:26.588727Z","caller":"traceutil/trace.go:171","msg":"trace[1995704112] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:590; }","duration":"154.71006ms","start":"2026-02-27T20:26:26.434005Z","end":"2026-02-27T20:26:26.588715Z","steps":["trace[1995704112] 'agreement among raft nodes before linearized reading' (duration: 154.652447ms)"],"step_count":1} {"level":"info","ts":"2026-02-27T20:26:43.685095Z","caller":"traceutil/trace.go:171","msg":"trace[201538413] transaction","detail":"{read_only:false; response_revision:762; number_of_response:1; }","duration":"372.190329ms","start":"2026-02-27T20:26:43.312869Z","end":"2026-02-27T20:26:43.685059Z","steps":["trace[201538413] 'process raft request' (duration: 316.003784ms)","trace[201538413] 'compare' (duration: 56.01275ms)"],"step_count":2} {"level":"warn","ts":"2026-02-27T20:26:43.685308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:26:43.312851Z","time spent":"372.365154ms","remote":"127.0.0.1:33452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-27T20:27:51.200205Z","caller":"traceutil/trace.go:171","msg":"trace[700378543] linearizableReadLoop","detail":"{readStateIndex:1037; appliedIndex:1036; }","duration":"208.78696ms","start":"2026-02-27T20:27:50.991401Z","end":"2026-02-27T20:27:51.200188Z","steps":["trace[700378543] 'read index received' (duration: 208.597666ms)","trace[700378543] 'applied index is now lower than readState.Index' (duration: 188.593µs)"],"step_count":2} {"level":"info","ts":"2026-02-27T20:27:51.200264Z","caller":"traceutil/trace.go:171","msg":"trace[892643367] transaction","detail":"{read_only:false; response_revision:994; number_of_response:1; }","duration":"209.253217ms","start":"2026-02-27T20:27:50.990976Z","end":"2026-02-27T20:27:51.20023Z","steps":["trace[892643367] 'process raft request' (duration: 209.106465ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:27:51.200405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.989273ms","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-27T20:27:51.200436Z","caller":"traceutil/trace.go:171","msg":"trace[1169097757] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:994; }","duration":"209.056144ms","start":"2026-02-27T20:27:50.991371Z","end":"2026-02-27T20:27:51.200427Z","steps":["trace[1169097757] 'agreement among raft nodes before linearized reading' (duration: 208.924021ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:27:51.200523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.233766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-02-27T20:27:51.200567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.377735ms","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-27T20:27:51.200586Z","caller":"traceutil/trace.go:171","msg":"trace[598254888] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:994; }","duration":"170.426857ms","start":"2026-02-27T20:27:51.030156Z","end":"2026-02-27T20:27:51.200583Z","steps":["trace[598254888] 'agreement among raft nodes before linearized reading' (duration: 170.375646ms)"],"step_count":1} {"level":"info","ts":"2026-02-27T20:27:51.200602Z","caller":"traceutil/trace.go:171","msg":"trace[1134242508] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:994; }","duration":"200.331388ms","start":"2026-02-27T20:27:51.000251Z","end":"2026-02-27T20:27:51.200582Z","steps":["trace[1134242508] 'agreement among raft nodes before linearized reading' (duration: 200.150424ms)"],"step_count":1}