{"level":"warn","ts":"2026-07-04T09:59:21.522129Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-04T09:59:21.522272Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.144:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.144:2380","--initial-cluster=instance=https://199.204.45.144:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.144:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.144: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-07-04T09:59:21.522383Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-04T09:59:21.522402Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.144:2380"]} {"level":"info","ts":"2026-07-04T09:59:21.522427Z","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-07-04T09:59:21.523662Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.144:2379"]} {"level":"info","ts":"2026-07-04T09:59:21.523839Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.144:2380"],"listen-peer-urls":["https://199.204.45.144:2380"],"advertise-client-urls":["https://199.204.45.144:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.144:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.144: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-07-04T09:59:21.529388Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.215161ms"} {"level":"info","ts":"2026-07-04T09:59:21.536167Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"4594e5f716bad646","cluster-id":"ff2e51b364668606"} {"level":"info","ts":"2026-07-04T09:59:21.536259Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 switched to configuration voters=()"} {"level":"info","ts":"2026-07-04T09:59:21.536281Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became follower at term 0"} {"level":"info","ts":"2026-07-04T09:59:21.536292Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 4594e5f716bad646 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-04T09:59:21.536306Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became follower at term 1"} {"level":"info","ts":"2026-07-04T09:59:21.536346Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 switched to configuration voters=(5013885134571230790)"} {"level":"warn","ts":"2026-07-04T09:59:21.544874Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-04T09:59:21.546412Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-04T09:59:21.547607Z","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-07-04T09:59:21.555651Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"4594e5f716bad646","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-04T09:59:21.556047Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"4594e5f716bad646","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-04T09:59:21.556173Z","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-07-04T09:59:21.556233Z","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-07-04T09:59:21.556246Z","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-07-04T09:59:21.559424Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 switched to configuration voters=(5013885134571230790)"} {"level":"info","ts":"2026-07-04T09:59:21.559585Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ff2e51b364668606","local-member-id":"4594e5f716bad646","added-peer-id":"4594e5f716bad646","added-peer-peer-urls":["https://199.204.45.144:2380"]} {"level":"info","ts":"2026-07-04T09:59:21.562845Z","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-07-04T09:59:21.562989Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.144:2380"} {"level":"info","ts":"2026-07-04T09:59:21.56302Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.144:2380"} {"level":"info","ts":"2026-07-04T09:59:21.563321Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-04T09:59:21.563232Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"4594e5f716bad646","initial-advertise-peer-urls":["https://199.204.45.144:2380"],"listen-peer-urls":["https://199.204.45.144:2380"],"advertise-client-urls":["https://199.204.45.144:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.144:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-04T09:59:22.437082Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 is starting a new election at term 1"} {"level":"info","ts":"2026-07-04T09:59:22.437167Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-04T09:59:22.437198Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 received MsgPreVoteResp from 4594e5f716bad646 at term 1"} {"level":"info","ts":"2026-07-04T09:59:22.437225Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became candidate at term 2"} {"level":"info","ts":"2026-07-04T09:59:22.437241Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 received MsgVoteResp from 4594e5f716bad646 at term 2"} {"level":"info","ts":"2026-07-04T09:59:22.437255Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became leader at term 2"} {"level":"info","ts":"2026-07-04T09:59:22.437278Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 4594e5f716bad646 elected leader 4594e5f716bad646 at term 2"} {"level":"info","ts":"2026-07-04T09:59:22.43826Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-04T09:59:22.439178Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"4594e5f716bad646","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.144:2379]}","request-path":"/0/members/4594e5f716bad646/attributes","cluster-id":"ff2e51b364668606","publish-timeout":"7s"} {"level":"info","ts":"2026-07-04T09:59:22.439366Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-04T09:59:22.439503Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-04T09:59:22.43994Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ff2e51b364668606","local-member-id":"4594e5f716bad646","cluster-version":"3.5"} {"level":"info","ts":"2026-07-04T09:59:22.440059Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-04T09:59:22.440103Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-04T09:59:22.442418Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.144:2379"} {"level":"info","ts":"2026-07-04T09:59:22.443216Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-04T09:59:22.444083Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-04T09:59:22.444144Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-04T09:59:23.912042Z","caller":"traceutil/trace.go:171","msg":"trace[532727216] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"119.678958ms","start":"2026-07-04T09:59:23.792328Z","end":"2026-07-04T09:59:23.912007Z","steps":["trace[532727216] 'process raft request' (duration: 119.413546ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T09:59:23.912124Z","caller":"traceutil/trace.go:171","msg":"trace[1560564696] linearizableReadLoop","detail":"{readStateIndex:10; appliedIndex:6; }","duration":"119.439665ms","start":"2026-07-04T09:59:23.792611Z","end":"2026-07-04T09:59:23.912051Z","steps":["trace[1560564696] 'read index received' (duration: 7.558258ms)","trace[1560564696] 'applied index is now lower than readState.Index' (duration: 111.874567ms)"],"step_count":2} {"level":"info","ts":"2026-07-04T09:59:23.912222Z","caller":"traceutil/trace.go:171","msg":"trace[794893925] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"119.816228ms","start":"2026-07-04T09:59:23.792396Z","end":"2026-07-04T09:59:23.912212Z","steps":["trace[794893925] 'process raft request' (duration: 119.574567ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T09:59:23.912142Z","caller":"traceutil/trace.go:171","msg":"trace[777840696] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"119.762148ms","start":"2026-07-04T09:59:23.792338Z","end":"2026-07-04T09:59:23.9121Z","steps":["trace[777840696] 'process raft request' (duration: 119.586186ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T09:59:23.912262Z","caller":"traceutil/trace.go:171","msg":"trace[1976381814] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"119.815609ms","start":"2026-07-04T09:59:23.792434Z","end":"2026-07-04T09:59:23.91225Z","steps":["trace[1976381814] 'process raft request' (duration: 119.574577ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T09:59:23.912606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.767358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-04T09:59:23.912745Z","caller":"traceutil/trace.go:171","msg":"trace[424908609] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:7; }","duration":"120.12299ms","start":"2026-07-04T09:59:23.7926Z","end":"2026-07-04T09:59:23.912723Z","steps":["trace[424908609] 'agreement among raft nodes before linearized reading' (duration: 119.636487ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T09:59:23.932286Z","caller":"traceutil/trace.go:171","msg":"trace[1701126803] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"127.446568ms","start":"2026-07-04T09:59:23.804815Z","end":"2026-07-04T09:59:23.932262Z","steps":["trace[1701126803] 'process raft request' (duration: 127.124355ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T09:59:23.932446Z","caller":"traceutil/trace.go:171","msg":"trace[1460668966] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"127.616599ms","start":"2026-07-04T09:59:23.804822Z","end":"2026-07-04T09:59:23.932439Z","steps":["trace[1460668966] 'process raft request' (duration: 127.239406ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T09:59:23.932919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.723558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3171"} {"level":"info","ts":"2026-07-04T09:59:23.93297Z","caller":"traceutil/trace.go:171","msg":"trace[88170453] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:11; }","duration":"137.802888ms","start":"2026-07-04T09:59:23.795155Z","end":"2026-07-04T09:59:23.932957Z","steps":["trace[88170453] 'agreement among raft nodes before linearized reading' (duration: 137.639617ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T09:59:23.932967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.200246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-04T09:59:23.93307Z","caller":"traceutil/trace.go:171","msg":"trace[209954197] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:11; }","duration":"140.281257ms","start":"2026-07-04T09:59:23.792726Z","end":"2026-07-04T09:59:23.933007Z","steps":["trace[209954197] 'agreement among raft nodes before linearized reading' (duration: 140.178686ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T09:59:24.109758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.672172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-04T09:59:24.109967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.562184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-04T09:59:24.110198Z","caller":"traceutil/trace.go:171","msg":"trace[1043212750] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"172.398502ms","start":"2026-07-04T09:59:23.937127Z","end":"2026-07-04T09:59:24.109525Z","steps":["trace[1043212750] 'process raft request' (duration: 172.229451ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T09:59:24.110762Z","caller":"traceutil/trace.go:171","msg":"trace[2026114669] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"173.040757ms","start":"2026-07-04T09:59:23.936502Z","end":"2026-07-04T09:59:24.109543Z","steps":["trace[2026114669] 'process raft request' (duration: 141.834836ms)","trace[2026114669] 'compare' (duration: 30.842648ms)"],"step_count":2} {"level":"info","ts":"2026-07-04T09:59:24.110897Z","caller":"traceutil/trace.go:171","msg":"trace[1159909628] transaction","detail":"{read_only:false; number_of_response:0; response_revision:17; }","duration":"171.905618ms","start":"2026-07-04T09:59:23.937667Z","end":"2026-07-04T09:59:24.109572Z","steps":["trace[1159909628] 'process raft request' (duration: 171.785017ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T09:59:24.111047Z","caller":"traceutil/trace.go:171","msg":"trace[594290152] linearizableReadLoop","detail":"{readStateIndex:24; appliedIndex:17; }","duration":"126.848059ms","start":"2026-07-04T09:59:23.982792Z","end":"2026-07-04T09:59:24.109641Z","steps":["trace[594290152] 'read index received' (duration: 95.585908ms)","trace[594290152] 'applied index is now lower than readState.Index' (duration: 31.260961ms)"],"step_count":2} {"level":"info","ts":"2026-07-04T09:59:24.111118Z","caller":"traceutil/trace.go:171","msg":"trace[511623529] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"172.418172ms","start":"2026-07-04T09:59:23.937268Z","end":"2026-07-04T09:59:24.109686Z","steps":["trace[511623529] 'process raft request' (duration: 172.14888ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T09:59:24.11129Z","caller":"traceutil/trace.go:171","msg":"trace[1854972026] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"171.133532ms","start":"2026-07-04T09:59:23.938742Z","end":"2026-07-04T09:59:24.109875Z","steps":["trace[1854972026] 'process raft request' (duration: 170.731059ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T09:59:24.111408Z","caller":"traceutil/trace.go:171","msg":"trace[1246711560] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"165.79152ms","start":"2026-07-04T09:59:23.944106Z","end":"2026-07-04T09:59:24.109897Z","steps":["trace[1246711560] 'process raft request' (duration: 165.465658ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T09:59:24.111623Z","caller":"traceutil/trace.go:171","msg":"trace[237275071] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:20; }","duration":"173.891883ms","start":"2026-07-04T09:59:23.936016Z","end":"2026-07-04T09:59:24.109908Z","steps":["trace[237275071] 'agreement among raft nodes before linearized reading' (duration: 173.632111ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T09:59:24.111679Z","caller":"traceutil/trace.go:171","msg":"trace[1791282410] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"170.808119ms","start":"2026-07-04T09:59:23.939115Z","end":"2026-07-04T09:59:24.109923Z","steps":["trace[1791282410] 'process raft request' (duration: 170.416946ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T09:59:24.111725Z","caller":"traceutil/trace.go:171","msg":"trace[1520895946] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:0; response_revision:20; }","duration":"172.680634ms","start":"2026-07-04T09:59:23.937356Z","end":"2026-07-04T09:59:24.110037Z","steps":["trace[1520895946] 'agreement among raft nodes before linearized reading' (duration: 172.555563ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T09:59:24.130296Z","caller":"traceutil/trace.go:171","msg":"trace[612197517] transaction","detail":"{read_only:false; response_revision:21; number_of_response:1; }","duration":"146.199179ms","start":"2026-07-04T09:59:23.984082Z","end":"2026-07-04T09:59:24.130282Z","steps":["trace[612197517] 'process raft request' (duration: 145.975817ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T09:59:24.130322Z","caller":"traceutil/trace.go:171","msg":"trace[941819891] transaction","detail":"{read_only:false; response_revision:23; number_of_response:1; }","duration":"141.585473ms","start":"2026-07-04T09:59:23.988719Z","end":"2026-07-04T09:59:24.130305Z","steps":["trace[941819891] 'process raft request' (duration: 141.482342ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T09:59:24.130347Z","caller":"traceutil/trace.go:171","msg":"trace[431609829] transaction","detail":"{read_only:false; response_revision:24; number_of_response:1; }","duration":"141.618703ms","start":"2026-07-04T09:59:23.988711Z","end":"2026-07-04T09:59:24.13033Z","steps":["trace[431609829] 'process raft request' (duration: 141.518372ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T09:59:24.130291Z","caller":"traceutil/trace.go:171","msg":"trace[1159475683] transaction","detail":"{read_only:false; response_revision:22; number_of_response:1; }","duration":"141.885915ms","start":"2026-07-04T09:59:23.988385Z","end":"2026-07-04T09:59:24.130271Z","steps":["trace[1159475683] 'process raft request' (duration: 141.782064ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T09:59:24.1307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.895297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-07-04T09:59:24.130751Z","caller":"traceutil/trace.go:171","msg":"trace[403823410] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:24; }","duration":"137.002497ms","start":"2026-07-04T09:59:23.993736Z","end":"2026-07-04T09:59:24.130738Z","steps":["trace[403823410] 'agreement among raft nodes before linearized reading' (duration: 136.851006ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T09:59:24.299866Z","caller":"traceutil/trace.go:171","msg":"trace[62647094] transaction","detail":"{read_only:false; response_revision:33; number_of_response:1; }","duration":"151.847631ms","start":"2026-07-04T09:59:24.14796Z","end":"2026-07-04T09:59:24.299808Z","steps":["trace[62647094] 'process raft request' (duration: 89.542281ms)","trace[62647094] 'compare' (duration: 62.039238ms)"],"step_count":2} {"level":"info","ts":"2026-07-04T09:59:24.300039Z","caller":"traceutil/trace.go:171","msg":"trace[1080100366] transaction","detail":"{read_only:false; response_revision:35; number_of_response:1; }","duration":"150.962705ms","start":"2026-07-04T09:59:24.149062Z","end":"2026-07-04T09:59:24.300025Z","steps":["trace[1080100366] 'process raft request' (duration: 150.678693ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T09:59:24.300035Z","caller":"traceutil/trace.go:171","msg":"trace[1481735116] transaction","detail":"{read_only:false; response_revision:34; number_of_response:1; }","duration":"151.079106ms","start":"2026-07-04T09:59:24.148924Z","end":"2026-07-04T09:59:24.300003Z","steps":["trace[1481735116] 'process raft request' (duration: 150.771803ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T09:59:24.299822Z","caller":"traceutil/trace.go:171","msg":"trace[150185197] linearizableReadLoop","detail":"{readStateIndex:37; appliedIndex:32; }","duration":"151.022445ms","start":"2026-07-04T09:59:24.148775Z","end":"2026-07-04T09:59:24.299797Z","steps":["trace[150185197] 'read index received' (duration: 37.858892ms)","trace[150185197] 'applied index is now lower than readState.Index' (duration: 113.162253ms)"],"step_count":2} {"level":"warn","ts":"2026-07-04T09:59:24.300551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.757411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-04T09:59:24.3006Z","caller":"traceutil/trace.go:171","msg":"trace[8889707] range","detail":"{range_begin:/registry/configmaps/kube-system/extension-apiserver-authentication; range_end:; response_count:0; response_revision:35; }","duration":"151.842861ms","start":"2026-07-04T09:59:24.148743Z","end":"2026-07-04T09:59:24.300586Z","steps":["trace[8889707] 'agreement among raft nodes before linearized reading' (duration: 151.63302ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T09:59:24.300962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.812803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-04T09:59:24.301009Z","caller":"traceutil/trace.go:171","msg":"trace[694470124] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:35; }","duration":"111.879663ms","start":"2026-07-04T09:59:24.189116Z","end":"2026-07-04T09:59:24.300996Z","steps":["trace[694470124] 'agreement among raft nodes before linearized reading' (duration: 111.811043ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T09:59:24.432532Z","caller":"traceutil/trace.go:171","msg":"trace[2109786389] linearizableReadLoop","detail":"{readStateIndex:42; appliedIndex:39; }","duration":"126.877928ms","start":"2026-07-04T09:59:24.305629Z","end":"2026-07-04T09:59:24.432507Z","steps":["trace[2109786389] 'read index received' (duration: 76.854284ms)","trace[2109786389] 'applied index is now lower than readState.Index' (duration: 50.022494ms)"],"step_count":2} {"level":"info","ts":"2026-07-04T09:59:24.43267Z","caller":"traceutil/trace.go:171","msg":"trace[886211061] transaction","detail":"{read_only:false; response_revision:37; number_of_response:1; }","duration":"128.201169ms","start":"2026-07-04T09:59:24.304423Z","end":"2026-07-04T09:59:24.432624Z","steps":["trace[886211061] 'process raft request' (duration: 97.631962ms)","trace[886211061] 'compare' (duration: 30.229613ms)"],"step_count":2} {"level":"info","ts":"2026-07-04T09:59:24.432687Z","caller":"traceutil/trace.go:171","msg":"trace[440184416] transaction","detail":"{read_only:false; response_revision:38; number_of_response:1; }","duration":"128.184389ms","start":"2026-07-04T09:59:24.304477Z","end":"2026-07-04T09:59:24.432661Z","steps":["trace[440184416] 'process raft request' (duration: 127.977437ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T09:59:24.432749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.094161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-node-lease/\" range_end:\"/registry/resourcequotas/kube-node-lease0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-04T09:59:24.432868Z","caller":"traceutil/trace.go:171","msg":"trace[461431067] range","detail":"{range_begin:/registry/resourcequotas/kube-node-lease/; range_end:/registry/resourcequotas/kube-node-lease0; response_count:0; response_revision:38; }","duration":"127.255522ms","start":"2026-07-04T09:59:24.305595Z","end":"2026-07-04T09:59:24.43285Z","steps":["trace[461431067] 'agreement among raft nodes before linearized reading' (duration: 127.01262ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T09:59:24.671777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.378822ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-07-04T09:59:24.672024Z","caller":"traceutil/trace.go:171","msg":"trace[1150464597] transaction","detail":"{read_only:false; response_revision:44; number_of_response:1; }","duration":"159.985376ms","start":"2026-07-04T09:59:24.51202Z","end":"2026-07-04T09:59:24.672005Z","steps":["trace[1150464597] 'process raft request' (duration: 159.935356ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T09:59:24.672379Z","caller":"traceutil/trace.go:171","msg":"trace[704271196] transaction","detail":"{read_only:false; response_revision:43; number_of_response:1; }","duration":"161.889449ms","start":"2026-07-04T09:59:24.510449Z","end":"2026-07-04T09:59:24.672338Z","steps":["trace[704271196] 'process raft request' (duration: 161.436454ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T09:59:24.672427Z","caller":"traceutil/trace.go:171","msg":"trace[1526782573] transaction","detail":"{read_only:false; response_revision:42; number_of_response:1; }","duration":"229.902962ms","start":"2026-07-04T09:59:24.442464Z","end":"2026-07-04T09:59:24.672367Z","steps":["trace[1526782573] 'process raft request' (duration: 115.321676ms)","trace[1526782573] 'compare' (duration: 113.223401ms)"],"step_count":2} {"level":"warn","ts":"2026-07-04T09:59:31.774633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.175199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-07-04T09:59:31.774814Z","caller":"traceutil/trace.go:171","msg":"trace[1140757700] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:294; }","duration":"148.410429ms","start":"2026-07-04T09:59:31.626382Z","end":"2026-07-04T09:59:31.774792Z","steps":["trace[1140757700] 'range keys from in-memory index tree' (duration: 148.033684ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T09:59:31.885873Z","caller":"traceutil/trace.go:171","msg":"trace[780232343] transaction","detail":"{read_only:false; response_revision:296; number_of_response:1; }","duration":"104.580038ms","start":"2026-07-04T09:59:31.781265Z","end":"2026-07-04T09:59:31.885845Z","steps":["trace[780232343] 'process raft request' (duration: 104.261886ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T09:59:31.886107Z","caller":"traceutil/trace.go:171","msg":"trace[788422561] transaction","detail":"{read_only:false; response_revision:297; number_of_response:1; }","duration":"102.010427ms","start":"2026-07-04T09:59:31.784067Z","end":"2026-07-04T09:59:31.886077Z","steps":["trace[788422561] 'process raft request' (duration: 101.695135ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T09:59:35.233576Z","caller":"traceutil/trace.go:171","msg":"trace[2047296569] transaction","detail":"{read_only:false; response_revision:362; number_of_response:1; }","duration":"123.336532ms","start":"2026-07-04T09:59:35.110187Z","end":"2026-07-04T09:59:35.233523Z","steps":["trace[2047296569] 'process raft request' (duration: 122.99885ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T09:59:35.739565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.749739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.144\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-07-04T09:59:35.739686Z","caller":"traceutil/trace.go:171","msg":"trace[1104641813] range","detail":"{range_begin:/registry/masterleases/199.204.45.144; range_end:; response_count:1; response_revision:362; }","duration":"219.952757ms","start":"2026-07-04T09:59:35.519708Z","end":"2026-07-04T09:59:35.739661Z","steps":["trace[1104641813] 'range keys from in-memory index tree' (duration: 219.530941ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T09:59:36.05119Z","caller":"traceutil/trace.go:171","msg":"trace[1519487352] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"130.314006ms","start":"2026-07-04T09:59:35.920842Z","end":"2026-07-04T09:59:36.051156Z","steps":["trace[1519487352] 'process raft request' (duration: 129.956103ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T09:59:36.051375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.927509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-07-04T09:59:36.051466Z","caller":"traceutil/trace.go:171","msg":"trace[1197702889] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:364; }","duration":"122.087296ms","start":"2026-07-04T09:59:35.929357Z","end":"2026-07-04T09:59:36.051444Z","steps":["trace[1197702889] 'agreement among raft nodes before linearized reading' (duration: 121.880178ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T09:59:36.051088Z","caller":"traceutil/trace.go:171","msg":"trace[428661164] linearizableReadLoop","detail":"{readStateIndex:375; appliedIndex:374; }","duration":"121.603097ms","start":"2026-07-04T09:59:35.929447Z","end":"2026-07-04T09:59:36.05105Z","steps":["trace[428661164] 'read index received' (duration: 121.195852ms)","trace[428661164] 'applied index is now lower than readState.Index' (duration: 405.995µs)"],"step_count":2} {"level":"info","ts":"2026-07-04T09:59:36.163Z","caller":"traceutil/trace.go:171","msg":"trace[1541235751] transaction","detail":"{read_only:false; response_revision:365; number_of_response:1; }","duration":"106.230502ms","start":"2026-07-04T09:59:36.056729Z","end":"2026-07-04T09:59:36.16296Z","steps":["trace[1541235751] 'process raft request' (duration: 106.016104ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T09:59:36.47148Z","caller":"traceutil/trace.go:171","msg":"trace[375197892] transaction","detail":"{read_only:false; response_revision:367; number_of_response:1; }","duration":"197.698704ms","start":"2026-07-04T09:59:36.273742Z","end":"2026-07-04T09:59:36.47144Z","steps":["trace[375197892] 'process raft request' (duration: 107.143297ms)","trace[375197892] 'compare' (duration: 90.381301ms)"],"step_count":2} {"level":"info","ts":"2026-07-04T09:59:37.553834Z","caller":"traceutil/trace.go:171","msg":"trace[1506961573] transaction","detail":"{read_only:false; response_revision:368; number_of_response:1; }","duration":"466.808618ms","start":"2026-07-04T09:59:37.087014Z","end":"2026-07-04T09:59:37.553822Z","steps":["trace[1506961573] 'process raft request' (duration: 466.625481ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T09:59:37.553978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.332765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-04T09:59:37.554032Z","caller":"traceutil/trace.go:171","msg":"trace[642554606] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:368; }","duration":"381.417548ms","start":"2026-07-04T09:59:37.172599Z","end":"2026-07-04T09:59:37.554017Z","steps":["trace[642554606] 'agreement among raft nodes before linearized reading' (duration: 381.330345ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T09:59:37.554065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T09:59:37.172584Z","time spent":"381.47272ms","remote":"127.0.0.1:60242","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-07-04T09:59:37.554172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T09:59:37.086987Z","time spent":"466.913502ms","remote":"127.0.0.1:60496","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-04T09:59:37.553795Z","caller":"traceutil/trace.go:171","msg":"trace[1064431466] linearizableReadLoop","detail":"{readStateIndex:379; appliedIndex:378; }","duration":"381.134407ms","start":"2026-07-04T09:59:37.172638Z","end":"2026-07-04T09:59:37.553772Z","steps":["trace[1064431466] 'read index received' (duration: 380.957761ms)","trace[1064431466] 'applied index is now lower than readState.Index' (duration: 175.816µs)"],"step_count":2} {"level":"warn","ts":"2026-07-04T09:59:38.643079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.125845ms","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-07-04T09:59:38.643222Z","caller":"traceutil/trace.go:171","msg":"trace[11503264] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:368; }","duration":"371.312273ms","start":"2026-07-04T09:59:38.271876Z","end":"2026-07-04T09:59:38.643188Z","steps":["trace[11503264] 'range keys from in-memory index tree' (duration: 371.033243ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T09:59:38.643282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T09:59:38.27187Z","time spent":"371.399936ms","remote":"127.0.0.1:60496","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-07-04T09:59:38.643814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.899518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-04T09:59:38.64385Z","caller":"traceutil/trace.go:171","msg":"trace[598894443] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:368; }","duration":"469.94416ms","start":"2026-07-04T09:59:38.173895Z","end":"2026-07-04T09:59:38.643839Z","steps":["trace[598894443] 'range keys from in-memory index tree' (duration: 469.870637ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T09:59:38.643879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T09:59:38.17389Z","time spent":"469.981902ms","remote":"127.0.0.1:60242","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-07-04T09:59:38.64429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"588.741473ms","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-07-04T09:59:38.644364Z","caller":"traceutil/trace.go:171","msg":"trace[1451978141] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:368; }","duration":"588.848397ms","start":"2026-07-04T09:59:38.055497Z","end":"2026-07-04T09:59:38.644345Z","steps":["trace[1451978141] 'range keys from in-memory index tree' (duration: 588.65287ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T09:59:38.644406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T09:59:38.055481Z","time spent":"588.91681ms","remote":"127.0.0.1:60496","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-07-04T09:59:38.643837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.557781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-07-04T09:59:38.644823Z","caller":"traceutil/trace.go:171","msg":"trace[1906544784] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:368; }","duration":"477.574388ms","start":"2026-07-04T09:59:38.167222Z","end":"2026-07-04T09:59:38.644796Z","steps":["trace[1906544784] 'range keys from in-memory index tree' (duration: 476.486388ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T09:59:38.644864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.661211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-07-04T09:59:38.64489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T09:59:38.167214Z","time spent":"477.658471ms","remote":"127.0.0.1:60496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-04T09:59:38.644915Z","caller":"traceutil/trace.go:171","msg":"trace[1350897054] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:368; }","duration":"168.757105ms","start":"2026-07-04T09:59:38.476145Z","end":"2026-07-04T09:59:38.644902Z","steps":["trace[1350897054] 'range keys from in-memory index tree' (duration: 168.459574ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T09:59:39.004515Z","caller":"traceutil/trace.go:171","msg":"trace[1655230790] transaction","detail":"{read_only:false; response_revision:369; number_of_response:1; }","duration":"356.013835ms","start":"2026-07-04T09:59:38.648476Z","end":"2026-07-04T09:59:39.00449Z","steps":["trace[1655230790] 'process raft request' (duration: 355.838249ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T09:59:39.004852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T09:59:38.64845Z","time spent":"356.14277ms","remote":"127.0.0.1:60496","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-07-04T09:59:39.867057Z","caller":"traceutil/trace.go:171","msg":"trace[1437148541] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"1.218123785s","start":"2026-07-04T09:59:38.648901Z","end":"2026-07-04T09:59:39.867025Z","steps":["trace[1437148541] 'process raft request' (duration: 1.21799937s)"],"step_count":1} {"level":"info","ts":"2026-07-04T09:59:39.867141Z","caller":"traceutil/trace.go:171","msg":"trace[1408865248] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"1.218242399s","start":"2026-07-04T09:59:38.648874Z","end":"2026-07-04T09:59:39.867117Z","steps":["trace[1408865248] 'process raft request' (duration: 1.217877206s)"],"step_count":1} {"level":"warn","ts":"2026-07-04T09:59:39.867234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T09:59:38.648874Z","time spent":"1.2182614s","remote":"127.0.0.1:60496","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-04T09:59:39.867313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T09:59:38.648842Z","time spent":"1.218352213s","remote":"127.0.0.1:60496","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-04T09:59:39.867308Z","caller":"traceutil/trace.go:171","msg":"trace[2000824994] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"1.21774242s","start":"2026-07-04T09:59:38.649527Z","end":"2026-07-04T09:59:39.867269Z","steps":["trace[2000824994] 'process raft request' (duration: 1.217424369s)"],"step_count":1} {"level":"warn","ts":"2026-07-04T09:59:39.86763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T09:59:38.649514Z","time spent":"1.217993779s","remote":"127.0.0.1:60496","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-07-04T10:00:05.22849Z","caller":"traceutil/trace.go:171","msg":"trace[1722510737] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"469.265435ms","start":"2026-07-04T10:00:04.759194Z","end":"2026-07-04T10:00:05.22846Z","steps":["trace[1722510737] 'process raft request' (duration: 469.107051ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:05.228638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:04.75916Z","time spent":"469.409509ms","remote":"127.0.0.1:60296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-04T10:00:05.277712Z","caller":"traceutil/trace.go:171","msg":"trace[1947359824] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"512.36621ms","start":"2026-07-04T10:00:04.765296Z","end":"2026-07-04T10:00:05.277662Z","steps":["trace[1947359824] 'process raft request' (duration: 511.685772ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T10:00:05.277738Z","caller":"traceutil/trace.go:171","msg":"trace[2128419931] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"504.003068ms","start":"2026-07-04T10:00:04.773703Z","end":"2026-07-04T10:00:05.277706Z","steps":["trace[2128419931] 'process raft request' (duration: 503.470423ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T10:00:05.277739Z","caller":"traceutil/trace.go:171","msg":"trace[564459221] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"498.793402ms","start":"2026-07-04T10:00:04.778905Z","end":"2026-07-04T10:00:05.277698Z","steps":["trace[564459221] 'process raft request' (duration: 498.33878ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:05.277892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:04.765274Z","time spent":"512.539145ms","remote":"127.0.0.1:60296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-04T10:00:05.277902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:04.773676Z","time spent":"504.142132ms","remote":"127.0.0.1:60296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-04T10:00:05.277945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:04.778902Z","time spent":"498.947687ms","remote":"127.0.0.1:60296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-04T10:00:05.278193Z","caller":"traceutil/trace.go:171","msg":"trace[1177165052] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"498.944077ms","start":"2026-07-04T10:00:04.778846Z","end":"2026-07-04T10:00:05.27779Z","steps":["trace[1177165052] 'process raft request' (duration: 498.370301ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T10:00:05.278262Z","caller":"traceutil/trace.go:171","msg":"trace[833546438] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"497.564609ms","start":"2026-07-04T10:00:04.780693Z","end":"2026-07-04T10:00:05.278257Z","steps":["trace[833546438] 'process raft request' (duration: 496.623993ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T10:00:05.278275Z","caller":"traceutil/trace.go:171","msg":"trace[904278225] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"476.747769ms","start":"2026-07-04T10:00:04.801519Z","end":"2026-07-04T10:00:05.278267Z","steps":["trace[904278225] 'process raft request' (duration: 475.876625ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:05.278295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:04.780675Z","time spent":"497.604439ms","remote":"127.0.0.1:60296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-04T10:00:05.278362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:04.778825Z","time spent":"499.456801ms","remote":"127.0.0.1:60296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-04T10:00:05.278361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:04.801516Z","time spent":"476.79011ms","remote":"127.0.0.1:60296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-04T10:00:05.278392Z","caller":"traceutil/trace.go:171","msg":"trace[1682499304] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"452.938407ms","start":"2026-07-04T10:00:04.825431Z","end":"2026-07-04T10:00:05.27837Z","steps":["trace[1682499304] 'process raft request' (duration: 452.192046ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:05.278459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:04.825394Z","time spent":"453.03669ms","remote":"127.0.0.1:60296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-04T10:00:05.278241Z","caller":"traceutil/trace.go:171","msg":"trace[1489307817] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"476.77894ms","start":"2026-07-04T10:00:04.801452Z","end":"2026-07-04T10:00:05.278231Z","steps":["trace[1489307817] 'process raft request' (duration: 475.908956ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:05.278518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:04.801431Z","time spent":"477.072589ms","remote":"127.0.0.1:60296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-04T10:00:05.278193Z","caller":"traceutil/trace.go:171","msg":"trace[1662210309] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"512.434512ms","start":"2026-07-04T10:00:04.765351Z","end":"2026-07-04T10:00:05.277786Z","steps":["trace[1662210309] 'process raft request' (duration: 511.744073ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:05.2786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:04.765348Z","time spent":"513.226884ms","remote":"127.0.0.1:60296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-04T10:00:05.278775Z","caller":"traceutil/trace.go:171","msg":"trace[835623736] linearizableReadLoop","detail":"{readStateIndex:520; appliedIndex:508; }","duration":"113.185578ms","start":"2026-07-04T10:00:05.16558Z","end":"2026-07-04T10:00:05.278766Z","steps":["trace[835623736] 'read index received' (duration: 62.734198ms)","trace[835623736] 'applied index is now lower than readState.Index' (duration: 50.45077ms)"],"step_count":2} {"level":"info","ts":"2026-07-04T10:00:05.278249Z","caller":"traceutil/trace.go:171","msg":"trace[2107694296] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"505.829218ms","start":"2026-07-04T10:00:04.77179Z","end":"2026-07-04T10:00:05.277619Z","steps":["trace[2107694296] 'process raft request' (duration: 505.337585ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:05.278958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.384184ms","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-07-04T10:00:05.278984Z","caller":"traceutil/trace.go:171","msg":"trace[684201273] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:503; }","duration":"113.450876ms","start":"2026-07-04T10:00:05.165527Z","end":"2026-07-04T10:00:05.278978Z","steps":["trace[684201273] 'agreement among raft nodes before linearized reading' (duration: 113.303352ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:05.278975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:04.771744Z","time spent":"507.129705ms","remote":"127.0.0.1:60296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-04T10:00:05.278819Z","caller":"traceutil/trace.go:171","msg":"trace[611500421] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"352.41937ms","start":"2026-07-04T10:00:04.926393Z","end":"2026-07-04T10:00:05.278812Z","steps":["trace[611500421] 'process raft request' (duration: 351.972188ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:05.279156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:04.926363Z","time spent":"352.77149ms","remote":"127.0.0.1:60296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-04T10:00:05.324538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.117098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-04T10:00:05.324639Z","caller":"traceutil/trace.go:171","msg":"trace[1370467773] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:505; }","duration":"153.252892ms","start":"2026-07-04T10:00:05.171356Z","end":"2026-07-04T10:00:05.324609Z","steps":["trace[1370467773] 'agreement among raft nodes before linearized reading' (duration: 153.063737ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T10:00:06.035533Z","caller":"traceutil/trace.go:171","msg":"trace[1000126903] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"636.691023ms","start":"2026-07-04T10:00:05.398684Z","end":"2026-07-04T10:00:06.035375Z","steps":["trace[1000126903] 'process raft request' (duration: 594.998483ms)","trace[1000126903] 'compare' (duration: 40.808386ms)"],"step_count":2} {"level":"warn","ts":"2026-07-04T10:00:06.035699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:05.398658Z","time spent":"636.95358ms","remote":"127.0.0.1:60296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23057,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-04T10:00:06.049629Z","caller":"traceutil/trace.go:171","msg":"trace[694736847] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"641.087361ms","start":"2026-07-04T10:00:05.408523Z","end":"2026-07-04T10:00:06.04961Z","steps":["trace[694736847] 'process raft request' (duration: 640.908746ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:06.04978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:05.408498Z","time spent":"641.196144ms","remote":"127.0.0.1:60296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58844,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-04T10:00:06.049857Z","caller":"traceutil/trace.go:171","msg":"trace[1937314256] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"634.609472ms","start":"2026-07-04T10:00:05.415226Z","end":"2026-07-04T10:00:06.049836Z","steps":["trace[1937314256] 'process raft request' (duration: 634.349475ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:06.049995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:05.415213Z","time spent":"634.703315ms","remote":"127.0.0.1:60296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-04T10:00:06.050121Z","caller":"traceutil/trace.go:171","msg":"trace[1930527001] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"617.513151ms","start":"2026-07-04T10:00:05.432585Z","end":"2026-07-04T10:00:06.050098Z","steps":["trace[1930527001] 'process raft request' (duration: 617.259204ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:06.050199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"528.131188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.144\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-07-04T10:00:06.050224Z","caller":"traceutil/trace.go:171","msg":"trace[1056122357] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"581.800067ms","start":"2026-07-04T10:00:05.468409Z","end":"2026-07-04T10:00:06.050209Z","steps":["trace[1056122357] 'process raft request' (duration: 581.675684ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T10:00:06.050234Z","caller":"traceutil/trace.go:171","msg":"trace[1014385907] range","detail":"{range_begin:/registry/masterleases/199.204.45.144; range_end:; response_count:1; response_revision:525; }","duration":"528.21305ms","start":"2026-07-04T10:00:05.522011Z","end":"2026-07-04T10:00:06.050224Z","steps":["trace[1014385907] 'agreement among raft nodes before linearized reading' (duration: 528.151269ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:06.050245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:05.432555Z","time spent":"617.628584ms","remote":"127.0.0.1:60296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":150480,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-04T10:00:06.050268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:05.52199Z","time spent":"528.270722ms","remote":"127.0.0.1:60272","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.144\" "} {"level":"info","ts":"2026-07-04T10:00:06.050276Z","caller":"traceutil/trace.go:171","msg":"trace[1758189621] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"598.128237ms","start":"2026-07-04T10:00:05.452139Z","end":"2026-07-04T10:00:06.050267Z","steps":["trace[1758189621] 'process raft request' (duration: 597.8959ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:06.050292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:05.468379Z","time spent":"581.877569ms","remote":"127.0.0.1:60496","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-04T10:00:06.050315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:05.45212Z","time spent":"598.176218ms","remote":"127.0.0.1:60296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":97665,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-04T10:00:06.050139Z","caller":"traceutil/trace.go:171","msg":"trace[1870947730] linearizableReadLoop","detail":"{readStateIndex:546; appliedIndex:540; }","duration":"528.054347ms","start":"2026-07-04T10:00:05.52207Z","end":"2026-07-04T10:00:06.050125Z","steps":["trace[1870947730] 'read index received' (duration: 471.631924ms)","trace[1870947730] 'applied index is now lower than readState.Index' (duration: 56.421803ms)"],"step_count":2} {"level":"warn","ts":"2026-07-04T10:00:06.593229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.940442ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-04T10:00:06.593351Z","caller":"traceutil/trace.go:171","msg":"trace[1457126234] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"386.591129ms","start":"2026-07-04T10:00:06.206738Z","end":"2026-07-04T10:00:06.593329Z","steps":["trace[1457126234] 'process raft request' (duration: 159.289577ms)","trace[1457126234] 'compare' (duration: 226.735227ms)"],"step_count":2} {"level":"warn","ts":"2026-07-04T10:00:06.593413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:06.206717Z","time spent":"386.673241ms","remote":"127.0.0.1:60296","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-07-04T10:00:06.688344Z","caller":"traceutil/trace.go:171","msg":"trace[790277603] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"441.902889ms","start":"2026-07-04T10:00:06.24642Z","end":"2026-07-04T10:00:06.688323Z","steps":["trace[790277603] 'process raft request' (duration: 441.804166ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T10:00:06.688398Z","caller":"traceutil/trace.go:171","msg":"trace[1510071786] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"446.887244ms","start":"2026-07-04T10:00:06.241487Z","end":"2026-07-04T10:00:06.688374Z","steps":["trace[1510071786] 'process raft request' (duration: 446.600256ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:06.688473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:06.246405Z","time spent":"442.001151ms","remote":"127.0.0.1:60296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":59607,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-04T10:00:06.688522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:06.241458Z","time spent":"446.996177ms","remote":"127.0.0.1:60296","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-07-04T10:00:07.672224Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15440203386254967948,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-04T10:00:08.17248Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15440203386254967948,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-04T10:00:08.305264Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.617164536s","expected-duration":"1s"} {"level":"warn","ts":"2026-07-04T10:00:08.461145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.54335591s","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-07-04T10:00:08.461265Z","caller":"traceutil/trace.go:171","msg":"trace[1091543511] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:543; }","duration":"1.543489984s","start":"2026-07-04T10:00:06.917757Z","end":"2026-07-04T10:00:08.461247Z","steps":["trace[1091543511] 'range keys from in-memory index tree' (duration: 1.54334077s)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:08.461314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.724399ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-04T10:00:08.461404Z","caller":"traceutil/trace.go:171","msg":"trace[1778424466] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"1.834638388s","start":"2026-07-04T10:00:06.626743Z","end":"2026-07-04T10:00:08.461382Z","steps":["trace[1778424466] 'process raft request' (duration: 1.678785296s)","trace[1778424466] 'compare' (duration: 155.505993ms)"],"step_count":2} {"level":"warn","ts":"2026-07-04T10:00:08.461445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:06.626716Z","time spent":"1.834715291s","remote":"127.0.0.1:60296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":19834,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-04T10:00:08.464563Z","caller":"traceutil/trace.go:171","msg":"trace[459753227] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"1.75116326s","start":"2026-07-04T10:00:06.713371Z","end":"2026-07-04T10:00:08.464534Z","steps":["trace[459753227] 'process raft request' (duration: 1.749413303s)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:08.464775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:06.713338Z","time spent":"1.751339005s","remote":"127.0.0.1:60296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":59616,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-04T10:00:08.464795Z","caller":"traceutil/trace.go:171","msg":"trace[1062528633] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"1.747724515s","start":"2026-07-04T10:00:06.716864Z","end":"2026-07-04T10:00:08.464588Z","steps":["trace[1062528633] 'process raft request' (duration: 1.746240946s)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:08.464974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:06.716833Z","time spent":"1.748101106s","remote":"127.0.0.1:60296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":80679,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-04T10:00:08.46516Z","caller":"traceutil/trace.go:171","msg":"trace[1975669025] linearizableReadLoop","detail":"{readStateIndex:569; appliedIndex:565; }","duration":"1.293875995s","start":"2026-07-04T10:00:07.171256Z","end":"2026-07-04T10:00:08.465132Z","steps":["trace[1975669025] 'read index received' (duration: 1.134330953s)","trace[1975669025] 'applied index is now lower than readState.Index' (duration: 159.541512ms)"],"step_count":2} {"level":"info","ts":"2026-07-04T10:00:08.465298Z","caller":"traceutil/trace.go:171","msg":"trace[733184776] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"514.823267ms","start":"2026-07-04T10:00:07.950467Z","end":"2026-07-04T10:00:08.46529Z","steps":["trace[733184776] 'process raft request' (duration: 512.926276ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:08.4654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:07.950445Z","time spent":"514.877329ms","remote":"127.0.0.1:60496","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-04T10:00:08.465758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.127838886s","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-07-04T10:00:08.465815Z","caller":"traceutil/trace.go:171","msg":"trace[345657157] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:547; }","duration":"1.12794883s","start":"2026-07-04T10:00:07.33785Z","end":"2026-07-04T10:00:08.465799Z","steps":["trace[345657157] 'agreement among raft nodes before linearized reading' (duration: 1.127765915s)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:08.465857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:07.337827Z","time spent":"1.128019212s","remote":"127.0.0.1:60496","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-07-04T10:00:08.465869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.294618265s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-04T10:00:08.465879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.245683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-04T10:00:08.465892Z","caller":"traceutil/trace.go:171","msg":"trace[722861944] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:547; }","duration":"1.294674476s","start":"2026-07-04T10:00:07.171211Z","end":"2026-07-04T10:00:08.465885Z","steps":["trace[722861944] 'agreement among raft nodes before linearized reading' (duration: 1.294630385s)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:08.46591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:07.171193Z","time spent":"1.294713958s","remote":"127.0.0.1:60242","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-07-04T10:00:08.46591Z","caller":"traceutil/trace.go:171","msg":"trace[390757729] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:547; }","duration":"339.299445ms","start":"2026-07-04T10:00:08.126602Z","end":"2026-07-04T10:00:08.465901Z","steps":["trace[390757729] 'agreement among raft nodes before linearized reading' (duration: 339.235773ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:08.465935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:08.126589Z","time spent":"339.341545ms","remote":"127.0.0.1:60496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-04T10:00:08.466067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.462569ms","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-07-04T10:00:08.466082Z","caller":"traceutil/trace.go:171","msg":"trace[175893274] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:547; }","duration":"339.52329ms","start":"2026-07-04T10:00:08.126554Z","end":"2026-07-04T10:00:08.466078Z","steps":["trace[175893274] 'agreement among raft nodes before linearized reading' (duration: 339.485599ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:08.466089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.353632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-07-04T10:00:08.466094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:08.126532Z","time spent":"339.560212ms","remote":"127.0.0.1:60496","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-07-04T10:00:08.466108Z","caller":"traceutil/trace.go:171","msg":"trace[1674380614] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:547; }","duration":"362.428674ms","start":"2026-07-04T10:00:08.103674Z","end":"2026-07-04T10:00:08.466103Z","steps":["trace[1674380614] 'agreement among raft nodes before linearized reading' (duration: 362.308051ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:08.466134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:08.103651Z","time spent":"362.479665ms","remote":"127.0.0.1:60496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-04T10:00:12.684094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.646137ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-04T10:00:12.684193Z","caller":"traceutil/trace.go:171","msg":"trace[768694147] linearizableReadLoop","detail":"{readStateIndex:615; appliedIndex:614; }","duration":"177.103209ms","start":"2026-07-04T10:00:12.507073Z","end":"2026-07-04T10:00:12.684176Z","steps":["trace[768694147] 'read index received' (duration: 69.278187ms)","trace[768694147] 'applied index is now lower than readState.Index' (duration: 107.824182ms)"],"step_count":2} {"level":"info","ts":"2026-07-04T10:00:12.684266Z","caller":"traceutil/trace.go:171","msg":"trace[1774242448] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"298.365597ms","start":"2026-07-04T10:00:12.385878Z","end":"2026-07-04T10:00:12.684244Z","steps":["trace[1774242448] 'process raft request' (duration: 190.441312ms)","trace[1774242448] 'compare' (duration: 107.527574ms)"],"step_count":2} {"level":"warn","ts":"2026-07-04T10:00:12.684529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.93004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-07-04T10:00:12.68456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.391692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-07-04T10:00:12.684599Z","caller":"traceutil/trace.go:171","msg":"trace[2024298938] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:592; }","duration":"166.476104ms","start":"2026-07-04T10:00:12.518111Z","end":"2026-07-04T10:00:12.684587Z","steps":["trace[2024298938] 'agreement among raft nodes before linearized reading' (duration: 166.378302ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T10:00:12.68457Z","caller":"traceutil/trace.go:171","msg":"trace[1224063710] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:592; }","duration":"171.020492ms","start":"2026-07-04T10:00:12.513538Z","end":"2026-07-04T10:00:12.684559Z","steps":["trace[1224063710] 'agreement among raft nodes before linearized reading' (duration: 170.909649ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:12.684665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.030378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-07-04T10:00:12.685246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.148205ms","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-07-04T10:00:12.685327Z","caller":"traceutil/trace.go:171","msg":"trace[284206079] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:592; }","duration":"178.303999ms","start":"2026-07-04T10:00:12.507005Z","end":"2026-07-04T10:00:12.685309Z","steps":["trace[284206079] 'agreement among raft nodes before linearized reading' (duration: 177.260942ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T10:00:12.68527Z","caller":"traceutil/trace.go:171","msg":"trace[1208140349] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:592; }","duration":"167.630934ms","start":"2026-07-04T10:00:12.517549Z","end":"2026-07-04T10:00:12.68518Z","steps":["trace[1208140349] 'agreement among raft nodes before linearized reading' (duration: 167.036508ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T10:00:13.039489Z","caller":"traceutil/trace.go:171","msg":"trace[869685678] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"346.48371ms","start":"2026-07-04T10:00:12.692974Z","end":"2026-07-04T10:00:13.039458Z","steps":["trace[869685678] 'process raft request' (duration: 274.221204ms)","trace[869685678] 'compare' (duration: 72.115972ms)"],"step_count":2} {"level":"warn","ts":"2026-07-04T10:00:13.039726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:12.69295Z","time spent":"346.629433ms","remote":"127.0.0.1:60496","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-07-04T10:00:13.055054Z","caller":"traceutil/trace.go:171","msg":"trace[717822876] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"361.74771ms","start":"2026-07-04T10:00:12.693284Z","end":"2026-07-04T10:00:13.055032Z","steps":["trace[717822876] 'process raft request' (duration: 361.616856ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:13.055148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:12.693255Z","time spent":"361.851741ms","remote":"127.0.0.1:60496","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-07-04T10:00:13.05539Z","caller":"traceutil/trace.go:171","msg":"trace[897838027] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"361.934984ms","start":"2026-07-04T10:00:12.69343Z","end":"2026-07-04T10:00:13.055365Z","steps":["trace[897838027] 'process raft request' (duration: 361.555564ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:13.055572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:12.693408Z","time spent":"362.058267ms","remote":"127.0.0.1:60496","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-04T10:00:13.055551Z","caller":"traceutil/trace.go:171","msg":"trace[1482936678] linearizableReadLoop","detail":"{readStateIndex:619; appliedIndex:615; }","duration":"360.294812ms","start":"2026-07-04T10:00:12.69522Z","end":"2026-07-04T10:00:13.055515Z","steps":["trace[1482936678] 'read index received' (duration: 271.952635ms)","trace[1482936678] 'applied index is now lower than readState.Index' (duration: 88.340957ms)"],"step_count":2} {"level":"warn","ts":"2026-07-04T10:00:13.055773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.524108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-04T10:00:13.055796Z","caller":"traceutil/trace.go:171","msg":"trace[1556450543] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"362.279063ms","start":"2026-07-04T10:00:12.693505Z","end":"2026-07-04T10:00:13.055784Z","steps":["trace[1556450543] 'process raft request' (duration: 361.7768ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T10:00:13.05584Z","caller":"traceutil/trace.go:171","msg":"trace[67456093] range","detail":"{range_begin:/registry/rolebindings/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:596; }","duration":"360.63076ms","start":"2026-07-04T10:00:12.69519Z","end":"2026-07-04T10:00:13.055821Z","steps":["trace[67456093] 'agreement among raft nodes before linearized reading' (duration: 360.437615ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:13.055858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:12.693481Z","time spent":"362.344804ms","remote":"127.0.0.1:60496","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-04T10:00:13.055892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:12.695178Z","time spent":"360.699132ms","remote":"127.0.0.1:60564","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/rolebindings/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"info","ts":"2026-07-04T10:00:14.005699Z","caller":"traceutil/trace.go:171","msg":"trace[842879037] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"560.485305ms","start":"2026-07-04T10:00:13.445147Z","end":"2026-07-04T10:00:14.005632Z","steps":["trace[842879037] 'process raft request' (duration: 559.739406ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:14.006317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:13.445124Z","time spent":"560.69179ms","remote":"127.0.0.1:60332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036193,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-04T10:00:14.673683Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15440203386254968066,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-04T10:00:15.15968Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.098057553s","expected-duration":"1s"} {"level":"info","ts":"2026-07-04T10:00:15.160142Z","caller":"traceutil/trace.go:171","msg":"trace[748793880] linearizableReadLoop","detail":"{readStateIndex:622; appliedIndex:621; }","duration":"986.5426ms","start":"2026-07-04T10:00:14.173573Z","end":"2026-07-04T10:00:15.160116Z","steps":["trace[748793880] 'read index received' (duration: 986.253503ms)","trace[748793880] 'applied index is now lower than readState.Index' (duration: 288.027µs)"],"step_count":2} {"level":"info","ts":"2026-07-04T10:00:15.160224Z","caller":"traceutil/trace.go:171","msg":"trace[1265314099] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"1.098688439s","start":"2026-07-04T10:00:14.061476Z","end":"2026-07-04T10:00:15.160164Z","steps":["trace[1265314099] 'process raft request' (duration: 1.098483504s)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:15.160406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:14.061446Z","time spent":"1.098876323s","remote":"127.0.0.1:60564","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1044,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-04T10:00:15.160502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.086242ms","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-07-04T10:00:15.160562Z","caller":"traceutil/trace.go:171","msg":"trace[1090167973] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:599; }","duration":"100.216766ms","start":"2026-07-04T10:00:15.060326Z","end":"2026-07-04T10:00:15.160543Z","steps":["trace[1090167973] 'agreement among raft nodes before linearized reading' (duration: 100.014191ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:15.160592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.01629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-07-04T10:00:15.160713Z","caller":"traceutil/trace.go:171","msg":"trace[818258639] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:599; }","duration":"100.162384ms","start":"2026-07-04T10:00:15.060522Z","end":"2026-07-04T10:00:15.160685Z","steps":["trace[818258639] 'agreement among raft nodes before linearized reading' (duration: 99.848996ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:15.160904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.552015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-07-04T10:00:15.16096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"986.745835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-04T10:00:15.160996Z","caller":"traceutil/trace.go:171","msg":"trace[209899520] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:599; }","duration":"987.482884ms","start":"2026-07-04T10:00:14.173502Z","end":"2026-07-04T10:00:15.160985Z","steps":["trace[209899520] 'agreement among raft nodes before linearized reading' (duration: 986.757606ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T10:00:15.160974Z","caller":"traceutil/trace.go:171","msg":"trace[1654422804] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:599; }","duration":"116.654358ms","start":"2026-07-04T10:00:15.0443Z","end":"2026-07-04T10:00:15.160955Z","steps":["trace[1654422804] 'agreement among raft nodes before linearized reading' (duration: 116.035512ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:15.161027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:14.173476Z","time spent":"987.541925ms","remote":"127.0.0.1:60240","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-07-04T10:00:15.161341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.035616ms","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-07-04T10:00:15.16143Z","caller":"traceutil/trace.go:171","msg":"trace[810419138] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:599; }","duration":"101.170709ms","start":"2026-07-04T10:00:15.060242Z","end":"2026-07-04T10:00:15.161413Z","steps":["trace[810419138] 'agreement among raft nodes before linearized reading' (duration: 100.091462ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:16.46937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"946.948831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.144\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-07-04T10:00:16.469436Z","caller":"traceutil/trace.go:171","msg":"trace[428595566] range","detail":"{range_begin:/registry/masterleases/199.204.45.144; range_end:; response_count:1; response_revision:603; }","duration":"947.061294ms","start":"2026-07-04T10:00:15.522359Z","end":"2026-07-04T10:00:16.46942Z","steps":["trace[428595566] 'range keys from in-memory index tree' (duration: 946.804038ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:16.469469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:15.522341Z","time spent":"947.121275ms","remote":"127.0.0.1:60272","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.144\" "} {"level":"warn","ts":"2026-07-04T10:00:16.673333Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15440203386254968077,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-04T10:00:17.174014Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15440203386254968077,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-04T10:00:17.337033Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.74335468s","expected-duration":"1s"} {"level":"info","ts":"2026-07-04T10:00:17.340104Z","caller":"traceutil/trace.go:171","msg":"trace[263093351] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"1.748689662s","start":"2026-07-04T10:00:15.591383Z","end":"2026-07-04T10:00:17.340072Z","steps":["trace[263093351] 'process raft request' (duration: 1.746901258s)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:17.340347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:15.591351Z","time spent":"1.748892447s","remote":"127.0.0.1:60332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036225,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-04T10:00:17.348105Z","caller":"traceutil/trace.go:171","msg":"trace[932070052] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"1.285303272s","start":"2026-07-04T10:00:16.062775Z","end":"2026-07-04T10:00:17.348079Z","steps":["trace[932070052] 'process raft request' (duration: 1.284305308s)"],"step_count":1} {"level":"info","ts":"2026-07-04T10:00:17.348389Z","caller":"traceutil/trace.go:171","msg":"trace[1923105534] linearizableReadLoop","detail":"{readStateIndex:629; appliedIndex:626; }","duration":"1.175888951s","start":"2026-07-04T10:00:16.172458Z","end":"2026-07-04T10:00:17.348347Z","steps":["trace[1923105534] 'read index received' (duration: 1.164808328s)","trace[1923105534] 'applied index is now lower than readState.Index' (duration: 11.079473ms)"],"step_count":2} {"level":"warn","ts":"2026-07-04T10:00:17.348459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:16.470652Z","time spent":"877.804337ms","remote":"127.0.0.1:60272","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-07-04T10:00:17.349776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.960071ms","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-07-04T10:00:17.349828Z","caller":"traceutil/trace.go:171","msg":"trace[1947866154] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:605; }","duration":"138.032832ms","start":"2026-07-04T10:00:17.211782Z","end":"2026-07-04T10:00:17.349815Z","steps":["trace[1947866154] 'agreement among raft nodes before linearized reading' (duration: 137.92286ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:17.350085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:16.062746Z","time spent":"1.285426586s","remote":"127.0.0.1:60496","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-07-04T10:00:17.350183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.177724156s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-04T10:00:17.350206Z","caller":"traceutil/trace.go:171","msg":"trace[1481363087] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:605; }","duration":"1.177797408s","start":"2026-07-04T10:00:16.172402Z","end":"2026-07-04T10:00:17.3502Z","steps":["trace[1481363087] 'agreement among raft nodes before linearized reading' (duration: 1.176191958s)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:17.350224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:16.172377Z","time spent":"1.177843299s","remote":"127.0.0.1:60242","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-07-04T10:00:17.350394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.254014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-07-04T10:00:17.350419Z","caller":"traceutil/trace.go:171","msg":"trace[1923224485] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:605; }","duration":"165.327136ms","start":"2026-07-04T10:00:17.185083Z","end":"2026-07-04T10:00:17.35041Z","steps":["trace[1923224485] 'agreement among raft nodes before linearized reading' (duration: 163.530702ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:17.349355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.185657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-04T10:00:17.350523Z","caller":"traceutil/trace.go:171","msg":"trace[1308343148] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:605; }","duration":"137.415618ms","start":"2026-07-04T10:00:17.213103Z","end":"2026-07-04T10:00:17.350518Z","steps":["trace[1308343148] 'agreement among raft nodes before linearized reading' (duration: 136.192197ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:17.350607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.647628ms","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-07-04T10:00:17.350624Z","caller":"traceutil/trace.go:171","msg":"trace[1743922557] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:605; }","duration":"137.603872ms","start":"2026-07-04T10:00:17.213017Z","end":"2026-07-04T10:00:17.35062Z","steps":["trace[1743922557] 'agreement among raft nodes before linearized reading' (duration: 136.619298ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T10:00:18.802834Z","caller":"traceutil/trace.go:171","msg":"trace[1106839766] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"402.167966ms","start":"2026-07-04T10:00:18.400593Z","end":"2026-07-04T10:00:18.802761Z","steps":["trace[1106839766] 'process raft request' (duration: 395.75385ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:18.803059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:18.400557Z","time spent":"402.372961ms","remote":"127.0.0.1:60332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036281,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-04T10:00:22.866936Z","caller":"traceutil/trace.go:171","msg":"trace[884269966] transaction","detail":"{read_only:false; response_revision:696; number_of_response:1; }","duration":"153.285767ms","start":"2026-07-04T10:00:22.713596Z","end":"2026-07-04T10:00:22.866882Z","steps":["trace[884269966] 'process raft request' (duration: 152.98742ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T10:00:29.804986Z","caller":"traceutil/trace.go:171","msg":"trace[1240284193] linearizableReadLoop","detail":"{readStateIndex:783; appliedIndex:782; }","duration":"372.638331ms","start":"2026-07-04T10:00:29.432313Z","end":"2026-07-04T10:00:29.804951Z","steps":["trace[1240284193] 'read index received' (duration: 367.587759ms)","trace[1240284193] 'applied index is now lower than readState.Index' (duration: 5.049132ms)"],"step_count":2} {"level":"info","ts":"2026-07-04T10:00:29.805043Z","caller":"traceutil/trace.go:171","msg":"trace[1270919227] transaction","detail":"{read_only:false; response_revision:754; number_of_response:1; }","duration":"379.201968ms","start":"2026-07-04T10:00:29.425815Z","end":"2026-07-04T10:00:29.805017Z","steps":["trace[1270919227] 'process raft request' (duration: 374.138735ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:29.805306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.365981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-07-04T10:00:29.805352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:29.425797Z","time spent":"379.31512ms","remote":"127.0.0.1:60496","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-07-04T10:00:29.805401Z","caller":"traceutil/trace.go:171","msg":"trace[970509417] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:754; }","duration":"352.499154ms","start":"2026-07-04T10:00:29.452884Z","end":"2026-07-04T10:00:29.805383Z","steps":["trace[970509417] 'agreement among raft nodes before linearized reading' (duration: 352.276799ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:29.805459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:29.452871Z","time spent":"352.573395ms","remote":"127.0.0.1:60496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-04T10:00:29.805856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.531231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-07-04T10:00:29.805953Z","caller":"traceutil/trace.go:171","msg":"trace[1345154232] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:754; }","duration":"373.637614ms","start":"2026-07-04T10:00:29.432294Z","end":"2026-07-04T10:00:29.805931Z","steps":["trace[1345154232] 'agreement among raft nodes before linearized reading' (duration: 372.776085ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:29.806033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:29.432287Z","time spent":"373.731936ms","remote":"127.0.0.1:60496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-04T10:00:32.833055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.289697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-04T10:00:32.833115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"571.706637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-04T10:00:32.833133Z","caller":"traceutil/trace.go:171","msg":"trace[1691374676] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:769; }","duration":"257.425001ms","start":"2026-07-04T10:00:32.57569Z","end":"2026-07-04T10:00:32.833115Z","steps":["trace[1691374676] 'range keys from in-memory index tree' (duration: 257.234367ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T10:00:32.833162Z","caller":"traceutil/trace.go:171","msg":"trace[1430017749] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:769; }","duration":"571.781478ms","start":"2026-07-04T10:00:32.261369Z","end":"2026-07-04T10:00:32.83315Z","steps":["trace[1430017749] 'range keys from in-memory index tree' (duration: 571.651346ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:32.83314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.394656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-04T10:00:32.833157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.37679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-04T10:00:32.833197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:32.261352Z","time spent":"571.835339ms","remote":"127.0.0.1:38968","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 "} {"level":"info","ts":"2026-07-04T10:00:32.833213Z","caller":"traceutil/trace.go:171","msg":"trace[1312337604] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:769; }","duration":"435.516059ms","start":"2026-07-04T10:00:32.397678Z","end":"2026-07-04T10:00:32.833194Z","steps":["trace[1312337604] 'range keys from in-memory index tree' (duration: 435.331214ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:32.833256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.883259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-04T10:00:32.833264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:32.397664Z","time spent":"435.58942ms","remote":"127.0.0.1:38990","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 "} {"level":"warn","ts":"2026-07-04T10:00:32.833355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.124944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-04T10:00:32.833379Z","caller":"traceutil/trace.go:171","msg":"trace[706406433] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:769; }","duration":"216.189405ms","start":"2026-07-04T10:00:32.617184Z","end":"2026-07-04T10:00:32.833373Z","steps":["trace[706406433] 'range keys from in-memory index tree' (duration: 216.040282ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:32.833386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.900486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-04T10:00:32.83342Z","caller":"traceutil/trace.go:171","msg":"trace[808012683] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:769; }","duration":"335.943786ms","start":"2026-07-04T10:00:32.497467Z","end":"2026-07-04T10:00:32.833411Z","steps":["trace[808012683] 'range keys from in-memory index tree' (duration: 335.830763ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:32.833421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"526.598706ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-04T10:00:32.833438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:32.497462Z","time spent":"335.970617ms","remote":"127.0.0.1:39018","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"info","ts":"2026-07-04T10:00:32.833451Z","caller":"traceutil/trace.go:171","msg":"trace[1816230567] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:769; }","duration":"526.638628ms","start":"2026-07-04T10:00:32.306802Z","end":"2026-07-04T10:00:32.833441Z","steps":["trace[1816230567] 'count revisions from in-memory index tree' (duration: 526.550816ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:32.833482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:32.306795Z","time spent":"526.676339ms","remote":"127.0.0.1:38974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-07-04T10:00:32.833487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.771928ms","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":"warn","ts":"2026-07-04T10:00:32.833534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.151451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-04T10:00:32.83354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.197295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-04T10:00:32.833556Z","caller":"traceutil/trace.go:171","msg":"trace[31979413] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:769; }","duration":"336.195161ms","start":"2026-07-04T10:00:32.497353Z","end":"2026-07-04T10:00:32.833548Z","steps":["trace[31979413] 'count revisions from in-memory index tree' (duration: 335.975097ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T10:00:32.833559Z","caller":"traceutil/trace.go:171","msg":"trace[459462161] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:769; }","duration":"216.295657ms","start":"2026-07-04T10:00:32.617259Z","end":"2026-07-04T10:00:32.833554Z","steps":["trace[459462161] 'count revisions from in-memory index tree' (duration: 216.078583ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:32.833574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:32.497338Z","time spent":"336.230983ms","remote":"127.0.0.1:39018","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"info","ts":"2026-07-04T10:00:32.833611Z","caller":"traceutil/trace.go:171","msg":"trace[1257333601] 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:769; }","duration":"414.808918ms","start":"2026-07-04T10:00:32.418703Z","end":"2026-07-04T10:00:32.833511Z","steps":["trace[1257333601] 'count revisions from in-memory index tree' (duration: 414.714097ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:32.833624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"526.798801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-04T10:00:32.833635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.234236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-04T10:00:32.833649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.436175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-04T10:00:32.833654Z","caller":"traceutil/trace.go:171","msg":"trace[1023544327] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:769; }","duration":"216.269476ms","start":"2026-07-04T10:00:32.617379Z","end":"2026-07-04T10:00:32.833649Z","steps":["trace[1023544327] 'range keys from in-memory index tree' (duration: 216.130324ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T10:00:32.833654Z","caller":"traceutil/trace.go:171","msg":"trace[230708779] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:769; }","duration":"526.851952ms","start":"2026-07-04T10:00:32.306794Z","end":"2026-07-04T10:00:32.833646Z","steps":["trace[230708779] 'range keys from in-memory index tree' (duration: 526.74266ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:32.833656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:32.418688Z","time spent":"414.954532ms","remote":"127.0.0.1:38992","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-07-04T10:00:32.833686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.428825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-04T10:00:32.833684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:32.306781Z","time spent":"526.894663ms","remote":"127.0.0.1:38974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 "} {"level":"info","ts":"2026-07-04T10:00:32.833701Z","caller":"traceutil/trace.go:171","msg":"trace[1187069962] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:769; }","duration":"306.467565ms","start":"2026-07-04T10:00:32.52723Z","end":"2026-07-04T10:00:32.833697Z","steps":["trace[1187069962] 'range keys from in-memory index tree' (duration: 306.343043ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:32.833716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:32.527215Z","time spent":"306.496487ms","remote":"127.0.0.1:39034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"warn","ts":"2026-07-04T10:00:32.833791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"525.82882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-04T10:00:32.833806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.214751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-04T10:00:32.833822Z","caller":"traceutil/trace.go:171","msg":"trace[1267320631] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:769; }","duration":"306.240311ms","start":"2026-07-04T10:00:32.527577Z","end":"2026-07-04T10:00:32.833817Z","steps":["trace[1267320631] 'range keys from in-memory index tree' (duration: 306.18594ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T10:00:32.833817Z","caller":"traceutil/trace.go:171","msg":"trace[1074573117] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:769; }","duration":"525.901092ms","start":"2026-07-04T10:00:32.307908Z","end":"2026-07-04T10:00:32.833809Z","steps":["trace[1074573117] 'range keys from in-memory index tree' (duration: 525.763178ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:32.833825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.961912ms","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-07-04T10:00:32.833844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:32.307887Z","time spent":"525.949732ms","remote":"127.0.0.1:38968","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 "} {"level":"warn","ts":"2026-07-04T10:00:32.833858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.035744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-04T10:00:32.833858Z","caller":"traceutil/trace.go:171","msg":"trace[1595314761] 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:769; }","duration":"415.023654ms","start":"2026-07-04T10:00:32.418825Z","end":"2026-07-04T10:00:32.833849Z","steps":["trace[1595314761] 'range keys from in-memory index tree' (duration: 414.928692ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T10:00:32.833875Z","caller":"traceutil/trace.go:171","msg":"trace[1543873074] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:769; }","duration":"281.090334ms","start":"2026-07-04T10:00:32.552778Z","end":"2026-07-04T10:00:32.833868Z","steps":["trace[1543873074] 'range keys from in-memory index tree' (duration: 280.957142ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:32.833892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:32.418811Z","time spent":"415.072484ms","remote":"127.0.0.1:38992","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-07-04T10:00:32.833966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.005743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-04T10:00:32.83322Z","caller":"traceutil/trace.go:171","msg":"trace[1290549854] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:769; }","duration":"257.478682ms","start":"2026-07-04T10:00:32.575726Z","end":"2026-07-04T10:00:32.833205Z","steps":["trace[1290549854] 'count revisions from in-memory index tree' (duration: 257.243547ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T10:00:32.833983Z","caller":"traceutil/trace.go:171","msg":"trace[31335416] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:769; }","duration":"281.036684ms","start":"2026-07-04T10:00:32.552942Z","end":"2026-07-04T10:00:32.833979Z","steps":["trace[31335416] 'range keys from in-memory index tree' (duration: 280.963622ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T10:00:32.833668Z","caller":"traceutil/trace.go:171","msg":"trace[626858984] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:769; }","duration":"306.486947ms","start":"2026-07-04T10:00:32.527175Z","end":"2026-07-04T10:00:32.833662Z","steps":["trace[626858984] 'count revisions from in-memory index tree' (duration: 306.390094ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:32.834032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"524.191975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-mkp9x\" ","response":"range_response_count:1 size:3965"} {"level":"warn","ts":"2026-07-04T10:00:32.83405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.149666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-04T10:00:32.834041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:32.527158Z","time spent":"306.872675ms","remote":"127.0.0.1:39034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"info","ts":"2026-07-04T10:00:32.834064Z","caller":"traceutil/trace.go:171","msg":"trace[1877190769] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:769; }","duration":"281.193157ms","start":"2026-07-04T10:00:32.552867Z","end":"2026-07-04T10:00:32.83406Z","steps":["trace[1877190769] 'count revisions from in-memory index tree' (duration: 281.045404ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T10:00:32.834058Z","caller":"traceutil/trace.go:171","msg":"trace[1702534438] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-mkp9x; range_end:; response_count:1; response_revision:769; }","duration":"524.239556ms","start":"2026-07-04T10:00:32.309811Z","end":"2026-07-04T10:00:32.83405Z","steps":["trace[1702534438] 'range keys from in-memory index tree' (duration: 524.063442ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:32.834062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.955732ms","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-07-04T10:00:32.834088Z","caller":"traceutil/trace.go:171","msg":"trace[1518948041] 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:769; }","duration":"415.028254ms","start":"2026-07-04T10:00:32.419051Z","end":"2026-07-04T10:00:32.834079Z","steps":["trace[1518948041] 'range keys from in-memory index tree' (duration: 414.86228ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:32.834085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:32.309801Z","time spent":"524.277867ms","remote":"127.0.0.1:60430","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3988,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-mkp9x\" "} {"level":"warn","ts":"2026-07-04T10:00:32.83411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:32.419031Z","time spent":"415.071724ms","remote":"127.0.0.1:38992","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-07-04T10:00:32.833063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.777674ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-04T10:00:32.833392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"571.916711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-04T10:00:32.834158Z","caller":"traceutil/trace.go:171","msg":"trace[1201752054] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:769; }","duration":"572.718408ms","start":"2026-07-04T10:00:32.261434Z","end":"2026-07-04T10:00:32.834152Z","steps":["trace[1201752054] 'count revisions from in-memory index tree' (duration: 571.85467ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:32.833838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:32.527572Z","time spent":"306.261031ms","remote":"127.0.0.1:39034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 "} {"level":"warn","ts":"2026-07-04T10:00:32.834211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.411792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-04T10:00:32.83423Z","caller":"traceutil/trace.go:171","msg":"trace[2018591175] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:769; }","duration":"369.446804ms","start":"2026-07-04T10:00:32.464778Z","end":"2026-07-04T10:00:32.834225Z","steps":["trace[2018591175] 'count revisions from in-memory index tree' (duration: 369.343651ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:32.834251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:32.464767Z","time spent":"369.476014ms","remote":"127.0.0.1:39006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true "} {"level":"info","ts":"2026-07-04T10:00:32.833275Z","caller":"traceutil/trace.go:171","msg":"trace[1501807535] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:769; }","duration":"256.902329ms","start":"2026-07-04T10:00:32.576367Z","end":"2026-07-04T10:00:32.83327Z","steps":["trace[1501807535] 'range keys from in-memory index tree' (duration: 256.839868ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:32.834175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:32.261419Z","time spent":"572.750529ms","remote":"127.0.0.1:38968","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-07-04T10:00:32.834339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.556526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-04T10:00:32.83436Z","caller":"traceutil/trace.go:171","msg":"trace[361309587] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:769; }","duration":"369.615357ms","start":"2026-07-04T10:00:32.464739Z","end":"2026-07-04T10:00:32.834354Z","steps":["trace[361309587] 'range keys from in-memory index tree' (duration: 369.449703ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:32.834377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:32.464719Z","time spent":"369.652898ms","remote":"127.0.0.1:39006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 "} {"level":"info","ts":"2026-07-04T10:00:32.834137Z","caller":"traceutil/trace.go:171","msg":"trace[184836951] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:769; }","duration":"436.910289ms","start":"2026-07-04T10:00:32.397221Z","end":"2026-07-04T10:00:32.834132Z","steps":["trace[184836951] 'range keys from in-memory index tree' (duration: 435.694263ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:32.83444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:32.397197Z","time spent":"437.232756ms","remote":"127.0.0.1:38990","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 "} {"level":"warn","ts":"2026-07-04T10:00:32.834451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.165138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-04T10:00:32.834468Z","caller":"traceutil/trace.go:171","msg":"trace[1035051554] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:769; }","duration":"369.196308ms","start":"2026-07-04T10:00:32.465267Z","end":"2026-07-04T10:00:32.834463Z","steps":["trace[1035051554] 'range keys from in-memory index tree' (duration: 369.137817ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:32.834486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:32.465261Z","time spent":"369.220188ms","remote":"127.0.0.1:39006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 "} {"level":"warn","ts":"2026-07-04T10:00:32.8343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.115523ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-04T10:00:32.834522Z","caller":"traceutil/trace.go:171","msg":"trace[106848294] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:769; }","duration":"437.335908ms","start":"2026-07-04T10:00:32.397174Z","end":"2026-07-04T10:00:32.83451Z","steps":["trace[106848294] 'count revisions from in-memory index tree' (duration: 437.058002ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:32.834568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:32.397126Z","time spent":"437.42729ms","remote":"127.0.0.1:38990","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true "} {"level":"warn","ts":"2026-07-04T10:00:33.041309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.297397ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-07-04T10:00:33.041391Z","caller":"traceutil/trace.go:171","msg":"trace[1197474497] linearizableReadLoop","detail":"{readStateIndex:799; appliedIndex:798; }","duration":"390.388892ms","start":"2026-07-04T10:00:32.650987Z","end":"2026-07-04T10:00:33.041376Z","steps":["trace[1197474497] 'read index received' (duration: 181.933652ms)","trace[1197474497] 'applied index is now lower than readState.Index' (duration: 208.45406ms)"],"step_count":2} {"level":"warn","ts":"2026-07-04T10:00:33.041557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.552376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-04T10:00:33.041608Z","caller":"traceutil/trace.go:171","msg":"trace[1027659076] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:769; }","duration":"390.626097ms","start":"2026-07-04T10:00:32.650972Z","end":"2026-07-04T10:00:33.041598Z","steps":["trace[1027659076] 'agreement among raft nodes before linearized reading' (duration: 390.512325ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:33.0417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:32.650963Z","time spent":"390.662618ms","remote":"127.0.0.1:39080","response type":"/etcdserverpb.KV/Range","request count":0,"request size":114,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-07-04T10:00:33.043347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.128869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-04T10:00:33.04339Z","caller":"traceutil/trace.go:171","msg":"trace[993011600] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:770; }","duration":"392.17993ms","start":"2026-07-04T10:00:32.651194Z","end":"2026-07-04T10:00:33.043373Z","steps":["trace[993011600] 'agreement among raft nodes before linearized reading' (duration: 392.119999ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:33.043423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.889576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-04T10:00:33.043461Z","caller":"traceutil/trace.go:171","msg":"trace[393130866] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:770; }","duration":"299.974308ms","start":"2026-07-04T10:00:32.743475Z","end":"2026-07-04T10:00:33.04345Z","steps":["trace[393130866] 'agreement among raft nodes before linearized reading' (duration: 299.903566ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:33.043528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:32.743453Z","time spent":"300.065659ms","remote":"127.0.0.1:39102","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 "} {"level":"info","ts":"2026-07-04T10:00:33.043618Z","caller":"traceutil/trace.go:171","msg":"trace[286008282] transaction","detail":"{read_only:false; response_revision:770; number_of_response:1; }","duration":"201.619852ms","start":"2026-07-04T10:00:32.841954Z","end":"2026-07-04T10:00:33.043574Z","steps":["trace[286008282] 'process raft request' (duration: 200.689402ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:33.043657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.79171ms","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-07-04T10:00:33.043738Z","caller":"traceutil/trace.go:171","msg":"trace[437192110] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:770; }","duration":"338.914294ms","start":"2026-07-04T10:00:32.704804Z","end":"2026-07-04T10:00:33.043719Z","steps":["trace[437192110] 'agreement among raft nodes before linearized reading' (duration: 338.770661ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:33.043801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:32.704798Z","time spent":"338.982145ms","remote":"127.0.0.1:39096","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-07-04T10:00:33.043865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.725819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-04T10:00:33.043897Z","caller":"traceutil/trace.go:171","msg":"trace[531876877] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:770; }","duration":"285.770629ms","start":"2026-07-04T10:00:32.758118Z","end":"2026-07-04T10:00:33.043888Z","steps":["trace[531876877] 'agreement among raft nodes before linearized reading' (duration: 285.718958ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:33.043987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.364253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-04T10:00:33.043993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.53577ms","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":"warn","ts":"2026-07-04T10:00:33.044008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.802467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-04T10:00:33.044028Z","caller":"traceutil/trace.go:171","msg":"trace[1934061227] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:770; }","duration":"120.835637ms","start":"2026-07-04T10:00:32.923187Z","end":"2026-07-04T10:00:33.044022Z","steps":["trace[1934061227] 'agreement among raft nodes before linearized reading' (duration: 120.802647ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T10:00:33.044027Z","caller":"traceutil/trace.go:171","msg":"trace[2016594184] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:770; }","duration":"300.586191ms","start":"2026-07-04T10:00:32.743431Z","end":"2026-07-04T10:00:33.044017Z","steps":["trace[2016594184] 'agreement among raft nodes before linearized reading' (duration: 300.52939ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:33.044059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:32.743425Z","time spent":"300.625152ms","remote":"127.0.0.1:39102","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":"warn","ts":"2026-07-04T10:00:33.044079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.96354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-04T10:00:33.044035Z","caller":"traceutil/trace.go:171","msg":"trace[509572095] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:770; }","duration":"286.479845ms","start":"2026-07-04T10:00:32.757531Z","end":"2026-07-04T10:00:33.044011Z","steps":["trace[509572095] 'agreement among raft nodes before linearized reading' (duration: 286.362883ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:33.044116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.674464ms","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-07-04T10:00:33.044133Z","caller":"traceutil/trace.go:171","msg":"trace[1756223380] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:770; }","duration":"248.719155ms","start":"2026-07-04T10:00:32.79541Z","end":"2026-07-04T10:00:33.044129Z","steps":["trace[1756223380] 'agreement among raft nodes before linearized reading' (duration: 248.695034ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:33.044212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.899442ms","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-07-04T10:00:33.044249Z","caller":"traceutil/trace.go:171","msg":"trace[256480585] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:770; }","duration":"314.947393ms","start":"2026-07-04T10:00:32.729293Z","end":"2026-07-04T10:00:33.04424Z","steps":["trace[256480585] 'agreement among raft nodes before linearized reading' (duration: 314.895062ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:33.044257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.73418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-04T10:00:33.044281Z","caller":"traceutil/trace.go:171","msg":"trace[731418583] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:770; }","duration":"286.760641ms","start":"2026-07-04T10:00:32.757514Z","end":"2026-07-04T10:00:33.044274Z","steps":["trace[731418583] 'agreement among raft nodes before linearized reading' (duration: 286.72031ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:33.044332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.010701ms","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":"warn","ts":"2026-07-04T10:00:33.044371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.885184ms","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-07-04T10:00:33.044384Z","caller":"traceutil/trace.go:171","msg":"trace[750908043] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:770; }","duration":"249.070492ms","start":"2026-07-04T10:00:32.795306Z","end":"2026-07-04T10:00:33.044377Z","steps":["trace[750908043] 'agreement among raft nodes before linearized reading' (duration: 249.004631ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T10:00:33.044406Z","caller":"traceutil/trace.go:171","msg":"trace[648957365] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:770; }","duration":"315.936274ms","start":"2026-07-04T10:00:32.728462Z","end":"2026-07-04T10:00:33.044399Z","steps":["trace[648957365] 'agreement among raft nodes before linearized reading' (duration: 315.888753ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T10:00:33.044094Z","caller":"traceutil/trace.go:171","msg":"trace[1478492275] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:770; }","duration":"121.020582ms","start":"2026-07-04T10:00:32.923069Z","end":"2026-07-04T10:00:33.04409Z","steps":["trace[1478492275] 'agreement among raft nodes before linearized reading' (duration: 120.996111ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:33.04444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:32.728453Z","time spent":"315.975035ms","remote":"127.0.0.1:39098","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-07-04T10:00:33.044283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:32.729288Z","time spent":"314.986264ms","remote":"127.0.0.1:39096","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":"warn","ts":"2026-07-04T10:00:33.0446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.717972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-07-04T10:00:33.044748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:32.651187Z","time spent":"392.219181ms","remote":"127.0.0.1:39080","response type":"/etcdserverpb.KV/Range","request count":0,"request size":115,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-07-04T10:00:33.04494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.777348ms","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-07-04T10:00:33.044948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.194651ms","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":"info","ts":"2026-07-04T10:00:33.044964Z","caller":"traceutil/trace.go:171","msg":"trace[416448414] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:770; }","duration":"249.828698ms","start":"2026-07-04T10:00:32.795129Z","end":"2026-07-04T10:00:33.044957Z","steps":["trace[416448414] 'agreement among raft nodes before linearized reading' (duration: 249.789828ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T10:00:33.044981Z","caller":"traceutil/trace.go:171","msg":"trace[483204646] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:770; }","duration":"340.231612ms","start":"2026-07-04T10:00:32.704738Z","end":"2026-07-04T10:00:33.04497Z","steps":["trace[483204646] 'agreement among raft nodes before linearized reading' (duration: 340.17354ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:33.045009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:32.704708Z","time spent":"340.292683ms","remote":"127.0.0.1:39096","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-07-04T10:00:33.045145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.548453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-04T10:00:33.045173Z","caller":"traceutil/trace.go:171","msg":"trace[616384617] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:770; }","duration":"366.596945ms","start":"2026-07-04T10:00:32.678567Z","end":"2026-07-04T10:00:33.045164Z","steps":["trace[616384617] 'agreement among raft nodes before linearized reading' (duration: 366.549104ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:33.045199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:32.678556Z","time spent":"366.634695ms","remote":"127.0.0.1:39086","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 "} {"level":"warn","ts":"2026-07-04T10:00:33.045338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.584855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-04T10:00:33.045378Z","caller":"traceutil/trace.go:171","msg":"trace[640096283] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:770; }","duration":"367.663217ms","start":"2026-07-04T10:00:32.677705Z","end":"2026-07-04T10:00:33.045369Z","steps":["trace[640096283] 'agreement among raft nodes before linearized reading' (duration: 367.605536ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:33.045405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:32.677683Z","time spent":"367.712449ms","remote":"127.0.0.1:39086","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 "} {"level":"warn","ts":"2026-07-04T10:00:33.045529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.815391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-04T10:00:33.045564Z","caller":"traceutil/trace.go:171","msg":"trace[2136431766] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:770; }","duration":"367.892682ms","start":"2026-07-04T10:00:32.677663Z","end":"2026-07-04T10:00:33.045556Z","steps":["trace[2136431766] 'agreement among raft nodes before linearized reading' (duration: 367.838581ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:33.04559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:32.677653Z","time spent":"367.928273ms","remote":"127.0.0.1:39086","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true "} {"level":"warn","ts":"2026-07-04T10:00:33.045731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.119302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-04T10:00:33.045767Z","caller":"traceutil/trace.go:171","msg":"trace[237281208] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:770; }","duration":"394.172224ms","start":"2026-07-04T10:00:32.651586Z","end":"2026-07-04T10:00:33.045758Z","steps":["trace[237281208] 'agreement among raft nodes before linearized reading' (duration: 394.111822ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:33.045793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:32.651582Z","time spent":"394.203614ms","remote":"127.0.0.1:39080","response type":"/etcdserverpb.KV/Range","request count":0,"request size":115,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 "} {"level":"warn","ts":"2026-07-04T10:00:33.044321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.776401ms","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":"info","ts":"2026-07-04T10:00:33.046033Z","caller":"traceutil/trace.go:171","msg":"trace[42791286] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:770; }","duration":"317.495058ms","start":"2026-07-04T10:00:32.728527Z","end":"2026-07-04T10:00:33.046022Z","steps":["trace[42791286] 'agreement among raft nodes before linearized reading' (duration: 315.774521ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:33.046067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:32.728521Z","time spent":"317.533599ms","remote":"127.0.0.1:39098","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-07-04T10:00:33.044376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.51371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-04T10:00:33.04629Z","caller":"traceutil/trace.go:171","msg":"trace[1111491805] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:770; }","duration":"302.427311ms","start":"2026-07-04T10:00:32.743856Z","end":"2026-07-04T10:00:33.046283Z","steps":["trace[1111491805] 'agreement among raft nodes before linearized reading' (duration: 300.50388ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:33.046317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:32.743789Z","time spent":"302.518743ms","remote":"127.0.0.1:39102","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 "} {"level":"info","ts":"2026-07-04T10:00:33.047735Z","caller":"traceutil/trace.go:171","msg":"trace[815420376] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:770; }","duration":"316.780582ms","start":"2026-07-04T10:00:32.727848Z","end":"2026-07-04T10:00:33.044628Z","steps":["trace[815420376] 'agreement among raft nodes before linearized reading' (duration: 316.720711ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:33.047807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:32.727834Z","time spent":"319.953021ms","remote":"127.0.0.1:60678","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":2,"response size":30,"request content":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true "} {"level":"info","ts":"2026-07-04T10:00:36.800937Z","caller":"traceutil/trace.go:171","msg":"trace[1861635846] transaction","detail":"{read_only:false; response_revision:792; number_of_response:1; }","duration":"291.990645ms","start":"2026-07-04T10:00:36.508923Z","end":"2026-07-04T10:00:36.800913Z","steps":["trace[1861635846] 'process raft request' (duration: 291.823352ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T10:00:37.012161Z","caller":"traceutil/trace.go:171","msg":"trace[912741012] linearizableReadLoop","detail":"{readStateIndex:826; appliedIndex:825; }","duration":"106.019541ms","start":"2026-07-04T10:00:36.906113Z","end":"2026-07-04T10:00:37.012132Z","steps":["trace[912741012] 'read index received' (duration: 102.291923ms)","trace[912741012] 'applied index is now lower than readState.Index' (duration: 3.726558ms)"],"step_count":2} {"level":"warn","ts":"2026-07-04T10:00:37.012336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.199014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-04T10:00:37.012408Z","caller":"traceutil/trace.go:171","msg":"trace[1791276632] transaction","detail":"{read_only:false; response_revision:795; number_of_response:1; }","duration":"195.32912ms","start":"2026-07-04T10:00:36.817042Z","end":"2026-07-04T10:00:37.012371Z","steps":["trace[1791276632] 'process raft request' (duration: 191.419758ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T10:00:37.012433Z","caller":"traceutil/trace.go:171","msg":"trace[1685764313] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:795; }","duration":"106.380238ms","start":"2026-07-04T10:00:36.906041Z","end":"2026-07-04T10:00:37.012421Z","steps":["trace[1685764313] 'agreement among raft nodes before linearized reading' (duration: 106.196704ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T10:00:40.453547Z","caller":"traceutil/trace.go:171","msg":"trace[411442314] transaction","detail":"{read_only:false; response_revision:845; number_of_response:1; }","duration":"213.169302ms","start":"2026-07-04T10:00:40.240352Z","end":"2026-07-04T10:00:40.453522Z","steps":["trace[411442314] 'process raft request' (duration: 213.008709ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:40.988783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.608101ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-07-04T10:00:41.025537Z","caller":"traceutil/trace.go:171","msg":"trace[1371650029] transaction","detail":"{read_only:false; response_revision:851; number_of_response:1; }","duration":"337.587488ms","start":"2026-07-04T10:00:40.687909Z","end":"2026-07-04T10:00:41.025497Z","steps":["trace[1371650029] 'process raft request' (duration: 337.274102ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T10:00:41.025574Z","caller":"traceutil/trace.go:171","msg":"trace[1205808019] transaction","detail":"{read_only:false; response_revision:852; number_of_response:1; }","duration":"334.791251ms","start":"2026-07-04T10:00:40.690758Z","end":"2026-07-04T10:00:41.025549Z","steps":["trace[1205808019] 'process raft request' (duration: 334.649369ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:41.025705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.077619ms","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":"warn","ts":"2026-07-04T10:00:41.025722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:40.687882Z","time spent":"337.749811ms","remote":"127.0.0.1:60316","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":719,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-04T10:00:41.025738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:00:40.69073Z","time spent":"334.906073ms","remote":"127.0.0.1:60430","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4762,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-04T10:00:41.02578Z","caller":"traceutil/trace.go:171","msg":"trace[2071154071] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:852; }","duration":"219.231612ms","start":"2026-07-04T10:00:40.806531Z","end":"2026-07-04T10:00:41.025762Z","steps":["trace[2071154071] 'agreement among raft nodes before linearized reading' (duration: 219.094709ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T10:00:41.025551Z","caller":"traceutil/trace.go:171","msg":"trace[240057963] linearizableReadLoop","detail":"{readStateIndex:884; appliedIndex:882; }","duration":"218.904365ms","start":"2026-07-04T10:00:40.806595Z","end":"2026-07-04T10:00:41.0255Z","steps":["trace[240057963] 'read index received' (duration: 218.511428ms)","trace[240057963] 'applied index is now lower than readState.Index' (duration: 391.407µs)"],"step_count":2} {"level":"warn","ts":"2026-07-04T10:00:41.025925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.270633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-04T10:00:41.025977Z","caller":"traceutil/trace.go:171","msg":"trace[1190316379] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:852; }","duration":"195.352975ms","start":"2026-07-04T10:00:40.83061Z","end":"2026-07-04T10:00:41.025963Z","steps":["trace[1190316379] 'agreement among raft nodes before linearized reading' (duration: 195.265383ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:41.026101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.254222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/coredns\" ","response":"range_response_count:1 size:179"} {"level":"info","ts":"2026-07-04T10:00:41.02613Z","caller":"traceutil/trace.go:171","msg":"trace[2070712410] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/coredns; range_end:; response_count:1; response_revision:852; }","duration":"148.330094ms","start":"2026-07-04T10:00:40.877793Z","end":"2026-07-04T10:00:41.026123Z","steps":["trace[2070712410] 'agreement among raft nodes before linearized reading' (duration: 148.258833ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:41.026164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.387716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/coredns\" ","response":"range_response_count:1 size:179"} {"level":"info","ts":"2026-07-04T10:00:41.02621Z","caller":"traceutil/trace.go:171","msg":"trace[440625450] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/coredns; range_end:; response_count:1; response_revision:852; }","duration":"148.455517ms","start":"2026-07-04T10:00:40.877743Z","end":"2026-07-04T10:00:41.026198Z","steps":["trace[440625450] 'agreement among raft nodes before linearized reading' (duration: 148.374375ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T10:00:41.142953Z","caller":"traceutil/trace.go:171","msg":"trace[525081294] transaction","detail":"{read_only:false; response_revision:853; number_of_response:1; }","duration":"102.496227ms","start":"2026-07-04T10:00:41.040425Z","end":"2026-07-04T10:00:41.142921Z","steps":["trace[525081294] 'process raft request' (duration: 98.69593ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T10:00:42.495144Z","caller":"traceutil/trace.go:171","msg":"trace[1032912049] transaction","detail":"{read_only:false; response_revision:867; number_of_response:1; }","duration":"132.297591ms","start":"2026-07-04T10:00:42.362815Z","end":"2026-07-04T10:00:42.495112Z","steps":["trace[1032912049] 'process raft request' (duration: 132.120477ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T10:00:42.820484Z","caller":"traceutil/trace.go:171","msg":"trace[2134979266] transaction","detail":"{read_only:false; response_revision:882; number_of_response:1; }","duration":"142.554296ms","start":"2026-07-04T10:00:42.677906Z","end":"2026-07-04T10:00:42.820461Z","steps":["trace[2134979266] 'process raft request' (duration: 141.816661ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T10:00:42.824317Z","caller":"traceutil/trace.go:171","msg":"trace[329900205] transaction","detail":"{read_only:false; response_revision:884; number_of_response:1; }","duration":"127.506564ms","start":"2026-07-04T10:00:42.696787Z","end":"2026-07-04T10:00:42.824293Z","steps":["trace[329900205] 'process raft request' (duration: 127.423052ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T10:00:42.824544Z","caller":"traceutil/trace.go:171","msg":"trace[694541975] transaction","detail":"{read_only:false; response_revision:883; number_of_response:1; }","duration":"127.81866ms","start":"2026-07-04T10:00:42.696708Z","end":"2026-07-04T10:00:42.824526Z","steps":["trace[694541975] 'process raft request' (duration: 127.383261ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T10:00:42.824803Z","caller":"traceutil/trace.go:171","msg":"trace[925674160] linearizableReadLoop","detail":"{readStateIndex:915; appliedIndex:913; }","duration":"128.049425ms","start":"2026-07-04T10:00:42.696725Z","end":"2026-07-04T10:00:42.824775Z","steps":["trace[925674160] 'read index received' (duration: 123.020044ms)","trace[925674160] 'applied index is now lower than readState.Index' (duration: 5.028461ms)"],"step_count":2} {"level":"info","ts":"2026-07-04T10:00:42.824847Z","caller":"traceutil/trace.go:171","msg":"trace[783655129] transaction","detail":"{read_only:false; response_revision:885; number_of_response:1; }","duration":"127.128336ms","start":"2026-07-04T10:00:42.697705Z","end":"2026-07-04T10:00:42.824834Z","steps":["trace[783655129] 'process raft request' (duration: 126.551894ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T10:00:42.824917Z","caller":"traceutil/trace.go:171","msg":"trace[1673174444] transaction","detail":"{read_only:false; response_revision:886; number_of_response:1; }","duration":"126.85574ms","start":"2026-07-04T10:00:42.698053Z","end":"2026-07-04T10:00:42.824909Z","steps":["trace[1673174444] 'process raft request' (duration: 126.495043ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T10:00:42.825071Z","caller":"traceutil/trace.go:171","msg":"trace[1837240235] transaction","detail":"{read_only:false; response_revision:887; number_of_response:1; }","duration":"124.804109ms","start":"2026-07-04T10:00:42.700252Z","end":"2026-07-04T10:00:42.825056Z","steps":["trace[1837240235] 'process raft request' (duration: 124.450102ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:00:42.825064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.31306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-ljnqm\" ","response":"range_response_count:1 size:4881"} {"level":"info","ts":"2026-07-04T10:00:42.825125Z","caller":"traceutil/trace.go:171","msg":"trace[1084545985] range","detail":"{range_begin:/registry/pods/kube-system/coredns-7c96b6546b-ljnqm; range_end:; response_count:1; response_revision:887; }","duration":"128.436532ms","start":"2026-07-04T10:00:42.696674Z","end":"2026-07-04T10:00:42.825111Z","steps":["trace[1084545985] 'agreement among raft nodes before linearized reading' (duration: 128.200728ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T10:00:44.700232Z","caller":"traceutil/trace.go:171","msg":"trace[43264563] transaction","detail":"{read_only:false; response_revision:897; number_of_response:1; }","duration":"137.872463ms","start":"2026-07-04T10:00:44.56233Z","end":"2026-07-04T10:00:44.700202Z","steps":["trace[43264563] 'process raft request' (duration: 137.71813ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T10:00:45.921826Z","caller":"traceutil/trace.go:171","msg":"trace[1391004898] transaction","detail":"{read_only:false; response_revision:924; number_of_response:1; }","duration":"112.764049ms","start":"2026-07-04T10:00:45.809031Z","end":"2026-07-04T10:00:45.921795Z","steps":["trace[1391004898] 'process raft request' (duration: 112.613516ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T10:00:46.082105Z","caller":"traceutil/trace.go:171","msg":"trace[406589251] linearizableReadLoop","detail":"{readStateIndex:958; appliedIndex:957; }","duration":"145.240647ms","start":"2026-07-04T10:00:45.936836Z","end":"2026-07-04T10:00:46.082077Z","steps":["trace[406589251] 'read index received' (duration: 94.582147ms)","trace[406589251] 'applied index is now lower than readState.Index' (duration: 50.6573ms)"],"step_count":2} {"level":"info","ts":"2026-07-04T10:00:46.082188Z","caller":"traceutil/trace.go:171","msg":"trace[225174053] transaction","detail":"{read_only:false; response_revision:925; number_of_response:1; }","duration":"152.644973ms","start":"2026-07-04T10:00:45.929492Z","end":"2026-07-04T10:00:46.082137Z","steps":["trace[225174053] 'process raft request' (duration: 101.929622ms)","trace[225174053] 'compare' (duration: 50.522337ms)"],"step_count":2} {"level":"warn","ts":"2026-07-04T10:00:46.082498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.635435ms","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-07-04T10:00:46.082591Z","caller":"traceutil/trace.go:171","msg":"trace[37986761] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:925; }","duration":"145.780997ms","start":"2026-07-04T10:00:45.936786Z","end":"2026-07-04T10:00:46.082567Z","steps":["trace[37986761] 'agreement among raft nodes before linearized reading' (duration: 145.43596ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T10:00:58.631386Z","caller":"traceutil/trace.go:171","msg":"trace[709648431] transaction","detail":"{read_only:false; response_revision:985; number_of_response:1; }","duration":"266.055085ms","start":"2026-07-04T10:00:58.365301Z","end":"2026-07-04T10:00:58.631356Z","steps":["trace[709648431] 'process raft request' (duration: 265.78072ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T10:01:04.302019Z","caller":"traceutil/trace.go:171","msg":"trace[637771429] transaction","detail":"{read_only:false; response_revision:1003; number_of_response:1; }","duration":"102.235144ms","start":"2026-07-04T10:01:04.199744Z","end":"2026-07-04T10:01:04.301979Z","steps":["trace[637771429] 'process raft request' (duration: 101.954089ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T10:01:15.816704Z","caller":"traceutil/trace.go:171","msg":"trace[1671959625] linearizableReadLoop","detail":"{readStateIndex:1083; appliedIndex:1082; }","duration":"273.467909ms","start":"2026-07-04T10:01:15.543199Z","end":"2026-07-04T10:01:15.816667Z","steps":["trace[1671959625] 'read index received' (duration: 273.291116ms)","trace[1671959625] 'applied index is now lower than readState.Index' (duration: 175.433µs)"],"step_count":2} {"level":"warn","ts":"2026-07-04T10:01:15.816943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.716123ms","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-07-04T10:01:15.817031Z","caller":"traceutil/trace.go:171","msg":"trace[56498533] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1043; }","duration":"273.816644ms","start":"2026-07-04T10:01:15.543193Z","end":"2026-07-04T10:01:15.817009Z","steps":["trace[56498533] 'agreement among raft nodes before linearized reading' (duration: 273.5739ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T10:01:16.517006Z","caller":"traceutil/trace.go:171","msg":"trace[1635874995] transaction","detail":"{read_only:false; response_revision:1047; number_of_response:1; }","duration":"134.533332ms","start":"2026-07-04T10:01:16.382432Z","end":"2026-07-04T10:01:16.516966Z","steps":["trace[1635874995] 'process raft request' (duration: 134.366689ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T10:01:16.660223Z","caller":"traceutil/trace.go:171","msg":"trace[427781609] transaction","detail":"{read_only:false; response_revision:1049; number_of_response:1; }","duration":"136.865139ms","start":"2026-07-04T10:01:16.523317Z","end":"2026-07-04T10:01:16.660182Z","steps":["trace[427781609] 'process raft request' (duration: 85.964944ms)","trace[427781609] 'compare' (duration: 50.242154ms)"],"step_count":2} {"level":"info","ts":"2026-07-04T10:01:17.034918Z","caller":"traceutil/trace.go:171","msg":"trace[2043745308] transaction","detail":"{read_only:false; response_revision:1050; number_of_response:1; }","duration":"115.474659ms","start":"2026-07-04T10:01:16.919412Z","end":"2026-07-04T10:01:17.034886Z","steps":["trace[2043745308] 'process raft request' (duration: 115.252485ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:01:18.78955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.819762ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-04T10:01:18.789686Z","caller":"traceutil/trace.go:171","msg":"trace[410361928] linearizableReadLoop","detail":"{readStateIndex:1094; appliedIndex:1093; }","duration":"125.382412ms","start":"2026-07-04T10:01:18.66426Z","end":"2026-07-04T10:01:18.789642Z","steps":["trace[410361928] 'read index received' (duration: 64.341µs)","trace[410361928] 'applied index is now lower than readState.Index' (duration: 125.316731ms)"],"step_count":2} {"level":"info","ts":"2026-07-04T10:01:18.789709Z","caller":"traceutil/trace.go:171","msg":"trace[1061153164] transaction","detail":"{read_only:false; response_revision:1054; number_of_response:1; }","duration":"242.945307ms","start":"2026-07-04T10:01:18.54673Z","end":"2026-07-04T10:01:18.789676Z","steps":["trace[1061153164] 'process raft request' (duration: 46.389314ms)","trace[1061153164] 'compare' (duration: 195.599858ms)"],"step_count":2} {"level":"warn","ts":"2026-07-04T10:01:18.790144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.88939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-07-04T10:01:18.790216Z","caller":"traceutil/trace.go:171","msg":"trace[469545847] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1054; }","duration":"126.016272ms","start":"2026-07-04T10:01:18.664187Z","end":"2026-07-04T10:01:18.790203Z","steps":["trace[469545847] 'agreement among raft nodes before linearized reading' (duration: 125.605665ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T10:01:32.127531Z","caller":"traceutil/trace.go:171","msg":"trace[661788744] linearizableReadLoop","detail":"{readStateIndex:1141; appliedIndex:1140; }","duration":"103.44988ms","start":"2026-07-04T10:01:32.024058Z","end":"2026-07-04T10:01:32.127508Z","steps":["trace[661788744] 'read index received' (duration: 103.289198ms)","trace[661788744] 'applied index is now lower than readState.Index' (duration: 159.882µs)"],"step_count":2} {"level":"warn","ts":"2026-07-04T10:01:32.127701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.628153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-07-04T10:01:32.127731Z","caller":"traceutil/trace.go:171","msg":"trace[1109652162] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1098; }","duration":"103.686834ms","start":"2026-07-04T10:01:32.024035Z","end":"2026-07-04T10:01:32.127721Z","steps":["trace[1109652162] 'agreement among raft nodes before linearized reading' (duration: 103.562292ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T10:01:32.127793Z","caller":"traceutil/trace.go:171","msg":"trace[512746054] transaction","detail":"{read_only:false; response_revision:1098; number_of_response:1; }","duration":"109.844776ms","start":"2026-07-04T10:01:32.017926Z","end":"2026-07-04T10:01:32.127771Z","steps":["trace[512746054] 'process raft request' (duration: 109.43662ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T10:01:33.212191Z","caller":"traceutil/trace.go:171","msg":"trace[1609795132] transaction","detail":"{read_only:false; response_revision:1103; number_of_response:1; }","duration":"114.700422ms","start":"2026-07-04T10:01:33.097458Z","end":"2026-07-04T10:01:33.212158Z","steps":["trace[1609795132] 'process raft request' (duration: 104.013812ms)","trace[1609795132] 'compare' (duration: 10.583618ms)"],"step_count":2} {"level":"info","ts":"2026-07-04T10:01:56.695941Z","caller":"traceutil/trace.go:171","msg":"trace[895392053] linearizableReadLoop","detail":"{readStateIndex:1225; appliedIndex:1224; }","duration":"439.806609ms","start":"2026-07-04T10:01:56.256062Z","end":"2026-07-04T10:01:56.695869Z","steps":["trace[895392053] 'read index received' (duration: 439.620817ms)","trace[895392053] 'applied index is now lower than readState.Index' (duration: 184.662µs)"],"step_count":2} {"level":"info","ts":"2026-07-04T10:01:56.696108Z","caller":"traceutil/trace.go:171","msg":"trace[2008869561] transaction","detail":"{read_only:false; response_revision:1177; number_of_response:1; }","duration":"455.594324ms","start":"2026-07-04T10:01:56.240499Z","end":"2026-07-04T10:01:56.696093Z","steps":["trace[2008869561] 'process raft request' (duration: 455.198819ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:01:56.696243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:01:56.240479Z","time spent":"455.677355ms","remote":"127.0.0.1:60496","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-04T10:01:56.696365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.029621ms","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":"warn","ts":"2026-07-04T10:01:56.696379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"440.277755ms","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-07-04T10:01:56.696434Z","caller":"traceutil/trace.go:171","msg":"trace[1338103152] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1177; }","duration":"371.101312ms","start":"2026-07-04T10:01:56.325317Z","end":"2026-07-04T10:01:56.696418Z","steps":["trace[1338103152] 'agreement among raft nodes before linearized reading' (duration: 370.912039ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T10:01:56.696481Z","caller":"traceutil/trace.go:171","msg":"trace[1947644868] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1177; }","duration":"440.434188ms","start":"2026-07-04T10:01:56.256021Z","end":"2026-07-04T10:01:56.696455Z","steps":["trace[1947644868] 'agreement among raft nodes before linearized reading' (duration: 440.233925ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:01:56.696509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:01:56.325295Z","time spent":"371.181592ms","remote":"127.0.0.1:60496","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-07-04T10:01:56.696544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:01:56.256005Z","time spent":"440.522699ms","remote":"127.0.0.1:60318","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true "} {"level":"info","ts":"2026-07-04T10:02:03.000247Z","caller":"traceutil/trace.go:171","msg":"trace[1206282577] transaction","detail":"{read_only:false; response_revision:1199; number_of_response:1; }","duration":"216.629688ms","start":"2026-07-04T10:02:02.783378Z","end":"2026-07-04T10:02:03.000008Z","steps":["trace[1206282577] 'process raft request' (duration: 184.436387ms)","trace[1206282577] 'compare' (duration: 32.063329ms)"],"step_count":2} {"level":"info","ts":"2026-07-04T10:02:03.287184Z","caller":"traceutil/trace.go:171","msg":"trace[1126418020] linearizableReadLoop","detail":"{readStateIndex:1250; appliedIndex:1248; }","duration":"113.078028ms","start":"2026-07-04T10:02:03.174084Z","end":"2026-07-04T10:02:03.287162Z","steps":["trace[1126418020] 'read index received' (duration: 21.294864ms)","trace[1126418020] 'applied index is now lower than readState.Index' (duration: 91.782154ms)"],"step_count":2} {"level":"warn","ts":"2026-07-04T10:02:03.287327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.22935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-04T10:02:03.287363Z","caller":"traceutil/trace.go:171","msg":"trace[1003324912] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1201; }","duration":"113.31459ms","start":"2026-07-04T10:02:03.174039Z","end":"2026-07-04T10:02:03.287354Z","steps":["trace[1003324912] 'agreement among raft nodes before linearized reading' (duration: 113.208699ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T10:02:03.287395Z","caller":"traceutil/trace.go:171","msg":"trace[1993130542] transaction","detail":"{read_only:false; response_revision:1201; number_of_response:1; }","duration":"135.964563ms","start":"2026-07-04T10:02:03.151409Z","end":"2026-07-04T10:02:03.287374Z","steps":["trace[1993130542] 'process raft request' (duration: 132.644409ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T10:02:16.661704Z","caller":"traceutil/trace.go:171","msg":"trace[587486780] transaction","detail":"{read_only:false; response_revision:1272; number_of_response:1; }","duration":"109.453677ms","start":"2026-07-04T10:02:16.552221Z","end":"2026-07-04T10:02:16.661675Z","steps":["trace[587486780] 'process raft request' (duration: 96.499141ms)","trace[587486780] 'compare' (duration: 12.749893ms)"],"step_count":2} {"level":"info","ts":"2026-07-04T10:02:17.59866Z","caller":"traceutil/trace.go:171","msg":"trace[880221681] transaction","detail":"{read_only:false; response_revision:1278; number_of_response:1; }","duration":"252.741779ms","start":"2026-07-04T10:02:17.345892Z","end":"2026-07-04T10:02:17.598634Z","steps":["trace[880221681] 'process raft request' (duration: 252.593177ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T10:02:17.693796Z","caller":"traceutil/trace.go:171","msg":"trace[1221594420] transaction","detail":"{read_only:false; response_revision:1279; number_of_response:1; }","duration":"250.600712ms","start":"2026-07-04T10:02:17.443166Z","end":"2026-07-04T10:02:17.693767Z","steps":["trace[1221594420] 'process raft request' (duration: 203.972294ms)","trace[1221594420] 'compare' (duration: 46.348064ms)"],"step_count":2} {"level":"info","ts":"2026-07-04T10:02:19.737741Z","caller":"traceutil/trace.go:171","msg":"trace[1913826178] transaction","detail":"{read_only:false; response_revision:1284; number_of_response:1; }","duration":"130.558325ms","start":"2026-07-04T10:02:19.607156Z","end":"2026-07-04T10:02:19.737715Z","steps":["trace[1913826178] 'process raft request' (duration: 130.423753ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:02:27.006537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.2803ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-04T10:02:27.006661Z","caller":"traceutil/trace.go:171","msg":"trace[1270289520] transaction","detail":"{read_only:false; response_revision:1314; number_of_response:1; }","duration":"137.407033ms","start":"2026-07-04T10:02:26.86923Z","end":"2026-07-04T10:02:27.006637Z","steps":["trace[1270289520] 'process raft request' (duration: 35.94122ms)","trace[1270289520] 'compare' (duration: 101.066928ms)"],"step_count":2} {"level":"info","ts":"2026-07-04T10:02:28.174281Z","caller":"traceutil/trace.go:171","msg":"trace[18355162] transaction","detail":"{read_only:false; response_revision:1317; number_of_response:1; }","duration":"407.30886ms","start":"2026-07-04T10:02:27.766935Z","end":"2026-07-04T10:02:28.174244Z","steps":["trace[18355162] 'process raft request' (duration: 406.873035ms)"],"step_count":1} {"level":"info","ts":"2026-07-04T10:02:28.174198Z","caller":"traceutil/trace.go:171","msg":"trace[2053730927] linearizableReadLoop","detail":"{readStateIndex:1372; appliedIndex:1371; }","duration":"402.895585ms","start":"2026-07-04T10:02:27.771269Z","end":"2026-07-04T10:02:28.174165Z","steps":["trace[2053730927] 'read index received' (duration: 402.48388ms)","trace[2053730927] 'applied index is now lower than readState.Index' (duration: 410.415µs)"],"step_count":2} {"level":"warn","ts":"2026-07-04T10:02:28.174462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:02:27.766898Z","time spent":"407.466913ms","remote":"127.0.0.1:60496","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-07-04T10:02:28.174492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.212069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-07-04T10:02:28.174612Z","caller":"traceutil/trace.go:171","msg":"trace[361906766] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1317; }","duration":"403.379602ms","start":"2026-07-04T10:02:27.771213Z","end":"2026-07-04T10:02:28.174593Z","steps":["trace[361906766] 'agreement among raft nodes before linearized reading' (duration: 403.111138ms)"],"step_count":1} {"level":"warn","ts":"2026-07-04T10:02:28.174698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-04T10:02:27.771174Z","time spent":"403.506043ms","remote":"127.0.0.1:60496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}