{"level":"warn","ts":"2026-08-01T02:32:40.410416Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-01T02:32:40.410514Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.156: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.156:2380","--initial-cluster=instance=https://199.204.45.156:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.156:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.156:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-08-01T02:32:40.410977Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-01T02:32:40.411001Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.156:2380"]} {"level":"info","ts":"2026-08-01T02:32:40.411135Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-08-01T02:32:40.411846Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"]} {"level":"info","ts":"2026-08-01T02:32:40.412067Z","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.156:2380"],"listen-peer-urls":["https://199.204.45.156:2380"],"advertise-client-urls":["https://199.204.45.156:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.156:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-08-01T02:32:40.540563Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"116.590845ms"} {"level":"info","ts":"2026-08-01T02:32:40.678237Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5ac240a6daec2148","cluster-id":"62163637a46c33c2"} {"level":"info","ts":"2026-08-01T02:32:40.678383Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=()"} {"level":"info","ts":"2026-08-01T02:32:40.678418Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became follower at term 0"} {"level":"info","ts":"2026-08-01T02:32:40.678495Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5ac240a6daec2148 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-01T02:32:40.678522Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became follower at term 1"} {"level":"info","ts":"2026-08-01T02:32:40.678635Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=(6539860694277038408)"} {"level":"warn","ts":"2026-08-01T02:32:40.79615Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-01T02:32:40.840769Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-01T02:32:40.863916Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-08-01T02:32:40.887725Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5ac240a6daec2148","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-01T02:32:40.888113Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5ac240a6daec2148","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-01T02:32:40.888101Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-08-01T02:32:40.888993Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-08-01T02:32:40.889123Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-08-01T02:32:40.900255Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-08-01T02:32:40.900438Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.156:2380"} {"level":"info","ts":"2026-08-01T02:32:40.900481Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.156:2380"} {"level":"info","ts":"2026-08-01T02:32:40.900605Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5ac240a6daec2148","initial-advertise-peer-urls":["https://199.204.45.156:2380"],"listen-peer-urls":["https://199.204.45.156:2380"],"advertise-client-urls":["https://199.204.45.156:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-01T02:32:40.900664Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-01T02:32:40.917732Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=(6539860694277038408)"} {"level":"info","ts":"2026-08-01T02:32:40.917896Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"62163637a46c33c2","local-member-id":"5ac240a6daec2148","added-peer-id":"5ac240a6daec2148","added-peer-peer-urls":["https://199.204.45.156:2380"]} {"level":"info","ts":"2026-08-01T02:32:41.587567Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 is starting a new election at term 1"} {"level":"info","ts":"2026-08-01T02:32:41.587624Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-01T02:32:41.587661Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 received MsgPreVoteResp from 5ac240a6daec2148 at term 1"} {"level":"info","ts":"2026-08-01T02:32:41.587681Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became candidate at term 2"} {"level":"info","ts":"2026-08-01T02:32:41.587692Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 received MsgVoteResp from 5ac240a6daec2148 at term 2"} {"level":"info","ts":"2026-08-01T02:32:41.587713Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became leader at term 2"} {"level":"info","ts":"2026-08-01T02:32:41.587726Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5ac240a6daec2148 elected leader 5ac240a6daec2148 at term 2"} {"level":"info","ts":"2026-08-01T02:32:41.603232Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-01T02:32:41.630005Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5ac240a6daec2148","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.156:2379]}","request-path":"/0/members/5ac240a6daec2148/attributes","cluster-id":"62163637a46c33c2","publish-timeout":"7s"} {"level":"info","ts":"2026-08-01T02:32:41.630012Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-01T02:32:41.630078Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-01T02:32:41.630581Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-01T02:32:41.630652Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-01T02:32:41.633261Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-01T02:32:41.633747Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.156:2379"} {"level":"info","ts":"2026-08-01T02:32:41.656611Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"62163637a46c33c2","local-member-id":"5ac240a6daec2148","cluster-version":"3.5"} {"level":"info","ts":"2026-08-01T02:32:41.65679Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-01T02:32:41.656851Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-01T02:32:43.284603Z","caller":"traceutil/trace.go:171","msg":"trace[1971626887] linearizableReadLoop","detail":"{readStateIndex:15; appliedIndex:14; }","duration":"146.685557ms","start":"2026-08-01T02:32:43.13789Z","end":"2026-08-01T02:32:43.284575Z","steps":["trace[1971626887] 'read index received' (duration: 118.266435ms)","trace[1971626887] 'applied index is now lower than readState.Index' (duration: 28.418122ms)"],"step_count":2} {"level":"warn","ts":"2026-08-01T02:32:43.284864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.410577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-08-01T02:32:43.284972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.212094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-01T02:32:43.284983Z","caller":"traceutil/trace.go:171","msg":"trace[839122139] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:12; }","duration":"177.596125ms","start":"2026-08-01T02:32:43.107366Z","end":"2026-08-01T02:32:43.284962Z","steps":["trace[839122139] 'agreement among raft nodes before linearized reading' (duration: 177.283693ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:32:43.28502Z","caller":"traceutil/trace.go:171","msg":"trace[737230715] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:12; }","duration":"194.271807ms","start":"2026-08-01T02:32:43.090736Z","end":"2026-08-01T02:32:43.285007Z","steps":["trace[737230715] 'agreement among raft nodes before linearized reading' (duration: 194.206983ms)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:32:43.285203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.570389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-01T02:32:43.285306Z","caller":"traceutil/trace.go:171","msg":"trace[428279623] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"193.781898ms","start":"2026-08-01T02:32:43.091506Z","end":"2026-08-01T02:32:43.285288Z","steps":["trace[428279623] 'process raft request' (duration: 164.604616ms)","trace[428279623] 'compare' (duration: 28.291458ms)"],"step_count":2} {"level":"warn","ts":"2026-08-01T02:32:43.284914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.389418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-01T02:32:43.285403Z","caller":"traceutil/trace.go:171","msg":"trace[413993497] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:12; }","duration":"189.933629ms","start":"2026-08-01T02:32:43.095457Z","end":"2026-08-01T02:32:43.28539Z","steps":["trace[413993497] 'agreement among raft nodes before linearized reading' (duration: 189.282893ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:32:43.285476Z","caller":"traceutil/trace.go:171","msg":"trace[2015504436] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:12; }","duration":"238.760197ms","start":"2026-08-01T02:32:43.046561Z","end":"2026-08-01T02:32:43.285321Z","steps":["trace[2015504436] 'agreement among raft nodes before linearized reading' (duration: 238.518947ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:32:43.332311Z","caller":"traceutil/trace.go:171","msg":"trace[1295174206] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"191.435377ms","start":"2026-08-01T02:32:43.14085Z","end":"2026-08-01T02:32:43.332285Z","steps":["trace[1295174206] 'process raft request' (duration: 190.99ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:32:43.332333Z","caller":"traceutil/trace.go:171","msg":"trace[513563518] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"189.087216ms","start":"2026-08-01T02:32:43.143209Z","end":"2026-08-01T02:32:43.332296Z","steps":["trace[513563518] 'process raft request' (duration: 188.92202ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:32:43.33234Z","caller":"traceutil/trace.go:171","msg":"trace[27212100] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"189.370717ms","start":"2026-08-01T02:32:43.142942Z","end":"2026-08-01T02:32:43.332313Z","steps":["trace[27212100] 'process raft request' (duration: 189.079286ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:32:43.332521Z","caller":"traceutil/trace.go:171","msg":"trace[470445272] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"188.145461ms","start":"2026-08-01T02:32:43.144294Z","end":"2026-08-01T02:32:43.33244Z","steps":["trace[470445272] 'process raft request' (duration: 187.944473ms)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:32:43.332622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.820308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3171"} {"level":"info","ts":"2026-08-01T02:32:43.332691Z","caller":"traceutil/trace.go:171","msg":"trace[476678343] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:18; }","duration":"187.934214ms","start":"2026-08-01T02:32:43.144743Z","end":"2026-08-01T02:32:43.332677Z","steps":["trace[476678343] 'agreement among raft nodes before linearized reading' (duration: 187.714434ms)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:32:43.332594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.97393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-sxxr6\" ","response":"range_response_count:1 size:861"} {"level":"info","ts":"2026-08-01T02:32:43.332879Z","caller":"traceutil/trace.go:171","msg":"trace[1586316465] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-sxxr6; range_end:; response_count:1; response_revision:18; }","duration":"191.335904ms","start":"2026-08-01T02:32:43.141532Z","end":"2026-08-01T02:32:43.332868Z","steps":["trace[1586316465] 'agreement among raft nodes before linearized reading' (duration: 190.749491ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:32:43.332866Z","caller":"traceutil/trace.go:171","msg":"trace[1969745590] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"189.541175ms","start":"2026-08-01T02:32:43.143264Z","end":"2026-08-01T02:32:43.332805Z","steps":["trace[1969745590] 'process raft request' (duration: 188.91319ms)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:32:43.332822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.66242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-01T02:32:43.333015Z","caller":"traceutil/trace.go:171","msg":"trace[1458371879] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:18; }","duration":"189.869147ms","start":"2026-08-01T02:32:43.143125Z","end":"2026-08-01T02:32:43.332994Z","steps":["trace[1458371879] 'agreement among raft nodes before linearized reading' (duration: 189.657089ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:32:43.333205Z","caller":"traceutil/trace.go:171","msg":"trace[1362245014] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"190.046854ms","start":"2026-08-01T02:32:43.14314Z","end":"2026-08-01T02:32:43.333187Z","steps":["trace[1362245014] 'process raft request' (duration: 188.947121ms)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:32:43.571261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.825672ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-08-01T02:32:43.571528Z","caller":"traceutil/trace.go:171","msg":"trace[1373434806] transaction","detail":"{read_only:false; response_revision:21; number_of_response:1; }","duration":"232.62275ms","start":"2026-08-01T02:32:43.338861Z","end":"2026-08-01T02:32:43.571484Z","steps":["trace[1373434806] 'process raft request' (duration: 232.511516ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:32:43.571574Z","caller":"traceutil/trace.go:171","msg":"trace[602661082] transaction","detail":"{read_only:false; response_revision:22; number_of_response:1; }","duration":"232.638581ms","start":"2026-08-01T02:32:43.338911Z","end":"2026-08-01T02:32:43.57155Z","steps":["trace[602661082] 'process raft request' (duration: 232.518996ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:32:43.571818Z","caller":"traceutil/trace.go:171","msg":"trace[84544645] transaction","detail":"{read_only:false; response_revision:24; number_of_response:1; }","duration":"232.700783ms","start":"2026-08-01T02:32:43.339085Z","end":"2026-08-01T02:32:43.571785Z","steps":["trace[84544645] 'process raft request' (duration: 232.414892ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:32:43.571799Z","caller":"traceutil/trace.go:171","msg":"trace[1515013809] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"232.89475ms","start":"2026-08-01T02:32:43.338846Z","end":"2026-08-01T02:32:43.571741Z","steps":["trace[1515013809] 'process raft request' (duration: 96.8079ms)","trace[1515013809] 'compare' (duration: 134.695856ms)"],"step_count":2} {"level":"info","ts":"2026-08-01T02:32:43.572015Z","caller":"traceutil/trace.go:171","msg":"trace[130200267] transaction","detail":"{read_only:false; response_revision:26; number_of_response:1; }","duration":"226.1164ms","start":"2026-08-01T02:32:43.345887Z","end":"2026-08-01T02:32:43.572003Z","steps":["trace[130200267] 'process raft request' (duration: 225.796848ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:32:43.571896Z","caller":"traceutil/trace.go:171","msg":"trace[329572043] transaction","detail":"{read_only:false; response_revision:28; number_of_response:1; }","duration":"217.852823ms","start":"2026-08-01T02:32:43.354029Z","end":"2026-08-01T02:32:43.571881Z","steps":["trace[329572043] 'process raft request' (duration: 217.824112ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:32:43.572078Z","caller":"traceutil/trace.go:171","msg":"trace[212735419] transaction","detail":"{read_only:false; response_revision:27; number_of_response:1; }","duration":"218.371243ms","start":"2026-08-01T02:32:43.353692Z","end":"2026-08-01T02:32:43.572063Z","steps":["trace[212735419] 'process raft request' (duration: 218.123773ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:32:43.572172Z","caller":"traceutil/trace.go:171","msg":"trace[1250957338] linearizableReadLoop","detail":"{readStateIndex:30; appliedIndex:23; }","duration":"221.497202ms","start":"2026-08-01T02:32:43.350664Z","end":"2026-08-01T02:32:43.572161Z","steps":["trace[1250957338] 'read index received' (duration: 85.006056ms)","trace[1250957338] 'applied index is now lower than readState.Index' (duration: 136.489516ms)"],"step_count":2} {"level":"info","ts":"2026-08-01T02:32:43.572589Z","caller":"traceutil/trace.go:171","msg":"trace[2104982072] transaction","detail":"{read_only:false; response_revision:23; number_of_response:1; }","duration":"233.609528ms","start":"2026-08-01T02:32:43.338961Z","end":"2026-08-01T02:32:43.572571Z","steps":["trace[2104982072] 'process raft request' (duration: 232.504986ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:32:43.571857Z","caller":"traceutil/trace.go:171","msg":"trace[284710446] transaction","detail":"{read_only:false; response_revision:25; number_of_response:1; }","duration":"229.631346ms","start":"2026-08-01T02:32:43.342199Z","end":"2026-08-01T02:32:43.57183Z","steps":["trace[284710446] 'process raft request' (duration: 229.391247ms)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:32:43.57263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.816667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-08-01T02:32:43.572801Z","caller":"traceutil/trace.go:171","msg":"trace[929350397] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:28; }","duration":"221.044946ms","start":"2026-08-01T02:32:43.351737Z","end":"2026-08-01T02:32:43.572782Z","steps":["trace[929350397] 'agreement among raft nodes before linearized reading' (duration: 220.547407ms)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:32:43.572737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.384689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-public/\" range_end:\"/registry/resourcequotas/kube-public0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-01T02:32:43.572941Z","caller":"traceutil/trace.go:171","msg":"trace[685755099] range","detail":"{range_begin:/registry/resourcequotas/kube-public/; range_end:/registry/resourcequotas/kube-public0; response_count:0; response_revision:28; }","duration":"233.610518ms","start":"2026-08-01T02:32:43.339316Z","end":"2026-08-01T02:32:43.572926Z","steps":["trace[685755099] 'agreement among raft nodes before linearized reading' (duration: 233.38346ms)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:32:43.90189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.407917ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-08-01T02:32:43.902073Z","caller":"traceutil/trace.go:171","msg":"trace[644299815] transaction","detail":"{read_only:false; response_revision:38; number_of_response:1; }","duration":"234.008204ms","start":"2026-08-01T02:32:43.668045Z","end":"2026-08-01T02:32:43.902053Z","steps":["trace[644299815] 'process raft request' (duration: 233.953652ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:32:43.902155Z","caller":"traceutil/trace.go:171","msg":"trace[778304924] linearizableReadLoop","detail":"{readStateIndex:41; appliedIndex:33; }","duration":"290.533436ms","start":"2026-08-01T02:32:43.611597Z","end":"2026-08-01T02:32:43.902131Z","steps":["trace[778304924] 'read index received' (duration: 52.114843ms)","trace[778304924] 'applied index is now lower than readState.Index' (duration: 238.416213ms)"],"step_count":2} {"level":"warn","ts":"2026-08-01T02:32:43.902364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.743415ms","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-08-01T02:32:43.902402Z","caller":"traceutil/trace.go:171","msg":"trace[340965217] range","detail":"{range_begin:/registry/resourcequotas/kube-node-lease/; range_end:/registry/resourcequotas/kube-node-lease0; response_count:0; response_revision:38; }","duration":"290.837348ms","start":"2026-08-01T02:32:43.611556Z","end":"2026-08-01T02:32:43.902394Z","steps":["trace[340965217] 'agreement among raft nodes before linearized reading' (duration: 290.675832ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:32:43.902387Z","caller":"traceutil/trace.go:171","msg":"trace[1271333939] transaction","detail":"{read_only:false; response_revision:37; number_of_response:1; }","duration":"291.184021ms","start":"2026-08-01T02:32:43.611175Z","end":"2026-08-01T02:32:43.902359Z","steps":["trace[1271333939] 'process raft request' (duration: 188.231294ms)","trace[1271333939] 'compare' (duration: 102.25465ms)"],"step_count":2} {"level":"warn","ts":"2026-08-01T02:32:44.317299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.236022ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-08-01T02:32:44.317464Z","caller":"traceutil/trace.go:171","msg":"trace[1893951112] linearizableReadLoop","detail":"{readStateIndex:46; appliedIndex:44; }","duration":"366.224709ms","start":"2026-08-01T02:32:43.951228Z","end":"2026-08-01T02:32:44.317453Z","steps":["trace[1893951112] 'read index received' (duration: 183.877592ms)","trace[1893951112] 'applied index is now lower than readState.Index' (duration: 182.346507ms)"],"step_count":2} {"level":"info","ts":"2026-08-01T02:32:44.317471Z","caller":"traceutil/trace.go:171","msg":"trace[1601394699] transaction","detail":"{read_only:false; response_revision:41; number_of_response:1; }","duration":"367.680714ms","start":"2026-08-01T02:32:43.949757Z","end":"2026-08-01T02:32:44.317438Z","steps":["trace[1601394699] 'process raft request' (duration: 185.253995ms)","trace[1601394699] 'compare' (duration: 182.089386ms)"],"step_count":2} {"level":"warn","ts":"2026-08-01T02:32:44.317592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:32:43.949734Z","time spent":"367.818709ms","remote":"127.0.0.1:59522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":326,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-01T02:32:44.317656Z","caller":"traceutil/trace.go:171","msg":"trace[206501168] transaction","detail":"{read_only:false; response_revision:42; number_of_response:1; }","duration":"366.526041ms","start":"2026-08-01T02:32:43.951123Z","end":"2026-08-01T02:32:44.317649Z","steps":["trace[206501168] 'process raft request' (duration: 366.25611ms)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:32:44.31769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:32:43.95111Z","time spent":"366.562031ms","remote":"127.0.0.1:54364","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":429,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-01T02:32:44.31778Z","caller":"traceutil/trace.go:171","msg":"trace[692347551] transaction","detail":"{read_only:false; response_revision:43; number_of_response:1; }","duration":"365.539192ms","start":"2026-08-01T02:32:43.952204Z","end":"2026-08-01T02:32:44.317744Z","steps":["trace[692347551] 'process raft request' (duration: 365.21649ms)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:32:44.317913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.422653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-01T02:32:44.31799Z","caller":"traceutil/trace.go:171","msg":"trace[789389491] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:43; }","duration":"329.556469ms","start":"2026-08-01T02:32:43.988414Z","end":"2026-08-01T02:32:44.31797Z","steps":["trace[789389491] 'agreement among raft nodes before linearized reading' (duration: 329.229156ms)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:32:44.317948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.701587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-01T02:32:44.318115Z","caller":"traceutil/trace.go:171","msg":"trace[588262646] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:43; }","duration":"366.916385ms","start":"2026-08-01T02:32:43.951179Z","end":"2026-08-01T02:32:44.318096Z","steps":["trace[588262646] 'agreement among raft nodes before linearized reading' (duration: 366.560141ms)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:32:44.318201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:32:43.951137Z","time spent":"367.05159ms","remote":"127.0.0.1:54362","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":0,"response size":26,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" "} {"level":"warn","ts":"2026-08-01T02:32:44.318038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:32:43.988389Z","time spent":"329.640852ms","remote":"127.0.0.1:59392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-01T02:32:44.318759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:32:43.952192Z","time spent":"365.662126ms","remote":"127.0.0.1:54438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":647,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-01T02:32:44.444813Z","caller":"traceutil/trace.go:171","msg":"trace[175319617] transaction","detail":"{read_only:false; response_revision:46; number_of_response:1; }","duration":"121.036085ms","start":"2026-08-01T02:32:44.323755Z","end":"2026-08-01T02:32:44.444791Z","steps":["trace[175319617] 'process raft request' (duration: 120.897909ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:32:44.444831Z","caller":"traceutil/trace.go:171","msg":"trace[868448239] transaction","detail":"{read_only:false; response_revision:45; number_of_response:1; }","duration":"121.503883ms","start":"2026-08-01T02:32:44.323293Z","end":"2026-08-01T02:32:44.444797Z","steps":["trace[868448239] 'process raft request' (duration: 109.791719ms)","trace[868448239] 'compare' (duration: 11.440692ms)"],"step_count":2} {"level":"info","ts":"2026-08-01T02:32:44.790484Z","caller":"traceutil/trace.go:171","msg":"trace[2137001859] transaction","detail":"{read_only:false; response_revision:88; number_of_response:1; }","duration":"123.956507ms","start":"2026-08-01T02:32:44.666503Z","end":"2026-08-01T02:32:44.790459Z","steps":["trace[2137001859] 'process raft request' (duration: 61.972349ms)","trace[2137001859] 'compare' (duration: 61.893195ms)"],"step_count":2} {"level":"warn","ts":"2026-08-01T02:32:45.269743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.55185ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-08-01T02:32:45.269831Z","caller":"traceutil/trace.go:171","msg":"trace[1949706341] transaction","detail":"{read_only:false; response_revision:100; number_of_response:1; }","duration":"232.701416ms","start":"2026-08-01T02:32:45.037114Z","end":"2026-08-01T02:32:45.269816Z","steps":["trace[1949706341] 'process raft request' (duration: 125.014951ms)","trace[1949706341] 'compare' (duration: 107.428075ms)"],"step_count":2} {"level":"warn","ts":"2026-08-01T02:32:45.875879Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2398342427797614608,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-01T02:32:46.37612Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2398342427797614608,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-01T02:32:46.636824Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.283892176s","expected-duration":"1s"} {"level":"warn","ts":"2026-08-01T02:32:47.196411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"559.305435ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-08-01T02:32:47.196488Z","caller":"traceutil/trace.go:171","msg":"trace[1069827339] linearizableReadLoop","detail":"{readStateIndex:106; appliedIndex:105; }","duration":"1.820940875s","start":"2026-08-01T02:32:45.37553Z","end":"2026-08-01T02:32:47.196471Z","steps":["trace[1069827339] 'read index received' (duration: 1.261430111s)","trace[1069827339] 'applied index is now lower than readState.Index' (duration: 559.509904ms)"],"step_count":2} {"level":"info","ts":"2026-08-01T02:32:47.196535Z","caller":"traceutil/trace.go:171","msg":"trace[1059424515] transaction","detail":"{read_only:false; response_revision:102; number_of_response:1; }","duration":"1.843702271s","start":"2026-08-01T02:32:45.352826Z","end":"2026-08-01T02:32:47.196528Z","steps":["trace[1059424515] 'process raft request' (duration: 1.284206748s)","trace[1059424515] 'compare' (duration: 558.884169ms)"],"step_count":2} {"level":"warn","ts":"2026-08-01T02:32:47.196565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:32:45.352802Z","time spent":"1.843748763s","remote":"127.0.0.1:54352","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":710,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-01T02:32:47.196865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.821152283s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:5894"} {"level":"info","ts":"2026-08-01T02:32:47.197217Z","caller":"traceutil/trace.go:171","msg":"trace[609507621] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:102; }","duration":"1.821702764s","start":"2026-08-01T02:32:45.37549Z","end":"2026-08-01T02:32:47.197193Z","steps":["trace[609507621] 'agreement among raft nodes before linearized reading' (duration: 1.821079499s)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:32:47.197278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:32:45.375473Z","time spent":"1.821788677s","remote":"127.0.0.1:59616","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":5916,"request content":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" "} {"level":"warn","ts":"2026-08-01T02:32:47.388024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999978698s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-08-01T02:32:47.388161Z","caller":"traceutil/trace.go:171","msg":"trace[1108641320] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000152465s","start":"2026-08-01T02:32:45.387986Z","end":"2026-08-01T02:32:47.388138Z","steps":["trace[1108641320] 'agreement among raft nodes before linearized reading' (duration: 1.999992149s)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:32:47.38827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:32:45.387977Z","time spent":"2.00028052s","remote":"127.0.0.1:59376","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-01T02:32:47.697481Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2398342427797614611,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-01T02:32:48.196044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999872797s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-08-01T02:32:48.196151Z","caller":"traceutil/trace.go:171","msg":"trace[211052107] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000048053s","start":"2026-08-01T02:32:46.196085Z","end":"2026-08-01T02:32:48.196133Z","steps":["trace[211052107] 'agreement among raft nodes before linearized reading' (duration: 1.999905468s)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:32:48.196193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:32:46.196065Z","time spent":"2.000119036s","remote":"127.0.0.1:59392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-01T02:32:48.19865Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2398342427797614611,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-01T02:32:48.699635Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2398342427797614611,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-01T02:32:48.726932Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.710296223s","expected-duration":"1s"} {"level":"warn","ts":"2026-08-01T02:32:49.488689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000053332s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-08-01T02:32:49.488774Z","caller":"traceutil/trace.go:171","msg":"trace[1651853466] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000181377s","start":"2026-08-01T02:32:47.488572Z","end":"2026-08-01T02:32:49.488753Z","steps":["trace[1651853466] 'agreement among raft nodes before linearized reading' (duration: 2.000070853s)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:32:49.488846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:32:47.488559Z","time spent":"2.00025434s","remote":"127.0.0.1:59392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-01T02:32:49.67596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"947.988884ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-08-01T02:32:49.676517Z","caller":"traceutil/trace.go:171","msg":"trace[1976504852] transaction","detail":"{read_only:false; response_revision:103; number_of_response:1; }","duration":"2.659896792s","start":"2026-08-01T02:32:47.016503Z","end":"2026-08-01T02:32:49.6764Z","steps":["trace[1976504852] 'process raft request' (duration: 1.710687829s)","trace[1976504852] 'compare' (duration: 947.360409ms)"],"step_count":2} {"level":"warn","ts":"2026-08-01T02:32:49.676622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:32:47.016465Z","time spent":"2.660108102s","remote":"127.0.0.1:59616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3965,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-01T02:32:50.140513Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.413313067s","expected-duration":"1s"} {"level":"warn","ts":"2026-08-01T02:32:50.268287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.323ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:14"} {"level":"info","ts":"2026-08-01T02:32:50.268529Z","caller":"traceutil/trace.go:171","msg":"trace[384452867] linearizableReadLoop","detail":"{readStateIndex:110; appliedIndex:106; }","duration":"3.071993768s","start":"2026-08-01T02:32:47.196504Z","end":"2026-08-01T02:32:50.268497Z","steps":["trace[384452867] 'read index received' (duration: 1.530702034s)","trace[384452867] 'applied index is now lower than readState.Index' (duration: 1.541291044s)"],"step_count":2} {"level":"info","ts":"2026-08-01T02:32:50.268574Z","caller":"traceutil/trace.go:171","msg":"trace[1329193135] transaction","detail":"{read_only:false; response_revision:105; number_of_response:1; }","duration":"2.091897195s","start":"2026-08-01T02:32:48.176671Z","end":"2026-08-01T02:32:50.268568Z","steps":["trace[1329193135] 'process raft request' (duration: 2.091780731s)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:32:50.268609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:32:48.176646Z","time spent":"2.091945277s","remote":"127.0.0.1:59616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5498,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-01T02:32:50.268708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.674909243s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-08-01T02:32:50.268725Z","caller":"traceutil/trace.go:171","msg":"trace[1814921954] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:105; }","duration":"3.674972575s","start":"2026-08-01T02:32:46.593746Z","end":"2026-08-01T02:32:50.268719Z","steps":["trace[1814921954] 'agreement among raft nodes before linearized reading' (duration: 3.674934714s)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:32:50.268742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:32:46.593726Z","time spent":"3.675012937s","remote":"127.0.0.1:54274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":453,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-08-01T02:32:50.268782Z","caller":"traceutil/trace.go:171","msg":"trace[694228321] transaction","detail":"{read_only:false; response_revision:104; number_of_response:1; }","duration":"3.054357062s","start":"2026-08-01T02:32:47.214393Z","end":"2026-08-01T02:32:50.26875Z","steps":["trace[694228321] 'process raft request' (duration: 2.926424197s)","trace[694228321] 'compare' (duration: 127.217356ms)"],"step_count":2} {"level":"warn","ts":"2026-08-01T02:32:50.2688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:32:47.706912Z","time spent":"2.561879831s","remote":"127.0.0.1:59474","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-08-01T02:32:50.268911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:32:47.214379Z","time spent":"3.054467186s","remote":"127.0.0.1:59616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7288,"response count":0,"response size":36,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-01T02:32:50.269129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.674677073s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-08-01T02:32:50.269235Z","caller":"traceutil/trace.go:171","msg":"trace[1318400884] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:105; }","duration":"3.675210876s","start":"2026-08-01T02:32:46.593977Z","end":"2026-08-01T02:32:50.269188Z","steps":["trace[1318400884] 'agreement among raft nodes before linearized reading' (duration: 3.67459092s)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:32:50.26927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:32:46.593955Z","time spent":"3.67530567s","remote":"127.0.0.1:54274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-01T02:32:50.275717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.076987081s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:certificates.k8s.io:legacy-unknown-approver\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-08-01T02:32:50.275752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"785.724193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-01T02:32:50.275796Z","caller":"traceutil/trace.go:171","msg":"trace[1712910648] range","detail":"{range_begin:/registry/clusterroles/system:certificates.k8s.io:legacy-unknown-approver; range_end:; response_count:0; response_revision:106; }","duration":"3.077096855s","start":"2026-08-01T02:32:47.198686Z","end":"2026-08-01T02:32:50.275783Z","steps":["trace[1712910648] 'agreement among raft nodes before linearized reading' (duration: 3.076938989s)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:32:50.275795Z","caller":"traceutil/trace.go:171","msg":"trace[1691357012] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:106; }","duration":"785.804796ms","start":"2026-08-01T02:32:49.489981Z","end":"2026-08-01T02:32:50.275786Z","steps":["trace[1691357012] 'agreement among raft nodes before linearized reading' (duration: 785.671611ms)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:32:50.27583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:32:47.198669Z","time spent":"3.077152908s","remote":"127.0.0.1:54352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":0,"response size":26,"request content":"key:\"/registry/clusterroles/system:certificates.k8s.io:legacy-unknown-approver\" "} {"level":"warn","ts":"2026-08-01T02:32:50.27571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.579941102s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-08-01T02:32:50.275855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:32:49.48996Z","time spent":"785.89002ms","remote":"127.0.0.1:59376","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-01T02:32:50.27589Z","caller":"traceutil/trace.go:171","msg":"trace[525397023] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:106; }","duration":"1.580158931s","start":"2026-08-01T02:32:48.695716Z","end":"2026-08-01T02:32:50.275875Z","steps":["trace[525397023] 'agreement among raft nodes before linearized reading' (duration: 1.57988246s)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:32:50.275921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:32:48.695698Z","time spent":"1.580215763s","remote":"127.0.0.1:59392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-01T02:32:50.275576Z","caller":"traceutil/trace.go:171","msg":"trace[1574273165] transaction","detail":"{read_only:false; response_revision:106; number_of_response:1; }","duration":"755.973113ms","start":"2026-08-01T02:32:49.519588Z","end":"2026-08-01T02:32:50.275561Z","steps":["trace[1574273165] 'process raft request' (duration: 755.863199ms)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:32:50.276143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:32:49.519559Z","time spent":"756.551406ms","remote":"127.0.0.1:59616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2905,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-01T02:32:52.623443Z","caller":"traceutil/trace.go:171","msg":"trace[1527743754] linearizableReadLoop","detail":"{readStateIndex:286; appliedIndex:285; }","duration":"142.54201ms","start":"2026-08-01T02:32:52.480876Z","end":"2026-08-01T02:32:52.623418Z","steps":["trace[1527743754] 'read index received' (duration: 142.29061ms)","trace[1527743754] 'applied index is now lower than readState.Index' (duration: 249.59µs)"],"step_count":2} {"level":"info","ts":"2026-08-01T02:32:52.623523Z","caller":"traceutil/trace.go:171","msg":"trace[253306125] transaction","detail":"{read_only:false; response_revision:280; number_of_response:1; }","duration":"152.398721ms","start":"2026-08-01T02:32:52.47108Z","end":"2026-08-01T02:32:52.623479Z","steps":["trace[253306125] 'process raft request' (duration: 152.160031ms)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:32:52.623606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.702097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-01T02:32:52.623656Z","caller":"traceutil/trace.go:171","msg":"trace[1687507228] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:0; response_revision:280; }","duration":"142.79325ms","start":"2026-08-01T02:32:52.480847Z","end":"2026-08-01T02:32:52.62364Z","steps":["trace[1687507228] 'agreement among raft nodes before linearized reading' (duration: 142.682636ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:32:52.903026Z","caller":"traceutil/trace.go:171","msg":"trace[1709292020] transaction","detail":"{read_only:false; response_revision:283; number_of_response:1; }","duration":"198.504426ms","start":"2026-08-01T02:32:52.7045Z","end":"2026-08-01T02:32:52.903005Z","steps":["trace[1709292020] 'process raft request' (duration: 198.434993ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:32:52.903263Z","caller":"traceutil/trace.go:171","msg":"trace[3650351] transaction","detail":"{read_only:false; response_revision:282; number_of_response:1; }","duration":"273.984768ms","start":"2026-08-01T02:32:52.629195Z","end":"2026-08-01T02:32:52.90318Z","steps":["trace[3650351] 'process raft request' (duration: 206.301965ms)","trace[3650351] 'compare' (duration: 67.082389ms)"],"step_count":2} {"level":"warn","ts":"2026-08-01T02:33:04.436954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.583542ms","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-08-01T02:33:04.43713Z","caller":"traceutil/trace.go:171","msg":"trace[306854383] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:421; }","duration":"203.817633ms","start":"2026-08-01T02:33:04.233288Z","end":"2026-08-01T02:33:04.437106Z","steps":["trace[306854383] 'range keys from in-memory index tree' (duration: 203.359973ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:33:04.58622Z","caller":"traceutil/trace.go:171","msg":"trace[1289498462] transaction","detail":"{read_only:false; response_revision:423; number_of_response:1; }","duration":"145.261961ms","start":"2026-08-01T02:33:04.440932Z","end":"2026-08-01T02:33:04.586194Z","steps":["trace[1289498462] 'process raft request' (duration: 99.989814ms)","trace[1289498462] 'compare' (duration: 45.10914ms)"],"step_count":2} {"level":"info","ts":"2026-08-01T02:33:04.586592Z","caller":"traceutil/trace.go:171","msg":"trace[1021742987] transaction","detail":"{read_only:false; response_revision:425; number_of_response:1; }","duration":"143.966304ms","start":"2026-08-01T02:33:04.4426Z","end":"2026-08-01T02:33:04.586567Z","steps":["trace[1021742987] 'process raft request' (duration: 143.841579ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:33:04.58665Z","caller":"traceutil/trace.go:171","msg":"trace[682335273] transaction","detail":"{read_only:false; response_revision:424; number_of_response:1; }","duration":"145.553853ms","start":"2026-08-01T02:33:04.440991Z","end":"2026-08-01T02:33:04.586545Z","steps":["trace[682335273] 'process raft request' (duration: 145.163706ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:33:25.880131Z","caller":"traceutil/trace.go:171","msg":"trace[1201593571] linearizableReadLoop","detail":"{readStateIndex:613; appliedIndex:612; }","duration":"120.735537ms","start":"2026-08-01T02:33:25.759367Z","end":"2026-08-01T02:33:25.880102Z","steps":["trace[1201593571] 'read index received' (duration: 118.886681ms)","trace[1201593571] 'applied index is now lower than readState.Index' (duration: 1.847706ms)"],"step_count":2} {"level":"info","ts":"2026-08-01T02:33:25.880261Z","caller":"traceutil/trace.go:171","msg":"trace[621893335] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"143.843256ms","start":"2026-08-01T02:33:25.736408Z","end":"2026-08-01T02:33:25.880251Z","steps":["trace[621893335] 'process raft request' (duration: 141.920977ms)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:33:25.880586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.189618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-01T02:33:25.880695Z","caller":"traceutil/trace.go:171","msg":"trace[586090242] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:588; }","duration":"121.326524ms","start":"2026-08-01T02:33:25.759339Z","end":"2026-08-01T02:33:25.880665Z","steps":["trace[586090242] 'agreement among raft nodes before linearized reading' (duration: 121.078923ms)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:33:27.242421Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2398342427797615632,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-01T02:33:27.743019Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2398342427797615632,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-01T02:33:27.769225Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.031325871s","expected-duration":"1s"} {"level":"info","ts":"2026-08-01T02:33:27.776066Z","caller":"traceutil/trace.go:171","msg":"trace[1206961434] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"1.038220914s","start":"2026-08-01T02:33:26.737821Z","end":"2026-08-01T02:33:27.776042Z","steps":["trace[1206961434] 'process raft request' (duration: 1.031786812s)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:33:27.776219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:33:26.737807Z","time spent":"1.03833847s","remote":"127.0.0.1:54274","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-01T02:33:27.77671Z","caller":"traceutil/trace.go:171","msg":"trace[874149240] linearizableReadLoop","detail":"{readStateIndex:638; appliedIndex:636; }","duration":"1.035240863s","start":"2026-08-01T02:33:26.741455Z","end":"2026-08-01T02:33:27.776696Z","steps":["trace[874149240] 'read index received' (duration: 1.028223874s)","trace[874149240] 'applied index is now lower than readState.Index' (duration: 7.015949ms)"],"step_count":2} {"level":"info","ts":"2026-08-01T02:33:27.776979Z","caller":"traceutil/trace.go:171","msg":"trace[1111202411] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"823.050567ms","start":"2026-08-01T02:33:26.953888Z","end":"2026-08-01T02:33:27.776939Z","steps":["trace[1111202411] 'process raft request' (duration: 822.489341ms)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:33:27.777012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.035488365s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-01T02:33:27.777056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"949.929869ms","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":"warn","ts":"2026-08-01T02:33:27.777068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.035533287s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-01T02:33:27.777093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"976.530244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-01T02:33:27.77712Z","caller":"traceutil/trace.go:171","msg":"trace[258523099] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:612; }","duration":"950.017713ms","start":"2026-08-01T02:33:26.827079Z","end":"2026-08-01T02:33:27.777097Z","steps":["trace[258523099] 'agreement among raft nodes before linearized reading' (duration: 949.925549ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:33:27.777134Z","caller":"traceutil/trace.go:171","msg":"trace[998710433] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:612; }","duration":"1.035613101s","start":"2026-08-01T02:33:26.741498Z","end":"2026-08-01T02:33:27.777111Z","steps":["trace[998710433] 'agreement among raft nodes before linearized reading' (duration: 1.035492385s)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:33:27.777112Z","caller":"traceutil/trace.go:171","msg":"trace[762237133] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:612; }","duration":"1.035656303s","start":"2026-08-01T02:33:26.74142Z","end":"2026-08-01T02:33:27.777076Z","steps":["trace[762237133] 'agreement among raft nodes before linearized reading' (duration: 1.035423292s)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:33:27.777153Z","caller":"traceutil/trace.go:171","msg":"trace[1441722124] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:612; }","duration":"976.625398ms","start":"2026-08-01T02:33:26.800516Z","end":"2026-08-01T02:33:27.777141Z","steps":["trace[1441722124] 'agreement among raft nodes before linearized reading' (duration: 976.477741ms)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:33:27.777167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:33:26.827063Z","time spent":"950.091957ms","remote":"127.0.0.1:36408","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true "} {"level":"warn","ts":"2026-08-01T02:33:27.777174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:33:26.741484Z","time spent":"1.035679194s","remote":"127.0.0.1:36380","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-08-01T02:33:27.777195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:33:26.741405Z","time spent":"1.035775858s","remote":"127.0.0.1:36380","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-08-01T02:33:27.777192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:33:26.800478Z","time spent":"976.703812ms","remote":"127.0.0.1:36396","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 "} {"level":"warn","ts":"2026-08-01T02:33:27.777314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:33:26.953869Z","time spent":"823.210464ms","remote":"127.0.0.1:59448","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570090,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-01T02:33:27.777346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"949.577042ms","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-08-01T02:33:27.777382Z","caller":"traceutil/trace.go:171","msg":"trace[1543267919] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:612; }","duration":"949.622605ms","start":"2026-08-01T02:33:26.82775Z","end":"2026-08-01T02:33:27.777372Z","steps":["trace[1543267919] 'agreement among raft nodes before linearized reading' (duration: 949.568252ms)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:33:27.777431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"984.891477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:7708"} {"level":"warn","ts":"2026-08-01T02:33:27.777439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"950.398052ms","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-08-01T02:33:27.777526Z","caller":"traceutil/trace.go:171","msg":"trace[919212790] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:612; }","duration":"985.002692ms","start":"2026-08-01T02:33:26.792512Z","end":"2026-08-01T02:33:27.777514Z","steps":["trace[919212790] 'agreement among raft nodes before linearized reading' (duration: 984.820443ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:33:27.777547Z","caller":"traceutil/trace.go:171","msg":"trace[198126991] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:612; }","duration":"950.510777ms","start":"2026-08-01T02:33:26.827021Z","end":"2026-08-01T02:33:27.777532Z","steps":["trace[198126991] 'agreement among raft nodes before linearized reading' (duration: 950.35762ms)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:33:27.777568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:33:26.792499Z","time spent":"985.059895ms","remote":"127.0.0.1:59448","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":1,"response size":7730,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io\" "} {"level":"warn","ts":"2026-08-01T02:33:27.777622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:33:26.827016Z","time spent":"950.557199ms","remote":"127.0.0.1:36408","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 "} {"level":"warn","ts":"2026-08-01T02:33:27.777787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"977.084262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-01T02:33:27.777791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"976.473523ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-01T02:33:27.777847Z","caller":"traceutil/trace.go:171","msg":"trace[2141140863] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:612; }","duration":"977.161844ms","start":"2026-08-01T02:33:26.80067Z","end":"2026-08-01T02:33:27.777832Z","steps":["trace[2141140863] 'agreement among raft nodes before linearized reading' (duration: 977.036369ms)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:33:27.777861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.029285106s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-08-01T02:33:27.777887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:33:26.800661Z","time spent":"977.217578ms","remote":"127.0.0.1:36396","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"info","ts":"2026-08-01T02:33:27.777903Z","caller":"traceutil/trace.go:171","msg":"trace[669988108] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:612; }","duration":"1.029335518s","start":"2026-08-01T02:33:26.748557Z","end":"2026-08-01T02:33:27.777893Z","steps":["trace[669988108] 'agreement among raft nodes before linearized reading' (duration: 1.029227063s)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:33:27.777933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:33:26.748552Z","time spent":"1.02937412s","remote":"127.0.0.1:54274","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-08-01T02:33:27.777932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:33:26.827744Z","time spent":"949.668657ms","remote":"127.0.0.1:36408","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 "} {"level":"warn","ts":"2026-08-01T02:33:27.777939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.026280645s","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-08-01T02:33:27.778068Z","caller":"traceutil/trace.go:171","msg":"trace[53700141] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:612; }","duration":"976.595208ms","start":"2026-08-01T02:33:26.80127Z","end":"2026-08-01T02:33:27.777866Z","steps":["trace[53700141] 'agreement among raft nodes before linearized reading' (duration: 976.459992ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:33:27.778095Z","caller":"traceutil/trace.go:171","msg":"trace[865085572] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:612; }","duration":"1.026444213s","start":"2026-08-01T02:33:26.75164Z","end":"2026-08-01T02:33:27.778084Z","steps":["trace[865085572] 'agreement among raft nodes before linearized reading' (duration: 1.026093897s)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:33:27.778127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:33:26.801263Z","time spent":"976.84864ms","remote":"127.0.0.1:36396","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 "} {"level":"warn","ts":"2026-08-01T02:33:27.778144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.024796905s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-01T02:33:27.778187Z","caller":"traceutil/trace.go:171","msg":"trace[1137649919] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:612; }","duration":"1.024865588s","start":"2026-08-01T02:33:26.753304Z","end":"2026-08-01T02:33:27.77817Z","steps":["trace[1137649919] 'agreement among raft nodes before linearized reading' (duration: 1.024807465s)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:33:27.778211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.024957332s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-01T02:33:27.778233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:33:26.753288Z","time spent":"1.024934592s","remote":"127.0.0.1:36390","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"info","ts":"2026-08-01T02:33:27.778259Z","caller":"traceutil/trace.go:171","msg":"trace[1800973897] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:612; }","duration":"1.025014846s","start":"2026-08-01T02:33:26.75323Z","end":"2026-08-01T02:33:27.778245Z","steps":["trace[1800973897] 'agreement among raft nodes before linearized reading' (duration: 1.024940552s)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:33:27.77828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:33:26.751636Z","time spent":"1.026486645s","remote":"127.0.0.1:54274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-01T02:33:27.778298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:33:26.753225Z","time spent":"1.025062898s","remote":"127.0.0.1:36390","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-08-01T02:33:27.779182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.024370056s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-01T02:33:27.779356Z","caller":"traceutil/trace.go:171","msg":"trace[1088537058] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:612; }","duration":"1.025445566s","start":"2026-08-01T02:33:26.753785Z","end":"2026-08-01T02:33:27.77923Z","steps":["trace[1088537058] 'agreement among raft nodes before linearized reading' (duration: 1.024330544s)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:33:27.779492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:33:26.75378Z","time spent":"1.025622104s","remote":"127.0.0.1:36380","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 "} {"level":"info","ts":"2026-08-01T02:33:33.976477Z","caller":"traceutil/trace.go:171","msg":"trace[278367564] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"161.428635ms","start":"2026-08-01T02:33:33.81501Z","end":"2026-08-01T02:33:33.976438Z","steps":["trace[278367564] 'process raft request' (duration: 131.322288ms)","trace[278367564] 'compare' (duration: 29.828624ms)"],"step_count":2} {"level":"info","ts":"2026-08-01T02:33:33.976557Z","caller":"traceutil/trace.go:171","msg":"trace[1316388373] transaction","detail":"{read_only:false; response_revision:655; number_of_response:1; }","duration":"160.923251ms","start":"2026-08-01T02:33:33.815601Z","end":"2026-08-01T02:33:33.976524Z","steps":["trace[1316388373] 'process raft request' (duration: 160.681709ms)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:33:34.538911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.555121ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-2dc5f\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-08-01T02:33:34.539005Z","caller":"traceutil/trace.go:171","msg":"trace[845038713] range","detail":"{range_begin:/registry/pods/kube-system/cilium-2dc5f; range_end:; response_count:1; response_revision:656; }","duration":"436.681668ms","start":"2026-08-01T02:33:34.102291Z","end":"2026-08-01T02:33:34.538973Z","steps":["trace[845038713] 'range keys from in-memory index tree' (duration: 436.344071ms)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:33:34.539049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:33:34.102271Z","time spent":"436.769392ms","remote":"127.0.0.1:59616","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16987,"request content":"key:\"/registry/pods/kube-system/cilium-2dc5f\" "} {"level":"info","ts":"2026-08-01T02:33:34.866828Z","caller":"traceutil/trace.go:171","msg":"trace[1693524099] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"309.988724ms","start":"2026-08-01T02:33:34.556811Z","end":"2026-08-01T02:33:34.8668Z","steps":["trace[1693524099] 'process raft request' (duration: 309.729992ms)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:33:34.867037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:33:34.55679Z","time spent":"310.163944ms","remote":"127.0.0.1:59616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-01T02:33:35.429395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.139973ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-01T02:33:35.429512Z","caller":"traceutil/trace.go:171","msg":"trace[573071991] transaction","detail":"{read_only:false; response_revision:658; number_of_response:1; }","duration":"514.44925ms","start":"2026-08-01T02:33:34.915041Z","end":"2026-08-01T02:33:35.42949Z","steps":["trace[573071991] 'process raft request' (duration: 349.118669ms)","trace[573071991] 'compare' (duration: 164.739983ms)"],"step_count":2} {"level":"warn","ts":"2026-08-01T02:33:35.429573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:33:34.915019Z","time spent":"514.526864ms","remote":"127.0.0.1:54274","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-01T02:33:36.487271Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2398342427797615751,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-01T02:33:36.987647Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2398342427797615751,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-01T02:33:37.204245Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.354291338s","expected-duration":"1s"} {"level":"info","ts":"2026-08-01T02:33:37.204593Z","caller":"traceutil/trace.go:171","msg":"trace[1811230204] transaction","detail":"{read_only:false; response_revision:660; number_of_response:1; }","duration":"1.354710988s","start":"2026-08-01T02:33:35.849853Z","end":"2026-08-01T02:33:37.204564Z","steps":["trace[1811230204] 'process raft request' (duration: 1.354571452s)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:33:37.204742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:33:35.849833Z","time spent":"1.354840515s","remote":"127.0.0.1:54274","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-01T02:33:38.514227Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.309829903s","expected-duration":"1s"} {"level":"warn","ts":"2026-08-01T02:33:38.756983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999802715s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-08-01T02:33:38.757112Z","caller":"traceutil/trace.go:171","msg":"trace[1602110547] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000020056s","start":"2026-08-01T02:33:36.75707Z","end":"2026-08-01T02:33:38.757091Z","steps":["trace[1602110547] 'agreement among raft nodes before linearized reading' (duration: 1.999847358s)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:33:38.757278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:33:36.75705Z","time spent":"2.000173304s","remote":"127.0.0.1:59392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-01T02:33:38.7976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.10551ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-08-01T02:33:38.797729Z","caller":"traceutil/trace.go:171","msg":"trace[1869964076] linearizableReadLoop","detail":"{readStateIndex:688; appliedIndex:686; }","duration":"2.816769591s","start":"2026-08-01T02:33:35.980941Z","end":"2026-08-01T02:33:38.79771Z","steps":["trace[1869964076] 'read index received' (duration: 1.223514753s)","trace[1869964076] 'applied index is now lower than readState.Index' (duration: 1.593253398s)"],"step_count":2} {"level":"warn","ts":"2026-08-01T02:33:38.79792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.816652847s","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-08-01T02:33:38.79796Z","caller":"traceutil/trace.go:171","msg":"trace[1378224794] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:660; }","duration":"2.816715899s","start":"2026-08-01T02:33:35.981233Z","end":"2026-08-01T02:33:38.797949Z","steps":["trace[1378224794] 'agreement among raft nodes before linearized reading' (duration: 2.816589503s)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:33:38.798004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:33:35.981226Z","time spent":"2.816758041s","remote":"127.0.0.1:54274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-01T02:33:38.798177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.759162023s","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-08-01T02:33:38.798211Z","caller":"traceutil/trace.go:171","msg":"trace[1631134575] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:660; }","duration":"2.759196036s","start":"2026-08-01T02:33:36.039007Z","end":"2026-08-01T02:33:38.798203Z","steps":["trace[1631134575] 'agreement among raft nodes before linearized reading' (duration: 2.759114491s)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:33:38.798232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:33:36.038966Z","time spent":"2.759261219s","remote":"127.0.0.1:54274","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-08-01T02:33:38.798384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.817448475s","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-08-01T02:33:38.798411Z","caller":"traceutil/trace.go:171","msg":"trace[1330147453] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:660; }","duration":"2.817510069s","start":"2026-08-01T02:33:35.980895Z","end":"2026-08-01T02:33:38.798405Z","steps":["trace[1330147453] 'agreement among raft nodes before linearized reading' (duration: 2.816868617s)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:33:38.798429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:33:35.980878Z","time spent":"2.81754695s","remote":"127.0.0.1:54274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-08-01T02:33:38.918127Z","caller":"traceutil/trace.go:171","msg":"trace[1662191418] linearizableReadLoop","detail":"{readStateIndex:692; appliedIndex:688; }","duration":"109.227058ms","start":"2026-08-01T02:33:38.808874Z","end":"2026-08-01T02:33:38.918101Z","steps":["trace[1662191418] 'read index received' (duration: 66.396619ms)","trace[1662191418] 'applied index is now lower than readState.Index' (duration: 42.829609ms)"],"step_count":2} {"level":"info","ts":"2026-08-01T02:33:38.918181Z","caller":"traceutil/trace.go:171","msg":"trace[1892232439] transaction","detail":"{read_only:false; response_revision:664; number_of_response:1; }","duration":"114.095963ms","start":"2026-08-01T02:33:38.804064Z","end":"2026-08-01T02:33:38.91816Z","steps":["trace[1892232439] 'process raft request' (duration: 113.998238ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:33:38.918224Z","caller":"traceutil/trace.go:171","msg":"trace[1635958682] transaction","detail":"{read_only:false; response_revision:662; number_of_response:1; }","duration":"115.309702ms","start":"2026-08-01T02:33:38.80289Z","end":"2026-08-01T02:33:38.9182Z","steps":["trace[1635958682] 'process raft request' (duration: 115.030708ms)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:33:38.918241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.369506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-01T02:33:38.918282Z","caller":"traceutil/trace.go:171","msg":"trace[505815884] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:664; }","duration":"109.438918ms","start":"2026-08-01T02:33:38.808833Z","end":"2026-08-01T02:33:38.918272Z","steps":["trace[505815884] 'agreement among raft nodes before linearized reading' (duration: 109.363345ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:33:38.918637Z","caller":"traceutil/trace.go:171","msg":"trace[969770516] transaction","detail":"{read_only:false; response_revision:663; number_of_response:1; }","duration":"115.446989ms","start":"2026-08-01T02:33:38.803108Z","end":"2026-08-01T02:33:38.918555Z","steps":["trace[969770516] 'process raft request' (duration: 114.919003ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:33:39.861344Z","caller":"traceutil/trace.go:171","msg":"trace[783798510] transaction","detail":"{read_only:false; response_revision:669; number_of_response:1; }","duration":"130.442718ms","start":"2026-08-01T02:33:39.730881Z","end":"2026-08-01T02:33:39.861324Z","steps":["trace[783798510] 'process raft request' (duration: 130.305962ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:33:40.302973Z","caller":"traceutil/trace.go:171","msg":"trace[725428167] transaction","detail":"{read_only:false; response_revision:670; number_of_response:1; }","duration":"127.234267ms","start":"2026-08-01T02:33:40.175713Z","end":"2026-08-01T02:33:40.302947Z","steps":["trace[725428167] 'process raft request' (duration: 127.070979ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:33:41.007005Z","caller":"traceutil/trace.go:171","msg":"trace[245088249] transaction","detail":"{read_only:false; response_revision:671; number_of_response:1; }","duration":"124.280663ms","start":"2026-08-01T02:33:40.882695Z","end":"2026-08-01T02:33:41.006976Z","steps":["trace[245088249] 'process raft request' (duration: 124.110785ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:33:41.124079Z","caller":"traceutil/trace.go:171","msg":"trace[353288761] transaction","detail":"{read_only:false; response_revision:673; number_of_response:1; }","duration":"112.061403ms","start":"2026-08-01T02:33:41.011985Z","end":"2026-08-01T02:33:41.124046Z","steps":["trace[353288761] 'process raft request' (duration: 85.802704ms)","trace[353288761] 'compare' (duration: 26.091831ms)"],"step_count":2} {"level":"info","ts":"2026-08-01T02:33:41.825568Z","caller":"traceutil/trace.go:171","msg":"trace[1309720844] transaction","detail":"{read_only:false; response_revision:681; number_of_response:1; }","duration":"504.482915ms","start":"2026-08-01T02:33:41.32088Z","end":"2026-08-01T02:33:41.825363Z","steps":["trace[1309720844] 'process raft request' (duration: 406.262976ms)","trace[1309720844] 'compare' (duration: 97.82331ms)"],"step_count":2} {"level":"info","ts":"2026-08-01T02:33:41.825779Z","caller":"traceutil/trace.go:171","msg":"trace[989087137] linearizableReadLoop","detail":"{readStateIndex:710; appliedIndex:709; }","duration":"459.632282ms","start":"2026-08-01T02:33:41.36613Z","end":"2026-08-01T02:33:41.825762Z","steps":["trace[989087137] 'read index received' (duration: 360.954011ms)","trace[989087137] 'applied index is now lower than readState.Index' (duration: 98.676491ms)"],"step_count":2} {"level":"warn","ts":"2026-08-01T02:33:41.82603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.887265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-08-01T02:33:41.826121Z","caller":"traceutil/trace.go:171","msg":"trace[1388931181] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:682; }","duration":"460.029422ms","start":"2026-08-01T02:33:41.366075Z","end":"2026-08-01T02:33:41.826105Z","steps":["trace[1388931181] 'agreement among raft nodes before linearized reading' (duration: 459.819171ms)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:33:41.826157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:33:41.366053Z","time spent":"460.098275ms","remote":"127.0.0.1:59522","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":373,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-08-01T02:33:41.826293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:33:41.320858Z","time spent":"505.160047ms","remote":"127.0.0.1:59424","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-01T02:33:49.610189Z","caller":"traceutil/trace.go:171","msg":"trace[1153044466] transaction","detail":"{read_only:false; response_revision:777; number_of_response:1; }","duration":"161.687849ms","start":"2026-08-01T02:33:49.448475Z","end":"2026-08-01T02:33:49.610162Z","steps":["trace[1153044466] 'process raft request' (duration: 161.569703ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:33:49.760251Z","caller":"traceutil/trace.go:171","msg":"trace[1887061621] transaction","detail":"{read_only:false; response_revision:780; number_of_response:1; }","duration":"108.149859ms","start":"2026-08-01T02:33:49.652069Z","end":"2026-08-01T02:33:49.760219Z","steps":["trace[1887061621] 'process raft request' (duration: 107.945069ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:33:50.514952Z","caller":"traceutil/trace.go:171","msg":"trace[1789334702] transaction","detail":"{read_only:false; response_revision:784; number_of_response:1; }","duration":"166.050198ms","start":"2026-08-01T02:33:50.348872Z","end":"2026-08-01T02:33:50.514922Z","steps":["trace[1789334702] 'process raft request' (duration: 159.383209ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:33:50.589273Z","caller":"traceutil/trace.go:171","msg":"trace[1251393083] transaction","detail":"{read_only:false; response_revision:785; number_of_response:1; }","duration":"221.553309ms","start":"2026-08-01T02:33:50.367696Z","end":"2026-08-01T02:33:50.589249Z","steps":["trace[1251393083] 'process raft request' (duration: 221.423403ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:33:50.733817Z","caller":"traceutil/trace.go:171","msg":"trace[1983992956] transaction","detail":"{read_only:false; response_revision:786; number_of_response:1; }","duration":"211.206376ms","start":"2026-08-01T02:33:50.522586Z","end":"2026-08-01T02:33:50.733793Z","steps":["trace[1983992956] 'process raft request' (duration: 211.067489ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:33:53.302228Z","caller":"traceutil/trace.go:171","msg":"trace[229476993] transaction","detail":"{read_only:false; response_revision:806; number_of_response:1; }","duration":"122.193829ms","start":"2026-08-01T02:33:53.18Z","end":"2026-08-01T02:33:53.302194Z","steps":["trace[229476993] 'process raft request' (duration: 47.596021ms)","trace[229476993] 'compare' (duration: 74.43455ms)"],"step_count":2} {"level":"warn","ts":"2026-08-01T02:33:55.255978Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2398342427797616052,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-01T02:33:55.278819Z","caller":"traceutil/trace.go:171","msg":"trace[1454931735] linearizableReadLoop","detail":"{readStateIndex:843; appliedIndex:842; }","duration":"523.422253ms","start":"2026-08-01T02:33:54.755265Z","end":"2026-08-01T02:33:55.278687Z","steps":["trace[1454931735] 'read index received' (duration: 523.268235ms)","trace[1454931735] 'applied index is now lower than readState.Index' (duration: 153.108µs)"],"step_count":2} {"level":"info","ts":"2026-08-01T02:33:55.278844Z","caller":"traceutil/trace.go:171","msg":"trace[1879703938] transaction","detail":"{read_only:false; response_revision:810; number_of_response:1; }","duration":"524.048165ms","start":"2026-08-01T02:33:54.754777Z","end":"2026-08-01T02:33:55.278825Z","steps":["trace[1879703938] 'process raft request' (duration: 523.780432ms)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:33:55.278987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.618879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-08-01T02:33:55.279001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.691597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-01T02:33:55.279031Z","caller":"traceutil/trace.go:171","msg":"trace[1563443797] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:810; }","duration":"452.698893ms","start":"2026-08-01T02:33:54.82632Z","end":"2026-08-01T02:33:55.279019Z","steps":["trace[1563443797] 'agreement among raft nodes before linearized reading' (duration: 452.614228ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:33:55.279053Z","caller":"traceutil/trace.go:171","msg":"trace[1723686737] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:810; }","duration":"523.816494ms","start":"2026-08-01T02:33:54.75522Z","end":"2026-08-01T02:33:55.279037Z","steps":["trace[1723686737] 'agreement among raft nodes before linearized reading' (duration: 523.679757ms)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:33:55.27907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:33:54.826308Z","time spent":"452.752026ms","remote":"127.0.0.1:54448","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":29,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-08-01T02:33:55.279098Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:33:54.755203Z","time spent":"523.887057ms","remote":"127.0.0.1:59392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-01T02:33:55.279102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.880771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-01T02:33:55.279194Z","caller":"traceutil/trace.go:171","msg":"trace[1779249872] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:810; }","duration":"339.032448ms","start":"2026-08-01T02:33:54.940142Z","end":"2026-08-01T02:33:55.279175Z","steps":["trace[1779249872] 'agreement among raft nodes before linearized reading' (duration: 338.850448ms)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:33:55.279282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:33:54.940123Z","time spent":"339.147235ms","remote":"127.0.0.1:54364","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":2,"response size":29,"request content":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true "} {"level":"warn","ts":"2026-08-01T02:33:55.279255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:33:54.754752Z","time spent":"524.14835ms","remote":"127.0.0.1:59600","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4905,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-01T02:34:03.2574Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2398342427797616164,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-01T02:34:03.46539Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.205729613s","expected-duration":"1s"} {"level":"warn","ts":"2026-08-01T02:34:03.492542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:34:02.048705Z","time spent":"1.443828518s","remote":"127.0.0.1:50670","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-08-01T02:34:03.492993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.318068298s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-08-01T02:34:03.493038Z","caller":"traceutil/trace.go:171","msg":"trace[1136680991] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:841; }","duration":"1.318147282s","start":"2026-08-01T02:34:02.174874Z","end":"2026-08-01T02:34:03.493021Z","steps":["trace[1136680991] 'range keys from in-memory index tree' (duration: 1.31792367s)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:34:03.493074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:34:02.174861Z","time spent":"1.318205885s","remote":"127.0.0.1:54274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-08-01T02:34:03.493998Z","caller":"traceutil/trace.go:171","msg":"trace[960244625] linearizableReadLoop","detail":"{readStateIndex:877; appliedIndex:876; }","duration":"737.434808ms","start":"2026-08-01T02:34:02.756491Z","end":"2026-08-01T02:34:03.493926Z","steps":["trace[960244625] 'read index received' (duration: 709.05178ms)","trace[960244625] 'applied index is now lower than readState.Index' (duration: 28.380908ms)"],"step_count":2} {"level":"info","ts":"2026-08-01T02:34:03.494195Z","caller":"traceutil/trace.go:171","msg":"trace[1653173665] transaction","detail":"{read_only:false; response_revision:842; number_of_response:1; }","duration":"1.234644018s","start":"2026-08-01T02:34:02.259532Z","end":"2026-08-01T02:34:03.494176Z","steps":["trace[1653173665] 'process raft request' (duration: 1.206022868s)","trace[1653173665] 'compare' (duration: 27.032079ms)"],"step_count":2} {"level":"warn","ts":"2026-08-01T02:34:03.494297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"590.064414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-01T02:34:03.494271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"737.780605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-01T02:34:03.494366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:34:02.259507Z","time spent":"1.234738212s","remote":"127.0.0.1:54250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-01T02:34:03.494429Z","caller":"traceutil/trace.go:171","msg":"trace[425303317] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:842; }","duration":"737.971135ms","start":"2026-08-01T02:34:02.75644Z","end":"2026-08-01T02:34:03.494411Z","steps":["trace[425303317] 'agreement among raft nodes before linearized reading' (duration: 737.777115ms)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:34:03.494477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:34:02.756421Z","time spent":"738.043258ms","remote":"127.0.0.1:59392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-01T02:34:03.4945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.20424ms","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-08-01T02:34:03.494517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.475703ms","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-08-01T02:34:03.494555Z","caller":"traceutil/trace.go:171","msg":"trace[230063891] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:842; }","duration":"120.531565ms","start":"2026-08-01T02:34:03.374013Z","end":"2026-08-01T02:34:03.494544Z","steps":["trace[230063891] 'agreement among raft nodes before linearized reading' (duration: 120.4316ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:34:03.494376Z","caller":"traceutil/trace.go:171","msg":"trace[1352910788] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:842; }","duration":"590.158899ms","start":"2026-08-01T02:34:02.904198Z","end":"2026-08-01T02:34:03.494357Z","steps":["trace[1352910788] 'agreement among raft nodes before linearized reading' (duration: 590.021052ms)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:34:03.494678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:34:02.90413Z","time spent":"590.485015ms","remote":"127.0.0.1:54496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":27,"request content":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-08-01T02:34:03.494821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"571.765567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-01T02:34:03.49486Z","caller":"traceutil/trace.go:171","msg":"trace[634213627] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:842; }","duration":"571.842431ms","start":"2026-08-01T02:34:02.923004Z","end":"2026-08-01T02:34:03.494846Z","steps":["trace[634213627] 'agreement among raft nodes before linearized reading' (duration: 571.762107ms)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:34:03.494893Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:34:02.922984Z","time spent":"571.898444ms","remote":"127.0.0.1:59448","response type":"/etcdserverpb.KV/Range","request count":0,"request size":120,"response count":31,"response size":29,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true "} {"level":"warn","ts":"2026-08-01T02:34:03.495725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.705288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-01T02:34:03.495764Z","caller":"traceutil/trace.go:171","msg":"trace[2045492323] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:842; }","duration":"152.232971ms","start":"2026-08-01T02:34:03.342288Z","end":"2026-08-01T02:34:03.494521Z","steps":["trace[2045492323] 'agreement among raft nodes before linearized reading' (duration: 152.117935ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:34:03.495811Z","caller":"traceutil/trace.go:171","msg":"trace[627876386] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:842; }","duration":"127.190004ms","start":"2026-08-01T02:34:03.368603Z","end":"2026-08-01T02:34:03.495793Z","steps":["trace[627876386] 'agreement among raft nodes before linearized reading' (duration: 125.622694ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:34:09.415971Z","caller":"traceutil/trace.go:171","msg":"trace[1896698876] transaction","detail":"{read_only:false; response_revision:904; number_of_response:1; }","duration":"131.777103ms","start":"2026-08-01T02:34:09.284177Z","end":"2026-08-01T02:34:09.415954Z","steps":["trace[1896698876] 'process raft request' (duration: 131.662117ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:34:09.525505Z","caller":"traceutil/trace.go:171","msg":"trace[2118502888] transaction","detail":"{read_only:false; response_revision:906; number_of_response:1; }","duration":"103.571742ms","start":"2026-08-01T02:34:09.421908Z","end":"2026-08-01T02:34:09.525479Z","steps":["trace[2118502888] 'process raft request' (duration: 75.54316ms)","trace[2118502888] 'compare' (duration: 27.688325ms)"],"step_count":2} {"level":"info","ts":"2026-08-01T02:34:09.728983Z","caller":"traceutil/trace.go:171","msg":"trace[1235002836] transaction","detail":"{read_only:false; response_revision:909; number_of_response:1; }","duration":"119.422501ms","start":"2026-08-01T02:34:09.609534Z","end":"2026-08-01T02:34:09.728956Z","steps":["trace[1235002836] 'process raft request' (duration: 119.228821ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:34:09.729144Z","caller":"traceutil/trace.go:171","msg":"trace[1214040932] transaction","detail":"{read_only:false; response_revision:908; number_of_response:1; }","duration":"120.222623ms","start":"2026-08-01T02:34:09.608892Z","end":"2026-08-01T02:34:09.729114Z","steps":["trace[1214040932] 'process raft request' (duration: 66.680727ms)","trace[1214040932] 'compare' (duration: 53.029229ms)"],"step_count":2} {"level":"info","ts":"2026-08-01T02:34:09.729156Z","caller":"traceutil/trace.go:171","msg":"trace[1797119501] transaction","detail":"{read_only:false; response_revision:910; number_of_response:1; }","duration":"119.539778ms","start":"2026-08-01T02:34:09.609593Z","end":"2026-08-01T02:34:09.729133Z","steps":["trace[1797119501] 'process raft request' (duration: 119.215801ms)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:34:17.890915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.806592ms","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-08-01T02:34:17.891024Z","caller":"traceutil/trace.go:171","msg":"trace[1102423803] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1002; }","duration":"124.94975ms","start":"2026-08-01T02:34:17.766052Z","end":"2026-08-01T02:34:17.891002Z","steps":["trace[1102423803] 'range keys from in-memory index tree' (duration: 124.664625ms)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:34:17.89112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.451811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-08-01T02:34:17.8912Z","caller":"traceutil/trace.go:171","msg":"trace[1993573033] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1002; }","duration":"122.556406ms","start":"2026-08-01T02:34:17.768625Z","end":"2026-08-01T02:34:17.891182Z","steps":["trace[1993573033] 'range keys from in-memory index tree' (duration: 122.336685ms)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:34:17.891419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.096764ms","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-08-01T02:34:17.89146Z","caller":"traceutil/trace.go:171","msg":"trace[457761629] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1002; }","duration":"123.176308ms","start":"2026-08-01T02:34:17.768271Z","end":"2026-08-01T02:34:17.891448Z","steps":["trace[457761629] 'range keys from in-memory index tree' (duration: 122.938266ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:34:41.445985Z","caller":"traceutil/trace.go:171","msg":"trace[1863258853] linearizableReadLoop","detail":"{readStateIndex:1142; appliedIndex:1142; }","duration":"116.198499ms","start":"2026-08-01T02:34:41.329763Z","end":"2026-08-01T02:34:41.445962Z","steps":["trace[1863258853] 'read index received' (duration: 116.186688ms)","trace[1863258853] 'applied index is now lower than readState.Index' (duration: 10.071µs)"],"step_count":2} {"level":"warn","ts":"2026-08-01T02:34:41.446108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.334507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-01T02:34:41.446185Z","caller":"traceutil/trace.go:171","msg":"trace[2051534419] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:1098; }","duration":"116.479464ms","start":"2026-08-01T02:34:41.329689Z","end":"2026-08-01T02:34:41.446169Z","steps":["trace[2051534419] 'agreement among raft nodes before linearized reading' (duration: 116.353267ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:35:20.428131Z","caller":"traceutil/trace.go:171","msg":"trace[653748398] transaction","detail":"{read_only:false; response_revision:1225; number_of_response:1; }","duration":"248.734687ms","start":"2026-08-01T02:35:20.17935Z","end":"2026-08-01T02:35:20.428085Z","steps":["trace[653748398] 'process raft request' (duration: 248.448089ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:35:27.960805Z","caller":"traceutil/trace.go:171","msg":"trace[255618572] linearizableReadLoop","detail":"{readStateIndex:1304; appliedIndex:1303; }","duration":"206.03397ms","start":"2026-08-01T02:35:27.754748Z","end":"2026-08-01T02:35:27.960782Z","steps":["trace[255618572] 'read index received' (duration: 205.849111ms)","trace[255618572] 'applied index is now lower than readState.Index' (duration: 183.989µs)"],"step_count":2} {"level":"info","ts":"2026-08-01T02:35:27.960848Z","caller":"traceutil/trace.go:171","msg":"trace[1178263467] transaction","detail":"{read_only:false; response_revision:1251; number_of_response:1; }","duration":"224.563682ms","start":"2026-08-01T02:35:27.736258Z","end":"2026-08-01T02:35:27.960822Z","steps":["trace[1178263467] 'process raft request' (duration: 224.393943ms)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:35:27.960961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.720525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-01T02:35:27.960966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.19666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-01T02:35:27.961006Z","caller":"traceutil/trace.go:171","msg":"trace[1474945393] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:1251; }","duration":"104.814635ms","start":"2026-08-01T02:35:27.856181Z","end":"2026-08-01T02:35:27.960995Z","steps":["trace[1474945393] 'agreement among raft nodes before linearized reading' (duration: 104.725115ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:35:27.961028Z","caller":"traceutil/trace.go:171","msg":"trace[1633343857] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1251; }","duration":"206.30779ms","start":"2026-08-01T02:35:27.754706Z","end":"2026-08-01T02:35:27.961014Z","steps":["trace[1633343857] 'agreement among raft nodes before linearized reading' (duration: 206.19026ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:35:30.903755Z","caller":"traceutil/trace.go:171","msg":"trace[485953426] transaction","detail":"{read_only:false; response_revision:1262; number_of_response:1; }","duration":"231.138308ms","start":"2026-08-01T02:35:30.672577Z","end":"2026-08-01T02:35:30.903716Z","steps":["trace[485953426] 'process raft request' (duration: 223.01835ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:35:30.903831Z","caller":"traceutil/trace.go:171","msg":"trace[1456183025] linearizableReadLoop","detail":"{readStateIndex:1315; appliedIndex:1314; }","duration":"147.816538ms","start":"2026-08-01T02:35:30.755978Z","end":"2026-08-01T02:35:30.903795Z","steps":["trace[1456183025] 'read index received' (duration: 139.60983ms)","trace[1456183025] 'applied index is now lower than readState.Index' (duration: 8.205058ms)"],"step_count":2} {"level":"warn","ts":"2026-08-01T02:35:30.90423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.219997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-01T02:35:30.904289Z","caller":"traceutil/trace.go:171","msg":"trace[783439878] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1262; }","duration":"148.320407ms","start":"2026-08-01T02:35:30.75595Z","end":"2026-08-01T02:35:30.904271Z","steps":["trace[783439878] 'agreement among raft nodes before linearized reading' (duration: 148.208367ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:35:41.100153Z","caller":"traceutil/trace.go:171","msg":"trace[565273349] transaction","detail":"{read_only:false; response_revision:1297; number_of_response:1; }","duration":"105.823076ms","start":"2026-08-01T02:35:40.994305Z","end":"2026-08-01T02:35:41.100128Z","steps":["trace[565273349] 'process raft request' (duration: 105.591096ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:35:41.236709Z","caller":"traceutil/trace.go:171","msg":"trace[1048193159] transaction","detail":"{read_only:false; response_revision:1298; number_of_response:1; }","duration":"132.527462ms","start":"2026-08-01T02:35:41.104161Z","end":"2026-08-01T02:35:41.236688Z","steps":["trace[1048193159] 'process raft request' (duration: 64.08802ms)","trace[1048193159] 'compare' (duration: 68.352162ms)"],"step_count":2} {"level":"info","ts":"2026-08-01T02:35:41.956258Z","caller":"traceutil/trace.go:171","msg":"trace[1886532739] linearizableReadLoop","detail":"{readStateIndex:1359; appliedIndex:1358; }","duration":"397.020882ms","start":"2026-08-01T02:35:41.559205Z","end":"2026-08-01T02:35:41.956226Z","steps":["trace[1886532739] 'read index received' (duration: 308.320187ms)","trace[1886532739] 'applied index is now lower than readState.Index' (duration: 88.698985ms)"],"step_count":2} {"level":"info","ts":"2026-08-01T02:35:41.956315Z","caller":"traceutil/trace.go:171","msg":"trace[832933770] transaction","detail":"{read_only:false; response_revision:1302; number_of_response:1; }","duration":"397.843575ms","start":"2026-08-01T02:35:41.558441Z","end":"2026-08-01T02:35:41.956284Z","steps":["trace[832933770] 'process raft request' (duration: 309.13194ms)","trace[832933770] 'compare' (duration: 88.376214ms)"],"step_count":2} {"level":"warn","ts":"2026-08-01T02:35:41.956504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.278082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/test-pvc-pod\" ","response":"range_response_count:1 size:1490"} {"level":"warn","ts":"2026-08-01T02:35:41.95652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.32759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-01T02:35:41.956576Z","caller":"traceutil/trace.go:171","msg":"trace[1479608294] range","detail":"{range_begin:/registry/pods/default/test-pvc-pod; range_end:; response_count:1; response_revision:1302; }","duration":"397.417625ms","start":"2026-08-01T02:35:41.559141Z","end":"2026-08-01T02:35:41.956559Z","steps":["trace[1479608294] 'agreement among raft nodes before linearized reading' (duration: 397.206283ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:35:41.956597Z","caller":"traceutil/trace.go:171","msg":"trace[1718274953] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1302; }","duration":"117.452042ms","start":"2026-08-01T02:35:41.839126Z","end":"2026-08-01T02:35:41.956578Z","steps":["trace[1718274953] 'agreement among raft nodes before linearized reading' (duration: 117.31633ms)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:35:41.956615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:35:41.55913Z","time spent":"397.477775ms","remote":"127.0.0.1:59616","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":1,"response size":1512,"request content":"key:\"/registry/pods/default/test-pvc-pod\" "} {"level":"warn","ts":"2026-08-01T02:35:41.956981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:35:41.558428Z","time spent":"397.971295ms","remote":"127.0.0.1:59572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":653,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-01T02:35:42.342874Z","caller":"traceutil/trace.go:171","msg":"trace[1499871212] linearizableReadLoop","detail":"{readStateIndex:1365; appliedIndex:1364; }","duration":"186.563201ms","start":"2026-08-01T02:35:42.156291Z","end":"2026-08-01T02:35:42.342854Z","steps":["trace[1499871212] 'read index received' (duration: 185.572788ms)","trace[1499871212] 'applied index is now lower than readState.Index' (duration: 989.603µs)"],"step_count":2} {"level":"info","ts":"2026-08-01T02:35:42.343022Z","caller":"traceutil/trace.go:171","msg":"trace[1342011258] transaction","detail":"{read_only:false; response_revision:1308; number_of_response:1; }","duration":"187.299342ms","start":"2026-08-01T02:35:42.155676Z","end":"2026-08-01T02:35:42.342976Z","steps":["trace[1342011258] 'process raft request' (duration: 186.127179ms)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:35:42.343101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.791381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-fd3d1f2f-66a0-4188-8698-8fbf33b23698\" ","response":"range_response_count:1 size:3579"} {"level":"info","ts":"2026-08-01T02:35:42.343442Z","caller":"traceutil/trace.go:171","msg":"trace[450986301] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-fd3d1f2f-66a0-4188-8698-8fbf33b23698; range_end:; response_count:1; response_revision:1308; }","duration":"187.159573ms","start":"2026-08-01T02:35:42.156259Z","end":"2026-08-01T02:35:42.343419Z","steps":["trace[450986301] 'agreement among raft nodes before linearized reading' (duration: 186.720621ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:35:43.457665Z","caller":"traceutil/trace.go:171","msg":"trace[1805601124] transaction","detail":"{read_only:false; response_revision:1316; number_of_response:1; }","duration":"191.804283ms","start":"2026-08-01T02:35:43.265832Z","end":"2026-08-01T02:35:43.457636Z","steps":["trace[1805601124] 'process raft request' (duration: 161.406602ms)","trace[1805601124] 'compare' (duration: 30.188471ms)"],"step_count":2} {"level":"info","ts":"2026-08-01T02:35:43.463458Z","caller":"traceutil/trace.go:171","msg":"trace[1654843179] linearizableReadLoop","detail":"{readStateIndex:1374; appliedIndex:1372; }","duration":"114.520694ms","start":"2026-08-01T02:35:43.348915Z","end":"2026-08-01T02:35:43.463436Z","steps":["trace[1654843179] 'read index received' (duration: 78.507444ms)","trace[1654843179] 'applied index is now lower than readState.Index' (duration: 36.01226ms)"],"step_count":2} {"level":"info","ts":"2026-08-01T02:35:43.463614Z","caller":"traceutil/trace.go:171","msg":"trace[560418736] transaction","detail":"{read_only:false; response_revision:1317; number_of_response:1; }","duration":"169.136377ms","start":"2026-08-01T02:35:43.294444Z","end":"2026-08-01T02:35:43.46358Z","steps":["trace[560418736] 'process raft request' (duration: 168.869486ms)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:35:43.463926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.982606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-fd3d1f2f-66a0-4188-8698-8fbf33b23698\" ","response":"range_response_count:1 size:3579"} {"level":"info","ts":"2026-08-01T02:35:43.463998Z","caller":"traceutil/trace.go:171","msg":"trace[1194060926] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-fd3d1f2f-66a0-4188-8698-8fbf33b23698; range_end:; response_count:1; response_revision:1317; }","duration":"115.098386ms","start":"2026-08-01T02:35:43.348881Z","end":"2026-08-01T02:35:43.463979Z","steps":["trace[1194060926] 'agreement among raft nodes before linearized reading' (duration: 114.843236ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:35:45.105605Z","caller":"traceutil/trace.go:171","msg":"trace[647796710] transaction","detail":"{read_only:false; response_revision:1321; number_of_response:1; }","duration":"157.060917ms","start":"2026-08-01T02:35:44.948519Z","end":"2026-08-01T02:35:45.105579Z","steps":["trace[647796710] 'process raft request' (duration: 156.612814ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:35:45.105856Z","caller":"traceutil/trace.go:171","msg":"trace[395555303] transaction","detail":"{read_only:false; response_revision:1322; number_of_response:1; }","duration":"156.213465ms","start":"2026-08-01T02:35:44.949598Z","end":"2026-08-01T02:35:45.105812Z","steps":["trace[395555303] 'process raft request' (duration: 155.937764ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:35:51.412136Z","caller":"traceutil/trace.go:171","msg":"trace[285675209] linearizableReadLoop","detail":"{readStateIndex:1418; appliedIndex:1417; }","duration":"238.070656ms","start":"2026-08-01T02:35:51.174043Z","end":"2026-08-01T02:35:51.412114Z","steps":["trace[285675209] 'read index received' (duration: 237.889155ms)","trace[285675209] 'applied index is now lower than readState.Index' (duration: 180.291µs)"],"step_count":2} {"level":"info","ts":"2026-08-01T02:35:51.412278Z","caller":"traceutil/trace.go:171","msg":"trace[113204862] transaction","detail":"{read_only:false; response_revision:1359; number_of_response:1; }","duration":"264.858719ms","start":"2026-08-01T02:35:51.147408Z","end":"2026-08-01T02:35:51.412267Z","steps":["trace[113204862] 'process raft request' (duration: 264.561577ms)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:35:51.412546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.204444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.156\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-08-01T02:35:51.412579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.524039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-08-01T02:35:51.412626Z","caller":"traceutil/trace.go:171","msg":"trace[1524564156] range","detail":"{range_begin:/registry/masterleases/199.204.45.156; range_end:; response_count:1; response_revision:1359; }","duration":"114.342155ms","start":"2026-08-01T02:35:51.298267Z","end":"2026-08-01T02:35:51.412609Z","steps":["trace[1524564156] 'agreement among raft nodes before linearized reading' (duration: 114.069943ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:35:51.412649Z","caller":"traceutil/trace.go:171","msg":"trace[1901800093] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1359; }","duration":"238.64114ms","start":"2026-08-01T02:35:51.173989Z","end":"2026-08-01T02:35:51.41263Z","steps":["trace[1901800093] 'agreement among raft nodes before linearized reading' (duration: 238.445429ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:35:51.551302Z","caller":"traceutil/trace.go:171","msg":"trace[22406963] transaction","detail":"{read_only:false; response_revision:1361; number_of_response:1; }","duration":"134.197256ms","start":"2026-08-01T02:35:51.417079Z","end":"2026-08-01T02:35:51.551276Z","steps":["trace[22406963] 'process raft request' (duration: 134.089715ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:35:51.551333Z","caller":"traceutil/trace.go:171","msg":"trace[802380737] transaction","detail":"{read_only:false; response_revision:1360; number_of_response:1; }","duration":"134.551707ms","start":"2026-08-01T02:35:51.416754Z","end":"2026-08-01T02:35:51.551306Z","steps":["trace[802380737] 'process raft request' (duration: 134.207264ms)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:35:58.682794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.099814ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-01T02:35:58.683087Z","caller":"traceutil/trace.go:171","msg":"trace[225136472] linearizableReadLoop","detail":"{readStateIndex:1450; appliedIndex:1449; }","duration":"230.031823ms","start":"2026-08-01T02:35:58.453037Z","end":"2026-08-01T02:35:58.683069Z","steps":["trace[225136472] 'read index received' (duration: 64.547516ms)","trace[225136472] 'applied index is now lower than readState.Index' (duration: 165.483217ms)"],"step_count":2} {"level":"warn","ts":"2026-08-01T02:35:58.683155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.118653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-01T02:35:58.683191Z","caller":"traceutil/trace.go:171","msg":"trace[661539977] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:1389; }","duration":"230.182585ms","start":"2026-08-01T02:35:58.452996Z","end":"2026-08-01T02:35:58.683179Z","steps":["trace[661539977] 'agreement among raft nodes before linearized reading' (duration: 230.121324ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:35:58.6833Z","caller":"traceutil/trace.go:171","msg":"trace[1437617332] transaction","detail":"{read_only:false; response_revision:1389; number_of_response:1; }","duration":"282.398078ms","start":"2026-08-01T02:35:58.400794Z","end":"2026-08-01T02:35:58.683193Z","steps":["trace[1437617332] 'process raft request' (duration: 116.80783ms)","trace[1437617332] 'compare' (duration: 164.959443ms)"],"step_count":2} {"level":"warn","ts":"2026-08-01T02:35:59.383234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.99289ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-01T02:35:59.383368Z","caller":"traceutil/trace.go:171","msg":"trace[1028870309] linearizableReadLoop","detail":"{readStateIndex:1451; appliedIndex:1450; }","duration":"695.042457ms","start":"2026-08-01T02:35:58.6883Z","end":"2026-08-01T02:35:59.383343Z","steps":["trace[1028870309] 'read index received' (duration: 469.871215ms)","trace[1028870309] 'applied index is now lower than readState.Index' (duration: 225.168672ms)"],"step_count":2} {"level":"info","ts":"2026-08-01T02:35:59.383455Z","caller":"traceutil/trace.go:171","msg":"trace[386274117] transaction","detail":"{read_only:false; response_revision:1390; number_of_response:1; }","duration":"756.247476ms","start":"2026-08-01T02:35:58.627182Z","end":"2026-08-01T02:35:59.38343Z","steps":["trace[386274117] 'process raft request' (duration: 530.929613ms)","trace[386274117] 'compare' (duration: 224.628477ms)"],"step_count":2} {"level":"warn","ts":"2026-08-01T02:35:59.383536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"695.22716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-01T02:35:59.38358Z","caller":"traceutil/trace.go:171","msg":"trace[1844498526] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:1390; }","duration":"695.313501ms","start":"2026-08-01T02:35:58.688254Z","end":"2026-08-01T02:35:59.383567Z","steps":["trace[1844498526] 'agreement among raft nodes before linearized reading' (duration: 695.234769ms)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:35:59.383573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:35:58.627159Z","time spent":"756.358748ms","remote":"127.0.0.1:54274","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-01T02:35:59.383632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:35:58.688235Z","time spent":"695.386682ms","remote":"127.0.0.1:59568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":0,"response size":27,"request content":"key:\"/registry/persistentvolumes/test-pv\" "} {"level":"warn","ts":"2026-08-01T02:35:59.383828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"627.049393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-01T02:35:59.383867Z","caller":"traceutil/trace.go:171","msg":"trace[373521611] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1390; }","duration":"627.124414ms","start":"2026-08-01T02:35:58.756731Z","end":"2026-08-01T02:35:59.383856Z","steps":["trace[373521611] 'agreement among raft nodes before linearized reading' (duration: 627.070233ms)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:35:59.383894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:35:58.756712Z","time spent":"627.176294ms","remote":"127.0.0.1:59392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-01T02:35:59.383981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"545.505764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-01T02:35:59.384044Z","caller":"traceutil/trace.go:171","msg":"trace[677631862] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1390; }","duration":"545.609996ms","start":"2026-08-01T02:35:58.838416Z","end":"2026-08-01T02:35:59.384026Z","steps":["trace[677631862] 'agreement among raft nodes before linearized reading' (duration: 545.521335ms)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:35:59.384102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:35:58.838392Z","time spent":"545.690906ms","remote":"127.0.0.1:54244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":27,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"warn","ts":"2026-08-01T02:35:59.384104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"461.894609ms","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-08-01T02:35:59.384178Z","caller":"traceutil/trace.go:171","msg":"trace[984877625] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1390; }","duration":"462.01087ms","start":"2026-08-01T02:35:58.922147Z","end":"2026-08-01T02:35:59.384158Z","steps":["trace[984877625] 'agreement among raft nodes before linearized reading' (duration: 461.801578ms)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:35:59.384227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:35:58.922127Z","time spent":"462.091281ms","remote":"127.0.0.1:54274","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-08-01T02:35:59.385145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.43234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-08-01T02:35:59.385263Z","caller":"traceutil/trace.go:171","msg":"trace[599943591] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1390; }","duration":"323.623151ms","start":"2026-08-01T02:35:59.061626Z","end":"2026-08-01T02:35:59.385249Z","steps":["trace[599943591] 'agreement among raft nodes before linearized reading' (duration: 322.204119ms)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:35:59.3853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-01T02:35:59.061606Z","time spent":"323.684211ms","remote":"127.0.0.1:54274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-08-01T02:35:59.610639Z","caller":"traceutil/trace.go:171","msg":"trace[339887590] transaction","detail":"{read_only:false; response_revision:1391; number_of_response:1; }","duration":"222.314088ms","start":"2026-08-01T02:35:59.388302Z","end":"2026-08-01T02:35:59.610616Z","steps":["trace[339887590] 'process raft request' (duration: 213.570962ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:35:59.610901Z","caller":"traceutil/trace.go:171","msg":"trace[567522717] transaction","detail":"{read_only:false; response_revision:1392; number_of_response:1; }","duration":"222.144687ms","start":"2026-08-01T02:35:59.388728Z","end":"2026-08-01T02:35:59.610872Z","steps":["trace[567522717] 'process raft request' (duration: 221.847265ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:35:59.61101Z","caller":"traceutil/trace.go:171","msg":"trace[1439461362] linearizableReadLoop","detail":"{readStateIndex:1453; appliedIndex:1451; }","duration":"164.164187ms","start":"2026-08-01T02:35:59.446824Z","end":"2026-08-01T02:35:59.610988Z","steps":["trace[1439461362] 'read index received' (duration: 155.100418ms)","trace[1439461362] 'applied index is now lower than readState.Index' (duration: 9.062449ms)"],"step_count":2} {"level":"warn","ts":"2026-08-01T02:35:59.61124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.401239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-08-01T02:35:59.611306Z","caller":"traceutil/trace.go:171","msg":"trace[364988544] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1393; }","duration":"164.52103ms","start":"2026-08-01T02:35:59.446769Z","end":"2026-08-01T02:35:59.611291Z","steps":["trace[364988544] 'agreement among raft nodes before linearized reading' (duration: 164.281328ms)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:36:18.254097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.860182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-08-01T02:36:18.254142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.639332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-xnpg7\" ","response":"range_response_count:1 size:5487"} {"level":"warn","ts":"2026-08-01T02:36:18.254165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.78764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/envoy-gateway-system/\" range_end:\"/registry/persistentvolumeclaims/envoy-gateway-system0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-01T02:36:18.254195Z","caller":"traceutil/trace.go:171","msg":"trace[232966816] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:1458; }","duration":"128.006813ms","start":"2026-08-01T02:36:18.126169Z","end":"2026-08-01T02:36:18.254176Z","steps":["trace[232966816] 'count revisions from in-memory index tree' (duration: 127.80891ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:36:18.25423Z","caller":"traceutil/trace.go:171","msg":"trace[1685134466] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-xnpg7; range_end:; response_count:1; response_revision:1458; }","duration":"209.779295ms","start":"2026-08-01T02:36:18.04443Z","end":"2026-08-01T02:36:18.254209Z","steps":["trace[1685134466] 'range keys from in-memory index tree' (duration: 209.45861ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:36:18.254247Z","caller":"traceutil/trace.go:171","msg":"trace[1620204162] range","detail":"{range_begin:/registry/persistentvolumeclaims/envoy-gateway-system/; range_end:/registry/persistentvolumeclaims/envoy-gateway-system0; response_count:0; response_revision:1458; }","duration":"150.084464ms","start":"2026-08-01T02:36:18.10414Z","end":"2026-08-01T02:36:18.254224Z","steps":["trace[1620204162] 'range keys from in-memory index tree' (duration: 149.726759ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:36:19.540859Z","caller":"traceutil/trace.go:171","msg":"trace[334912349] linearizableReadLoop","detail":"{readStateIndex:1525; appliedIndex:1524; }","duration":"184.321375ms","start":"2026-08-01T02:36:19.356511Z","end":"2026-08-01T02:36:19.540833Z","steps":["trace[334912349] 'read index received' (duration: 184.132622ms)","trace[334912349] 'applied index is now lower than readState.Index' (duration: 187.523µs)"],"step_count":2} {"level":"info","ts":"2026-08-01T02:36:19.540968Z","caller":"traceutil/trace.go:171","msg":"trace[2029219814] transaction","detail":"{read_only:false; response_revision:1459; number_of_response:1; }","duration":"185.730315ms","start":"2026-08-01T02:36:19.355204Z","end":"2026-08-01T02:36:19.540934Z","steps":["trace[2029219814] 'process raft request' (duration: 185.43605ms)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:36:19.541324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.804682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/envoy-rate-limit\" ","response":"range_response_count:1 size:4460"} {"level":"warn","ts":"2026-08-01T02:36:19.541101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.120854ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/kube-node-lease/\" range_end:\"/registry/ingress/kube-node-lease0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-01T02:36:19.541386Z","caller":"traceutil/trace.go:171","msg":"trace[451040671] range","detail":"{range_begin:/registry/ingress/kube-node-lease/; range_end:/registry/ingress/kube-node-lease0; response_count:0; response_revision:1459; }","duration":"166.435238ms","start":"2026-08-01T02:36:19.37493Z","end":"2026-08-01T02:36:19.541365Z","steps":["trace[451040671] 'agreement among raft nodes before linearized reading' (duration: 166.112353ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:36:19.541407Z","caller":"traceutil/trace.go:171","msg":"trace[462935989] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/envoy-rate-limit; range_end:; response_count:1; response_revision:1459; }","duration":"184.909323ms","start":"2026-08-01T02:36:19.356484Z","end":"2026-08-01T02:36:19.541393Z","steps":["trace[462935989] 'agreement among raft nodes before linearized reading' (duration: 184.515007ms)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:36:19.541187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.491188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/kube-public/\" range_end:\"/registry/services/endpoints/kube-public0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-01T02:36:19.541491Z","caller":"traceutil/trace.go:171","msg":"trace[293434337] range","detail":"{range_begin:/registry/services/endpoints/kube-public/; range_end:/registry/services/endpoints/kube-public0; response_count:0; response_revision:1459; }","duration":"145.852352ms","start":"2026-08-01T02:36:19.395623Z","end":"2026-08-01T02:36:19.541475Z","steps":["trace[293434337] 'agreement among raft nodes before linearized reading' (duration: 145.476897ms)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:36:19.541213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.687441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/envoy-oidc-hmac\" ","response":"range_response_count:1 size:452"} {"level":"info","ts":"2026-08-01T02:36:19.541579Z","caller":"traceutil/trace.go:171","msg":"trace[235919672] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/envoy-oidc-hmac; range_end:; response_count:1; response_revision:1459; }","duration":"130.093996ms","start":"2026-08-01T02:36:19.411466Z","end":"2026-08-01T02:36:19.54156Z","steps":["trace[235919672] 'agreement among raft nodes before linearized reading' (duration: 129.586409ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:36:19.906962Z","caller":"traceutil/trace.go:171","msg":"trace[1790831140] linearizableReadLoop","detail":"{readStateIndex:1527; appliedIndex:1526; }","duration":"110.188571ms","start":"2026-08-01T02:36:19.796744Z","end":"2026-08-01T02:36:19.906932Z","steps":["trace[1790831140] 'read index received' (duration: 66.635696ms)","trace[1790831140] 'applied index is now lower than readState.Index' (duration: 43.551635ms)"],"step_count":2} {"level":"info","ts":"2026-08-01T02:36:19.907043Z","caller":"traceutil/trace.go:171","msg":"trace[913454653] transaction","detail":"{read_only:false; response_revision:1461; number_of_response:1; }","duration":"118.066204ms","start":"2026-08-01T02:36:19.788933Z","end":"2026-08-01T02:36:19.906999Z","steps":["trace[913454653] 'process raft request' (duration: 74.496199ms)","trace[913454653] 'compare' (duration: 43.368253ms)"],"step_count":2} {"level":"warn","ts":"2026-08-01T02:36:19.907222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.458155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-08-01T02:36:19.907272Z","caller":"traceutil/trace.go:171","msg":"trace[219123712] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1461; }","duration":"110.549507ms","start":"2026-08-01T02:36:19.796709Z","end":"2026-08-01T02:36:19.907258Z","steps":["trace[219123712] 'agreement among raft nodes before linearized reading' (duration: 110.380335ms)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:36:19.907475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.576908ms","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-08-01T02:36:19.907529Z","caller":"traceutil/trace.go:171","msg":"trace[1259148921] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1461; }","duration":"108.66496ms","start":"2026-08-01T02:36:19.798852Z","end":"2026-08-01T02:36:19.907517Z","steps":["trace[1259148921] 'agreement among raft nodes before linearized reading' (duration: 108.559048ms)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:36:19.907715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.768394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/default\" ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-08-01T02:36:19.907738Z","caller":"traceutil/trace.go:171","msg":"trace[542182160] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/default; range_end:; response_count:1; response_revision:1461; }","duration":"102.806146ms","start":"2026-08-01T02:36:19.804925Z","end":"2026-08-01T02:36:19.907732Z","steps":["trace[542182160] 'agreement among raft nodes before linearized reading' (duration: 102.735085ms)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:36:19.907724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.24751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/kube-public/\" range_end:\"/registry/networkpolicies/kube-public0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-01T02:36:19.9078Z","caller":"traceutil/trace.go:171","msg":"trace[909477703] range","detail":"{range_begin:/registry/networkpolicies/kube-public/; range_end:/registry/networkpolicies/kube-public0; response_count:0; response_revision:1461; }","duration":"105.345772ms","start":"2026-08-01T02:36:19.802434Z","end":"2026-08-01T02:36:19.907779Z","steps":["trace[909477703] 'agreement among raft nodes before linearized reading' (duration: 105.20167ms)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:36:19.907798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.95054ms","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-08-01T02:36:19.90785Z","caller":"traceutil/trace.go:171","msg":"trace[1108969999] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1461; }","duration":"106.029221ms","start":"2026-08-01T02:36:19.801808Z","end":"2026-08-01T02:36:19.907837Z","steps":["trace[1108969999] 'agreement among raft nodes before linearized reading' (duration: 105.852139ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:36:26.242822Z","caller":"traceutil/trace.go:171","msg":"trace[893436649] linearizableReadLoop","detail":"{readStateIndex:1549; appliedIndex:1548; }","duration":"125.80951ms","start":"2026-08-01T02:36:26.116987Z","end":"2026-08-01T02:36:26.242797Z","steps":["trace[893436649] 'read index received' (duration: 125.645477ms)","trace[893436649] 'applied index is now lower than readState.Index' (duration: 163.063µs)"],"step_count":2} {"level":"info","ts":"2026-08-01T02:36:26.242969Z","caller":"traceutil/trace.go:171","msg":"trace[1388464801] transaction","detail":"{read_only:false; response_revision:1482; number_of_response:1; }","duration":"155.253848ms","start":"2026-08-01T02:36:26.087689Z","end":"2026-08-01T02:36:26.242943Z","steps":["trace[1388464801] 'process raft request' (duration: 154.955672ms)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:36:26.243105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.089875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-08-01T02:36:26.243147Z","caller":"traceutil/trace.go:171","msg":"trace[1581942956] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1482; }","duration":"126.166547ms","start":"2026-08-01T02:36:26.116969Z","end":"2026-08-01T02:36:26.243136Z","steps":["trace[1581942956] 'agreement among raft nodes before linearized reading' (duration: 125.987984ms)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:36:26.243289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.823511ms","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-08-01T02:36:26.243276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.153197ms","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-08-01T02:36:26.243315Z","caller":"traceutil/trace.go:171","msg":"trace[642116984] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1482; }","duration":"125.864822ms","start":"2026-08-01T02:36:26.117442Z","end":"2026-08-01T02:36:26.243307Z","steps":["trace[642116984] 'agreement among raft nodes before linearized reading' (duration: 125.789381ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:36:26.243351Z","caller":"traceutil/trace.go:171","msg":"trace[300089422] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1482; }","duration":"126.245838ms","start":"2026-08-01T02:36:26.117086Z","end":"2026-08-01T02:36:26.243332Z","steps":["trace[300089422] 'agreement among raft nodes before linearized reading' (duration: 126.008064ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:36:30.507821Z","caller":"traceutil/trace.go:171","msg":"trace[1273406175] linearizableReadLoop","detail":"{readStateIndex:1564; appliedIndex:1563; }","duration":"169.986212ms","start":"2026-08-01T02:36:30.337813Z","end":"2026-08-01T02:36:30.507799Z","steps":["trace[1273406175] 'read index received' (duration: 169.84522ms)","trace[1273406175] 'applied index is now lower than readState.Index' (duration: 140.112µs)"],"step_count":2} {"level":"info","ts":"2026-08-01T02:36:30.507955Z","caller":"traceutil/trace.go:171","msg":"trace[1500578436] transaction","detail":"{read_only:false; response_revision:1496; number_of_response:1; }","duration":"171.866575ms","start":"2026-08-01T02:36:30.336061Z","end":"2026-08-01T02:36:30.507928Z","steps":["trace[1500578436] 'process raft request' (duration: 171.61488ms)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:36:30.508126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.145887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-08-01T02:36:30.508204Z","caller":"traceutil/trace.go:171","msg":"trace[405986326] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1496; }","duration":"159.264049ms","start":"2026-08-01T02:36:30.348921Z","end":"2026-08-01T02:36:30.508185Z","steps":["trace[405986326] 'agreement among raft nodes before linearized reading' (duration: 159.043385ms)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:36:30.50819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.469208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-08-01T02:36:30.508277Z","caller":"traceutil/trace.go:171","msg":"trace[212305045] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1496; }","duration":"150.57675ms","start":"2026-08-01T02:36:30.357682Z","end":"2026-08-01T02:36:30.508258Z","steps":["trace[212305045] 'agreement among raft nodes before linearized reading' (duration: 150.341216ms)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:36:30.508271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.794732ms","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-08-01T02:36:30.508206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.733376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-after-finished-controller\" ","response":"range_response_count:1 size:224"} {"level":"info","ts":"2026-08-01T02:36:30.508438Z","caller":"traceutil/trace.go:171","msg":"trace[2070305709] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1496; }","duration":"154.917004ms","start":"2026-08-01T02:36:30.353431Z","end":"2026-08-01T02:36:30.508348Z","steps":["trace[2070305709] 'agreement among raft nodes before linearized reading' (duration: 154.649369ms)"],"step_count":1} {"level":"info","ts":"2026-08-01T02:36:30.50845Z","caller":"traceutil/trace.go:171","msg":"trace[1946681261] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-after-finished-controller; range_end:; response_count:1; response_revision:1496; }","duration":"128.98312ms","start":"2026-08-01T02:36:30.379447Z","end":"2026-08-01T02:36:30.50843Z","steps":["trace[1946681261] 'agreement among raft nodes before linearized reading' (duration: 128.603204ms)"],"step_count":1} {"level":"warn","ts":"2026-08-01T02:36:30.508649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.825016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/\" range_end:\"/registry/events/kube-system0\" limit:500 ","response":"range_response_count:86 size:63964"} {"level":"info","ts":"2026-08-01T02:36:30.508705Z","caller":"traceutil/trace.go:171","msg":"trace[833074823] range","detail":"{range_begin:/registry/events/kube-system/; range_end:/registry/events/kube-system0; response_count:86; response_revision:1496; }","duration":"170.888927ms","start":"2026-08-01T02:36:30.3378Z","end":"2026-08-01T02:36:30.508689Z","steps":["trace[833074823] 'agreement among raft nodes before linearized reading' (duration: 170.123154ms)"],"step_count":1}