{"level":"warn","ts":"2026-08-22T14:27:26.334866Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-22T14:27:26.334983Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.74: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.74:2380","--initial-cluster=instance=https://199.204.45.74:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.74:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.74: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-08-22T14:27:26.335115Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-22T14:27:26.335132Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.74:2380"]} {"level":"info","ts":"2026-08-22T14:27:26.335186Z","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-08-22T14:27:26.33686Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.74:2379"]} {"level":"info","ts":"2026-08-22T14:27:26.33718Z","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.74:2380"],"listen-peer-urls":["https://199.204.45.74:2380"],"advertise-client-urls":["https://199.204.45.74:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.74:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.74: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-08-22T14:27:26.343151Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.618924ms"} {"level":"info","ts":"2026-08-22T14:27:26.349301Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"89ba38f964b95aa0","cluster-id":"54492f71bf65c400"} {"level":"info","ts":"2026-08-22T14:27:26.349417Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 switched to configuration voters=()"} {"level":"info","ts":"2026-08-22T14:27:26.34945Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became follower at term 0"} {"level":"info","ts":"2026-08-22T14:27:26.349516Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 89ba38f964b95aa0 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-22T14:27:26.349527Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became follower at term 1"} {"level":"info","ts":"2026-08-22T14:27:26.349598Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 switched to configuration voters=(9924307372652190368)"} {"level":"warn","ts":"2026-08-22T14:27:26.359403Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-22T14:27:26.361689Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-22T14:27:26.363045Z","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-08-22T14:27:26.365445Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"89ba38f964b95aa0","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-22T14:27:26.368848Z","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-08-22T14:27:26.368987Z","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-08-22T14:27:26.369007Z","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-08-22T14:27:26.369518Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"89ba38f964b95aa0","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-22T14:27:26.372371Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 switched to configuration voters=(9924307372652190368)"} {"level":"info","ts":"2026-08-22T14:27:26.37298Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"54492f71bf65c400","local-member-id":"89ba38f964b95aa0","added-peer-id":"89ba38f964b95aa0","added-peer-peer-urls":["https://199.204.45.74:2380"]} {"level":"info","ts":"2026-08-22T14:27:26.374556Z","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-08-22T14:27:26.374673Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.74:2380"} {"level":"info","ts":"2026-08-22T14:27:26.374748Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.74:2380"} {"level":"info","ts":"2026-08-22T14:27:26.375597Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-22T14:27:26.375729Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"89ba38f964b95aa0","initial-advertise-peer-urls":["https://199.204.45.74:2380"],"listen-peer-urls":["https://199.204.45.74:2380"],"advertise-client-urls":["https://199.204.45.74:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.74:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-22T14:27:26.550736Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 is starting a new election at term 1"} {"level":"info","ts":"2026-08-22T14:27:26.550793Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-22T14:27:26.550818Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 received MsgPreVoteResp from 89ba38f964b95aa0 at term 1"} {"level":"info","ts":"2026-08-22T14:27:26.550833Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became candidate at term 2"} {"level":"info","ts":"2026-08-22T14:27:26.55084Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 received MsgVoteResp from 89ba38f964b95aa0 at term 2"} {"level":"info","ts":"2026-08-22T14:27:26.550851Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became leader at term 2"} {"level":"info","ts":"2026-08-22T14:27:26.550861Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 89ba38f964b95aa0 elected leader 89ba38f964b95aa0 at term 2"} {"level":"info","ts":"2026-08-22T14:27:26.551787Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"89ba38f964b95aa0","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.74:2379]}","request-path":"/0/members/89ba38f964b95aa0/attributes","cluster-id":"54492f71bf65c400","publish-timeout":"7s"} {"level":"info","ts":"2026-08-22T14:27:26.55182Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-22T14:27:26.551802Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-22T14:27:26.55212Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-22T14:27:26.552271Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-22T14:27:26.552302Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-22T14:27:26.554074Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-22T14:27:26.55434Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"54492f71bf65c400","local-member-id":"89ba38f964b95aa0","cluster-version":"3.5"} {"level":"info","ts":"2026-08-22T14:27:26.554464Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-22T14:27:26.554502Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-22T14:27:26.555459Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.74:2379"} {"level":"warn","ts":"2026-08-22T14:27:28.709395Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6530395561375174020,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-22T14:27:30.579473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.449370124s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-08-22T14:27:30.579851Z","caller":"traceutil/trace.go:171","msg":"trace[931426830] linearizableReadLoop","detail":"{readStateIndex:16; appliedIndex:9; }","duration":"2.371367955s","start":"2026-08-22T14:27:28.208464Z","end":"2026-08-22T14:27:30.579832Z","steps":["trace[931426830] 'read index received' (duration: 921.104596ms)","trace[931426830] 'applied index is now lower than readState.Index' (duration: 1.450262469s)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:27:30.579875Z","caller":"traceutil/trace.go:171","msg":"trace[606393728] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"2.3721524s","start":"2026-08-22T14:27:28.207679Z","end":"2026-08-22T14:27:30.579832Z","steps":["trace[606393728] 'process raft request' (duration: 2.371989689s)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:27:30.579956Z","caller":"traceutil/trace.go:171","msg":"trace[1886645445] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"2.37222269s","start":"2026-08-22T14:27:28.207723Z","end":"2026-08-22T14:27:30.579946Z","steps":["trace[1886645445] 'process raft request' (duration: 2.371976478s)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:27:30.579991Z","caller":"traceutil/trace.go:171","msg":"trace[945666024] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"2.372998024s","start":"2026-08-22T14:27:28.206963Z","end":"2026-08-22T14:27:30.579961Z","steps":["trace[945666024] 'process raft request' (duration: 2.372620761s)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:27:30.580022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:27:28.207718Z","time spent":"2.37226763s","remote":"127.0.0.1:40956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-22T14:27:30.580061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:27:28.207655Z","time spent":"2.372323811s","remote":"127.0.0.1:40956","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-08-22T14:27:30.580082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:27:28.206959Z","time spent":"2.373071954s","remote":"127.0.0.1:40848","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-08-22T14:27:30.580163Z","caller":"traceutil/trace.go:171","msg":"trace[1358603228] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"2.372307931s","start":"2026-08-22T14:27:28.207846Z","end":"2026-08-22T14:27:30.580154Z","steps":["trace[1358603228] 'process raft request' (duration: 2.371897759s)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:27:30.580204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:27:28.2078Z","time spent":"2.372384881s","remote":"127.0.0.1:40956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-22T14:27:30.580187Z","caller":"traceutil/trace.go:171","msg":"trace[447429835] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"2.373307105s","start":"2026-08-22T14:27:28.206844Z","end":"2026-08-22T14:27:30.580151Z","steps":["trace[447429835] 'process raft request' (duration: 922.721844ms)","trace[447429835] 'compare' (duration: 1.449246814s)"],"step_count":2} {"level":"warn","ts":"2026-08-22T14:27:30.580235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.373485836s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-22T14:27:30.580273Z","caller":"traceutil/trace.go:171","msg":"trace[978634325] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:13; }","duration":"2.373539576s","start":"2026-08-22T14:27:28.206721Z","end":"2026-08-22T14:27:30.58026Z","steps":["trace[978634325] 'agreement among raft nodes before linearized reading' (duration: 2.373456036s)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:27:30.580302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.375223145s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.74\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-08-22T14:27:30.580319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:27:28.206837Z","time spent":"2.373416455s","remote":"127.0.0.1:40956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-22T14:27:30.580347Z","caller":"traceutil/trace.go:171","msg":"trace[326597775] range","detail":"{range_begin:/registry/masterleases/199.204.45.74; range_end:; response_count:0; response_revision:13; }","duration":"2.375288976s","start":"2026-08-22T14:27:28.20505Z","end":"2026-08-22T14:27:30.580339Z","steps":["trace[326597775] 'agreement among raft nodes before linearized reading' (duration: 2.375219075s)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:27:30.580352Z","caller":"traceutil/trace.go:171","msg":"trace[1849911876] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"2.37230416s","start":"2026-08-22T14:27:28.208035Z","end":"2026-08-22T14:27:30.58034Z","steps":["trace[1849911876] 'process raft request' (duration: 2.371734567s)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:27:30.580392Z","caller":"traceutil/trace.go:171","msg":"trace[1381655866] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"2.353913455s","start":"2026-08-22T14:27:28.226469Z","end":"2026-08-22T14:27:30.580382Z","steps":["trace[1381655866] 'process raft request' (duration: 2.353327792s)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:27:30.580447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:27:28.20799Z","time spent":"2.37240096s","remote":"127.0.0.1:40956","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-08-22T14:27:30.58046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.167096452s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-08-22T14:27:30.580474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:27:28.226455Z","time spent":"2.353997435s","remote":"127.0.0.1:40662","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-22T14:27:30.580494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"768.525079ms","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-08-22T14:27:30.580495Z","caller":"traceutil/trace.go:171","msg":"trace[1549537241] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:13; }","duration":"1.167167652s","start":"2026-08-22T14:27:29.413316Z","end":"2026-08-22T14:27:30.580484Z","steps":["trace[1549537241] 'agreement among raft nodes before linearized reading' (duration: 1.167121612s)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:27:30.580303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:27:28.206709Z","time spent":"2.373587196s","remote":"127.0.0.1:40520","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-08-22T14:27:30.580527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.323071205s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-08-22T14:27:30.580528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:27:29.413293Z","time spent":"1.167229932s","remote":"127.0.0.1:40400","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-08-22T14:27:30.580507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.174521208s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-22T14:27:30.580526Z","caller":"traceutil/trace.go:171","msg":"trace[752600699] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:13; }","duration":"768.615659ms","start":"2026-08-22T14:27:29.8119Z","end":"2026-08-22T14:27:30.580516Z","steps":["trace[752600699] 'agreement among raft nodes before linearized reading' (duration: 768.528209ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:27:30.580555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.474196502s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-08-22T14:27:30.580583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:27:29.811871Z","time spent":"768.70668ms","remote":"127.0.0.1:40668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-node-lease/instance\" "} {"level":"info","ts":"2026-08-22T14:27:30.580565Z","caller":"traceutil/trace.go:171","msg":"trace[539292917] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:13; }","duration":"2.323096795s","start":"2026-08-22T14:27:28.257451Z","end":"2026-08-22T14:27:30.580547Z","steps":["trace[539292917] 'agreement among raft nodes before linearized reading' (duration: 2.323060055s)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:27:30.580588Z","caller":"traceutil/trace.go:171","msg":"trace[156670961] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:13; }","duration":"1.474314784s","start":"2026-08-22T14:27:29.106264Z","end":"2026-08-22T14:27:30.580578Z","steps":["trace[156670961] 'agreement among raft nodes before linearized reading' (duration: 1.474265263s)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:27:30.580592Z","caller":"traceutil/trace.go:171","msg":"trace[323062597] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:13; }","duration":"2.174654099s","start":"2026-08-22T14:27:28.405916Z","end":"2026-08-22T14:27:30.58057Z","steps":["trace[323062597] 'agreement among raft nodes before linearized reading' (duration: 2.174515548s)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:27:30.580619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:27:28.257407Z","time spent":"2.323205176s","remote":"127.0.0.1:40520","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-08-22T14:27:30.580622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:27:29.106214Z","time spent":"1.474401234s","remote":"127.0.0.1:40752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":27,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" "} {"level":"warn","ts":"2026-08-22T14:27:30.580637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:27:28.405894Z","time spent":"2.174734119s","remote":"127.0.0.1:40668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" "} {"level":"warn","ts":"2026-08-22T14:27:30.580393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:27:28.205039Z","time spent":"2.375348196s","remote":"127.0.0.1:40436","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.74\" "} {"level":"warn","ts":"2026-08-22T14:27:30.580457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.474028082s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-22T14:27:30.580738Z","caller":"traceutil/trace.go:171","msg":"trace[1970470439] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:13; }","duration":"1.474324753s","start":"2026-08-22T14:27:29.106404Z","end":"2026-08-22T14:27:30.580728Z","steps":["trace[1970470439] 'agreement among raft nodes before linearized reading' (duration: 1.473957372s)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:27:30.580456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.371682767s","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":"info","ts":"2026-08-22T14:27:30.580782Z","caller":"traceutil/trace.go:171","msg":"trace[266712881] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:13; }","duration":"2.372040518s","start":"2026-08-22T14:27:28.208732Z","end":"2026-08-22T14:27:30.580773Z","steps":["trace[266712881] 'agreement among raft nodes before linearized reading' (duration: 2.371609037s)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:27:30.580817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:27:28.208722Z","time spent":"2.372087729s","remote":"127.0.0.1:40500","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-08-22T14:27:30.580781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:27:29.106288Z","time spent":"1.474484104s","remote":"127.0.0.1:40772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":27,"request content":"key:\"/registry/priorityclasses/system-node-critical\" "} {"level":"info","ts":"2026-08-22T14:27:31.038701Z","caller":"traceutil/trace.go:171","msg":"trace[151051639] linearizableReadLoop","detail":"{readStateIndex:17; appliedIndex:16; }","duration":"453.588887ms","start":"2026-08-22T14:27:30.585088Z","end":"2026-08-22T14:27:31.038677Z","steps":["trace[151051639] 'read index received' (duration: 453.535907ms)","trace[151051639] 'applied index is now lower than readState.Index' (duration: 51.5µs)"],"step_count":2} {"level":"warn","ts":"2026-08-22T14:27:31.03887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.761079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-z7654\" ","response":"range_response_count:1 size:861"} {"level":"info","ts":"2026-08-22T14:27:31.038894Z","caller":"traceutil/trace.go:171","msg":"trace[222174870] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-z7654; range_end:; response_count:1; response_revision:14; }","duration":"453.828419ms","start":"2026-08-22T14:27:30.585058Z","end":"2026-08-22T14:27:31.038886Z","steps":["trace[222174870] 'agreement among raft nodes before linearized reading' (duration: 453.736439ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:27:31.038921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:27:30.585045Z","time spent":"453.86704ms","remote":"127.0.0.1:40662","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":884,"request content":"key:\"/registry/certificatesigningrequests/csr-z7654\" "} {"level":"info","ts":"2026-08-22T14:27:31.038863Z","caller":"traceutil/trace.go:171","msg":"trace[4953908] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"454.10797ms","start":"2026-08-22T14:27:30.584709Z","end":"2026-08-22T14:27:31.038817Z","steps":["trace[4953908] 'process raft request' (duration: 453.857429ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:27:31.039067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:27:30.584683Z","time spent":"454.296292ms","remote":"127.0.0.1:40520","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":338,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-22T14:27:31.052568Z","caller":"traceutil/trace.go:171","msg":"trace[232051486] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"467.443899ms","start":"2026-08-22T14:27:30.585104Z","end":"2026-08-22T14:27:31.052548Z","steps":["trace[232051486] 'process raft request' (duration: 467.324088ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:27:31.052674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:27:30.585063Z","time spent":"467.54795ms","remote":"127.0.0.1:40956","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-08-22T14:27:31.052768Z","caller":"traceutil/trace.go:171","msg":"trace[1574912798] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"466.843296ms","start":"2026-08-22T14:27:30.585917Z","end":"2026-08-22T14:27:31.05276Z","steps":["trace[1574912798] 'process raft request' (duration: 466.779495ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:27:31.0528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:27:30.585909Z","time spent":"466.872326ms","remote":"127.0.0.1:40956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":923,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-22T14:27:31.052857Z","caller":"traceutil/trace.go:171","msg":"trace[1240235466] transaction","detail":"{read_only:false; number_of_response:0; response_revision:15; }","duration":"467.491808ms","start":"2026-08-22T14:27:30.58536Z","end":"2026-08-22T14:27:31.052852Z","steps":["trace[1240235466] 'process raft request' (duration: 467.142956ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:27:31.052884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:27:30.585333Z","time spent":"467.537928ms","remote":"127.0.0.1:40520","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-22T14:27:31.052927Z","caller":"traceutil/trace.go:171","msg":"trace[1035372124] transaction","detail":"{read_only:false; response_revision:21; number_of_response:1; }","duration":"466.656584ms","start":"2026-08-22T14:27:30.586255Z","end":"2026-08-22T14:27:31.052911Z","steps":["trace[1035372124] 'process raft request' (duration: 466.459833ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:27:31.053029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:27:30.586242Z","time spent":"466.730516ms","remote":"127.0.0.1:40848","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-22T14:27:31.053107Z","caller":"traceutil/trace.go:171","msg":"trace[753879975] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"467.193208ms","start":"2026-08-22T14:27:30.585905Z","end":"2026-08-22T14:27:31.053098Z","steps":["trace[753879975] 'process raft request' (duration: 466.765335ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:27:31.053145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:27:30.585897Z","time spent":"467.230778ms","remote":"127.0.0.1:40772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":429,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-22T14:27:31.053137Z","caller":"traceutil/trace.go:171","msg":"trace[2118612891] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"467.59211ms","start":"2026-08-22T14:27:30.585519Z","end":"2026-08-22T14:27:31.053111Z","steps":["trace[2118612891] 'process raft request' (duration: 467.063357ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:27:31.053197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.341821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-08-22T14:27:31.053222Z","caller":"traceutil/trace.go:171","msg":"trace[1247772620] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:21; }","duration":"411.391822ms","start":"2026-08-22T14:27:30.641822Z","end":"2026-08-22T14:27:31.053214Z","steps":["trace[1247772620] 'agreement among raft nodes before linearized reading' (duration: 411.319381ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:27:31.053242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:27:30.641809Z","time spent":"411.428322ms","remote":"127.0.0.1:40520","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":373,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-08-22T14:27:31.053263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:27:30.585507Z","time spent":"467.685921ms","remote":"127.0.0.1:40956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-22T14:27:31.053338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.130016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-08-22T14:27:31.053358Z","caller":"traceutil/trace.go:171","msg":"trace[60396945] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:21; }","duration":"418.148506ms","start":"2026-08-22T14:27:30.635204Z","end":"2026-08-22T14:27:31.053352Z","steps":["trace[60396945] 'agreement among raft nodes before linearized reading' (duration: 418.114296ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:27:31.053375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:27:30.635168Z","time spent":"418.203276ms","remote":"127.0.0.1:40520","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":373,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-08-22T14:27:31.053466Z","caller":"traceutil/trace.go:171","msg":"trace[750521410] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"467.752021ms","start":"2026-08-22T14:27:30.585698Z","end":"2026-08-22T14:27:31.05345Z","steps":["trace[750521410] 'process raft request' (duration: 466.927616ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:27:31.053477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.57304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3490"} {"level":"info","ts":"2026-08-22T14:27:31.053504Z","caller":"traceutil/trace.go:171","msg":"trace[1935353581] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:21; }","duration":"467.62324ms","start":"2026-08-22T14:27:30.585871Z","end":"2026-08-22T14:27:31.053494Z","steps":["trace[1935353581] 'agreement among raft nodes before linearized reading' (duration: 467.56188ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:27:31.053522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:27:30.585858Z","time spent":"467.65991ms","remote":"127.0.0.1:40578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3513,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-08-22T14:27:31.053527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:27:30.585685Z","time spent":"467.806261ms","remote":"127.0.0.1:40956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-22T14:27:31.053613Z","caller":"traceutil/trace.go:171","msg":"trace[2059205161] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"467.74826ms","start":"2026-08-22T14:27:30.585857Z","end":"2026-08-22T14:27:31.053605Z","steps":["trace[2059205161] 'process raft request' (duration: 466.790175ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:27:31.053624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"468.093662ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-admin\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-22T14:27:31.053642Z","caller":"traceutil/trace.go:171","msg":"trace[552705546] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-admin; range_end:; response_count:0; response_revision:21; }","duration":"468.123642ms","start":"2026-08-22T14:27:30.585513Z","end":"2026-08-22T14:27:31.053636Z","steps":["trace[552705546] 'agreement among raft nodes before linearized reading' (duration: 468.095372ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:27:31.053652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:27:30.585841Z","time spent":"467.79094ms","remote":"127.0.0.1:40956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-22T14:27:31.05366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:27:30.585502Z","time spent":"468.152883ms","remote":"127.0.0.1:40752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":27,"request content":"key:\"/registry/clusterroles/system:aggregate-to-admin\" "} {"level":"warn","ts":"2026-08-22T14:27:31.053743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"468.484965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-22T14:27:31.053758Z","caller":"traceutil/trace.go:171","msg":"trace[791671696] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21; }","duration":"468.523075ms","start":"2026-08-22T14:27:30.58523Z","end":"2026-08-22T14:27:31.053753Z","steps":["trace[791671696] 'agreement among raft nodes before linearized reading' (duration: 468.499415ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:27:31.05378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:27:30.585215Z","time spent":"468.561545ms","remote":"127.0.0.1:40414","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-08-22T14:27:38.759185Z","caller":"traceutil/trace.go:171","msg":"trace[1437301676] linearizableReadLoop","detail":"{readStateIndex:354; appliedIndex:353; }","duration":"198.091406ms","start":"2026-08-22T14:27:38.561043Z","end":"2026-08-22T14:27:38.759134Z","steps":["trace[1437301676] 'read index received' (duration: 197.357273ms)","trace[1437301676] 'applied index is now lower than readState.Index' (duration: 732.093µs)"],"step_count":2} {"level":"warn","ts":"2026-08-22T14:27:38.759468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.644968ms","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-08-22T14:27:38.759616Z","caller":"traceutil/trace.go:171","msg":"trace[608151105] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:344; }","duration":"148.84607ms","start":"2026-08-22T14:27:38.610742Z","end":"2026-08-22T14:27:38.759588Z","steps":["trace[608151105] 'agreement among raft nodes before linearized reading' (duration: 148.631149ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:27:38.759625Z","caller":"traceutil/trace.go:171","msg":"trace[1893483661] transaction","detail":"{read_only:false; response_revision:344; number_of_response:1; }","duration":"220.63346ms","start":"2026-08-22T14:27:38.538719Z","end":"2026-08-22T14:27:38.759352Z","steps":["trace[1893483661] 'process raft request' (duration: 219.766345ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:27:38.760104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.043181ms","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-08-22T14:27:38.760186Z","caller":"traceutil/trace.go:171","msg":"trace[1257288143] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:344; }","duration":"199.181201ms","start":"2026-08-22T14:27:38.560982Z","end":"2026-08-22T14:27:38.760163Z","steps":["trace[1257288143] 'agreement among raft nodes before linearized reading' (duration: 198.88154ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:27:42.834769Z","caller":"traceutil/trace.go:171","msg":"trace[632423652] transaction","detail":"{read_only:false; response_revision:404; number_of_response:1; }","duration":"107.825558ms","start":"2026-08-22T14:27:42.726921Z","end":"2026-08-22T14:27:42.834747Z","steps":["trace[632423652] 'process raft request' (duration: 107.674647ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:27:51.607903Z","caller":"traceutil/trace.go:171","msg":"trace[24613308] transaction","detail":"{read_only:false; response_revision:425; number_of_response:1; }","duration":"104.312622ms","start":"2026-08-22T14:27:51.503568Z","end":"2026-08-22T14:27:51.60788Z","steps":["trace[24613308] 'process raft request' (duration: 104.142881ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:27:52.222453Z","caller":"traceutil/trace.go:171","msg":"trace[1443171733] transaction","detail":"{read_only:false; response_revision:427; number_of_response:1; }","duration":"112.910533ms","start":"2026-08-22T14:27:52.109506Z","end":"2026-08-22T14:27:52.222416Z","steps":["trace[1443171733] 'process raft request' (duration: 99.856419ms)","trace[1443171733] 'compare' (duration: 12.610702ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T14:27:52.728682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.812537ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-22T14:27:52.728771Z","caller":"traceutil/trace.go:171","msg":"trace[219804631] linearizableReadLoop","detail":"{readStateIndex:443; appliedIndex:442; }","duration":"304.678174ms","start":"2026-08-22T14:27:52.42408Z","end":"2026-08-22T14:27:52.728758Z","steps":["trace[219804631] 'read index received' (duration: 68.572396ms)","trace[219804631] 'applied index is now lower than readState.Index' (duration: 236.104748ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T14:27:52.728819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.748424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-22T14:27:52.728804Z","caller":"traceutil/trace.go:171","msg":"trace[1789991481] transaction","detail":"{read_only:false; response_revision:429; number_of_response:1; }","duration":"404.379993ms","start":"2026-08-22T14:27:52.324399Z","end":"2026-08-22T14:27:52.728779Z","steps":["trace[1789991481] 'process raft request' (duration: 168.264755ms)","trace[1789991481] 'compare' (duration: 235.619326ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:27:52.728838Z","caller":"traceutil/trace.go:171","msg":"trace[1399864669] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:429; }","duration":"304.816014ms","start":"2026-08-22T14:27:52.424013Z","end":"2026-08-22T14:27:52.728829Z","steps":["trace[1399864669] 'agreement among raft nodes before linearized reading' (duration: 304.776304ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:27:52.728857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:27:52.423989Z","time spent":"304.863845ms","remote":"127.0.0.1:40668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-22T14:27:52.728895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:27:52.324369Z","time spent":"404.477833ms","remote":"127.0.0.1:40668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T14:27:54.913267Z","caller":"traceutil/trace.go:171","msg":"trace[766033211] linearizableReadLoop","detail":"{readStateIndex:448; appliedIndex:447; }","duration":"180.887134ms","start":"2026-08-22T14:27:54.732346Z","end":"2026-08-22T14:27:54.913233Z","steps":["trace[766033211] 'read index received' (duration: 180.796444ms)","trace[766033211] 'applied index is now lower than readState.Index' (duration: 89.59µs)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:27:54.91344Z","caller":"traceutil/trace.go:171","msg":"trace[1055675410] transaction","detail":"{read_only:false; response_revision:434; number_of_response:1; }","duration":"310.860709ms","start":"2026-08-22T14:27:54.602569Z","end":"2026-08-22T14:27:54.91343Z","steps":["trace[1055675410] 'process raft request' (duration: 310.517947ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:27:54.91353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:27:54.602546Z","time spent":"310.926709ms","remote":"127.0.0.1:40668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-22T14:27:54.913628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.059335ms","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-08-22T14:27:54.913727Z","caller":"traceutil/trace.go:171","msg":"trace[1022388744] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:434; }","duration":"181.365987ms","start":"2026-08-22T14:27:54.732329Z","end":"2026-08-22T14:27:54.913695Z","steps":["trace[1022388744] 'agreement among raft nodes before linearized reading' (duration: 180.996664ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:27:54.913897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.72235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-22T14:27:54.914012Z","caller":"traceutil/trace.go:171","msg":"trace[233860890] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:434; }","duration":"130.90412ms","start":"2026-08-22T14:27:54.783075Z","end":"2026-08-22T14:27:54.913979Z","steps":["trace[233860890] 'agreement among raft nodes before linearized reading' (duration: 130.542088ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:28:08.412681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.50421ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-22T14:28:08.413128Z","caller":"traceutil/trace.go:171","msg":"trace[277710791] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"356.126027ms","start":"2026-08-22T14:28:08.056988Z","end":"2026-08-22T14:28:08.413114Z","steps":["trace[277710791] 'process raft request' (duration: 356.086325ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:28:08.413189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:28:08.056942Z","time spent":"356.222531ms","remote":"127.0.0.1:40456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-22T14:28:08.413353Z","caller":"traceutil/trace.go:171","msg":"trace[505409920] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"394.516399ms","start":"2026-08-22T14:28:08.018827Z","end":"2026-08-22T14:28:08.413343Z","steps":["trace[505409920] 'process raft request' (duration: 250.493979ms)","trace[505409920] 'compare' (duration: 142.348452ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T14:28:08.41339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:28:08.01882Z","time spent":"394.555401ms","remote":"127.0.0.1:40456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-22T14:28:08.413615Z","caller":"traceutil/trace.go:171","msg":"trace[144249623] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"382.20528ms","start":"2026-08-22T14:28:08.031355Z","end":"2026-08-22T14:28:08.41356Z","steps":["trace[144249623] 'process raft request' (duration: 381.578671ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:28:08.413713Z","caller":"traceutil/trace.go:171","msg":"trace[1500896657] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"392.326596ms","start":"2026-08-22T14:28:08.021378Z","end":"2026-08-22T14:28:08.413704Z","steps":["trace[1500896657] 'process raft request' (duration: 391.497378ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:28:08.413663Z","caller":"traceutil/trace.go:171","msg":"trace[1679165252] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"373.585647ms","start":"2026-08-22T14:28:08.040033Z","end":"2026-08-22T14:28:08.413618Z","steps":["trace[1679165252] 'process raft request' (duration: 372.9932ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:28:08.413791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:28:08.02137Z","time spent":"392.373468ms","remote":"127.0.0.1:40456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-22T14:28:08.413805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:28:08.031336Z","time spent":"382.372718ms","remote":"127.0.0.1:40456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30393,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T14:28:08.413843Z","caller":"traceutil/trace.go:171","msg":"trace[398740183] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"394.905587ms","start":"2026-08-22T14:28:08.018921Z","end":"2026-08-22T14:28:08.413827Z","steps":["trace[398740183] 'process raft request' (duration: 393.854848ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:28:08.413921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:28:08.018917Z","time spent":"394.95841ms","remote":"127.0.0.1:40456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10063,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T14:28:08.413952Z","caller":"traceutil/trace.go:171","msg":"trace[2050922084] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"385.227684ms","start":"2026-08-22T14:28:08.028712Z","end":"2026-08-22T14:28:08.41394Z","steps":["trace[2050922084] 'process raft request' (duration: 384.192245ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:28:08.413949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:28:08.040009Z","time spent":"373.783316ms","remote":"127.0.0.1:40456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-22T14:28:08.414004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:28:08.02869Z","time spent":"385.289057ms","remote":"127.0.0.1:40956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-22T14:28:08.413681Z","caller":"traceutil/trace.go:171","msg":"trace[1914798375] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"382.209331ms","start":"2026-08-22T14:28:08.031427Z","end":"2026-08-22T14:28:08.413637Z","steps":["trace[1914798375] 'process raft request' (duration: 381.556051ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:28:08.414322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:28:08.031421Z","time spent":"382.808899ms","remote":"127.0.0.1:40456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-22T14:28:08.43714Z","caller":"traceutil/trace.go:171","msg":"trace[298130778] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"340.318585ms","start":"2026-08-22T14:28:08.096789Z","end":"2026-08-22T14:28:08.437108Z","steps":["trace[298130778] 'process raft request' (duration: 340.038542ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:28:08.437258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:28:08.096769Z","time spent":"340.43018ms","remote":"127.0.0.1:40956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-22T14:28:08.437334Z","caller":"traceutil/trace.go:171","msg":"trace[403440700] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"340.422449ms","start":"2026-08-22T14:28:08.096892Z","end":"2026-08-22T14:28:08.437315Z","steps":["trace[403440700] 'process raft request' (duration: 340.062452ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:28:08.437429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:28:08.096873Z","time spent":"340.505173ms","remote":"127.0.0.1:40456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7326,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T14:28:08.437459Z","caller":"traceutil/trace.go:171","msg":"trace[896118891] transaction","detail":"{read_only:false; number_of_response:1; response_revision:546; }","duration":"336.474003ms","start":"2026-08-22T14:28:08.100977Z","end":"2026-08-22T14:28:08.437451Z","steps":["trace[896118891] 'process raft request' (duration: 336.078285ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:28:08.437516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:28:08.100925Z","time spent":"336.554798ms","remote":"127.0.0.1:40456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":7375,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T14:28:08.437619Z","caller":"traceutil/trace.go:171","msg":"trace[1272934858] transaction","detail":"{read_only:false; number_of_response:1; response_revision:546; }","duration":"339.543168ms","start":"2026-08-22T14:28:08.098066Z","end":"2026-08-22T14:28:08.437609Z","steps":["trace[1272934858] 'process raft request' (duration: 338.94808ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:28:08.437656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:28:08.098052Z","time spent":"339.58476ms","remote":"127.0.0.1:40456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":101,"response count":0,"response size":10112,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T14:28:08.437786Z","caller":"traceutil/trace.go:171","msg":"trace[445983388] linearizableReadLoop","detail":"{readStateIndex:569; appliedIndex:555; }","duration":"265.019551ms","start":"2026-08-22T14:28:08.172742Z","end":"2026-08-22T14:28:08.437762Z","steps":["trace[445983388] 'read index received' (duration: 96.588264ms)","trace[445983388] 'applied index is now lower than readState.Index' (duration: 168.430117ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:28:08.437965Z","caller":"traceutil/trace.go:171","msg":"trace[1317113069] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"278.997807ms","start":"2026-08-22T14:28:08.158925Z","end":"2026-08-22T14:28:08.437923Z","steps":["trace[1317113069] 'process raft request' (duration: 278.699462ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:28:08.43799Z","caller":"traceutil/trace.go:171","msg":"trace[170006053] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"336.594101ms","start":"2026-08-22T14:28:08.101379Z","end":"2026-08-22T14:28:08.437973Z","steps":["trace[170006053] 'process raft request' (duration: 335.786532ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:28:08.438093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:28:08.101341Z","time spent":"336.692074ms","remote":"127.0.0.1:40456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28739,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-22T14:28:08.438149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.359487ms","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-08-22T14:28:08.438235Z","caller":"traceutil/trace.go:171","msg":"trace[1111513230] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:548; }","duration":"265.545005ms","start":"2026-08-22T14:28:08.172661Z","end":"2026-08-22T14:28:08.438206Z","steps":["trace[1111513230] 'agreement among raft nodes before linearized reading' (duration: 265.246462ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:28:08.458737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.021984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-22T14:28:08.458859Z","caller":"traceutil/trace.go:171","msg":"trace[2095697477] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:549; }","duration":"156.195762ms","start":"2026-08-22T14:28:08.302603Z","end":"2026-08-22T14:28:08.458799Z","steps":["trace[2095697477] 'agreement among raft nodes before linearized reading' (duration: 155.989402ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:28:08.988884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.747191ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-22T14:28:08.989213Z","caller":"traceutil/trace.go:171","msg":"trace[1546029737] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"529.522595ms","start":"2026-08-22T14:28:08.45965Z","end":"2026-08-22T14:28:08.989173Z","steps":["trace[1546029737] 'process raft request' (duration: 386.383887ms)","trace[1546029737] 'compare' (duration: 142.600123ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T14:28:08.989357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:28:08.45963Z","time spent":"529.677153ms","remote":"127.0.0.1:40456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7693,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T14:28:08.989386Z","caller":"traceutil/trace.go:171","msg":"trace[722463697] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"520.288912ms","start":"2026-08-22T14:28:08.469084Z","end":"2026-08-22T14:28:08.989373Z","steps":["trace[722463697] 'process raft request' (duration: 520.127374ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:28:08.989587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:28:08.469057Z","time spent":"520.442629ms","remote":"127.0.0.1:40456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58844,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T14:28:08.989886Z","caller":"traceutil/trace.go:171","msg":"trace[1068279254] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"517.094723ms","start":"2026-08-22T14:28:08.472779Z","end":"2026-08-22T14:28:08.989874Z","steps":["trace[1068279254] 'process raft request' (duration: 516.981758ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:28:08.990354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:28:08.472747Z","time spent":"517.560044ms","remote":"127.0.0.1:40456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79947,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T14:28:08.990006Z","caller":"traceutil/trace.go:171","msg":"trace[1551857049] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"520.534154ms","start":"2026-08-22T14:28:08.469377Z","end":"2026-08-22T14:28:08.989912Z","steps":["trace[1551857049] 'process raft request' (duration: 519.936836ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:28:08.990536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:28:08.469371Z","time spent":"521.113251ms","remote":"127.0.0.1:40668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T14:28:08.996561Z","caller":"traceutil/trace.go:171","msg":"trace[1542060075] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"501.286271ms","start":"2026-08-22T14:28:08.495253Z","end":"2026-08-22T14:28:08.996539Z","steps":["trace[1542060075] 'process raft request' (duration: 501.010327ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:28:08.99672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:28:08.495231Z","time spent":"501.400836ms","remote":"127.0.0.1:40456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":31121,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T14:28:08.996897Z","caller":"traceutil/trace.go:171","msg":"trace[1162106630] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"501.315872ms","start":"2026-08-22T14:28:08.495551Z","end":"2026-08-22T14:28:08.996867Z","steps":["trace[1162106630] 'process raft request' (duration: 500.951985ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:28:08.997092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:28:08.495544Z","time spent":"501.420347ms","remote":"127.0.0.1:40456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T14:28:08.997636Z","caller":"traceutil/trace.go:171","msg":"trace[337786145] linearizableReadLoop","detail":"{readStateIndex:581; appliedIndex:573; }","duration":"384.246166ms","start":"2026-08-22T14:28:08.61337Z","end":"2026-08-22T14:28:08.997616Z","steps":["trace[337786145] 'read index received' (duration: 232.718503ms)","trace[337786145] 'applied index is now lower than readState.Index' (duration: 151.526743ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:28:08.998242Z","caller":"traceutil/trace.go:171","msg":"trace[1182782221] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"495.682948ms","start":"2026-08-22T14:28:08.502539Z","end":"2026-08-22T14:28:08.998222Z","steps":["trace[1182782221] 'process raft request' (duration: 494.222969ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:28:08.998326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:28:08.502531Z","time spent":"495.762641ms","remote":"127.0.0.1:40456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17062,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-22T14:28:08.998387Z","caller":"traceutil/trace.go:171","msg":"trace[324528930] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"473.452304ms","start":"2026-08-22T14:28:08.524894Z","end":"2026-08-22T14:28:08.998346Z","steps":["trace[324528930] 'process raft request' (duration: 472.615184ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:28:08.998491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:28:08.524868Z","time spent":"473.58536ms","remote":"127.0.0.1:40456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":150480,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-22T14:28:08.998648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.274015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T14:28:08.998713Z","caller":"traceutil/trace.go:171","msg":"trace[1921933002] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:560; }","duration":"385.38754ms","start":"2026-08-22T14:28:08.613313Z","end":"2026-08-22T14:28:08.9987Z","steps":["trace[1921933002] 'agreement among raft nodes before linearized reading' (duration: 385.292006ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:28:08.998774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:28:08.613287Z","time spent":"385.467363ms","remote":"127.0.0.1:47526","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"warn","ts":"2026-08-22T14:28:08.998798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.306597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T14:28:08.998896Z","caller":"traceutil/trace.go:171","msg":"trace[1128854611] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:560; }","duration":"385.60062ms","start":"2026-08-22T14:28:08.613284Z","end":"2026-08-22T14:28:08.998885Z","steps":["trace[1128854611] 'agreement among raft nodes before linearized reading' (duration: 385.38732ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:28:08.998994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:28:08.613256Z","time spent":"385.720736ms","remote":"127.0.0.1:47526","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 "} {"level":"warn","ts":"2026-08-22T14:28:08.999167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.665283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T14:28:08.999229Z","caller":"traceutil/trace.go:171","msg":"trace[378996774] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:560; }","duration":"385.759598ms","start":"2026-08-22T14:28:08.61346Z","end":"2026-08-22T14:28:08.999219Z","steps":["trace[378996774] 'agreement among raft nodes before linearized reading' (duration: 385.677753ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:28:08.999272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:28:08.613445Z","time spent":"385.815991ms","remote":"127.0.0.1:47526","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 "} {"level":"info","ts":"2026-08-22T14:28:09.339176Z","caller":"traceutil/trace.go:171","msg":"trace[1090723318] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"328.737089ms","start":"2026-08-22T14:28:09.010412Z","end":"2026-08-22T14:28:09.339149Z","steps":["trace[1090723318] 'process raft request' (duration: 320.291328ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:28:09.339533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:28:09.010404Z","time spent":"328.864136ms","remote":"127.0.0.1:40668","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-08-22T14:28:09.339579Z","caller":"traceutil/trace.go:171","msg":"trace[1595178511] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"323.983ms","start":"2026-08-22T14:28:09.015541Z","end":"2026-08-22T14:28:09.339524Z","steps":["trace[1595178511] 'process raft request' (duration: 323.525498ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:28:09.339807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:28:09.015519Z","time spent":"324.163109ms","remote":"127.0.0.1:40456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":31130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T14:28:09.340103Z","caller":"traceutil/trace.go:171","msg":"trace[1575877412] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"246.947938ms","start":"2026-08-22T14:28:09.093124Z","end":"2026-08-22T14:28:09.340072Z","steps":["trace[1575877412] 'process raft request' (duration: 246.792881ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:28:09.340282Z","caller":"traceutil/trace.go:171","msg":"trace[333640166] linearizableReadLoop","detail":"{readStateIndex:583; appliedIndex:582; }","duration":"328.770953ms","start":"2026-08-22T14:28:09.011438Z","end":"2026-08-22T14:28:09.340209Z","steps":["trace[333640166] 'read index received' (duration: 25.809808ms)","trace[333640166] 'applied index is now lower than readState.Index' (duration: 302.958214ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T14:28:09.340396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.951441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-22T14:28:09.340463Z","caller":"traceutil/trace.go:171","msg":"trace[1037086062] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:565; }","duration":"329.052325ms","start":"2026-08-22T14:28:09.0114Z","end":"2026-08-22T14:28:09.340452Z","steps":["trace[1037086062] 'agreement among raft nodes before linearized reading' (duration: 328.933789ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:28:09.340498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:28:09.01138Z","time spent":"329.110517ms","remote":"127.0.0.1:40668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-22T14:28:09.340526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.700929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T14:28:09.340628Z","caller":"traceutil/trace.go:171","msg":"trace[337780671] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:565; }","duration":"119.844206ms","start":"2026-08-22T14:28:09.220763Z","end":"2026-08-22T14:28:09.340608Z","steps":["trace[337780671] 'agreement among raft nodes before linearized reading' (duration: 119.643497ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:28:09.340013Z","caller":"traceutil/trace.go:171","msg":"trace[1447237402] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"322.277521ms","start":"2026-08-22T14:28:09.017722Z","end":"2026-08-22T14:28:09.34Z","steps":["trace[1447237402] 'process raft request' (duration: 321.997208ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:28:09.341158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:28:09.017701Z","time spent":"323.405864ms","remote":"127.0.0.1:40456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29546,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-22T14:28:11.423393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"451.024807ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-22T14:28:11.42382Z","caller":"traceutil/trace.go:171","msg":"trace[5093109] linearizableReadLoop","detail":"{readStateIndex:627; appliedIndex:626; }","duration":"920.861681ms","start":"2026-08-22T14:28:10.502938Z","end":"2026-08-22T14:28:11.423799Z","steps":["trace[5093109] 'read index received' (duration: 469.187135ms)","trace[5093109] 'applied index is now lower than readState.Index' (duration: 451.672146ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:28:11.423843Z","caller":"traceutil/trace.go:171","msg":"trace[1329173814] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"927.297876ms","start":"2026-08-22T14:28:10.496512Z","end":"2026-08-22T14:28:11.42381Z","steps":["trace[1329173814] 'process raft request' (duration: 475.699333ms)","trace[1329173814] 'compare' (duration: 450.726274ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T14:28:11.424081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"921.146324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/xlistenersets.gateway.networking.x-k8s.io\" ","response":"range_response_count:1 size:29476"} {"level":"info","ts":"2026-08-22T14:28:11.424152Z","caller":"traceutil/trace.go:171","msg":"trace[665550076] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/xlistenersets.gateway.networking.x-k8s.io; range_end:; response_count:1; response_revision:606; }","duration":"921.268639ms","start":"2026-08-22T14:28:10.502862Z","end":"2026-08-22T14:28:11.424131Z","steps":["trace[665550076] 'agreement among raft nodes before linearized reading' (duration: 921.019948ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:28:11.424192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:28:10.502828Z","time spent":"921.355073ms","remote":"127.0.0.1:40456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":1,"response size":29499,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/xlistenersets.gateway.networking.x-k8s.io\" "} {"level":"warn","ts":"2026-08-22T14:28:11.424304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:28:10.4965Z","time spent":"927.583738ms","remote":"127.0.0.1:40668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T14:28:11.437772Z","caller":"traceutil/trace.go:171","msg":"trace[282052244] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"898.262177ms","start":"2026-08-22T14:28:10.539486Z","end":"2026-08-22T14:28:11.437748Z","steps":["trace[282052244] 'process raft request' (duration: 897.683031ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:28:11.437926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:28:10.539432Z","time spent":"898.443676ms","remote":"127.0.0.1:40456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":15673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-22T14:28:11.438073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.595235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-22T14:28:11.437957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.66698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-22T14:28:11.43821Z","caller":"traceutil/trace.go:171","msg":"trace[705686911] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:607; }","duration":"442.030646ms","start":"2026-08-22T14:28:10.99616Z","end":"2026-08-22T14:28:11.438191Z","steps":["trace[705686911] 'agreement among raft nodes before linearized reading' (duration: 441.594516ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:28:11.438261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:28:10.996111Z","time spent":"442.140611ms","remote":"127.0.0.1:40668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-08-22T14:28:11.43816Z","caller":"traceutil/trace.go:171","msg":"trace[1120505129] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:607; }","duration":"216.737312ms","start":"2026-08-22T14:28:11.221409Z","end":"2026-08-22T14:28:11.438146Z","steps":["trace[1120505129] 'agreement among raft nodes before linearized reading' (duration: 216.636647ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:28:13.519055Z","caller":"traceutil/trace.go:171","msg":"trace[2041144212] linearizableReadLoop","detail":"{readStateIndex:636; appliedIndex:635; }","duration":"294.063738ms","start":"2026-08-22T14:28:13.224968Z","end":"2026-08-22T14:28:13.519032Z","steps":["trace[2041144212] 'read index received' (duration: 293.953822ms)","trace[2041144212] 'applied index is now lower than readState.Index' (duration: 106.676µs)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:28:13.519278Z","caller":"traceutil/trace.go:171","msg":"trace[804271117] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"328.693436ms","start":"2026-08-22T14:28:13.190574Z","end":"2026-08-22T14:28:13.519268Z","steps":["trace[804271117] 'process raft request' (duration: 328.317399ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:28:13.519368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:28:13.190559Z","time spent":"328.753849ms","remote":"127.0.0.1:40520","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":397,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-22T14:28:13.519597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.624942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T14:28:13.519628Z","caller":"traceutil/trace.go:171","msg":"trace[300581379] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:614; }","duration":"294.699545ms","start":"2026-08-22T14:28:13.224919Z","end":"2026-08-22T14:28:13.519619Z","steps":["trace[300581379] 'agreement among raft nodes before linearized reading' (duration: 294.597711ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:28:17.384595Z","caller":"traceutil/trace.go:171","msg":"trace[1136132354] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"118.421967ms","start":"2026-08-22T14:28:17.266123Z","end":"2026-08-22T14:28:17.384545Z","steps":["trace[1136132354] 'process raft request' (duration: 112.961648ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:28:18.418159Z","caller":"traceutil/trace.go:171","msg":"trace[2075476531] linearizableReadLoop","detail":"{readStateIndex:676; appliedIndex:675; }","duration":"197.820648ms","start":"2026-08-22T14:28:18.220312Z","end":"2026-08-22T14:28:18.418132Z","steps":["trace[2075476531] 'read index received' (duration: 197.465132ms)","trace[2075476531] 'applied index is now lower than readState.Index' (duration: 354.266µs)"],"step_count":2} {"level":"warn","ts":"2026-08-22T14:28:18.418288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.962163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T14:28:18.418335Z","caller":"traceutil/trace.go:171","msg":"trace[1097314035] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:653; }","duration":"198.050936ms","start":"2026-08-22T14:28:18.220267Z","end":"2026-08-22T14:28:18.418317Z","steps":["trace[1097314035] 'agreement among raft nodes before linearized reading' (duration: 197.967003ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:28:18.418523Z","caller":"traceutil/trace.go:171","msg":"trace[669840204] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"287.250221ms","start":"2026-08-22T14:28:18.131234Z","end":"2026-08-22T14:28:18.418484Z","steps":["trace[669840204] 'process raft request' (duration: 286.730959ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:28:19.745829Z","caller":"traceutil/trace.go:171","msg":"trace[1174242200] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"133.736349ms","start":"2026-08-22T14:28:19.612064Z","end":"2026-08-22T14:28:19.745801Z","steps":["trace[1174242200] 'process raft request' (duration: 133.561502ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:28:19.746029Z","caller":"traceutil/trace.go:171","msg":"trace[953047974] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"133.879765ms","start":"2026-08-22T14:28:19.612119Z","end":"2026-08-22T14:28:19.745999Z","steps":["trace[953047974] 'process raft request' (duration: 133.639465ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:28:21.462491Z","caller":"traceutil/trace.go:171","msg":"trace[1826986536] transaction","detail":"{read_only:false; response_revision:684; number_of_response:1; }","duration":"229.753227ms","start":"2026-08-22T14:28:21.232715Z","end":"2026-08-22T14:28:21.462468Z","steps":["trace[1826986536] 'process raft request' (duration: 229.57387ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:28:35.276625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"879.31398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-22T14:28:35.276696Z","caller":"traceutil/trace.go:171","msg":"trace[468135204] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:809; }","duration":"879.421314ms","start":"2026-08-22T14:28:34.397257Z","end":"2026-08-22T14:28:35.276678Z","steps":["trace[468135204] 'count revisions from in-memory index tree' (duration: 879.247958ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:28:35.276725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:28:34.39724Z","time spent":"879.478286ms","remote":"127.0.0.1:40594","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":12,"response size":30,"request content":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true "} {"level":"warn","ts":"2026-08-22T14:28:35.276708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.73641ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-22T14:28:35.276764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.645619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-08-22T14:28:35.276849Z","caller":"traceutil/trace.go:171","msg":"trace[1930283854] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:809; }","duration":"469.915456ms","start":"2026-08-22T14:28:34.806911Z","end":"2026-08-22T14:28:35.276826Z","steps":["trace[1930283854] 'range keys from in-memory index tree' (duration: 469.714119ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:28:35.276864Z","caller":"traceutil/trace.go:171","msg":"trace[1293096034] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:809; }","duration":"190.802054ms","start":"2026-08-22T14:28:35.086034Z","end":"2026-08-22T14:28:35.276837Z","steps":["trace[1293096034] 'range keys from in-memory index tree' (duration: 190.447952ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:28:35.276865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.072316284s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-bhkkj\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-08-22T14:28:35.276932Z","caller":"traceutil/trace.go:171","msg":"trace[1904358896] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-bhkkj; range_end:; response_count:1; response_revision:809; }","duration":"1.07246432s","start":"2026-08-22T14:28:34.20445Z","end":"2026-08-22T14:28:35.276914Z","steps":["trace[1904358896] 'range keys from in-memory index tree' (duration: 1.072161449s)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:28:35.276971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:28:34.204423Z","time spent":"1.072541062s","remote":"127.0.0.1:40594","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3987,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-bhkkj\" "} {"level":"warn","ts":"2026-08-22T14:28:49.586304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.465637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-08-22T14:28:49.586402Z","caller":"traceutil/trace.go:171","msg":"trace[954772124] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:972; }","duration":"209.647162ms","start":"2026-08-22T14:28:49.376735Z","end":"2026-08-22T14:28:49.586382Z","steps":["trace[954772124] 'range keys from in-memory index tree' (duration: 209.264951ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:29:21.86664Z","caller":"traceutil/trace.go:171","msg":"trace[1048569900] transaction","detail":"{read_only:false; response_revision:1093; number_of_response:1; }","duration":"114.378681ms","start":"2026-08-22T14:29:21.752239Z","end":"2026-08-22T14:29:21.866618Z","steps":["trace[1048569900] 'process raft request' (duration: 114.061464ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:30:28.516084Z","caller":"traceutil/trace.go:171","msg":"trace[536207675] linearizableReadLoop","detail":"{readStateIndex:1403; appliedIndex:1402; }","duration":"210.880029ms","start":"2026-08-22T14:30:28.305182Z","end":"2026-08-22T14:30:28.516063Z","steps":["trace[536207675] 'read index received' (duration: 210.757467ms)","trace[536207675] 'applied index is now lower than readState.Index' (duration: 121.152µs)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:30:28.516183Z","caller":"traceutil/trace.go:171","msg":"trace[316128429] transaction","detail":"{read_only:false; response_revision:1348; number_of_response:1; }","duration":"220.508843ms","start":"2026-08-22T14:30:28.295626Z","end":"2026-08-22T14:30:28.516135Z","steps":["trace[316128429] 'process raft request' (duration: 220.29893ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:30:28.516356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.164114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-08-22T14:30:28.516394Z","caller":"traceutil/trace.go:171","msg":"trace[1710005742] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1348; }","duration":"211.257425ms","start":"2026-08-22T14:30:28.305126Z","end":"2026-08-22T14:30:28.516383Z","steps":["trace[1710005742] 'agreement among raft nodes before linearized reading' (duration: 211.072472ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:30:28.516552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.032759ms","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-08-22T14:30:28.516662Z","caller":"traceutil/trace.go:171","msg":"trace[1363715911] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1348; }","duration":"106.207831ms","start":"2026-08-22T14:30:28.41043Z","end":"2026-08-22T14:30:28.516638Z","steps":["trace[1363715911] 'agreement among raft nodes before linearized reading' (duration: 105.801734ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:30:28.750034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.547046ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-22T14:30:28.750158Z","caller":"traceutil/trace.go:171","msg":"trace[1211776617] transaction","detail":"{read_only:false; response_revision:1349; number_of_response:1; }","duration":"228.662978ms","start":"2026-08-22T14:30:28.521473Z","end":"2026-08-22T14:30:28.750136Z","steps":["trace[1211776617] 'process raft request' (duration: 57.901478ms)","trace[1211776617] 'compare' (duration: 170.412035ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:30:29.173438Z","caller":"traceutil/trace.go:171","msg":"trace[1891384743] transaction","detail":"{read_only:false; response_revision:1350; number_of_response:1; }","duration":"651.876636ms","start":"2026-08-22T14:30:28.521526Z","end":"2026-08-22T14:30:29.173403Z","steps":["trace[1891384743] 'process raft request' (duration: 651.621792ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:30:29.173604Z","caller":"traceutil/trace.go:171","msg":"trace[2087580939] linearizableReadLoop","detail":"{readStateIndex:1406; appliedIndex:1403; }","duration":"642.055399ms","start":"2026-08-22T14:30:28.531515Z","end":"2026-08-22T14:30:29.173571Z","steps":["trace[2087580939] 'read index received' (duration: 47.938389ms)","trace[2087580939] 'applied index is now lower than readState.Index' (duration: 594.11495ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T14:30:29.173655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:30:28.521493Z","time spent":"652.063859ms","remote":"127.0.0.1:40668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T14:30:29.173674Z","caller":"traceutil/trace.go:171","msg":"trace[441494814] transaction","detail":"{read_only:false; response_revision:1351; number_of_response:1; }","duration":"652.105519ms","start":"2026-08-22T14:30:28.52154Z","end":"2026-08-22T14:30:29.173645Z","steps":["trace[441494814] 'process raft request' (duration: 651.803315ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:30:29.173836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:30:28.521511Z","time spent":"652.2293ms","remote":"127.0.0.1:40668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-22T14:30:29.173846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"642.312742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-22T14:30:29.173889Z","caller":"traceutil/trace.go:171","msg":"trace[1744525169] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1351; }","duration":"642.393823ms","start":"2026-08-22T14:30:28.531484Z","end":"2026-08-22T14:30:29.173878Z","steps":["trace[1744525169] 'agreement among raft nodes before linearized reading' (duration: 642.211031ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:30:29.173922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:30:28.531471Z","time spent":"642.443705ms","remote":"127.0.0.1:40668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-22T14:30:30.217803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"580.678063ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-22T14:30:30.217953Z","caller":"traceutil/trace.go:171","msg":"trace[2001166033] transaction","detail":"{read_only:false; response_revision:1352; number_of_response:1; }","duration":"1.519447517s","start":"2026-08-22T14:30:28.698482Z","end":"2026-08-22T14:30:30.21793Z","steps":["trace[2001166033] 'process raft request' (duration: 938.564231ms)","trace[2001166033] 'compare' (duration: 580.373459ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:30:30.218001Z","caller":"traceutil/trace.go:171","msg":"trace[477199416] linearizableReadLoop","detail":"{readStateIndex:1407; appliedIndex:1406; }","duration":"1.044328516s","start":"2026-08-22T14:30:29.173664Z","end":"2026-08-22T14:30:30.217993Z","steps":["trace[477199416] 'read index received' (duration: 463.39975ms)","trace[477199416] 'applied index is now lower than readState.Index' (duration: 580.927896ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T14:30:30.21805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:30:28.698451Z","time spent":"1.519555028s","remote":"127.0.0.1:40668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T14:30:30.217969Z","caller":"traceutil/trace.go:171","msg":"trace[477784709] transaction","detail":"{read_only:false; response_revision:1353; number_of_response:1; }","duration":"1.039413457s","start":"2026-08-22T14:30:29.178543Z","end":"2026-08-22T14:30:30.217956Z","steps":["trace[477784709] 'process raft request' (duration: 1.039362426s)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:30:30.218188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:30:29.178519Z","time spent":"1.039643841s","remote":"127.0.0.1:40668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-22T14:30:30.218237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.341853072s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T14:30:30.218267Z","caller":"traceutil/trace.go:171","msg":"trace[857485166] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:1353; }","duration":"1.341921903s","start":"2026-08-22T14:30:28.876337Z","end":"2026-08-22T14:30:30.218259Z","steps":["trace[857485166] 'agreement among raft nodes before linearized reading' (duration: 1.341872502s)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:30:30.218295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:30:28.876317Z","time spent":"1.341971623s","remote":"127.0.0.1:40566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":0,"response size":28,"request content":"key:\"/registry/persistentvolumes/test-pv\" "} {"level":"warn","ts":"2026-08-22T14:30:30.218515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.686798499s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-22T14:30:30.218546Z","caller":"traceutil/trace.go:171","msg":"trace[1971404396] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1353; }","duration":"1.686865391s","start":"2026-08-22T14:30:28.531671Z","end":"2026-08-22T14:30:30.218537Z","steps":["trace[1971404396] 'agreement among raft nodes before linearized reading' (duration: 1.68675326s)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:30:30.218573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:30:28.531658Z","time spent":"1.686909082s","remote":"127.0.0.1:40668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-22T14:30:30.218704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"861.205474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-22T14:30:30.218734Z","caller":"traceutil/trace.go:171","msg":"trace[591780283] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1353; }","duration":"861.282716ms","start":"2026-08-22T14:30:29.357443Z","end":"2026-08-22T14:30:30.218726Z","steps":["trace[591780283] 'agreement among raft nodes before linearized reading' (duration: 861.234575ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:30:30.218761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:30:29.35742Z","time spent":"861.333776ms","remote":"127.0.0.1:56628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":30,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-08-22T14:30:30.496561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.341903ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-22T14:30:30.496682Z","caller":"traceutil/trace.go:171","msg":"trace[831769686] linearizableReadLoop","detail":"{readStateIndex:1409; appliedIndex:1408; }","duration":"272.814498ms","start":"2026-08-22T14:30:30.223845Z","end":"2026-08-22T14:30:30.49666Z","steps":["trace[831769686] 'read index received' (duration: 165.04451ms)","trace[831769686] 'applied index is now lower than readState.Index' (duration: 107.767958ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:30:30.496697Z","caller":"traceutil/trace.go:171","msg":"trace[1855786774] transaction","detail":"{read_only:false; response_revision:1354; number_of_response:1; }","duration":"273.943404ms","start":"2026-08-22T14:30:30.222726Z","end":"2026-08-22T14:30:30.496669Z","steps":["trace[1855786774] 'process raft request' (duration: 166.231266ms)","trace[1855786774] 'compare' (duration: 107.215081ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T14:30:30.496766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.911309ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T14:30:30.496813Z","caller":"traceutil/trace.go:171","msg":"trace[1568233264] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:1354; }","duration":"272.96881ms","start":"2026-08-22T14:30:30.223829Z","end":"2026-08-22T14:30:30.496798Z","steps":["trace[1568233264] 'agreement among raft nodes before linearized reading' (duration: 272.889579ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:30:31.422781Z","caller":"traceutil/trace.go:171","msg":"trace[29518763] linearizableReadLoop","detail":"{readStateIndex:1410; appliedIndex:1409; }","duration":"282.405722ms","start":"2026-08-22T14:30:31.140345Z","end":"2026-08-22T14:30:31.422751Z","steps":["trace[29518763] 'read index received' (duration: 282.132709ms)","trace[29518763] 'applied index is now lower than readState.Index' (duration: 271.993µs)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:30:31.422827Z","caller":"traceutil/trace.go:171","msg":"trace[257864802] transaction","detail":"{read_only:false; response_revision:1355; number_of_response:1; }","duration":"665.09465ms","start":"2026-08-22T14:30:30.757696Z","end":"2026-08-22T14:30:31.422791Z","steps":["trace[257864802] 'process raft request' (duration: 664.876227ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:30:31.422979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:30:30.75768Z","time spent":"665.212362ms","remote":"127.0.0.1:40668","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-08-22T14:30:31.422988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.618906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-22T14:30:31.423025Z","caller":"traceutil/trace.go:171","msg":"trace[241610295] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:1355; }","duration":"282.723957ms","start":"2026-08-22T14:30:31.140292Z","end":"2026-08-22T14:30:31.423016Z","steps":["trace[241610295] 'agreement among raft nodes before linearized reading' (duration: 282.601334ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:30:31.42325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.054409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-08-22T14:30:31.423327Z","caller":"traceutil/trace.go:171","msg":"trace[999597415] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1355; }","duration":"245.195091ms","start":"2026-08-22T14:30:31.178116Z","end":"2026-08-22T14:30:31.423311Z","steps":["trace[999597415] 'agreement among raft nodes before linearized reading' (duration: 244.987538ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:30:31.423549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.248641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-08-22T14:30:31.423614Z","caller":"traceutil/trace.go:171","msg":"trace[1337042108] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1355; }","duration":"245.332522ms","start":"2026-08-22T14:30:31.17827Z","end":"2026-08-22T14:30:31.423603Z","steps":["trace[1337042108] 'agreement among raft nodes before linearized reading' (duration: 245.213481ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:30:31.75104Z","caller":"traceutil/trace.go:171","msg":"trace[888350482] transaction","detail":"{read_only:false; response_revision:1356; number_of_response:1; }","duration":"322.396932ms","start":"2026-08-22T14:30:31.428608Z","end":"2026-08-22T14:30:31.751005Z","steps":["trace[888350482] 'process raft request' (duration: 322.21687ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:30:31.751509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:30:31.428586Z","time spent":"322.583284ms","remote":"127.0.0.1:40668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T14:30:31.771537Z","caller":"traceutil/trace.go:171","msg":"trace[1061807] transaction","detail":"{read_only:false; response_revision:1357; number_of_response:1; }","duration":"342.61365ms","start":"2026-08-22T14:30:31.428884Z","end":"2026-08-22T14:30:31.771497Z","steps":["trace[1061807] 'process raft request' (duration: 336.580068ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:30:31.771827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:30:31.428868Z","time spent":"342.756553ms","remote":"127.0.0.1:40668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T14:30:32.766545Z","caller":"traceutil/trace.go:171","msg":"trace[826560092] transaction","detail":"{read_only:false; response_revision:1364; number_of_response:1; }","duration":"129.630914ms","start":"2026-08-22T14:30:32.636882Z","end":"2026-08-22T14:30:32.766513Z","steps":["trace[826560092] 'process raft request' (duration: 129.465381ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:30:59.825904Z","caller":"traceutil/trace.go:171","msg":"trace[780590431] linearizableReadLoop","detail":"{readStateIndex:1514; appliedIndex:1513; }","duration":"171.164836ms","start":"2026-08-22T14:30:59.654716Z","end":"2026-08-22T14:30:59.825881Z","steps":["trace[780590431] 'read index received' (duration: 171.042943ms)","trace[780590431] 'applied index is now lower than readState.Index' (duration: 118.912µs)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:30:59.82599Z","caller":"traceutil/trace.go:171","msg":"trace[1306533517] transaction","detail":"{read_only:false; response_revision:1453; number_of_response:1; }","duration":"228.376353ms","start":"2026-08-22T14:30:59.59758Z","end":"2026-08-22T14:30:59.825957Z","steps":["trace[1306533517] 'process raft request' (duration: 228.16048ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:30:59.826062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.237506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-22T14:30:59.826051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.310187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-system/system::extension-apiserver-authentication-reader\" ","response":"range_response_count:1 size:856"} {"level":"info","ts":"2026-08-22T14:30:59.826101Z","caller":"traceutil/trace.go:171","msg":"trace[1737627621] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1453; }","duration":"154.302997ms","start":"2026-08-22T14:30:59.671784Z","end":"2026-08-22T14:30:59.826087Z","steps":["trace[1737627621] 'agreement among raft nodes before linearized reading' (duration: 154.240796ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:30:59.826112Z","caller":"traceutil/trace.go:171","msg":"trace[1664487409] range","detail":"{range_begin:/registry/rolebindings/kube-system/system::extension-apiserver-authentication-reader; range_end:; response_count:1; response_revision:1453; }","duration":"171.412429ms","start":"2026-08-22T14:30:59.654683Z","end":"2026-08-22T14:30:59.826095Z","steps":["trace[1664487409] 'agreement among raft nodes before linearized reading' (duration: 171.293218ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:30:59.826286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.468792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-system/system::leader-locking-kube-controller-manager\" ","response":"range_response_count:1 size:853"} {"level":"info","ts":"2026-08-22T14:30:59.826378Z","caller":"traceutil/trace.go:171","msg":"trace[1413530364] range","detail":"{range_begin:/registry/rolebindings/kube-system/system::leader-locking-kube-controller-manager; range_end:; response_count:1; response_revision:1453; }","duration":"138.579733ms","start":"2026-08-22T14:30:59.687774Z","end":"2026-08-22T14:30:59.826354Z","steps":["trace[1413530364] 'agreement among raft nodes before linearized reading' (duration: 138.35081ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:31:03.184176Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6530395561375178131,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-22T14:31:03.305285Z","caller":"traceutil/trace.go:171","msg":"trace[2041445516] linearizableReadLoop","detail":"{readStateIndex:1527; appliedIndex:1526; }","duration":"622.037984ms","start":"2026-08-22T14:31:02.683226Z","end":"2026-08-22T14:31:03.305264Z","steps":["trace[2041445516] 'read index received' (duration: 621.862801ms)","trace[2041445516] 'applied index is now lower than readState.Index' (duration: 174.243µs)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:31:03.305402Z","caller":"traceutil/trace.go:171","msg":"trace[415733866] transaction","detail":"{read_only:false; response_revision:1465; number_of_response:1; }","duration":"624.829659ms","start":"2026-08-22T14:31:02.680562Z","end":"2026-08-22T14:31:03.305392Z","steps":["trace[415733866] 'process raft request' (duration: 624.574375ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:31:03.305516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:31:02.680538Z","time spent":"624.889009ms","remote":"127.0.0.1:40668","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-08-22T14:31:03.305575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"580.205313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-08-22T14:31:03.305658Z","caller":"traceutil/trace.go:171","msg":"trace[115514908] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:1465; }","duration":"580.320164ms","start":"2026-08-22T14:31:02.725317Z","end":"2026-08-22T14:31:03.305637Z","steps":["trace[115514908] 'agreement among raft nodes before linearized reading' (duration: 580.181432ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:31:03.305708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:31:02.725306Z","time spent":"580.392844ms","remote":"127.0.0.1:40614","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" "} {"level":"warn","ts":"2026-08-22T14:31:03.3058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"622.56128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cronjob-controller\" ","response":"range_response_count:1 size:201"} {"level":"info","ts":"2026-08-22T14:31:03.305868Z","caller":"traceutil/trace.go:171","msg":"trace[201686411] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cronjob-controller; range_end:; response_count:1; response_revision:1465; }","duration":"622.644342ms","start":"2026-08-22T14:31:02.683211Z","end":"2026-08-22T14:31:03.305855Z","steps":["trace[201686411] 'agreement among raft nodes before linearized reading' (duration: 622.520521ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:31:03.305904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:31:02.683202Z","time spent":"622.694183ms","remote":"127.0.0.1:40614","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":1,"response size":224,"request content":"key:\"/registry/serviceaccounts/kube-system/cronjob-controller\" "}