{"level":"warn","ts":"2026-06-10T10:08:44.915115Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-10T10:08:44.915221Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.191: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.19.213.191:2380","--initial-cluster=instance=https://199.19.213.191:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.191:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.191: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-06-10T10:08:44.915295Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-10T10:08:44.915307Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.191:2380"]} {"level":"info","ts":"2026-06-10T10:08:44.915334Z","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-06-10T10:08:44.916135Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.191:2379"]} {"level":"info","ts":"2026-06-10T10:08:44.916254Z","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.19.213.191:2380"],"listen-peer-urls":["https://199.19.213.191:2380"],"advertise-client-urls":["https://199.19.213.191:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.191:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.191: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-06-10T10:08:44.921245Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.544855ms"} {"level":"info","ts":"2026-06-10T10:08:44.929004Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e892d50a3a4fc0f4","cluster-id":"21eccdda20ff4e92"} {"level":"info","ts":"2026-06-10T10:08:44.929187Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 switched to configuration voters=()"} {"level":"info","ts":"2026-06-10T10:08:44.929229Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 became follower at term 0"} {"level":"info","ts":"2026-06-10T10:08:44.929253Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e892d50a3a4fc0f4 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-10T10:08:44.929276Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 became follower at term 1"} {"level":"info","ts":"2026-06-10T10:08:44.929335Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 switched to configuration voters=(16758691403303731444)"} {"level":"warn","ts":"2026-06-10T10:08:44.936403Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-10T10:08:44.937818Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-10T10:08:44.938915Z","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-06-10T10:08:44.94123Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e892d50a3a4fc0f4","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-10T10:08:44.941451Z","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-06-10T10:08:44.941594Z","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-06-10T10:08:44.941611Z","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-06-10T10:08:44.941548Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e892d50a3a4fc0f4","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-10T10:08:44.944266Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 switched to configuration voters=(16758691403303731444)"} {"level":"info","ts":"2026-06-10T10:08:44.944783Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"21eccdda20ff4e92","local-member-id":"e892d50a3a4fc0f4","added-peer-id":"e892d50a3a4fc0f4","added-peer-peer-urls":["https://199.19.213.191:2380"]} {"level":"info","ts":"2026-06-10T10:08:44.946717Z","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-06-10T10:08:44.946858Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.191:2380"} {"level":"info","ts":"2026-06-10T10:08:44.94695Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.191:2380"} {"level":"info","ts":"2026-06-10T10:08:44.946981Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e892d50a3a4fc0f4","initial-advertise-peer-urls":["https://199.19.213.191:2380"],"listen-peer-urls":["https://199.19.213.191:2380"],"advertise-client-urls":["https://199.19.213.191:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.191:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-10T10:08:44.947028Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-10T10:08:45.530067Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 is starting a new election at term 1"} {"level":"info","ts":"2026-06-10T10:08:45.530141Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-10T10:08:45.53019Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 received MsgPreVoteResp from e892d50a3a4fc0f4 at term 1"} {"level":"info","ts":"2026-06-10T10:08:45.530219Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 became candidate at term 2"} {"level":"info","ts":"2026-06-10T10:08:45.530231Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 received MsgVoteResp from e892d50a3a4fc0f4 at term 2"} {"level":"info","ts":"2026-06-10T10:08:45.530248Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 became leader at term 2"} {"level":"info","ts":"2026-06-10T10:08:45.530261Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e892d50a3a4fc0f4 elected leader e892d50a3a4fc0f4 at term 2"} {"level":"info","ts":"2026-06-10T10:08:45.565002Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-10T10:08:45.566051Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e892d50a3a4fc0f4","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.191:2379]}","request-path":"/0/members/e892d50a3a4fc0f4/attributes","cluster-id":"21eccdda20ff4e92","publish-timeout":"7s"} {"level":"info","ts":"2026-06-10T10:08:45.566263Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-10T10:08:45.566413Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-10T10:08:45.567319Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"21eccdda20ff4e92","local-member-id":"e892d50a3a4fc0f4","cluster-version":"3.5"} {"level":"info","ts":"2026-06-10T10:08:45.567496Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-10T10:08:45.567537Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-10T10:08:45.570481Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-10T10:08:45.571367Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.191:2379"} {"level":"info","ts":"2026-06-10T10:08:45.571552Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-10T10:08:45.571609Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-10T10:08:47.138565Z","caller":"traceutil/trace.go:171","msg":"trace[1599138849] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"169.721297ms","start":"2026-06-10T10:08:46.968804Z","end":"2026-06-10T10:08:47.138525Z","steps":["trace[1599138849] 'process raft request' (duration: 167.375967ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:08:47.13862Z","caller":"traceutil/trace.go:171","msg":"trace[1485893482] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"169.695796ms","start":"2026-06-10T10:08:46.96888Z","end":"2026-06-10T10:08:47.138575Z","steps":["trace[1485893482] 'process raft request' (duration: 169.578853ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:08:47.13865Z","caller":"traceutil/trace.go:171","msg":"trace[2095658235] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"169.676926ms","start":"2026-06-10T10:08:46.968941Z","end":"2026-06-10T10:08:47.138618Z","steps":["trace[2095658235] 'process raft request' (duration: 169.589414ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:08:47.138848Z","caller":"traceutil/trace.go:171","msg":"trace[2005835417] linearizableReadLoop","detail":"{readStateIndex:27; appliedIndex:17; }","duration":"142.369849ms","start":"2026-06-10T10:08:46.996456Z","end":"2026-06-10T10:08:47.138825Z","steps":["trace[2005835417] 'read index received' (duration: 139.745364ms)","trace[2005835417] 'applied index is now lower than readState.Index' (duration: 2.623415ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:08:47.138918Z","caller":"traceutil/trace.go:171","msg":"trace[1474176489] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"168.313727ms","start":"2026-06-10T10:08:46.970544Z","end":"2026-06-10T10:08:47.138858Z","steps":["trace[1474176489] 'process raft request' (duration: 168.051021ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:08:47.138976Z","caller":"traceutil/trace.go:171","msg":"trace[345545872] transaction","detail":"{read_only:false; response_revision:22; number_of_response:1; }","duration":"145.971014ms","start":"2026-06-10T10:08:46.992993Z","end":"2026-06-10T10:08:47.138964Z","steps":["trace[345545872] 'process raft request' (duration: 145.719059ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:08:47.13903Z","caller":"traceutil/trace.go:171","msg":"trace[1305256424] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"170.034043ms","start":"2026-06-10T10:08:46.968983Z","end":"2026-06-10T10:08:47.139017Z","steps":["trace[1305256424] 'process raft request' (duration: 169.576574ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:08:47.139203Z","caller":"traceutil/trace.go:171","msg":"trace[363518333] transaction","detail":"{read_only:false; response_revision:23; number_of_response:1; }","duration":"142.9046ms","start":"2026-06-10T10:08:46.996249Z","end":"2026-06-10T10:08:47.139154Z","steps":["trace[363518333] 'process raft request' (duration: 142.501172ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:08:47.139238Z","caller":"traceutil/trace.go:171","msg":"trace[825638623] transaction","detail":"{read_only:false; response_revision:24; number_of_response:1; }","duration":"142.001261ms","start":"2026-06-10T10:08:46.997226Z","end":"2026-06-10T10:08:47.139227Z","steps":["trace[825638623] 'process raft request' (duration: 141.559832ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:08:47.139226Z","caller":"traceutil/trace.go:171","msg":"trace[1454807089] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"165.474136ms","start":"2026-06-10T10:08:46.973697Z","end":"2026-06-10T10:08:47.139171Z","steps":["trace[1454807089] 'process raft request' (duration: 164.952055ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:08:47.139464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.979992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-rczqc\" ","response":"range_response_count:1 size:861"} {"level":"info","ts":"2026-06-10T10:08:47.139574Z","caller":"traceutil/trace.go:171","msg":"trace[2113179770] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-rczqc; range_end:; response_count:1; response_revision:24; }","duration":"143.140344ms","start":"2026-06-10T10:08:46.99642Z","end":"2026-06-10T10:08:47.139561Z","steps":["trace[2113179770] 'agreement among raft nodes before linearized reading' (duration: 142.961061ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:08:47.139586Z","caller":"traceutil/trace.go:171","msg":"trace[1482390173] transaction","detail":"{read_only:false; response_revision:21; number_of_response:1; }","duration":"165.036678ms","start":"2026-06-10T10:08:46.97454Z","end":"2026-06-10T10:08:47.139577Z","steps":["trace[1482390173] 'process raft request' (duration: 164.138889ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:08:47.139962Z","caller":"traceutil/trace.go:171","msg":"trace[633741496] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"170.786518ms","start":"2026-06-10T10:08:46.96891Z","end":"2026-06-10T10:08:47.139696Z","steps":["trace[633741496] 'process raft request' (duration: 169.585603ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:08:48.800732Z","caller":"traceutil/trace.go:171","msg":"trace[464059743] transaction","detail":"{read_only:false; response_revision:195; number_of_response:1; }","duration":"264.764855ms","start":"2026-06-10T10:08:48.535933Z","end":"2026-06-10T10:08:48.800698Z","steps":["trace[464059743] 'process raft request' (duration: 264.582801ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:08:54.503104Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13903912432670835660,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-10T10:08:55.004203Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13903912432670835660,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-10T10:08:55.435442Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.446731871s","expected-duration":"1s"} {"level":"info","ts":"2026-06-10T10:08:55.43599Z","caller":"traceutil/trace.go:171","msg":"trace[894251134] linearizableReadLoop","detail":"{readStateIndex:309; appliedIndex:308; }","duration":"1.43295178s","start":"2026-06-10T10:08:54.003005Z","end":"2026-06-10T10:08:55.435957Z","steps":["trace[894251134] 'read index received' (duration: 1.432713105s)","trace[894251134] 'applied index is now lower than readState.Index' (duration: 237.355µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:08:55.436054Z","caller":"traceutil/trace.go:171","msg":"trace[1896567220] transaction","detail":"{read_only:false; response_revision:299; number_of_response:1; }","duration":"1.447463247s","start":"2026-06-10T10:08:53.988527Z","end":"2026-06-10T10:08:55.43599Z","steps":["trace[1896567220] 'process raft request' (duration: 1.447252422s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:08:55.436197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.433163154s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-10T10:08:55.436272Z","caller":"traceutil/trace.go:171","msg":"trace[1611004043] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:299; }","duration":"1.433306218s","start":"2026-06-10T10:08:54.002937Z","end":"2026-06-10T10:08:55.436244Z","steps":["trace[1611004043] 'agreement among raft nodes before linearized reading' (duration: 1.433104524s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:08:55.436305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:08:54.002913Z","time spent":"1.433386369s","remote":"127.0.0.1:51466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-10T10:08:55.436257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.6902ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:08:55.436434Z","caller":"traceutil/trace.go:171","msg":"trace[99732987] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:299; }","duration":"412.857444ms","start":"2026-06-10T10:08:55.023512Z","end":"2026-06-10T10:08:55.436369Z","steps":["trace[99732987] 'agreement among raft nodes before linearized reading' (duration: 412.66512ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:08:55.436624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:08:53.988486Z","time spent":"1.447664461s","remote":"127.0.0.1:51382","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":192,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-10T10:08:55.436747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.073651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-10T10:08:55.436847Z","caller":"traceutil/trace.go:171","msg":"trace[1011794397] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:299; }","duration":"247.233464ms","start":"2026-06-10T10:08:55.189586Z","end":"2026-06-10T10:08:55.436819Z","steps":["trace[1011794397] 'agreement among raft nodes before linearized reading' (duration: 247.04511ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:08:55.436857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.492755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-06-10T10:08:55.436949Z","caller":"traceutil/trace.go:171","msg":"trace[239024043] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:299; }","duration":"313.636087ms","start":"2026-06-10T10:08:55.123291Z","end":"2026-06-10T10:08:55.436927Z","steps":["trace[239024043] 'agreement among raft nodes before linearized reading' (duration: 313.412583ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:08:55.436993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:08:55.123212Z","time spent":"313.77302ms","remote":"127.0.0.1:51466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-10T10:08:55.437026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.800168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-06-10T10:08:55.437247Z","caller":"traceutil/trace.go:171","msg":"trace[585363071] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:299; }","duration":"248.960102ms","start":"2026-06-10T10:08:55.188136Z","end":"2026-06-10T10:08:55.437096Z","steps":["trace[585363071] 'agreement among raft nodes before linearized reading' (duration: 248.488582ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:08:56.063883Z","caller":"traceutil/trace.go:171","msg":"trace[947957470] transaction","detail":"{read_only:false; response_revision:301; number_of_response:1; }","duration":"621.976483ms","start":"2026-06-10T10:08:55.44188Z","end":"2026-06-10T10:08:56.063857Z","steps":["trace[947957470] 'process raft request' (duration: 562.145969ms)","trace[947957470] 'compare' (duration: 59.286993ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:08:56.063904Z","caller":"traceutil/trace.go:171","msg":"trace[693963285] transaction","detail":"{read_only:false; response_revision:302; number_of_response:1; }","duration":"621.627206ms","start":"2026-06-10T10:08:55.442242Z","end":"2026-06-10T10:08:56.06387Z","steps":["trace[693963285] 'process raft request' (duration: 621.284789ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:08:56.064101Z","caller":"traceutil/trace.go:171","msg":"trace[100635338] transaction","detail":"{read_only:false; response_revision:303; number_of_response:1; }","duration":"621.742448ms","start":"2026-06-10T10:08:55.442315Z","end":"2026-06-10T10:08:56.064058Z","steps":["trace[100635338] 'process raft request' (duration: 621.292139ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:08:56.064206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:08:55.442304Z","time spent":"621.84923ms","remote":"127.0.0.1:51466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:08:56.064243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:08:55.442232Z","time spent":"621.739038ms","remote":"127.0.0.1:51466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:08:56.064207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:08:55.44186Z","time spent":"622.089795ms","remote":"127.0.0.1:51466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:08:56.064281Z","caller":"traceutil/trace.go:171","msg":"trace[1477433669] linearizableReadLoop","detail":"{readStateIndex:314; appliedIndex:310; }","duration":"522.338087ms","start":"2026-06-10T10:08:55.541924Z","end":"2026-06-10T10:08:56.064262Z","steps":["trace[1477433669] 'read index received' (duration: 462.044194ms)","trace[1477433669] 'applied index is now lower than readState.Index' (duration: 60.292963ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:08:56.064358Z","caller":"traceutil/trace.go:171","msg":"trace[2097432120] transaction","detail":"{read_only:false; response_revision:304; number_of_response:1; }","duration":"618.928809ms","start":"2026-06-10T10:08:55.44541Z","end":"2026-06-10T10:08:56.064339Z","steps":["trace[2097432120] 'process raft request' (duration: 618.226404ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:08:56.06446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"522.526021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-06-10T10:08:56.064495Z","caller":"traceutil/trace.go:171","msg":"trace[241458305] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:304; }","duration":"522.615793ms","start":"2026-06-10T10:08:55.541869Z","end":"2026-06-10T10:08:56.064484Z","steps":["trace[241458305] 'agreement among raft nodes before linearized reading' (duration: 522.47663ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:08:56.064505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:08:55.445397Z","time spent":"619.062632ms","remote":"127.0.0.1:51370","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5321,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:08:56.064524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:08:55.541848Z","time spent":"522.668694ms","remote":"127.0.0.1:51288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-06-10T10:08:56.283463Z","caller":"traceutil/trace.go:171","msg":"trace[991587694] linearizableReadLoop","detail":"{readStateIndex:316; appliedIndex:315; }","duration":"141.494619ms","start":"2026-06-10T10:08:56.141936Z","end":"2026-06-10T10:08:56.283431Z","steps":["trace[991587694] 'read index received' (duration: 141.137932ms)","trace[991587694] 'applied index is now lower than readState.Index' (duration: 355.397µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:08:56.284052Z","caller":"traceutil/trace.go:171","msg":"trace[2020563363] transaction","detail":"{read_only:false; response_revision:306; number_of_response:1; }","duration":"209.397615ms","start":"2026-06-10T10:08:56.074578Z","end":"2026-06-10T10:08:56.283975Z","steps":["trace[2020563363] 'process raft request' (duration: 208.661079ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:08:56.284196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.222405ms","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-06-10T10:08:56.28448Z","caller":"traceutil/trace.go:171","msg":"trace[415083028] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:306; }","duration":"142.383099ms","start":"2026-06-10T10:08:56.141901Z","end":"2026-06-10T10:08:56.284284Z","steps":["trace[415083028] 'agreement among raft nodes before linearized reading' (duration: 142.205495ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:08:56.28504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.861144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-06-10T10:08:56.285091Z","caller":"traceutil/trace.go:171","msg":"trace[1716705426] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:306; }","duration":"138.972306ms","start":"2026-06-10T10:08:56.146106Z","end":"2026-06-10T10:08:56.285078Z","steps":["trace[1716705426] 'agreement among raft nodes before linearized reading' (duration: 138.885804ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:08:56.28536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.8315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"info","ts":"2026-06-10T10:08:56.285403Z","caller":"traceutil/trace.go:171","msg":"trace[1604540950] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:306; }","duration":"126.895471ms","start":"2026-06-10T10:08:56.158495Z","end":"2026-06-10T10:08:56.285391Z","steps":["trace[1604540950] 'agreement among raft nodes before linearized reading' (duration: 126.821139ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:08:56.285955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.859895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-06-10T10:08:56.286047Z","caller":"traceutil/trace.go:171","msg":"trace[465851862] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:306; }","duration":"139.979418ms","start":"2026-06-10T10:08:56.146047Z","end":"2026-06-10T10:08:56.286026Z","steps":["trace[465851862] 'agreement among raft nodes before linearized reading' (duration: 139.813514ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:08:56.286167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.194694ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-06-10T10:08:56.286233Z","caller":"traceutil/trace.go:171","msg":"trace[1671928749] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:306; }","duration":"143.083603ms","start":"2026-06-10T10:08:56.143132Z","end":"2026-06-10T10:08:56.286215Z","steps":["trace[1671928749] 'agreement among raft nodes before linearized reading' (duration: 141.129122ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:09:26.42823Z","caller":"traceutil/trace.go:171","msg":"trace[1351113069] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"187.020561ms","start":"2026-06-10T10:09:26.241189Z","end":"2026-06-10T10:09:26.428209Z","steps":["trace[1351113069] 'process raft request' (duration: 186.988381ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:09:26.428288Z","caller":"traceutil/trace.go:171","msg":"trace[1681097408] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"187.244876ms","start":"2026-06-10T10:09:26.241006Z","end":"2026-06-10T10:09:26.428251Z","steps":["trace[1681097408] 'process raft request' (duration: 187.135484ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:09:26.428594Z","caller":"traceutil/trace.go:171","msg":"trace[871254378] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"191.711675ms","start":"2026-06-10T10:09:26.236855Z","end":"2026-06-10T10:09:26.428567Z","steps":["trace[871254378] 'process raft request' (duration: 191.175623ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:09:26.435463Z","caller":"traceutil/trace.go:171","msg":"trace[1180611289] transaction","detail":"{read_only:false; number_of_response:0; response_revision:512; }","duration":"186.457149ms","start":"2026-06-10T10:09:26.24898Z","end":"2026-06-10T10:09:26.435437Z","steps":["trace[1180611289] 'process raft request' (duration: 186.020608ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:09:26.436032Z","caller":"traceutil/trace.go:171","msg":"trace[461526423] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"131.925738ms","start":"2026-06-10T10:09:26.304091Z","end":"2026-06-10T10:09:26.436017Z","steps":["trace[461526423] 'process raft request' (duration: 131.366635ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:09:26.436065Z","caller":"traceutil/trace.go:171","msg":"trace[724074574] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"127.366777ms","start":"2026-06-10T10:09:26.308679Z","end":"2026-06-10T10:09:26.436046Z","steps":["trace[724074574] 'process raft request' (duration: 126.864336ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:09:26.436195Z","caller":"traceutil/trace.go:171","msg":"trace[1358335995] transaction","detail":"{read_only:false; number_of_response:1; response_revision:518; }","duration":"116.372973ms","start":"2026-06-10T10:09:26.319815Z","end":"2026-06-10T10:09:26.436188Z","steps":["trace[1358335995] 'process raft request' (duration: 115.804131ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:09:26.436286Z","caller":"traceutil/trace.go:171","msg":"trace[206873201] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"116.317031ms","start":"2026-06-10T10:09:26.319964Z","end":"2026-06-10T10:09:26.436281Z","steps":["trace[206873201] 'process raft request' (duration: 115.697608ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:09:26.436346Z","caller":"traceutil/trace.go:171","msg":"trace[1125347262] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"116.284041ms","start":"2026-06-10T10:09:26.320056Z","end":"2026-06-10T10:09:26.43634Z","steps":["trace[1125347262] 'process raft request' (duration: 115.668517ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:09:26.43643Z","caller":"traceutil/trace.go:171","msg":"trace[891188302] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"112.492876ms","start":"2026-06-10T10:09:26.323929Z","end":"2026-06-10T10:09:26.436422Z","steps":["trace[891188302] 'process raft request' (duration: 111.847972ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:09:26.436553Z","caller":"traceutil/trace.go:171","msg":"trace[1699595451] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"138.302089ms","start":"2026-06-10T10:09:26.298243Z","end":"2026-06-10T10:09:26.436545Z","steps":["trace[1699595451] 'process raft request' (duration: 137.048382ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:09:26.436635Z","caller":"traceutil/trace.go:171","msg":"trace[1443028851] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"148.638419ms","start":"2026-06-10T10:09:26.287987Z","end":"2026-06-10T10:09:26.436626Z","steps":["trace[1443028851] 'process raft request' (duration: 147.084764ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:09:26.436898Z","caller":"traceutil/trace.go:171","msg":"trace[1529623808] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"147.397031ms","start":"2026-06-10T10:09:26.289491Z","end":"2026-06-10T10:09:26.436888Z","steps":["trace[1529623808] 'process raft request' (duration: 145.687223ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:09:26.43698Z","caller":"traceutil/trace.go:171","msg":"trace[1561697612] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"138.869832ms","start":"2026-06-10T10:09:26.298104Z","end":"2026-06-10T10:09:26.436974Z","steps":["trace[1561697612] 'process raft request' (duration: 137.142544ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:09:27.365258Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13903912432670836129,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-10T10:09:27.465564Z","caller":"traceutil/trace.go:171","msg":"trace[142582069] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"612.105786ms","start":"2026-06-10T10:09:26.853436Z","end":"2026-06-10T10:09:27.465542Z","steps":["trace[142582069] 'process raft request' (duration: 610.394169ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:09:27.465686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:09:26.853422Z","time spent":"612.203978ms","remote":"127.0.0.1:51192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":73770,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-10T10:09:27.474403Z","caller":"traceutil/trace.go:171","msg":"trace[370268910] linearizableReadLoop","detail":"{readStateIndex:574; appliedIndex:571; }","duration":"609.461897ms","start":"2026-06-10T10:09:26.86492Z","end":"2026-06-10T10:09:27.474382Z","steps":["trace[370268910] 'read index received' (duration: 598.995375ms)","trace[370268910] 'applied index is now lower than readState.Index' (duration: 10.465092ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:09:27.474441Z","caller":"traceutil/trace.go:171","msg":"trace[10671172] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"466.100817ms","start":"2026-06-10T10:09:27.008308Z","end":"2026-06-10T10:09:27.474408Z","steps":["trace[10671172] 'process raft request' (duration: 465.875701ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:09:27.474564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"609.617022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:09:27.474611Z","caller":"traceutil/trace.go:171","msg":"trace[969358889] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:553; }","duration":"609.689684ms","start":"2026-06-10T10:09:26.86491Z","end":"2026-06-10T10:09:27.474599Z","steps":["trace[969358889] 'agreement among raft nodes before linearized reading' (duration: 609.581502ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:09:27.474648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"534.416853ms","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":"warn","ts":"2026-06-10T10:09:27.474653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:09:26.864905Z","time spent":"609.738925ms","remote":"127.0.0.1:39632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"info","ts":"2026-06-10T10:09:27.474682Z","caller":"traceutil/trace.go:171","msg":"trace[2074643338] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:553; }","duration":"534.495475ms","start":"2026-06-10T10:09:26.940175Z","end":"2026-06-10T10:09:27.474671Z","steps":["trace[2074643338] 'agreement among raft nodes before linearized reading' (duration: 534.459164ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:09:27.474736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:09:26.940149Z","time spent":"534.577936ms","remote":"127.0.0.1:39646","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":"warn","ts":"2026-06-10T10:09:27.474717Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:09:27.008287Z","time spent":"466.27455ms","remote":"127.0.0.1:51192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":65199,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:09:27.474571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"609.542011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-10T10:09:27.474874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"535.278902ms","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-06-10T10:09:27.474888Z","caller":"traceutil/trace.go:171","msg":"trace[1723883488] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:553; }","duration":"609.881108ms","start":"2026-06-10T10:09:26.864997Z","end":"2026-06-10T10:09:27.474878Z","steps":["trace[1723883488] 'agreement among raft nodes before linearized reading' (duration: 609.51743ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:09:27.474908Z","caller":"traceutil/trace.go:171","msg":"trace[758841991] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:553; }","duration":"535.319053ms","start":"2026-06-10T10:09:26.939582Z","end":"2026-06-10T10:09:27.474901Z","steps":["trace[758841991] 'agreement among raft nodes before linearized reading' (duration: 535.275092ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:09:27.474927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:09:26.939578Z","time spent":"535.344293ms","remote":"127.0.0.1:39646","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-06-10T10:09:27.474932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:09:26.864985Z","time spent":"609.934319ms","remote":"127.0.0.1:39632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-10T10:09:27.474992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.476646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-10T10:09:27.474624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"511.958064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-10T10:09:27.475091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.597689ms","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:5"} {"level":"info","ts":"2026-06-10T10:09:27.475123Z","caller":"traceutil/trace.go:171","msg":"trace[1938072545] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:553; }","duration":"476.64687ms","start":"2026-06-10T10:09:26.998469Z","end":"2026-06-10T10:09:27.475116Z","steps":["trace[1938072545] 'agreement among raft nodes before linearized reading' (duration: 476.601289ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:09:27.475157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:09:26.998466Z","time spent":"476.681611ms","remote":"127.0.0.1:39680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-06-10T10:09:27.475217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"562.499546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:09:27.475206Z","caller":"traceutil/trace.go:171","msg":"trace[2061385484] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"607.195887ms","start":"2026-06-10T10:09:26.867131Z","end":"2026-06-10T10:09:27.474327Z","steps":["trace[2061385484] 'process raft request' (duration: 606.766968ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:09:27.475255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"562.405244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:09:27.475301Z","caller":"traceutil/trace.go:171","msg":"trace[350577408] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:553; }","duration":"562.459555ms","start":"2026-06-10T10:09:26.912833Z","end":"2026-06-10T10:09:27.475292Z","steps":["trace[350577408] 'agreement among raft nodes before linearized reading' (duration: 562.398274ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:09:27.475312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"562.446364ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-10T10:09:27.475312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.848714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:09:27.475338Z","caller":"traceutil/trace.go:171","msg":"trace[1863104242] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:553; }","duration":"562.478265ms","start":"2026-06-10T10:09:26.912852Z","end":"2026-06-10T10:09:27.475331Z","steps":["trace[1863104242] 'agreement among raft nodes before linearized reading' (duration: 562.216059ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:09:27.475336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:09:26.912829Z","time spent":"562.498846ms","remote":"127.0.0.1:39638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"warn","ts":"2026-06-10T10:09:27.475355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:09:26.91285Z","time spent":"562.500785ms","remote":"127.0.0.1:39638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"info","ts":"2026-06-10T10:09:27.475356Z","caller":"traceutil/trace.go:171","msg":"trace[669038173] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:553; }","duration":"476.921636ms","start":"2026-06-10T10:09:26.998425Z","end":"2026-06-10T10:09:27.475347Z","steps":["trace[669038173] 'agreement among raft nodes before linearized reading' (duration: 476.854835ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:09:27.47527Z","caller":"traceutil/trace.go:171","msg":"trace[841327213] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:553; }","duration":"562.621598ms","start":"2026-06-10T10:09:26.912639Z","end":"2026-06-10T10:09:27.47526Z","steps":["trace[841327213] 'agreement among raft nodes before linearized reading' (duration: 562.466195ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:09:27.475427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"495.530489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-10T10:09:27.475463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:09:26.91262Z","time spent":"562.834023ms","remote":"127.0.0.1:39632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 "} {"level":"info","ts":"2026-06-10T10:09:27.475494Z","caller":"traceutil/trace.go:171","msg":"trace[451588928] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:553; }","duration":"495.637281ms","start":"2026-06-10T10:09:26.979837Z","end":"2026-06-10T10:09:27.475474Z","steps":["trace[451588928] 'agreement among raft nodes before linearized reading' (duration: 495.555859ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:09:27.475527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"511.953834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:09:27.47509Z","caller":"traceutil/trace.go:171","msg":"trace[647578390] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:553; }","duration":"512.508615ms","start":"2026-06-10T10:09:26.962569Z","end":"2026-06-10T10:09:27.475077Z","steps":["trace[647578390] 'agreement among raft nodes before linearized reading' (duration: 512.023765ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:09:27.475559Z","caller":"traceutil/trace.go:171","msg":"trace[1435760814] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:553; }","duration":"512.001645ms","start":"2026-06-10T10:09:26.963548Z","end":"2026-06-10T10:09:27.475549Z","steps":["trace[1435760814] 'agreement among raft nodes before linearized reading' (duration: 511.949534ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:09:27.475569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:09:26.979813Z","time spent":"495.742144ms","remote":"127.0.0.1:39664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-06-10T10:09:27.475588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:09:26.963492Z","time spent":"512.088016ms","remote":"127.0.0.1:39656","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-10T10:09:27.475594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:09:26.962542Z","time spent":"513.039537ms","remote":"127.0.0.1:39656","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-06-10T10:09:27.475408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:09:26.99841Z","time spent":"476.989767ms","remote":"127.0.0.1:39680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"info","ts":"2026-06-10T10:09:27.475044Z","caller":"traceutil/trace.go:171","msg":"trace[1916582647] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:553; }","duration":"476.543577ms","start":"2026-06-10T10:09:26.998484Z","end":"2026-06-10T10:09:27.475027Z","steps":["trace[1916582647] 'agreement among raft nodes before linearized reading' (duration: 476.462816ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:09:27.475332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"495.421247ms","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:5"} {"level":"warn","ts":"2026-06-10T10:09:27.475797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:09:26.998471Z","time spent":"477.314895ms","remote":"127.0.0.1:39664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 "} {"level":"info","ts":"2026-06-10T10:09:27.475809Z","caller":"traceutil/trace.go:171","msg":"trace[935799494] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:553; }","duration":"495.954278ms","start":"2026-06-10T10:09:26.979837Z","end":"2026-06-10T10:09:27.475791Z","steps":["trace[935799494] 'agreement among raft nodes before linearized reading' (duration: 495.381696ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:09:27.475862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:09:26.979818Z","time spent":"496.03037ms","remote":"127.0.0.1:39664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-06-10T10:09:27.475057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"535.481846ms","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-06-10T10:09:27.475904Z","caller":"traceutil/trace.go:171","msg":"trace[1966034] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:553; }","duration":"536.357735ms","start":"2026-06-10T10:09:26.939536Z","end":"2026-06-10T10:09:27.475893Z","steps":["trace[1966034] 'agreement among raft nodes before linearized reading' (duration: 535.503617ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:09:27.475402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:09:26.867122Z","time spent":"608.180979ms","remote":"127.0.0.1:51192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":151212,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:09:27.475951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:09:26.939521Z","time spent":"536.417836ms","remote":"127.0.0.1:39646","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-06-10T10:09:27.474718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"511.937004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:09:27.47602Z","caller":"traceutil/trace.go:171","msg":"trace[2104079656] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:553; }","duration":"513.284653ms","start":"2026-06-10T10:09:26.962723Z","end":"2026-06-10T10:09:27.476008Z","steps":["trace[2104079656] 'agreement among raft nodes before linearized reading' (duration: 511.856302ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:09:27.476062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:09:26.962715Z","time spent":"513.333934ms","remote":"127.0.0.1:39656","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 "} {"level":"warn","ts":"2026-06-10T10:09:28.446899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.980519ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:09:28.447012Z","caller":"traceutil/trace.go:171","msg":"trace[1875808396] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:573; }","duration":"164.100092ms","start":"2026-06-10T10:09:28.282893Z","end":"2026-06-10T10:09:28.446993Z","steps":["trace[1875808396] 'range keys from in-memory index tree' (duration: 163.968769ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:09:28.447054Z","caller":"traceutil/trace.go:171","msg":"trace[1535631983] linearizableReadLoop","detail":"{readStateIndex:595; appliedIndex:594; }","duration":"189.252571ms","start":"2026-06-10T10:09:28.257776Z","end":"2026-06-10T10:09:28.447028Z","steps":["trace[1535631983] 'read index received' (duration: 188.093454ms)","trace[1535631983] 'applied index is now lower than readState.Index' (duration: 1.158047ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:09:28.447208Z","caller":"traceutil/trace.go:171","msg":"trace[2136791083] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"193.479904ms","start":"2026-06-10T10:09:28.253717Z","end":"2026-06-10T10:09:28.447197Z","steps":["trace[2136791083] 'process raft request' (duration: 192.108063ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:09:28.447483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.69806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-10T10:09:28.447541Z","caller":"traceutil/trace.go:171","msg":"trace[1714515189] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:574; }","duration":"189.788973ms","start":"2026-06-10T10:09:28.257743Z","end":"2026-06-10T10:09:28.447532Z","steps":["trace[1714515189] 'agreement among raft nodes before linearized reading' (duration: 189.559788ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:09:28.453789Z","caller":"traceutil/trace.go:171","msg":"trace[1746246274] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"105.969252ms","start":"2026-06-10T10:09:28.347803Z","end":"2026-06-10T10:09:28.453773Z","steps":["trace[1746246274] 'process raft request' (duration: 105.534132ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:09:28.45419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.551866ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:7708"} {"level":"info","ts":"2026-06-10T10:09:28.45426Z","caller":"traceutil/trace.go:171","msg":"trace[302064748] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:575; }","duration":"170.649047ms","start":"2026-06-10T10:09:28.283591Z","end":"2026-06-10T10:09:28.45424Z","steps":["trace[302064748] 'agreement among raft nodes before linearized reading' (duration: 170.229218ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:09:28.454313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.588611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:570105"} {"level":"info","ts":"2026-06-10T10:09:28.454356Z","caller":"traceutil/trace.go:171","msg":"trace[1319855165] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:575; }","duration":"154.654163ms","start":"2026-06-10T10:09:28.29969Z","end":"2026-06-10T10:09:28.454344Z","steps":["trace[1319855165] 'agreement among raft nodes before linearized reading' (duration: 154.242704ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:09:33.978518Z","caller":"traceutil/trace.go:171","msg":"trace[1221052830] linearizableReadLoop","detail":"{readStateIndex:627; appliedIndex:626; }","duration":"209.166682ms","start":"2026-06-10T10:09:33.769328Z","end":"2026-06-10T10:09:33.978494Z","steps":["trace[1221052830] 'read index received' (duration: 208.404326ms)","trace[1221052830] 'applied index is now lower than readState.Index' (duration: 761.486µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:09:33.978621Z","caller":"traceutil/trace.go:171","msg":"trace[212929634] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"524.714206ms","start":"2026-06-10T10:09:33.453892Z","end":"2026-06-10T10:09:33.978606Z","steps":["trace[212929634] 'process raft request' (duration: 524.061631ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:09:33.978748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:09:33.453876Z","time spent":"524.782198ms","remote":"127.0.0.1:51268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:09:33.978959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.632702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-10T10:09:33.979008Z","caller":"traceutil/trace.go:171","msg":"trace[720037643] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:605; }","duration":"209.726184ms","start":"2026-06-10T10:09:33.769269Z","end":"2026-06-10T10:09:33.978995Z","steps":["trace[720037643] 'agreement among raft nodes before linearized reading' (duration: 209.322535ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:09:34.972595Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13903912432670836258,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-10T10:09:35.222451Z","caller":"traceutil/trace.go:171","msg":"trace[74155554] linearizableReadLoop","detail":"{readStateIndex:634; appliedIndex:633; }","duration":"750.67726ms","start":"2026-06-10T10:09:34.47165Z","end":"2026-06-10T10:09:35.222327Z","steps":["trace[74155554] 'read index received' (duration: 746.630061ms)","trace[74155554] 'applied index is now lower than readState.Index' (duration: 4.045599ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:09:35.223706Z","caller":"traceutil/trace.go:171","msg":"trace[1304766935] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"768.342622ms","start":"2026-06-10T10:09:34.45523Z","end":"2026-06-10T10:09:35.223573Z","steps":["trace[1304766935] 'process raft request' (duration: 763.74912ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:09:35.223918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:09:34.45519Z","time spent":"768.621229ms","remote":"127.0.0.1:51268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:09:35.223921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"741.461956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-06-10T10:09:35.22394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"738.49236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-10T10:09:35.224115Z","caller":"traceutil/trace.go:171","msg":"trace[1859811731] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:611; }","duration":"741.667111ms","start":"2026-06-10T10:09:34.482377Z","end":"2026-06-10T10:09:35.224044Z","steps":["trace[1859811731] 'agreement among raft nodes before linearized reading' (duration: 741.302953ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:09:35.224159Z","caller":"traceutil/trace.go:171","msg":"trace[505976877] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:611; }","duration":"738.661674ms","start":"2026-06-10T10:09:34.485394Z","end":"2026-06-10T10:09:35.224056Z","steps":["trace[505976877] 'agreement among raft nodes before linearized reading' (duration: 738.252375ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:09:35.224134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.879432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-2hlrn\" ","response":"range_response_count:1 size:16965"} {"level":"warn","ts":"2026-06-10T10:09:35.224036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"745.054285ms","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-06-10T10:09:35.224324Z","caller":"traceutil/trace.go:171","msg":"trace[372020850] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:611; }","duration":"745.409944ms","start":"2026-06-10T10:09:34.478897Z","end":"2026-06-10T10:09:35.224307Z","steps":["trace[372020850] 'agreement among raft nodes before linearized reading' (duration: 744.704728ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:09:35.224256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:09:34.48538Z","time spent":"738.863978ms","remote":"127.0.0.1:51466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-10T10:09:35.224406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:09:34.478887Z","time spent":"745.472465ms","remote":"127.0.0.1:51466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-10T10:09:35.224196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:09:34.482363Z","time spent":"741.814104ms","remote":"127.0.0.1:51466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-10T10:09:35.224473Z","caller":"traceutil/trace.go:171","msg":"trace[145958053] range","detail":"{range_begin:/registry/pods/kube-system/cilium-2hlrn; range_end:; response_count:1; response_revision:611; }","duration":"458.204089ms","start":"2026-06-10T10:09:34.766091Z","end":"2026-06-10T10:09:35.224295Z","steps":["trace[145958053] 'agreement among raft nodes before linearized reading' (duration: 457.651497ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:09:35.224597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:09:34.766038Z","time spent":"458.547507ms","remote":"127.0.0.1:51370","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-2hlrn\" "} {"level":"warn","ts":"2026-06-10T10:09:35.224868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"753.208746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:09:35.224972Z","caller":"traceutil/trace.go:171","msg":"trace[743547287] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:611; }","duration":"753.297299ms","start":"2026-06-10T10:09:34.47161Z","end":"2026-06-10T10:09:35.224907Z","steps":["trace[743547287] 'agreement among raft nodes before linearized reading' (duration: 751.938749ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:09:35.225013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:09:34.471588Z","time spent":"753.414911ms","remote":"127.0.0.1:51146","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-10T10:09:35.983347Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13903912432670836261,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-10T10:09:36.255101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.930187ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-10T10:09:36.25525Z","caller":"traceutil/trace.go:171","msg":"trace[1824619756] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"1.024249194s","start":"2026-06-10T10:09:35.230983Z","end":"2026-06-10T10:09:36.255232Z","steps":["trace[1824619756] 'process raft request' (duration: 901.98805ms)","trace[1824619756] 'compare' (duration: 121.550898ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:09:36.255302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:09:35.230958Z","time spent":"1.024320816s","remote":"127.0.0.1:51466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:09:36.25552Z","caller":"traceutil/trace.go:171","msg":"trace[1491295582] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"1.024162292s","start":"2026-06-10T10:09:35.231347Z","end":"2026-06-10T10:09:36.255509Z","steps":["trace[1491295582] 'process raft request' (duration: 1.023838215s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:09:36.25558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:09:35.231287Z","time spent":"1.024267385s","remote":"127.0.0.1:51466","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-06-10T10:09:36.255657Z","caller":"traceutil/trace.go:171","msg":"trace[1341524317] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"1.015567381s","start":"2026-06-10T10:09:35.240065Z","end":"2026-06-10T10:09:36.255633Z","steps":["trace[1341524317] 'process raft request' (duration: 1.015363996s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:09:36.256819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:09:35.240044Z","time spent":"1.015682524s","remote":"127.0.0.1:51370","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:09:36.809199Z","caller":"traceutil/trace.go:171","msg":"trace[215688655] linearizableReadLoop","detail":"{readStateIndex:639; appliedIndex:635; }","duration":"1.337247601s","start":"2026-06-10T10:09:35.471913Z","end":"2026-06-10T10:09:36.80916Z","steps":["trace[215688655] 'read index received' (duration: 661.017562ms)","trace[215688655] 'applied index is now lower than readState.Index' (duration: 676.228279ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:09:36.809258Z","caller":"traceutil/trace.go:171","msg":"trace[2067574398] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"1.530120011s","start":"2026-06-10T10:09:35.279106Z","end":"2026-06-10T10:09:36.809226Z","steps":["trace[2067574398] 'process raft request' (duration: 1.481753177s)","trace[2067574398] 'compare' (duration: 47.807222ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:09:36.809386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:09:35.279091Z","time spent":"1.530223123s","remote":"127.0.0.1:51424","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-10T10:09:36.809534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"819.15415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-10T10:09:36.809579Z","caller":"traceutil/trace.go:171","msg":"trace[1989114129] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:616; }","duration":"819.250342ms","start":"2026-06-10T10:09:35.990318Z","end":"2026-06-10T10:09:36.809568Z","steps":["trace[1989114129] 'agreement among raft nodes before linearized reading' (duration: 819.013837ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:09:36.80961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:09:35.990276Z","time spent":"819.327454ms","remote":"127.0.0.1:51466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-10T10:09:36.809746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.337613528s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:09:36.809877Z","caller":"traceutil/trace.go:171","msg":"trace[1299685942] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:616; }","duration":"1.337978226s","start":"2026-06-10T10:09:35.471863Z","end":"2026-06-10T10:09:36.809841Z","steps":["trace[1299685942] 'agreement among raft nodes before linearized reading' (duration: 1.337406674s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:09:36.809989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:09:35.471844Z","time spent":"1.338127029s","remote":"127.0.0.1:51132","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-10T10:09:42.069433Z","caller":"traceutil/trace.go:171","msg":"trace[1697373382] transaction","detail":"{read_only:false; response_revision:694; number_of_response:1; }","duration":"128.695746ms","start":"2026-06-10T10:09:41.940705Z","end":"2026-06-10T10:09:42.0694Z","steps":["trace[1697373382] 'process raft request' (duration: 128.227765ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:09:49.997207Z","caller":"traceutil/trace.go:171","msg":"trace[1563064253] transaction","detail":"{read_only:false; response_revision:759; number_of_response:1; }","duration":"130.078216ms","start":"2026-06-10T10:09:49.86711Z","end":"2026-06-10T10:09:49.997188Z","steps":["trace[1563064253] 'process raft request' (duration: 129.967474ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:09:53.193351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"673.652431ms","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-06-10T10:09:53.193451Z","caller":"traceutil/trace.go:171","msg":"trace[1661224132] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:781; }","duration":"673.781953ms","start":"2026-06-10T10:09:52.519635Z","end":"2026-06-10T10:09:53.193417Z","steps":["trace[1661224132] 'range keys from in-memory index tree' (duration: 673.478016ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:09:53.193494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:09:52.519622Z","time spent":"673.862946ms","remote":"127.0.0.1:51466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-10T10:09:53.193791Z","caller":"traceutil/trace.go:171","msg":"trace[816806995] linearizableReadLoop","detail":"{readStateIndex:811; appliedIndex:810; }","duration":"297.878431ms","start":"2026-06-10T10:09:52.895852Z","end":"2026-06-10T10:09:53.19373Z","steps":["trace[816806995] 'read index received' (duration: 241.871747ms)","trace[816806995] 'applied index is now lower than readState.Index' (duration: 56.005314ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:09:53.193837Z","caller":"traceutil/trace.go:171","msg":"trace[1363250116] transaction","detail":"{read_only:false; response_revision:782; number_of_response:1; }","duration":"307.981496ms","start":"2026-06-10T10:09:52.885842Z","end":"2026-06-10T10:09:53.193823Z","steps":["trace[1363250116] 'process raft request' (duration: 251.934782ms)","trace[1363250116] 'compare' (duration: 55.702145ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:09:53.193927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:09:52.885826Z","time spent":"308.044687ms","remote":"127.0.0.1:51424","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:09:53.194022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.155259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-10T10:09:53.194058Z","caller":"traceutil/trace.go:171","msg":"trace[1515765352] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:782; }","duration":"298.23282ms","start":"2026-06-10T10:09:52.895813Z","end":"2026-06-10T10:09:53.194046Z","steps":["trace[1515765352] 'agreement among raft nodes before linearized reading' (duration: 298.050596ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:09:53.383561Z","caller":"traceutil/trace.go:171","msg":"trace[599920562] transaction","detail":"{read_only:false; response_revision:783; number_of_response:1; }","duration":"184.362162ms","start":"2026-06-10T10:09:53.199159Z","end":"2026-06-10T10:09:53.383521Z","steps":["trace[599920562] 'process raft request' (duration: 184.112497ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:09:53.388761Z","caller":"traceutil/trace.go:171","msg":"trace[117201134] linearizableReadLoop","detail":"{readStateIndex:813; appliedIndex:811; }","duration":"121.522497ms","start":"2026-06-10T10:09:53.267161Z","end":"2026-06-10T10:09:53.388683Z","steps":["trace[117201134] 'read index received' (duration: 116.148227ms)","trace[117201134] 'applied index is now lower than readState.Index' (duration: 5.37223ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:09:53.388996Z","caller":"traceutil/trace.go:171","msg":"trace[185018567] transaction","detail":"{read_only:false; response_revision:784; number_of_response:1; }","duration":"189.772612ms","start":"2026-06-10T10:09:53.199188Z","end":"2026-06-10T10:09:53.388961Z","steps":["trace[185018567] 'process raft request' (duration: 189.095327ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:09:53.389347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.16297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:09:53.389429Z","caller":"traceutil/trace.go:171","msg":"trace[137260969] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:784; }","duration":"122.293873ms","start":"2026-06-10T10:09:53.267117Z","end":"2026-06-10T10:09:53.38941Z","steps":["trace[137260969] 'agreement among raft nodes before linearized reading' (duration: 122.163101ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:10:27.774875Z","caller":"traceutil/trace.go:171","msg":"trace[1033059019] transaction","detail":"{read_only:false; response_revision:992; number_of_response:1; }","duration":"203.237653ms","start":"2026-06-10T10:10:27.571612Z","end":"2026-06-10T10:10:27.774849Z","steps":["trace[1033059019] 'process raft request' (duration: 203.07616ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:10:28.994275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"712.104128ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:10:28.994417Z","caller":"traceutil/trace.go:171","msg":"trace[1746865560] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:992; }","duration":"712.256382ms","start":"2026-06-10T10:10:28.282139Z","end":"2026-06-10T10:10:28.994396Z","steps":["trace[1746865560] 'range keys from in-memory index tree' (duration: 712.087578ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:10:28.994813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"520.241331ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-10T10:10:28.995716Z","caller":"traceutil/trace.go:171","msg":"trace[1718601644] transaction","detail":"{read_only:false; response_revision:994; number_of_response:1; }","duration":"863.790099ms","start":"2026-06-10T10:10:28.131912Z","end":"2026-06-10T10:10:28.995702Z","steps":["trace[1718601644] 'process raft request' (duration: 863.686346ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:10:28.995796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:10:28.131889Z","time spent":"863.867701ms","remote":"127.0.0.1:51466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:10:28.995823Z","caller":"traceutil/trace.go:171","msg":"trace[256309696] linearizableReadLoop","detail":"{readStateIndex:1030; appliedIndex:1028; }","duration":"1.383703832s","start":"2026-06-10T10:10:27.612084Z","end":"2026-06-10T10:10:28.995787Z","steps":["trace[256309696] 'read index received' (duration: 162.648037ms)","trace[256309696] 'applied index is now lower than readState.Index' (duration: 1.221053335s)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:10:28.99589Z","caller":"traceutil/trace.go:171","msg":"trace[437843120] transaction","detail":"{read_only:false; response_revision:993; number_of_response:1; }","duration":"1.42257641s","start":"2026-06-10T10:10:27.573266Z","end":"2026-06-10T10:10:28.995842Z","steps":["trace[437843120] 'process raft request' (duration: 901.233874ms)","trace[437843120] 'compare' (duration: 519.009473ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:10:28.996079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:10:27.57326Z","time spent":"1.422718693s","remote":"127.0.0.1:51466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:10:28.996208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.384089861s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-10T10:10:28.996265Z","caller":"traceutil/trace.go:171","msg":"trace[2029002083] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:994; }","duration":"1.384180913s","start":"2026-06-10T10:10:27.612069Z","end":"2026-06-10T10:10:28.99625Z","steps":["trace[2029002083] 'agreement among raft nodes before linearized reading' (duration: 1.383904547s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:10:28.996321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:10:27.612061Z","time spent":"1.384241995s","remote":"127.0.0.1:51466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-10T10:10:28.996457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.837375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.191\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-06-10T10:10:28.99643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"525.820668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-10T10:10:28.996587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"490.974471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-10T10:10:28.996503Z","caller":"traceutil/trace.go:171","msg":"trace[1101329473] range","detail":"{range_begin:/registry/masterleases/199.19.213.191; range_end:; response_count:1; response_revision:994; }","duration":"140.905247ms","start":"2026-06-10T10:10:28.855584Z","end":"2026-06-10T10:10:28.996489Z","steps":["trace[1101329473] 'agreement among raft nodes before linearized reading' (duration: 140.767614ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:10:28.996653Z","caller":"traceutil/trace.go:171","msg":"trace[300247493] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:994; }","duration":"491.067103ms","start":"2026-06-10T10:10:28.505562Z","end":"2026-06-10T10:10:28.99663Z","steps":["trace[300247493] 'agreement among raft nodes before linearized reading' (duration: 490.882939ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:10:28.996325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.74207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-06-10T10:10:28.996728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:10:28.505544Z","time spent":"491.175265ms","remote":"127.0.0.1:51466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-10T10:10:28.996759Z","caller":"traceutil/trace.go:171","msg":"trace[46018500] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:994; }","duration":"426.209871ms","start":"2026-06-10T10:10:28.570536Z","end":"2026-06-10T10:10:28.996745Z","steps":["trace[46018500] 'agreement among raft nodes before linearized reading' (duration: 425.674419ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:10:28.996804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:10:28.570519Z","time spent":"426.275192ms","remote":"127.0.0.1:51466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-10T10:10:28.99694Z","caller":"traceutil/trace.go:171","msg":"trace[448720232] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:994; }","duration":"526.302638ms","start":"2026-06-10T10:10:28.470382Z","end":"2026-06-10T10:10:28.996685Z","steps":["trace[448720232] 'agreement among raft nodes before linearized reading' (duration: 525.750916ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:10:28.997169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:10:28.47036Z","time spent":"526.766368ms","remote":"127.0.0.1:51132","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-10T10:10:29.672789Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13903912432670837092,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-10T10:10:29.97556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.076184ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"warn","ts":"2026-06-10T10:10:29.97566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:10:28.999928Z","time spent":"975.728533ms","remote":"127.0.0.1:51176","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-06-10T10:10:29.978149Z","caller":"traceutil/trace.go:171","msg":"trace[931001229] transaction","detail":"{read_only:false; response_revision:995; number_of_response:1; }","duration":"969.41349ms","start":"2026-06-10T10:10:29.008719Z","end":"2026-06-10T10:10:29.978132Z","steps":["trace[931001229] 'process raft request' (duration: 969.142214ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:10:29.978352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:10:29.008702Z","time spent":"969.549114ms","remote":"127.0.0.1:51466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:10:29.978829Z","caller":"traceutil/trace.go:171","msg":"trace[504977265] transaction","detail":"{read_only:false; response_revision:996; number_of_response:1; }","duration":"970.015735ms","start":"2026-06-10T10:10:29.00878Z","end":"2026-06-10T10:10:29.978796Z","steps":["trace[504977265] 'process raft request' (duration: 969.234806ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:10:29.978994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:10:29.008776Z","time spent":"970.139987ms","remote":"127.0.0.1:51466","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-06-10T10:10:29.979112Z","caller":"traceutil/trace.go:171","msg":"trace[840964439] transaction","detail":"{read_only:false; response_revision:997; number_of_response:1; }","duration":"970.28961ms","start":"2026-06-10T10:10:29.008812Z","end":"2026-06-10T10:10:29.979102Z","steps":["trace[840964439] 'process raft request' (duration: 969.888291ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:10:29.97916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:10:29.008808Z","time spent":"970.325691ms","remote":"127.0.0.1:51466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:10:29.979273Z","caller":"traceutil/trace.go:171","msg":"trace[1157597456] transaction","detail":"{read_only:false; response_revision:998; number_of_response:1; }","duration":"783.017868ms","start":"2026-06-10T10:10:29.196246Z","end":"2026-06-10T10:10:29.979264Z","steps":["trace[1157597456] 'process raft request' (duration: 782.483186ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:10:29.979345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:10:29.196214Z","time spent":"783.082609ms","remote":"127.0.0.1:51466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:10:29.979502Z","caller":"traceutil/trace.go:171","msg":"trace[1947857494] linearizableReadLoop","detail":"{readStateIndex:1036; appliedIndex:1031; }","duration":"807.177062ms","start":"2026-06-10T10:10:29.172304Z","end":"2026-06-10T10:10:29.979482Z","steps":["trace[1947857494] 'read index received' (duration: 508.159129ms)","trace[1947857494] 'applied index is now lower than readState.Index' (duration: 299.015863ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:10:29.979662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"807.347485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:10:29.979703Z","caller":"traceutil/trace.go:171","msg":"trace[511877564] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:998; }","duration":"807.432737ms","start":"2026-06-10T10:10:29.17226Z","end":"2026-06-10T10:10:29.979693Z","steps":["trace[511877564] 'agreement among raft nodes before linearized reading' (duration: 807.347486ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:10:29.979746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:10:29.172243Z","time spent":"807.493308ms","remote":"127.0.0.1:51514","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":28,"request content":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true "} {"level":"warn","ts":"2026-06-10T10:10:29.979967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"508.108347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:10:29.980001Z","caller":"traceutil/trace.go:171","msg":"trace[949878862] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:999; }","duration":"508.176709ms","start":"2026-06-10T10:10:29.471816Z","end":"2026-06-10T10:10:29.979993Z","steps":["trace[949878862] 'agreement among raft nodes before linearized reading' (duration: 508.105768ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:10:29.980026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:10:29.471795Z","time spent":"508.22606ms","remote":"127.0.0.1:51132","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-10T10:10:29.980253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.872011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-10T10:10:29.98029Z","caller":"traceutil/trace.go:171","msg":"trace[1256261140] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:999; }","duration":"177.935742ms","start":"2026-06-10T10:10:29.802346Z","end":"2026-06-10T10:10:29.980282Z","steps":["trace[1256261140] 'agreement among raft nodes before linearized reading' (duration: 177.816349ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:10:51.689766Z","caller":"traceutil/trace.go:171","msg":"trace[385494256] linearizableReadLoop","detail":"{readStateIndex:1109; appliedIndex:1108; }","duration":"477.723673ms","start":"2026-06-10T10:10:51.212021Z","end":"2026-06-10T10:10:51.689744Z","steps":["trace[385494256] 'read index received' (duration: 477.558359ms)","trace[385494256] 'applied index is now lower than readState.Index' (duration: 164.414µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:10:51.69005Z","caller":"traceutil/trace.go:171","msg":"trace[877912402] transaction","detail":"{read_only:false; response_revision:1067; number_of_response:1; }","duration":"568.071031ms","start":"2026-06-10T10:10:51.121948Z","end":"2026-06-10T10:10:51.690019Z","steps":["trace[877912402] 'process raft request' (duration: 567.664612ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:10:51.690085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.957509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:10:51.69017Z","caller":"traceutil/trace.go:171","msg":"trace[2020798338] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:1067; }","duration":"153.105323ms","start":"2026-06-10T10:10:51.537045Z","end":"2026-06-10T10:10:51.69015Z","steps":["trace[2020798338] 'agreement among raft nodes before linearized reading' (duration: 152.949699ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:10:51.690222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:10:51.121927Z","time spent":"568.218194ms","remote":"127.0.0.1:51466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:10:51.690141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"478.092662ms","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-06-10T10:10:51.690316Z","caller":"traceutil/trace.go:171","msg":"trace[45705411] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1067; }","duration":"478.313456ms","start":"2026-06-10T10:10:51.211977Z","end":"2026-06-10T10:10:51.69029Z","steps":["trace[45705411] 'agreement among raft nodes before linearized reading' (duration: 477.968708ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:10:51.690371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:10:51.211956Z","time spent":"478.400848ms","remote":"127.0.0.1:51466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-10T10:10:52.017285Z","caller":"traceutil/trace.go:171","msg":"trace[1271413486] transaction","detail":"{read_only:false; response_revision:1068; number_of_response:1; }","duration":"323.392023ms","start":"2026-06-10T10:10:51.693849Z","end":"2026-06-10T10:10:52.017241Z","steps":["trace[1271413486] 'process raft request' (duration: 264.72043ms)","trace[1271413486] 'compare' (duration: 58.457918ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:10:52.017463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:10:51.693833Z","time spent":"323.555906ms","remote":"127.0.0.1:51466","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-06-10T10:11:10.000584Z","caller":"traceutil/trace.go:171","msg":"trace[1530072534] transaction","detail":"{read_only:false; response_revision:1177; number_of_response:1; }","duration":"115.470564ms","start":"2026-06-10T10:11:09.885095Z","end":"2026-06-10T10:11:10.000566Z","steps":["trace[1530072534] 'process raft request' (duration: 115.354861ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:11:12.146209Z","caller":"traceutil/trace.go:171","msg":"trace[1948363259] transaction","detail":"{read_only:false; response_revision:1184; number_of_response:1; }","duration":"140.56486ms","start":"2026-06-10T10:11:12.005614Z","end":"2026-06-10T10:11:12.146178Z","steps":["trace[1948363259] 'process raft request' (duration: 140.241532ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:11:28.731443Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13903912432670837681,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-10T10:11:28.851696Z","caller":"traceutil/trace.go:171","msg":"trace[1992614811] transaction","detail":"{read_only:false; response_revision:1236; number_of_response:1; }","duration":"632.976401ms","start":"2026-06-10T10:11:28.218689Z","end":"2026-06-10T10:11:28.851666Z","steps":["trace[1992614811] 'process raft request' (duration: 632.708045ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:11:28.851822Z","caller":"traceutil/trace.go:171","msg":"trace[1484360495] linearizableReadLoop","detail":"{readStateIndex:1287; appliedIndex:1286; }","duration":"620.699293ms","start":"2026-06-10T10:11:28.230929Z","end":"2026-06-10T10:11:28.851628Z","steps":["trace[1484360495] 'read index received' (duration: 620.351946ms)","trace[1484360495] 'applied index is now lower than readState.Index' (duration: 345.927µs)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:11:28.851884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:11:28.218665Z","time spent":"633.147576ms","remote":"127.0.0.1:51466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:11:28.851908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"620.973009ms","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-06-10T10:11:28.851991Z","caller":"traceutil/trace.go:171","msg":"trace[1345318673] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1236; }","duration":"621.124433ms","start":"2026-06-10T10:11:28.230851Z","end":"2026-06-10T10:11:28.851975Z","steps":["trace[1345318673] 'agreement among raft nodes before linearized reading' (duration: 620.904238ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:11:28.852036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:11:28.230809Z","time spent":"621.215535ms","remote":"127.0.0.1:51466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-10T10:11:28.852117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"461.086077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-06-10T10:11:28.852137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.105594ms","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-06-10T10:11:28.852154Z","caller":"traceutil/trace.go:171","msg":"trace[1016443877] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1236; }","duration":"461.155239ms","start":"2026-06-10T10:11:28.39099Z","end":"2026-06-10T10:11:28.852145Z","steps":["trace[1016443877] 'agreement among raft nodes before linearized reading' (duration: 461.062767ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:11:28.852163Z","caller":"traceutil/trace.go:171","msg":"trace[1371012834] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1236; }","duration":"471.185826ms","start":"2026-06-10T10:11:28.38097Z","end":"2026-06-10T10:11:28.852155Z","steps":["trace[1371012834] 'agreement among raft nodes before linearized reading' (duration: 471.104274ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:11:28.852178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:11:28.380935Z","time spent":"471.240557ms","remote":"127.0.0.1:51466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-10T10:11:28.852177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:11:28.390974Z","time spent":"461.197179ms","remote":"127.0.0.1:51466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-10T10:11:28.852182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"575.193386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-10T10:11:28.85223Z","caller":"traceutil/trace.go:171","msg":"trace[918447050] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1236; }","duration":"575.317008ms","start":"2026-06-10T10:11:28.276899Z","end":"2026-06-10T10:11:28.852216Z","steps":["trace[918447050] 'agreement among raft nodes before linearized reading' (duration: 575.097764ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:11:28.852287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:11:28.276876Z","time spent":"575.400391ms","remote":"127.0.0.1:51466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-10T10:11:28.852419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.631651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-10T10:11:28.85255Z","caller":"traceutil/trace.go:171","msg":"trace[2069571107] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1236; }","duration":"384.842675ms","start":"2026-06-10T10:11:28.46768Z","end":"2026-06-10T10:11:28.852523Z","steps":["trace[2069571107] 'agreement among raft nodes before linearized reading' (duration: 384.351503ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:11:28.852624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:11:28.467622Z","time spent":"384.987939ms","remote":"127.0.0.1:51466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-10T10:11:29.120184Z","caller":"traceutil/trace.go:171","msg":"trace[1509350898] transaction","detail":"{read_only:false; response_revision:1242; number_of_response:1; }","duration":"153.767944ms","start":"2026-06-10T10:11:28.966351Z","end":"2026-06-10T10:11:29.120119Z","steps":["trace[1509350898] 'process raft request' (duration: 153.555929ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:11:30.236137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"764.491832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:11:30.23622Z","caller":"traceutil/trace.go:171","msg":"trace[1232778705] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1243; }","duration":"764.618256ms","start":"2026-06-10T10:11:29.471579Z","end":"2026-06-10T10:11:30.236197Z","steps":["trace[1232778705] 'range keys from in-memory index tree' (duration: 764.36956ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:11:30.236259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:11:29.471558Z","time spent":"764.692838ms","remote":"127.0.0.1:51132","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-10T10:11:30.236653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"720.555441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:11:30.236782Z","caller":"traceutil/trace.go:171","msg":"trace[1019724373] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1243; }","duration":"720.749796ms","start":"2026-06-10T10:11:29.516002Z","end":"2026-06-10T10:11:30.236751Z","steps":["trace[1019724373] 'count revisions from in-memory index tree' (duration: 720.442318ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:11:30.236848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:11:29.515985Z","time spent":"720.843607ms","remote":"127.0.0.1:51266","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true "} {"level":"warn","ts":"2026-06-10T10:11:31.21385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.83939ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-10T10:11:31.213932Z","caller":"traceutil/trace.go:171","msg":"trace[611809125] transaction","detail":"{read_only:false; response_revision:1245; number_of_response:1; }","duration":"307.954298ms","start":"2026-06-10T10:11:30.905961Z","end":"2026-06-10T10:11:31.213916Z","steps":["trace[611809125] 'process raft request' (duration: 82.978084ms)","trace[611809125] 'compare' (duration: 224.668956ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:11:31.213969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:11:30.905944Z","time spent":"308.00817ms","remote":"127.0.0.1:51466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:11:31.786582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.384787ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-10T10:11:31.786789Z","caller":"traceutil/trace.go:171","msg":"trace[1408480503] transaction","detail":"{read_only:false; response_revision:1246; number_of_response:1; }","duration":"876.903372ms","start":"2026-06-10T10:11:30.909861Z","end":"2026-06-10T10:11:31.786765Z","steps":["trace[1408480503] 'process raft request' (duration: 433.249939ms)","trace[1408480503] 'compare' (duration: 443.098561ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:11:31.786809Z","caller":"traceutil/trace.go:171","msg":"trace[1692509] transaction","detail":"{read_only:false; response_revision:1248; number_of_response:1; }","duration":"876.163446ms","start":"2026-06-10T10:11:30.910628Z","end":"2026-06-10T10:11:31.786791Z","steps":["trace[1692509] 'process raft request' (duration: 876.100664ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:11:31.787039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:11:30.910619Z","time spent":"876.225298ms","remote":"127.0.0.1:51466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:11:31.787089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:11:30.909852Z","time spent":"876.989315ms","remote":"127.0.0.1:51466","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-06-10T10:11:31.787149Z","caller":"traceutil/trace.go:171","msg":"trace[988399463] transaction","detail":"{read_only:false; response_revision:1249; number_of_response:1; }","duration":"876.293389ms","start":"2026-06-10T10:11:30.910844Z","end":"2026-06-10T10:11:31.787138Z","steps":["trace[988399463] 'process raft request' (duration: 875.916391ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:11:31.787203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:11:30.910835Z","time spent":"876.339ms","remote":"127.0.0.1:51466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:11:31.787247Z","caller":"traceutil/trace.go:171","msg":"trace[605377819] transaction","detail":"{read_only:false; response_revision:1247; number_of_response:1; }","duration":"877.366113ms","start":"2026-06-10T10:11:30.90987Z","end":"2026-06-10T10:11:31.787237Z","steps":["trace[605377819] 'process raft request' (duration: 876.80876ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:11:31.7873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:11:30.909853Z","time spent":"877.426775ms","remote":"127.0.0.1:51466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:11:31.787309Z","caller":"traceutil/trace.go:171","msg":"trace[1075952705] linearizableReadLoop","detail":"{readStateIndex:1302; appliedIndex:1297; }","duration":"405.391078ms","start":"2026-06-10T10:11:31.381909Z","end":"2026-06-10T10:11:31.7873Z","steps":["trace[1075952705] 'read index received' (duration: 252.249459ms)","trace[1075952705] 'applied index is now lower than readState.Index' (duration: 153.140789ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:11:31.787417Z","caller":"traceutil/trace.go:171","msg":"trace[1498992664] transaction","detail":"{read_only:false; response_revision:1250; number_of_response:1; }","duration":"678.262385ms","start":"2026-06-10T10:11:31.109148Z","end":"2026-06-10T10:11:31.78741Z","steps":["trace[1498992664] 'process raft request' (duration: 677.930797ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:11:31.787459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:11:31.109125Z","time spent":"678.309905ms","remote":"127.0.0.1:51466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:11:31.787527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.682032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:11:31.78755Z","caller":"traceutil/trace.go:171","msg":"trace[1454934273] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1250; }","duration":"315.726062ms","start":"2026-06-10T10:11:31.471817Z","end":"2026-06-10T10:11:31.787543Z","steps":["trace[1454934273] 'agreement among raft nodes before linearized reading' (duration: 315.686522ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:11:31.787569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:11:31.471806Z","time spent":"315.759843ms","remote":"127.0.0.1:51132","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-10T10:11:31.787588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.661955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:11:31.78763Z","caller":"traceutil/trace.go:171","msg":"trace[250791550] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:1250; }","duration":"405.738066ms","start":"2026-06-10T10:11:31.381879Z","end":"2026-06-10T10:11:31.787617Z","steps":["trace[250791550] 'agreement among raft nodes before linearized reading' (duration: 405.661884ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:11:31.787666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:11:31.381863Z","time spent":"405.794158ms","remote":"127.0.0.1:43468","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true "} {"level":"info","ts":"2026-06-10T10:11:43.267651Z","caller":"traceutil/trace.go:171","msg":"trace[605157750] transaction","detail":"{read_only:false; response_revision:1345; number_of_response:1; }","duration":"355.112682ms","start":"2026-06-10T10:11:42.912504Z","end":"2026-06-10T10:11:43.267617Z","steps":["trace[605157750] 'process raft request' (duration: 354.744324ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:11:43.26783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:11:42.912482Z","time spent":"355.250906ms","remote":"127.0.0.1:51466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:11:43.973186Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13903912432670837889,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-10T10:11:44.348032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.032333535s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-10T10:11:44.348209Z","caller":"traceutil/trace.go:171","msg":"trace[66348246] transaction","detail":"{read_only:false; response_revision:1347; number_of_response:1; }","duration":"1.072651016s","start":"2026-06-10T10:11:43.27554Z","end":"2026-06-10T10:11:44.348191Z","steps":["trace[66348246] 'process raft request' (duration: 1.072586504s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:11:44.348293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:11:43.275515Z","time spent":"1.072737067s","remote":"127.0.0.1:51466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:11:44.348543Z","caller":"traceutil/trace.go:171","msg":"trace[2088603931] transaction","detail":"{read_only:false; response_revision:1346; number_of_response:1; }","duration":"1.075618433s","start":"2026-06-10T10:11:43.272903Z","end":"2026-06-10T10:11:44.348522Z","steps":["trace[2088603931] 'process raft request' (duration: 42.700935ms)","trace[2088603931] 'compare' (duration: 1.032233333s)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:11:44.348634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:11:43.27282Z","time spent":"1.075770077s","remote":"127.0.0.1:51466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":515,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:11:44.349034Z","caller":"traceutil/trace.go:171","msg":"trace[1849527894] transaction","detail":"{read_only:false; response_revision:1348; number_of_response:1; }","duration":"593.179271ms","start":"2026-06-10T10:11:43.755838Z","end":"2026-06-10T10:11:44.349017Z","steps":["trace[1849527894] 'process raft request' (duration: 593.093179ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:11:44.349261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:11:43.755815Z","time spent":"593.315445ms","remote":"127.0.0.1:51466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:11:44.351963Z","caller":"traceutil/trace.go:171","msg":"trace[1796477511] linearizableReadLoop","detail":"{readStateIndex:1402; appliedIndex:1399; }","duration":"879.110801ms","start":"2026-06-10T10:11:43.472836Z","end":"2026-06-10T10:11:44.351947Z","steps":["trace[1796477511] 'read index received' (duration: 753.846962ms)","trace[1796477511] 'applied index is now lower than readState.Index' (duration: 125.262749ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:11:44.352197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"879.353407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:11:44.352299Z","caller":"traceutil/trace.go:171","msg":"trace[1508234262] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1348; }","duration":"879.45653ms","start":"2026-06-10T10:11:43.472829Z","end":"2026-06-10T10:11:44.352285Z","steps":["trace[1508234262] 'agreement among raft nodes before linearized reading' (duration: 879.329056ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:11:44.352473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:11:43.47277Z","time spent":"879.690216ms","remote":"127.0.0.1:51132","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-10T10:11:44.352857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"780.991676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:535"} {"level":"info","ts":"2026-06-10T10:11:44.352991Z","caller":"traceutil/trace.go:171","msg":"trace[762936127] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1348; }","duration":"781.156309ms","start":"2026-06-10T10:11:43.57182Z","end":"2026-06-10T10:11:44.352976Z","steps":["trace[762936127] 'agreement among raft nodes before linearized reading' (duration: 780.939675ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:11:44.353112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:11:43.571803Z","time spent":"781.297173ms","remote":"127.0.0.1:51466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":558,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-06-10T10:11:44.353469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.591641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-10T10:11:44.353611Z","caller":"traceutil/trace.go:171","msg":"trace[32725282] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1348; }","duration":"423.774965ms","start":"2026-06-10T10:11:43.929824Z","end":"2026-06-10T10:11:44.353599Z","steps":["trace[32725282] 'agreement among raft nodes before linearized reading' (duration: 423.53381ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:11:44.353761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:11:43.929805Z","time spent":"423.941328ms","remote":"127.0.0.1:51466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-10T10:11:44.35408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.49749ms","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-06-10T10:11:44.35426Z","caller":"traceutil/trace.go:171","msg":"trace[1335786685] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1348; }","duration":"424.729916ms","start":"2026-06-10T10:11:43.929518Z","end":"2026-06-10T10:11:44.354248Z","steps":["trace[1335786685] 'agreement among raft nodes before linearized reading' (duration: 424.47834ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:11:44.354385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:11:43.929498Z","time spent":"424.873739ms","remote":"127.0.0.1:51466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-10T10:11:44.354728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.179076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-10T10:11:44.354881Z","caller":"traceutil/trace.go:171","msg":"trace[1056813577] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1348; }","duration":"425.346619ms","start":"2026-06-10T10:11:43.929515Z","end":"2026-06-10T10:11:44.354862Z","steps":["trace[1056813577] 'agreement among raft nodes before linearized reading' (duration: 425.128404ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:11:44.355068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:11:43.929504Z","time spent":"425.543235ms","remote":"127.0.0.1:51466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-10T10:11:44.355389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.105221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-10T10:11:44.355428Z","caller":"traceutil/trace.go:171","msg":"trace[1970288213] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1348; }","duration":"427.144691ms","start":"2026-06-10T10:11:43.928273Z","end":"2026-06-10T10:11:44.355417Z","steps":["trace[1970288213] 'agreement among raft nodes before linearized reading' (duration: 427.047109ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:11:44.355451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:11:43.928216Z","time spent":"427.230213ms","remote":"127.0.0.1:51466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-10T10:15:26.737357Z","caller":"traceutil/trace.go:171","msg":"trace[2735399] transaction","detail":"{read_only:false; response_revision:2397; number_of_response:1; }","duration":"100.929812ms","start":"2026-06-10T10:15:26.636396Z","end":"2026-06-10T10:15:26.737326Z","steps":["trace[2735399] 'process raft request' (duration: 58.012882ms)","trace[2735399] 'compare' (duration: 42.535292ms)"],"step_count":2}