{"level":"warn","ts":"2026-07-02T00:23:43.020861Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-02T00:23:43.020977Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.205: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.205:2380","--initial-cluster=instance=https://199.204.45.205:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.205:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.205:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-07-02T00:23:43.021062Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-02T00:23:43.021074Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.205:2380"]} {"level":"info","ts":"2026-07-02T00:23:43.021096Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-07-02T00:23:43.022165Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"]} {"level":"info","ts":"2026-07-02T00:23:43.022306Z","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.205:2380"],"listen-peer-urls":["https://199.204.45.205:2380"],"advertise-client-urls":["https://199.204.45.205:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.205:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-07-02T00:23:43.026103Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.509116ms"} {"level":"info","ts":"2026-07-02T00:23:43.035844Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"71d28e9ac1bc4e5d","cluster-id":"4a4ae660c7a9a6a7"} {"level":"info","ts":"2026-07-02T00:23:43.035953Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=()"} {"level":"info","ts":"2026-07-02T00:23:43.035988Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became follower at term 0"} {"level":"info","ts":"2026-07-02T00:23:43.036009Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 71d28e9ac1bc4e5d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-02T00:23:43.036023Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became follower at term 1"} {"level":"info","ts":"2026-07-02T00:23:43.036085Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=(8201774666721545821)"} {"level":"warn","ts":"2026-07-02T00:23:43.042785Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-02T00:23:43.044132Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-02T00:23:43.045292Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-07-02T00:23:43.047778Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"71d28e9ac1bc4e5d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-02T00:23:43.047957Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"71d28e9ac1bc4e5d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-02T00:23:43.049035Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=(8201774666721545821)"} {"level":"info","ts":"2026-07-02T00:23:43.049363Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4a4ae660c7a9a6a7","local-member-id":"71d28e9ac1bc4e5d","added-peer-id":"71d28e9ac1bc4e5d","added-peer-peer-urls":["https://199.204.45.205:2380"]} {"level":"info","ts":"2026-07-02T00:23:43.048061Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-02T00:23:43.049673Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-02T00:23:43.0497Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-02T00:23:43.053031Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-07-02T00:23:43.053134Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.205:2380"} {"level":"info","ts":"2026-07-02T00:23:43.053264Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"71d28e9ac1bc4e5d","initial-advertise-peer-urls":["https://199.204.45.205:2380"],"listen-peer-urls":["https://199.204.45.205:2380"],"advertise-client-urls":["https://199.204.45.205:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-02T00:23:43.053295Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-02T00:23:43.053227Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.205:2380"} {"level":"info","ts":"2026-07-02T00:23:43.736817Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d is starting a new election at term 1"} {"level":"info","ts":"2026-07-02T00:23:43.736907Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became pre-candidate at term 1"} {"level":"info","ts":"2026-07-02T00:23:43.736961Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d received MsgPreVoteResp from 71d28e9ac1bc4e5d at term 1"} {"level":"info","ts":"2026-07-02T00:23:43.736982Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became candidate at term 2"} {"level":"info","ts":"2026-07-02T00:23:43.737Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d received MsgVoteResp from 71d28e9ac1bc4e5d at term 2"} {"level":"info","ts":"2026-07-02T00:23:43.737016Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became leader at term 2"} {"level":"info","ts":"2026-07-02T00:23:43.737029Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 71d28e9ac1bc4e5d elected leader 71d28e9ac1bc4e5d at term 2"} {"level":"info","ts":"2026-07-02T00:23:43.738053Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-02T00:23:43.738846Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"71d28e9ac1bc4e5d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.205:2379]}","request-path":"/0/members/71d28e9ac1bc4e5d/attributes","cluster-id":"4a4ae660c7a9a6a7","publish-timeout":"7s"} {"level":"info","ts":"2026-07-02T00:23:43.739035Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-02T00:23:43.739082Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-02T00:23:43.73929Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4a4ae660c7a9a6a7","local-member-id":"71d28e9ac1bc4e5d","cluster-version":"3.5"} {"level":"info","ts":"2026-07-02T00:23:43.739417Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-02T00:23:43.739453Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-02T00:23:43.742239Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.205:2379"} {"level":"info","ts":"2026-07-02T00:23:43.742914Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-02T00:23:43.742988Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-02T00:23:43.743079Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-02T00:23:45.251477Z","caller":"traceutil/trace.go:171","msg":"trace[1623998378] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"116.213091ms","start":"2026-07-02T00:23:45.135236Z","end":"2026-07-02T00:23:45.251449Z","steps":["trace[1623998378] 'process raft request' (duration: 24.067997ms)","trace[1623998378] 'compare' (duration: 92.034081ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:23:45.252416Z","caller":"traceutil/trace.go:171","msg":"trace[613763394] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"117.083714ms","start":"2026-07-02T00:23:45.135294Z","end":"2026-07-02T00:23:45.252377Z","steps":["trace[613763394] 'process raft request' (duration: 116.878809ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:23:45.252459Z","caller":"traceutil/trace.go:171","msg":"trace[654752947] linearizableReadLoop","detail":"{readStateIndex:12; appliedIndex:6; }","duration":"116.742575ms","start":"2026-07-02T00:23:45.135688Z","end":"2026-07-02T00:23:45.25243Z","steps":["trace[654752947] 'read index received' (duration: 23.642535ms)","trace[654752947] 'applied index is now lower than readState.Index' (duration: 93.09846ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:23:45.252694Z","caller":"traceutil/trace.go:171","msg":"trace[1583741194] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"117.337231ms","start":"2026-07-02T00:23:45.135339Z","end":"2026-07-02T00:23:45.252676Z","steps":["trace[1583741194] 'process raft request' (duration: 116.92209ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:23:45.252928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.227058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-02T00:23:45.253Z","caller":"traceutil/trace.go:171","msg":"trace[1053949601] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:10; }","duration":"117.325381ms","start":"2026-07-02T00:23:45.135658Z","end":"2026-07-02T00:23:45.252984Z","steps":["trace[1053949601] 'agreement among raft nodes before linearized reading' (duration: 117.179427ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:23:45.253009Z","caller":"traceutil/trace.go:171","msg":"trace[104352352] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"117.380192ms","start":"2026-07-02T00:23:45.135611Z","end":"2026-07-02T00:23:45.252991Z","steps":["trace[104352352] 'process raft request' (duration: 116.740264ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:23:45.253158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.55388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-02T00:23:45.253193Z","caller":"traceutil/trace.go:171","msg":"trace[1234208249] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:10; }","duration":"116.604131ms","start":"2026-07-02T00:23:45.13658Z","end":"2026-07-02T00:23:45.253184Z","steps":["trace[1234208249] 'agreement among raft nodes before linearized reading' (duration: 116.5529ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:23:45.253418Z","caller":"traceutil/trace.go:171","msg":"trace[1917155720] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"117.977348ms","start":"2026-07-02T00:23:45.135427Z","end":"2026-07-02T00:23:45.253405Z","steps":["trace[1917155720] 'process raft request' (duration: 116.865278ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:23:45.255946Z","caller":"traceutil/trace.go:171","msg":"trace[618182854] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"117.385632ms","start":"2026-07-02T00:23:45.135547Z","end":"2026-07-02T00:23:45.252933Z","steps":["trace[618182854] 'process raft request' (duration: 116.777146ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:23:45.457934Z","caller":"traceutil/trace.go:171","msg":"trace[570527894] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"146.581789ms","start":"2026-07-02T00:23:45.311322Z","end":"2026-07-02T00:23:45.457904Z","steps":["trace[570527894] 'process raft request' (duration: 70.539015ms)","trace[570527894] 'compare' (duration: 75.754227ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:23:45.457946Z","caller":"traceutil/trace.go:171","msg":"trace[1837241772] transaction","detail":"{read_only:false; response_revision:21; number_of_response:1; }","duration":"146.033214ms","start":"2026-07-02T00:23:45.311854Z","end":"2026-07-02T00:23:45.457887Z","steps":["trace[1837241772] 'process raft request' (duration: 145.89521ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:23:45.45834Z","caller":"traceutil/trace.go:171","msg":"trace[1598345745] transaction","detail":"{read_only:false; response_revision:22; number_of_response:1; }","duration":"146.273161ms","start":"2026-07-02T00:23:45.312053Z","end":"2026-07-02T00:23:45.458326Z","steps":["trace[1598345745] 'process raft request' (duration: 145.739156ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:23:45.458632Z","caller":"traceutil/trace.go:171","msg":"trace[1174533979] transaction","detail":"{read_only:false; response_revision:23; number_of_response:1; }","duration":"146.007863ms","start":"2026-07-02T00:23:45.312581Z","end":"2026-07-02T00:23:45.458589Z","steps":["trace[1174533979] 'process raft request' (duration: 145.268043ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:23:45.45869Z","caller":"traceutil/trace.go:171","msg":"trace[1079325921] linearizableReadLoop","detail":"{readStateIndex:30; appliedIndex:23; }","duration":"142.743404ms","start":"2026-07-02T00:23:45.31592Z","end":"2026-07-02T00:23:45.458664Z","steps":["trace[1079325921] 'read index received' (duration: 66.001291ms)","trace[1079325921] 'applied index is now lower than readState.Index' (duration: 76.738263ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:23:45.458747Z","caller":"traceutil/trace.go:171","msg":"trace[1845413935] transaction","detail":"{read_only:false; response_revision:24; number_of_response:1; }","duration":"145.53008ms","start":"2026-07-02T00:23:45.313205Z","end":"2026-07-02T00:23:45.458735Z","steps":["trace[1845413935] 'process raft request' (duration: 145.262573ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:23:45.458742Z","caller":"traceutil/trace.go:171","msg":"trace[1584210281] transaction","detail":"{read_only:false; response_revision:26; number_of_response:1; }","duration":"143.007112ms","start":"2026-07-02T00:23:45.31571Z","end":"2026-07-02T00:23:45.458718Z","steps":["trace[1584210281] 'process raft request' (duration: 142.879418ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:23:45.458819Z","caller":"traceutil/trace.go:171","msg":"trace[1915996218] transaction","detail":"{read_only:false; response_revision:27; number_of_response:1; }","duration":"140.080642ms","start":"2026-07-02T00:23:45.318728Z","end":"2026-07-02T00:23:45.458809Z","steps":["trace[1915996218] 'process raft request' (duration: 139.889617ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:23:45.458969Z","caller":"traceutil/trace.go:171","msg":"trace[1169837889] transaction","detail":"{read_only:false; response_revision:25; number_of_response:1; }","duration":"145.382506ms","start":"2026-07-02T00:23:45.313576Z","end":"2026-07-02T00:23:45.458958Z","steps":["trace[1169837889] 'process raft request' (duration: 144.967355ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:23:45.458981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.476493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-02T00:23:45.459007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.236983ms","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-07-02T00:23:45.459039Z","caller":"traceutil/trace.go:171","msg":"trace[1952366031] range","detail":"{range_begin:/registry/resourcequotas/kube-public/; range_end:/registry/resourcequotas/kube-public0; response_count:0; response_revision:27; }","duration":"145.315795ms","start":"2026-07-02T00:23:45.31371Z","end":"2026-07-02T00:23:45.459026Z","steps":["trace[1952366031] 'agreement among raft nodes before linearized reading' (duration: 145.249903ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:23:45.459049Z","caller":"traceutil/trace.go:171","msg":"trace[761186684] range","detail":"{range_begin:/registry/configmaps/kube-system/extension-apiserver-authentication; range_end:; response_count:0; response_revision:27; }","duration":"140.623116ms","start":"2026-07-02T00:23:45.318402Z","end":"2026-07-02T00:23:45.459025Z","steps":["trace[761186684] 'agreement among raft nodes before linearized reading' (duration: 140.440081ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:23:45.459158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.382588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-02T00:23:45.459205Z","caller":"traceutil/trace.go:171","msg":"trace[1773358200] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:27; }","duration":"126.46476ms","start":"2026-07-02T00:23:45.332718Z","end":"2026-07-02T00:23:45.459183Z","steps":["trace[1773358200] 'agreement among raft nodes before linearized reading' (duration: 126.385468ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:23:45.753543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.840701ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-07-02T00:23:45.753945Z","caller":"traceutil/trace.go:171","msg":"trace[389477713] transaction","detail":"{read_only:false; response_revision:29; number_of_response:1; }","duration":"292.078458ms","start":"2026-07-02T00:23:45.46184Z","end":"2026-07-02T00:23:45.753918Z","steps":["trace[389477713] 'process raft request' (duration: 142.159658ms)","trace[389477713] 'compare' (duration: 148.707677ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:23:45.753963Z","caller":"traceutil/trace.go:171","msg":"trace[1193332613] transaction","detail":"{read_only:false; response_revision:33; number_of_response:1; }","duration":"290.67679ms","start":"2026-07-02T00:23:45.463263Z","end":"2026-07-02T00:23:45.75394Z","steps":["trace[1193332613] 'process raft request' (duration: 290.517066ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:23:45.75402Z","caller":"traceutil/trace.go:171","msg":"trace[2098503697] transaction","detail":"{read_only:false; response_revision:35; number_of_response:1; }","duration":"290.585178ms","start":"2026-07-02T00:23:45.463403Z","end":"2026-07-02T00:23:45.753988Z","steps":["trace[2098503697] 'process raft request' (duration: 290.421824ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:23:45.75405Z","caller":"traceutil/trace.go:171","msg":"trace[1464878960] transaction","detail":"{read_only:false; response_revision:34; number_of_response:1; }","duration":"290.654749ms","start":"2026-07-02T00:23:45.463368Z","end":"2026-07-02T00:23:45.754023Z","steps":["trace[1464878960] 'process raft request' (duration: 290.433873ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:23:45.754273Z","caller":"traceutil/trace.go:171","msg":"trace[724572791] transaction","detail":"{read_only:false; response_revision:32; number_of_response:1; }","duration":"291.161654ms","start":"2026-07-02T00:23:45.463099Z","end":"2026-07-02T00:23:45.75426Z","steps":["trace[724572791] 'process raft request' (duration: 290.64248ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:23:45.754313Z","caller":"traceutil/trace.go:171","msg":"trace[1549990557] transaction","detail":"{read_only:false; response_revision:36; number_of_response:1; }","duration":"290.838375ms","start":"2026-07-02T00:23:45.463464Z","end":"2026-07-02T00:23:45.754302Z","steps":["trace[1549990557] 'process raft request' (duration: 290.388463ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:23:45.754274Z","caller":"traceutil/trace.go:171","msg":"trace[494638053] transaction","detail":"{read_only:false; response_revision:31; number_of_response:1; }","duration":"291.182864ms","start":"2026-07-02T00:23:45.46308Z","end":"2026-07-02T00:23:45.754263Z","steps":["trace[494638053] 'process raft request' (duration: 290.622518ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:23:45.754481Z","caller":"traceutil/trace.go:171","msg":"trace[1727160922] linearizableReadLoop","detail":"{readStateIndex:40; appliedIndex:32; }","duration":"257.641809ms","start":"2026-07-02T00:23:45.496829Z","end":"2026-07-02T00:23:45.75447Z","steps":["trace[1727160922] 'read index received' (duration: 107.082032ms)","trace[1727160922] 'applied index is now lower than readState.Index' (duration: 150.558467ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T00:23:45.754641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.807874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-node-lease/\" range_end:\"/registry/resourcequotas/kube-node-lease0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-02T00:23:45.754666Z","caller":"traceutil/trace.go:171","msg":"trace[952182578] transaction","detail":"{read_only:false; response_revision:30; number_of_response:1; }","duration":"291.75018ms","start":"2026-07-02T00:23:45.462146Z","end":"2026-07-02T00:23:45.753896Z","steps":["trace[952182578] 'process raft request' (duration: 291.494513ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:23:45.754679Z","caller":"traceutil/trace.go:171","msg":"trace[25556533] range","detail":"{range_begin:/registry/resourcequotas/kube-node-lease/; range_end:/registry/resourcequotas/kube-node-lease0; response_count:0; response_revision:36; }","duration":"257.883016ms","start":"2026-07-02T00:23:45.496785Z","end":"2026-07-02T00:23:45.754668Z","steps":["trace[25556533] 'agreement among raft nodes before linearized reading' (duration: 257.770403ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:23:46.025429Z","caller":"traceutil/trace.go:171","msg":"trace[1692051036] transaction","detail":"{read_only:false; response_revision:42; number_of_response:1; }","duration":"169.279908ms","start":"2026-07-02T00:23:45.85612Z","end":"2026-07-02T00:23:46.0254Z","steps":["trace[1692051036] 'process raft request' (duration: 82.532131ms)","trace[1692051036] 'compare' (duration: 86.585063ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:24:07.33672Z","caller":"traceutil/trace.go:171","msg":"trace[651989382] transaction","detail":"{read_only:false; response_revision:427; number_of_response:1; }","duration":"120.571299ms","start":"2026-07-02T00:24:07.216124Z","end":"2026-07-02T00:24:07.336695Z","steps":["trace[651989382] 'process raft request' (duration: 120.443256ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:24:08.846478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.027956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-07-02T00:24:08.846624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.371339882s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-02T00:24:08.846544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.360673451s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-02T00:24:08.846728Z","caller":"traceutil/trace.go:171","msg":"trace[11376230] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:427; }","duration":"1.371557797s","start":"2026-07-02T00:24:07.475147Z","end":"2026-07-02T00:24:08.846705Z","steps":["trace[11376230] 'range keys from in-memory index tree' (duration: 1.371232969s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:24:08.846721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"703.812041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-07-02T00:24:08.846677Z","caller":"traceutil/trace.go:171","msg":"trace[223321118] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:427; }","duration":"274.282923ms","start":"2026-07-02T00:24:08.572364Z","end":"2026-07-02T00:24:08.846647Z","steps":["trace[223321118] 'range keys from in-memory index tree' (duration: 273.847891ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:24:08.846818Z","caller":"traceutil/trace.go:171","msg":"trace[1220012638] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:427; }","duration":"703.982956ms","start":"2026-07-02T00:24:08.14281Z","end":"2026-07-02T00:24:08.846793Z","steps":["trace[1220012638] 'range keys from in-memory index tree' (duration: 703.678497ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:24:08.846794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:24:07.475127Z","time spent":"1.371659141s","remote":"127.0.0.1:41856","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-07-02T00:24:08.846889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:24:08.142787Z","time spent":"704.092159ms","remote":"127.0.0.1:42138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":526,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-07-02T00:24:08.84679Z","caller":"traceutil/trace.go:171","msg":"trace[1997637349] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:427; }","duration":"1.360947108s","start":"2026-07-02T00:24:07.485816Z","end":"2026-07-02T00:24:08.846763Z","steps":["trace[1997637349] 'range keys from in-memory index tree' (duration: 1.360555888s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:24:08.846981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:24:07.485809Z","time spent":"1.361157494s","remote":"127.0.0.1:42138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-02T00:24:19.579847Z","caller":"traceutil/trace.go:171","msg":"trace[196878592] linearizableReadLoop","detail":"{readStateIndex:471; appliedIndex:470; }","duration":"104.928043ms","start":"2026-07-02T00:24:19.474889Z","end":"2026-07-02T00:24:19.579817Z","steps":["trace[196878592] 'read index received' (duration: 104.769538ms)","trace[196878592] 'applied index is now lower than readState.Index' (duration: 157.585µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:24:19.579919Z","caller":"traceutil/trace.go:171","msg":"trace[2000967197] transaction","detail":"{read_only:false; response_revision:455; number_of_response:1; }","duration":"129.428771ms","start":"2026-07-02T00:24:19.450456Z","end":"2026-07-02T00:24:19.579884Z","steps":["trace[2000967197] 'process raft request' (duration: 129.200374ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:24:19.579979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.070306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T00:24:19.580111Z","caller":"traceutil/trace.go:171","msg":"trace[2035598143] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:455; }","duration":"105.129828ms","start":"2026-07-02T00:24:19.474876Z","end":"2026-07-02T00:24:19.580006Z","steps":["trace[2035598143] 'agreement among raft nodes before linearized reading' (duration: 105.049066ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:24:39.278321Z","caller":"traceutil/trace.go:171","msg":"trace[995759018] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"112.277782ms","start":"2026-07-02T00:24:39.165994Z","end":"2026-07-02T00:24:39.278272Z","steps":["trace[995759018] 'process raft request' (duration: 111.872891ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:24:49.596327Z","caller":"traceutil/trace.go:171","msg":"trace[923666199] linearizableReadLoop","detail":"{readStateIndex:544; appliedIndex:543; }","duration":"121.208527ms","start":"2026-07-02T00:24:49.475098Z","end":"2026-07-02T00:24:49.596307Z","steps":["trace[923666199] 'read index received' (duration: 72.430392ms)","trace[923666199] 'applied index is now lower than readState.Index' (duration: 48.777135ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T00:24:49.59644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.33011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T00:24:49.596427Z","caller":"traceutil/trace.go:171","msg":"trace[355169085] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"137.151773ms","start":"2026-07-02T00:24:49.45924Z","end":"2026-07-02T00:24:49.596392Z","steps":["trace[355169085] 'process raft request' (duration: 88.256095ms)","trace[355169085] 'compare' (duration: 48.713113ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:24:49.59647Z","caller":"traceutil/trace.go:171","msg":"trace[1273245358] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:522; }","duration":"121.376781ms","start":"2026-07-02T00:24:49.475084Z","end":"2026-07-02T00:24:49.596461Z","steps":["trace[1273245358] 'agreement among raft nodes before linearized reading' (duration: 121.292879ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:24:56.653854Z","caller":"traceutil/trace.go:171","msg":"trace[1058514705] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"124.208389ms","start":"2026-07-02T00:24:56.529619Z","end":"2026-07-02T00:24:56.653827Z","steps":["trace[1058514705] 'process raft request' (duration: 124.037924ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:24:57.222675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.660612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.205\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-07-02T00:24:57.222712Z","caller":"traceutil/trace.go:171","msg":"trace[1505686980] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"113.478564ms","start":"2026-07-02T00:24:57.109203Z","end":"2026-07-02T00:24:57.222681Z","steps":["trace[1505686980] 'process raft request' (duration: 94.526496ms)","trace[1505686980] 'compare' (duration: 18.838525ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:24:57.222883Z","caller":"traceutil/trace.go:171","msg":"trace[1811876292] range","detail":"{range_begin:/registry/masterleases/199.204.45.205; range_end:; response_count:1; response_revision:537; }","duration":"256.880859ms","start":"2026-07-02T00:24:56.965949Z","end":"2026-07-02T00:24:57.22283Z","steps":["trace[1811876292] 'range keys from in-memory index tree' (duration: 256.57592ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:25:06.018544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.444248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-02T00:25:06.018611Z","caller":"traceutil/trace.go:171","msg":"trace[1689249408] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:589; }","duration":"206.559621ms","start":"2026-07-02T00:25:05.812036Z","end":"2026-07-02T00:25:06.018596Z","steps":["trace[1689249408] 'range keys from in-memory index tree' (duration: 206.292494ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:25:08.193138Z","caller":"traceutil/trace.go:171","msg":"trace[841164661] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"140.384811ms","start":"2026-07-02T00:25:08.052719Z","end":"2026-07-02T00:25:08.193104Z","steps":["trace[841164661] 'process raft request' (duration: 140.259057ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:25:11.518201Z","caller":"traceutil/trace.go:171","msg":"trace[1380539095] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"252.55508ms","start":"2026-07-02T00:25:11.26558Z","end":"2026-07-02T00:25:11.518135Z","steps":["trace[1380539095] 'process raft request' (duration: 252.427827ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:25:11.531384Z","caller":"traceutil/trace.go:171","msg":"trace[345231127] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"250.188816ms","start":"2026-07-02T00:25:11.281176Z","end":"2026-07-02T00:25:11.531365Z","steps":["trace[345231127] 'process raft request' (duration: 249.905918ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:25:11.531513Z","caller":"traceutil/trace.go:171","msg":"trace[934708246] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"258.632557ms","start":"2026-07-02T00:25:11.272872Z","end":"2026-07-02T00:25:11.531504Z","steps":["trace[934708246] 'process raft request' (duration: 257.894177ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:25:11.531541Z","caller":"traceutil/trace.go:171","msg":"trace[1362293661] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"246.031552ms","start":"2026-07-02T00:25:11.285484Z","end":"2026-07-02T00:25:11.531515Z","steps":["trace[1362293661] 'process raft request' (duration: 245.635401ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:25:11.531606Z","caller":"traceutil/trace.go:171","msg":"trace[80512584] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"250.538306ms","start":"2026-07-02T00:25:11.281062Z","end":"2026-07-02T00:25:11.5316Z","steps":["trace[80512584] 'process raft request' (duration: 249.934579ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:25:11.531672Z","caller":"traceutil/trace.go:171","msg":"trace[1245589148] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"250.549705ms","start":"2026-07-02T00:25:11.281115Z","end":"2026-07-02T00:25:11.531665Z","steps":["trace[1245589148] 'process raft request' (duration: 249.928348ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:25:11.531732Z","caller":"traceutil/trace.go:171","msg":"trace[1720339858] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"243.070251ms","start":"2026-07-02T00:25:11.288653Z","end":"2026-07-02T00:25:11.531723Z","steps":["trace[1720339858] 'process raft request' (duration: 242.503035ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:25:11.531768Z","caller":"traceutil/trace.go:171","msg":"trace[1040221281] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"184.985862ms","start":"2026-07-02T00:25:11.346775Z","end":"2026-07-02T00:25:11.531761Z","steps":["trace[1040221281] 'process raft request' (duration: 184.530439ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:25:11.531819Z","caller":"traceutil/trace.go:171","msg":"trace[330324839] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"240.690096ms","start":"2026-07-02T00:25:11.291124Z","end":"2026-07-02T00:25:11.531814Z","steps":["trace[330324839] 'process raft request' (duration: 240.07351ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:25:11.531872Z","caller":"traceutil/trace.go:171","msg":"trace[1915953004] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"214.180051ms","start":"2026-07-02T00:25:11.317687Z","end":"2026-07-02T00:25:11.531867Z","steps":["trace[1915953004] 'process raft request' (duration: 213.560614ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:25:11.531579Z","caller":"traceutil/trace.go:171","msg":"trace[737497799] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"258.671688ms","start":"2026-07-02T00:25:11.272902Z","end":"2026-07-02T00:25:11.531573Z","steps":["trace[737497799] 'process raft request' (duration: 258.046711ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:25:12.268059Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5646844468482458094,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-02T00:25:12.375376Z","caller":"traceutil/trace.go:171","msg":"trace[186068094] transaction","detail":"{read_only:false; response_revision:676; number_of_response:1; }","duration":"611.11485ms","start":"2026-07-02T00:25:11.764215Z","end":"2026-07-02T00:25:12.37533Z","steps":["trace[186068094] 'process raft request' (duration: 586.389224ms)","trace[186068094] 'compare' (duration: 24.342206ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T00:25:12.376145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:25:11.764185Z","time spent":"611.294305ms","remote":"127.0.0.1:41932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23066,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T00:25:12.3804Z","caller":"traceutil/trace.go:171","msg":"trace[1016190800] linearizableReadLoop","detail":"{readStateIndex:710; appliedIndex:707; }","duration":"613.279559ms","start":"2026-07-02T00:25:11.767102Z","end":"2026-07-02T00:25:12.380382Z","steps":["trace[1016190800] 'read index received' (duration: 583.597407ms)","trace[1016190800] 'applied index is now lower than readState.Index' (duration: 29.681492ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:25:12.380482Z","caller":"traceutil/trace.go:171","msg":"trace[355895875] transaction","detail":"{read_only:false; response_revision:677; number_of_response:1; }","duration":"604.808808ms","start":"2026-07-02T00:25:11.775664Z","end":"2026-07-02T00:25:12.380473Z","steps":["trace[355895875] 'process raft request' (duration: 604.252813ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:25:12.38054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:25:11.77564Z","time spent":"604.8593ms","remote":"127.0.0.1:41932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":97665,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-02T00:25:12.380877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.130021ms","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-07-02T00:25:12.380974Z","caller":"traceutil/trace.go:171","msg":"trace[1979352861] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:678; }","duration":"175.279535ms","start":"2026-07-02T00:25:12.205667Z","end":"2026-07-02T00:25:12.380947Z","steps":["trace[1979352861] 'agreement among raft nodes before linearized reading' (duration: 175.020028ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:25:12.381057Z","caller":"traceutil/trace.go:171","msg":"trace[1678340954] transaction","detail":"{read_only:false; response_revision:678; number_of_response:1; }","duration":"602.641349ms","start":"2026-07-02T00:25:11.77837Z","end":"2026-07-02T00:25:12.381011Z","steps":["trace[1678340954] 'process raft request' (duration: 601.859277ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:25:12.381354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:25:11.778363Z","time spent":"602.812523ms","remote":"127.0.0.1:41932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":59607,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T00:25:12.38172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"614.608017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-02T00:25:12.381762Z","caller":"traceutil/trace.go:171","msg":"trace[1066445059] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:678; }","duration":"614.683218ms","start":"2026-07-02T00:25:11.767068Z","end":"2026-07-02T00:25:12.381751Z","steps":["trace[1066445059] 'agreement among raft nodes before linearized reading' (duration: 614.153073ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:25:12.381795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:25:11.76705Z","time spent":"614.73585ms","remote":"127.0.0.1:42138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-02T00:25:14.572266Z","caller":"traceutil/trace.go:171","msg":"trace[870039573] transaction","detail":"{read_only:false; response_revision:718; number_of_response:1; }","duration":"172.1271ms","start":"2026-07-02T00:25:14.398698Z","end":"2026-07-02T00:25:14.570825Z","steps":["trace[870039573] 'process raft request' (duration: 75.26984ms)","trace[870039573] 'compare' (duration: 96.370707ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:25:16.540577Z","caller":"traceutil/trace.go:171","msg":"trace[626663753] transaction","detail":"{read_only:false; response_revision:725; number_of_response:1; }","duration":"226.758484ms","start":"2026-07-02T00:25:16.313723Z","end":"2026-07-02T00:25:16.540482Z","steps":["trace[626663753] 'process raft request' (duration: 222.978411ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:25:16.760833Z","caller":"traceutil/trace.go:171","msg":"trace[789885691] transaction","detail":"{read_only:false; response_revision:728; number_of_response:1; }","duration":"147.947238ms","start":"2026-07-02T00:25:16.612854Z","end":"2026-07-02T00:25:16.760801Z","steps":["trace[789885691] 'process raft request' (duration: 147.877246ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:25:16.760862Z","caller":"traceutil/trace.go:171","msg":"trace[1955240151] transaction","detail":"{read_only:false; response_revision:727; number_of_response:1; }","duration":"180.553741ms","start":"2026-07-02T00:25:16.580266Z","end":"2026-07-02T00:25:16.76082Z","steps":["trace[1955240151] 'process raft request' (duration: 136.872045ms)","trace[1955240151] 'compare' (duration: 43.360847ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T00:25:19.772473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.6992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-07-02T00:25:19.772604Z","caller":"traceutil/trace.go:171","msg":"trace[1544315037] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:747; }","duration":"155.883535ms","start":"2026-07-02T00:25:19.616684Z","end":"2026-07-02T00:25:19.772567Z","steps":["trace[1544315037] 'range keys from in-memory index tree' (duration: 155.428043ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:25:20.014899Z","caller":"traceutil/trace.go:171","msg":"trace[932703659] transaction","detail":"{read_only:false; response_revision:748; number_of_response:1; }","duration":"238.764363ms","start":"2026-07-02T00:25:19.776078Z","end":"2026-07-02T00:25:20.014843Z","steps":["trace[932703659] 'process raft request' (duration: 238.233659ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:25:20.300551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.365845ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T00:25:20.301301Z","caller":"traceutil/trace.go:171","msg":"trace[393506321] transaction","detail":"{read_only:false; response_revision:749; number_of_response:1; }","duration":"524.739049ms","start":"2026-07-02T00:25:19.776452Z","end":"2026-07-02T00:25:20.301191Z","steps":["trace[393506321] 'process raft request' (duration: 369.630984ms)","trace[393506321] 'compare' (duration: 154.144899ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:25:20.301422Z","caller":"traceutil/trace.go:171","msg":"trace[1112568381] linearizableReadLoop","detail":"{readStateIndex:783; appliedIndex:781; }","duration":"460.147091ms","start":"2026-07-02T00:25:19.841228Z","end":"2026-07-02T00:25:20.301375Z","steps":["trace[1112568381] 'read index received' (duration: 173.509528ms)","trace[1112568381] 'applied index is now lower than readState.Index' (duration: 286.636683ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T00:25:20.301494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:25:19.776428Z","time spent":"524.976655ms","remote":"127.0.0.1:42138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T00:25:20.301894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.675176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T00:25:20.301957Z","caller":"traceutil/trace.go:171","msg":"trace[33095883] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:750; }","duration":"460.780208ms","start":"2026-07-02T00:25:19.84115Z","end":"2026-07-02T00:25:20.30193Z","steps":["trace[33095883] 'agreement among raft nodes before linearized reading' (duration: 460.709536ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:25:20.30199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:25:19.841117Z","time spent":"460.866701ms","remote":"127.0.0.1:41856","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-02T00:25:20.302137Z","caller":"traceutil/trace.go:171","msg":"trace[96562968] transaction","detail":"{read_only:false; response_revision:750; number_of_response:1; }","duration":"363.429205ms","start":"2026-07-02T00:25:19.938697Z","end":"2026-07-02T00:25:20.302126Z","steps":["trace[96562968] 'process raft request' (duration: 362.17436ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:25:20.302206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:25:19.938647Z","time spent":"363.521328ms","remote":"127.0.0.1:41980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T00:25:20.302364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.369589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-lng9b\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-07-02T00:25:20.303086Z","caller":"traceutil/trace.go:171","msg":"trace[4569127] range","detail":"{range_begin:/registry/pods/kube-system/cilium-lng9b; range_end:; response_count:1; response_revision:750; }","duration":"161.180371ms","start":"2026-07-02T00:25:20.141889Z","end":"2026-07-02T00:25:20.303069Z","steps":["trace[4569127] 'agreement among raft nodes before linearized reading' (duration: 160.270577ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:25:20.635543Z","caller":"traceutil/trace.go:171","msg":"trace[820258272] transaction","detail":"{read_only:false; response_revision:751; number_of_response:1; }","duration":"315.030589ms","start":"2026-07-02T00:25:20.320479Z","end":"2026-07-02T00:25:20.63551Z","steps":["trace[820258272] 'process raft request' (duration: 304.46962ms)","trace[820258272] 'compare' (duration: 10.382614ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T00:25:20.635802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:25:20.320463Z","time spent":"315.177712ms","remote":"127.0.0.1:42062","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T00:25:20.66225Z","caller":"traceutil/trace.go:171","msg":"trace[1576375881] linearizableReadLoop","detail":"{readStateIndex:786; appliedIndex:784; }","duration":"186.847741ms","start":"2026-07-02T00:25:20.47538Z","end":"2026-07-02T00:25:20.662228Z","steps":["trace[1576375881] 'read index received' (duration: 149.603182ms)","trace[1576375881] 'applied index is now lower than readState.Index' (duration: 37.243159ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:25:20.662337Z","caller":"traceutil/trace.go:171","msg":"trace[383519174] transaction","detail":"{read_only:false; response_revision:752; number_of_response:1; }","duration":"300.44949ms","start":"2026-07-02T00:25:20.361864Z","end":"2026-07-02T00:25:20.662313Z","steps":["trace[383519174] 'process raft request' (duration: 300.235115ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:25:20.662457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:25:20.36184Z","time spent":"300.556263ms","remote":"127.0.0.1:42110","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-02T00:25:20.662703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.310754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T00:25:20.662801Z","caller":"traceutil/trace.go:171","msg":"trace[1795228320] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:752; }","duration":"187.419437ms","start":"2026-07-02T00:25:20.475321Z","end":"2026-07-02T00:25:20.66274Z","steps":["trace[1795228320] 'agreement among raft nodes before linearized reading' (duration: 187.111359ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:25:21.854587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.09563519s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T00:25:21.854737Z","caller":"traceutil/trace.go:171","msg":"trace[1153052510] linearizableReadLoop","detail":"{readStateIndex:788; appliedIndex:787; }","duration":"1.164256358s","start":"2026-07-02T00:25:20.690456Z","end":"2026-07-02T00:25:21.854712Z","steps":["trace[1153052510] 'read index received' (duration: 68.33917ms)","trace[1153052510] 'applied index is now lower than readState.Index' (duration: 1.095915108s)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:25:21.854763Z","caller":"traceutil/trace.go:171","msg":"trace[1193630371] transaction","detail":"{read_only:false; response_revision:754; number_of_response:1; }","duration":"1.171433084s","start":"2026-07-02T00:25:20.683293Z","end":"2026-07-02T00:25:21.854726Z","steps":["trace[1193630371] 'process raft request' (duration: 75.514366ms)","trace[1193630371] 'compare' (duration: 1.095446865s)"],"step_count":2} {"level":"warn","ts":"2026-07-02T00:25:21.854878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.164413162s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/envoy-gateway-system/\" range_end:\"/registry/limitranges/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T00:25:21.854915Z","caller":"traceutil/trace.go:171","msg":"trace[895011756] range","detail":"{range_begin:/registry/limitranges/envoy-gateway-system/; range_end:/registry/limitranges/envoy-gateway-system0; response_count:0; response_revision:754; }","duration":"1.164461783s","start":"2026-07-02T00:25:20.690439Z","end":"2026-07-02T00:25:21.854901Z","steps":["trace[895011756] 'agreement among raft nodes before linearized reading' (duration: 1.164387571s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:25:21.854942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:25:20.683271Z","time spent":"1.171561687s","remote":"127.0.0.1:42138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T00:25:21.854971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:25:20.690431Z","time spent":"1.164530474s","remote":"127.0.0.1:42014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":27,"request content":"key:\"/registry/limitranges/envoy-gateway-system/\" range_end:\"/registry/limitranges/envoy-gateway-system0\" "} {"level":"warn","ts":"2026-07-02T00:25:21.855283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.455242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-02T00:25:21.855333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.061652349s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-07-02T00:25:21.855353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"448.347397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T00:25:21.855375Z","caller":"traceutil/trace.go:171","msg":"trace[1783441315] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:754; }","duration":"1.061739412s","start":"2026-07-02T00:25:20.79362Z","end":"2026-07-02T00:25:21.85536Z","steps":["trace[1783441315] 'agreement among raft nodes before linearized reading' (duration: 1.061606929s)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:25:21.855374Z","caller":"traceutil/trace.go:171","msg":"trace[465029367] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:754; }","duration":"379.575835ms","start":"2026-07-02T00:25:21.475774Z","end":"2026-07-02T00:25:21.85535Z","steps":["trace[465029367] 'agreement among raft nodes before linearized reading' (duration: 379.460852ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:25:21.855359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.346114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T00:25:21.855406Z","caller":"traceutil/trace.go:171","msg":"trace[1866797558] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:754; }","duration":"448.44952ms","start":"2026-07-02T00:25:21.406941Z","end":"2026-07-02T00:25:21.85539Z","steps":["trace[1866797558] 'agreement among raft nodes before linearized reading' (duration: 448.337257ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:25:21.855412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:25:20.793596Z","time spent":"1.061808964s","remote":"127.0.0.1:42138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-02T00:25:21.855415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:25:21.475754Z","time spent":"379.653817ms","remote":"127.0.0.1:41856","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-02T00:25:21.85543Z","caller":"traceutil/trace.go:171","msg":"trace[634520311] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:754; }","duration":"195.507619ms","start":"2026-07-02T00:25:21.659904Z","end":"2026-07-02T00:25:21.855411Z","steps":["trace[634520311] 'agreement among raft nodes before linearized reading' (duration: 195.372315ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:25:21.855443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:25:21.40692Z","time spent":"448.514481ms","remote":"127.0.0.1:42188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":27,"request content":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true "} {"level":"warn","ts":"2026-07-02T00:25:21.855425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.468285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-02T00:25:21.855504Z","caller":"traceutil/trace.go:171","msg":"trace[2084387403] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:754; }","duration":"503.595819ms","start":"2026-07-02T00:25:21.351888Z","end":"2026-07-02T00:25:21.855483Z","steps":["trace[2084387403] 'agreement among raft nodes before linearized reading' (duration: 503.468175ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:25:21.855544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:25:21.351865Z","time spent":"503.667581ms","remote":"127.0.0.1:42404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":1,"response size":29,"request content":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true "} {"level":"info","ts":"2026-07-02T00:25:21.973723Z","caller":"traceutil/trace.go:171","msg":"trace[1342348187] transaction","detail":"{read_only:false; response_revision:756; number_of_response:1; }","duration":"113.737591ms","start":"2026-07-02T00:25:21.859957Z","end":"2026-07-02T00:25:21.973694Z","steps":["trace[1342348187] 'process raft request' (duration: 102.975017ms)","trace[1342348187] 'compare' (duration: 10.589449ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:25:22.408513Z","caller":"traceutil/trace.go:171","msg":"trace[913565499] transaction","detail":"{read_only:false; response_revision:765; number_of_response:1; }","duration":"148.445941ms","start":"2026-07-02T00:25:22.260036Z","end":"2026-07-02T00:25:22.408482Z","steps":["trace[913565499] 'process raft request' (duration: 96.12184ms)","trace[913565499] 'compare' (duration: 52.126066ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:25:22.408508Z","caller":"traceutil/trace.go:171","msg":"trace[787701318] linearizableReadLoop","detail":"{readStateIndex:800; appliedIndex:799; }","duration":"102.801323ms","start":"2026-07-02T00:25:22.30567Z","end":"2026-07-02T00:25:22.408471Z","steps":["trace[787701318] 'read index received' (duration: 50.42912ms)","trace[787701318] 'applied index is now lower than readState.Index' (duration: 52.370693ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T00:25:22.408912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.217894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-07-02T00:25:22.408981Z","caller":"traceutil/trace.go:171","msg":"trace[1841831097] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:765; }","duration":"103.332948ms","start":"2026-07-02T00:25:22.305633Z","end":"2026-07-02T00:25:22.408966Z","steps":["trace[1841831097] 'agreement among raft nodes before linearized reading' (duration: 102.955097ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:25:23.505496Z","caller":"traceutil/trace.go:171","msg":"trace[664229689] linearizableReadLoop","detail":"{readStateIndex:823; appliedIndex:822; }","duration":"223.70304ms","start":"2026-07-02T00:25:23.281766Z","end":"2026-07-02T00:25:23.505469Z","steps":["trace[664229689] 'read index received' (duration: 178.73452ms)","trace[664229689] 'applied index is now lower than readState.Index' (duration: 44.96729ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T00:25:23.505862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.06584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T00:25:23.505913Z","caller":"traceutil/trace.go:171","msg":"trace[1015217405] transaction","detail":"{read_only:false; response_revision:787; number_of_response:1; }","duration":"228.844762ms","start":"2026-07-02T00:25:23.277039Z","end":"2026-07-02T00:25:23.505884Z","steps":["trace[1015217405] 'process raft request' (duration: 183.552792ms)","trace[1015217405] 'compare' (duration: 44.714884ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:25:23.505959Z","caller":"traceutil/trace.go:171","msg":"trace[1228419529] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:787; }","duration":"224.191744ms","start":"2026-07-02T00:25:23.281733Z","end":"2026-07-02T00:25:23.505925Z","steps":["trace[1228419529] 'agreement among raft nodes before linearized reading' (duration: 224.04589ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:25:23.506161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.643016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-02T00:25:23.506322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.171939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T00:25:23.506365Z","caller":"traceutil/trace.go:171","msg":"trace[521213721] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:787; }","duration":"199.239832ms","start":"2026-07-02T00:25:23.307114Z","end":"2026-07-02T00:25:23.506354Z","steps":["trace[521213721] 'agreement among raft nodes before linearized reading' (duration: 199.17439ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:25:23.506337Z","caller":"traceutil/trace.go:171","msg":"trace[2026556191] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:787; }","duration":"152.806011ms","start":"2026-07-02T00:25:23.353455Z","end":"2026-07-02T00:25:23.506261Z","steps":["trace[2026556191] 'agreement among raft nodes before linearized reading' (duration: 152.454691ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:25:23.506484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.453115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-02T00:25:23.50648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.608571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-02T00:25:23.506617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.478986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-02T00:25:23.506679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.366999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T00:25:23.506712Z","caller":"traceutil/trace.go:171","msg":"trace[2070366990] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:787; }","duration":"161.865188ms","start":"2026-07-02T00:25:23.344808Z","end":"2026-07-02T00:25:23.506673Z","steps":["trace[2070366990] 'agreement among raft nodes before linearized reading' (duration: 161.588561ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:25:23.506736Z","caller":"traceutil/trace.go:171","msg":"trace[1714705215] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:787; }","duration":"224.493653ms","start":"2026-07-02T00:25:23.282229Z","end":"2026-07-02T00:25:23.506723Z","steps":["trace[1714705215] 'agreement among raft nodes before linearized reading' (duration: 224.370859ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:25:23.506783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.547607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T00:25:23.506895Z","caller":"traceutil/trace.go:171","msg":"trace[1176400252] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:787; }","duration":"200.699081ms","start":"2026-07-02T00:25:23.306185Z","end":"2026-07-02T00:25:23.506884Z","steps":["trace[1176400252] 'agreement among raft nodes before linearized reading' (duration: 200.568098ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:25:23.50673Z","caller":"traceutil/trace.go:171","msg":"trace[82263476] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:787; }","duration":"200.603318ms","start":"2026-07-02T00:25:23.306106Z","end":"2026-07-02T00:25:23.506709Z","steps":["trace[82263476] 'agreement among raft nodes before linearized reading' (duration: 200.482175ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:25:23.506558Z","caller":"traceutil/trace.go:171","msg":"trace[845319833] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:787; }","duration":"162.576349ms","start":"2026-07-02T00:25:23.343964Z","end":"2026-07-02T00:25:23.50654Z","steps":["trace[845319833] 'agreement among raft nodes before linearized reading' (duration: 162.443135ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:25:23.507292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.127272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T00:25:23.507342Z","caller":"traceutil/trace.go:171","msg":"trace[919238076] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:787; }","duration":"225.52641ms","start":"2026-07-02T00:25:23.281803Z","end":"2026-07-02T00:25:23.50733Z","steps":["trace[919238076] 'agreement among raft nodes before linearized reading' (duration: 224.058ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:25:24.935179Z","caller":"traceutil/trace.go:171","msg":"trace[1260417176] transaction","detail":"{read_only:false; response_revision:808; number_of_response:1; }","duration":"130.791398ms","start":"2026-07-02T00:25:24.804363Z","end":"2026-07-02T00:25:24.935154Z","steps":["trace[1260417176] 'process raft request' (duration: 105.158507ms)","trace[1260417176] 'compare' (duration: 25.520618ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:25:24.97321Z","caller":"traceutil/trace.go:171","msg":"trace[2138961533] transaction","detail":"{read_only:false; response_revision:809; number_of_response:1; }","duration":"129.627366ms","start":"2026-07-02T00:25:24.843557Z","end":"2026-07-02T00:25:24.973185Z","steps":["trace[2138961533] 'process raft request' (duration: 129.515713ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:25:25.090809Z","caller":"traceutil/trace.go:171","msg":"trace[391033166] transaction","detail":"{read_only:false; response_revision:810; number_of_response:1; }","duration":"108.970621ms","start":"2026-07-02T00:25:24.981801Z","end":"2026-07-02T00:25:25.090772Z","steps":["trace[391033166] 'process raft request' (duration: 108.437946ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:25:34.081316Z","caller":"traceutil/trace.go:171","msg":"trace[77282081] transaction","detail":"{read_only:false; response_revision:898; number_of_response:1; }","duration":"158.172987ms","start":"2026-07-02T00:25:33.923115Z","end":"2026-07-02T00:25:34.081288Z","steps":["trace[77282081] 'process raft request' (duration: 157.833268ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:25:36.964675Z","caller":"traceutil/trace.go:171","msg":"trace[1258913895] transaction","detail":"{read_only:false; response_revision:915; number_of_response:1; }","duration":"353.357496ms","start":"2026-07-02T00:25:36.61128Z","end":"2026-07-02T00:25:36.964637Z","steps":["trace[1258913895] 'process raft request' (duration: 353.14405ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:25:36.964908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:25:36.611243Z","time spent":"353.548661ms","remote":"127.0.0.1:42138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T00:25:37.175728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.962362ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T00:25:37.175844Z","caller":"traceutil/trace.go:171","msg":"trace[1421769388] transaction","detail":"{read_only:false; response_revision:916; number_of_response:1; }","duration":"173.571227ms","start":"2026-07-02T00:25:37.002252Z","end":"2026-07-02T00:25:37.175823Z","steps":["trace[1421769388] 'process raft request' (duration: 46.398649ms)","trace[1421769388] 'compare' (duration: 126.825489ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:26:08.481421Z","caller":"traceutil/trace.go:171","msg":"trace[1730209065] transaction","detail":"{read_only:false; response_revision:1113; number_of_response:1; }","duration":"131.97323ms","start":"2026-07-02T00:26:08.349421Z","end":"2026-07-02T00:26:08.481394Z","steps":["trace[1730209065] 'process raft request' (duration: 130.628083ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:26:08.48216Z","caller":"traceutil/trace.go:171","msg":"trace[1862456613] transaction","detail":"{read_only:false; response_revision:1114; number_of_response:1; }","duration":"132.103144ms","start":"2026-07-02T00:26:08.350042Z","end":"2026-07-02T00:26:08.482145Z","steps":["trace[1862456613] 'process raft request' (duration: 131.925369ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:26:11.527312Z","caller":"traceutil/trace.go:171","msg":"trace[410638506] transaction","detail":"{read_only:false; response_revision:1126; number_of_response:1; }","duration":"400.637668ms","start":"2026-07-02T00:26:11.126651Z","end":"2026-07-02T00:26:11.527289Z","steps":["trace[410638506] 'process raft request' (duration: 400.493674ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:26:11.527475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:26:11.126627Z","time spent":"400.756642ms","remote":"127.0.0.1:42138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T00:26:12.597427Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.070210774s","expected-duration":"1s"} {"level":"warn","ts":"2026-07-02T00:26:12.617275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:26:11.847915Z","time spent":"769.351294ms","remote":"127.0.0.1:59646","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-07-02T00:26:12.617771Z","caller":"traceutil/trace.go:171","msg":"trace[1059584588] linearizableReadLoop","detail":"{readStateIndex:1173; appliedIndex:1171; }","duration":"1.14322735s","start":"2026-07-02T00:26:11.474516Z","end":"2026-07-02T00:26:12.617743Z","steps":["trace[1059584588] 'read index received' (duration: 52.729192ms)","trace[1059584588] 'applied index is now lower than readState.Index' (duration: 1.090496988s)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:26:12.617861Z","caller":"traceutil/trace.go:171","msg":"trace[343736825] transaction","detail":"{read_only:false; response_revision:1127; number_of_response:1; }","duration":"1.191398359s","start":"2026-07-02T00:26:11.42643Z","end":"2026-07-02T00:26:12.617829Z","steps":["trace[343736825] 'process raft request' (duration: 1.171183686s)","trace[343736825] 'compare' (duration: 19.542084ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T00:26:12.617904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.143369014s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T00:26:12.617942Z","caller":"traceutil/trace.go:171","msg":"trace[591855439] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1127; }","duration":"1.143447777s","start":"2026-07-02T00:26:11.474484Z","end":"2026-07-02T00:26:12.617932Z","steps":["trace[591855439] 'agreement among raft nodes before linearized reading' (duration: 1.143374725s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:26:12.61797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:26:11.474469Z","time spent":"1.143493588s","remote":"127.0.0.1:41856","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-07-02T00:26:12.618016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:26:11.426409Z","time spent":"1.191506201s","remote":"127.0.0.1:42138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T00:26:12.829847Z","caller":"traceutil/trace.go:171","msg":"trace[1523178970] transaction","detail":"{read_only:false; response_revision:1128; number_of_response:1; }","duration":"974.386822ms","start":"2026-07-02T00:26:11.855422Z","end":"2026-07-02T00:26:12.829809Z","steps":["trace[1523178970] 'process raft request' (duration: 971.816062ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:26:12.83006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:26:11.855406Z","time spent":"974.548507ms","remote":"127.0.0.1:42138","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-07-02T00:26:12.831357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.493734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-02T00:26:12.831397Z","caller":"traceutil/trace.go:171","msg":"trace[650827439] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1128; }","duration":"336.575496ms","start":"2026-07-02T00:26:12.494812Z","end":"2026-07-02T00:26:12.831388Z","steps":["trace[650827439] 'agreement among raft nodes before linearized reading' (duration: 336.447503ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:26:12.831233Z","caller":"traceutil/trace.go:171","msg":"trace[1027398461] linearizableReadLoop","detail":"{readStateIndex:1175; appliedIndex:1173; }","duration":"213.384477ms","start":"2026-07-02T00:26:12.617831Z","end":"2026-07-02T00:26:12.831216Z","steps":["trace[1027398461] 'read index received' (duration: 209.320265ms)","trace[1027398461] 'applied index is now lower than readState.Index' (duration: 4.063342ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T00:26:12.83142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:26:12.494789Z","time spent":"336.625348ms","remote":"127.0.0.1:42138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-02T00:26:12.831442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.635058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-07-02T00:26:12.831474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"474.319354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-02T00:26:12.831511Z","caller":"traceutil/trace.go:171","msg":"trace[725379112] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1128; }","duration":"336.748241ms","start":"2026-07-02T00:26:12.494747Z","end":"2026-07-02T00:26:12.831495Z","steps":["trace[725379112] 'agreement among raft nodes before linearized reading' (duration: 336.557276ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:26:12.831549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:26:12.49473Z","time spent":"336.811483ms","remote":"127.0.0.1:42138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-02T00:26:12.831552Z","caller":"traceutil/trace.go:171","msg":"trace[1500741390] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1128; }","duration":"474.434967ms","start":"2026-07-02T00:26:12.357097Z","end":"2026-07-02T00:26:12.831532Z","steps":["trace[1500741390] 'agreement among raft nodes before linearized reading' (duration: 474.240662ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:26:12.831554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.353838931s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-07-02T00:26:12.831607Z","caller":"traceutil/trace.go:171","msg":"trace[593558636] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1128; }","duration":"1.353909443s","start":"2026-07-02T00:26:11.477687Z","end":"2026-07-02T00:26:12.831597Z","steps":["trace[593558636] 'agreement among raft nodes before linearized reading' (duration: 1.353773589s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:26:12.831601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:26:12.357076Z","time spent":"474.51256ms","remote":"127.0.0.1:42138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-02T00:26:12.831634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:26:11.477683Z","time spent":"1.353944995s","remote":"127.0.0.1:42138","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":"warn","ts":"2026-07-02T00:26:12.831746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.989839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T00:26:12.831764Z","caller":"traceutil/trace.go:171","msg":"trace[578875776] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1128; }","duration":"212.029069ms","start":"2026-07-02T00:26:12.619729Z","end":"2026-07-02T00:26:12.831758Z","steps":["trace[578875776] 'agreement among raft nodes before linearized reading' (duration: 212.001109ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:26:35.926775Z","caller":"traceutil/trace.go:171","msg":"trace[163410084] transaction","detail":"{read_only:false; response_revision:1205; number_of_response:1; }","duration":"276.461005ms","start":"2026-07-02T00:26:35.650284Z","end":"2026-07-02T00:26:35.926745Z","steps":["trace[163410084] 'process raft request' (duration: 276.250379ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:26:36.691024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"644.899594ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T00:26:36.691128Z","caller":"traceutil/trace.go:171","msg":"trace[312723836] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1205; }","duration":"645.13165ms","start":"2026-07-02T00:26:36.045978Z","end":"2026-07-02T00:26:36.691109Z","steps":["trace[312723836] 'count revisions from in-memory index tree' (duration: 644.748039ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:26:36.691176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:26:36.045956Z","time spent":"645.207312ms","remote":"127.0.0.1:39014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-07-02T00:26:37.464916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.860727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-02T00:26:37.464996Z","caller":"traceutil/trace.go:171","msg":"trace[1149901171] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:1211; }","duration":"141.9931ms","start":"2026-07-02T00:26:37.322986Z","end":"2026-07-02T00:26:37.464979Z","steps":["trace[1149901171] 'count revisions from in-memory index tree' (duration: 141.778035ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:26:39.536489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.540002ms","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-07-02T00:26:39.536572Z","caller":"traceutil/trace.go:171","msg":"trace[672429715] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1215; }","duration":"349.651375ms","start":"2026-07-02T00:26:39.186887Z","end":"2026-07-02T00:26:39.536539Z","steps":["trace[672429715] 'range keys from in-memory index tree' (duration: 349.368307ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:26:39.536608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:26:39.186866Z","time spent":"349.733447ms","remote":"127.0.0.1:42138","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":"warn","ts":"2026-07-02T00:26:39.536636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.211038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-07-02T00:26:39.536705Z","caller":"traceutil/trace.go:171","msg":"trace[34522274] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1215; }","duration":"332.346872ms","start":"2026-07-02T00:26:39.204341Z","end":"2026-07-02T00:26:39.536688Z","steps":["trace[34522274] 'range keys from in-memory index tree' (duration: 331.687003ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:26:39.536745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:26:39.20432Z","time spent":"332.416074ms","remote":"127.0.0.1:42138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":512,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-07-02T00:26:39.777783Z","caller":"traceutil/trace.go:171","msg":"trace[424111749] transaction","detail":"{read_only:false; response_revision:1216; number_of_response:1; }","duration":"236.834712ms","start":"2026-07-02T00:26:39.540904Z","end":"2026-07-02T00:26:39.777739Z","steps":["trace[424111749] 'process raft request' (duration: 236.687138ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:26:39.828707Z","caller":"traceutil/trace.go:171","msg":"trace[1271755984] transaction","detail":"{read_only:false; response_revision:1218; number_of_response:1; }","duration":"286.608682ms","start":"2026-07-02T00:26:39.542081Z","end":"2026-07-02T00:26:39.828689Z","steps":["trace[1271755984] 'process raft request' (duration: 286.565871ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:26:39.82881Z","caller":"traceutil/trace.go:171","msg":"trace[456540438] transaction","detail":"{read_only:false; response_revision:1217; number_of_response:1; }","duration":"287.465825ms","start":"2026-07-02T00:26:39.5413Z","end":"2026-07-02T00:26:39.828766Z","steps":["trace[456540438] 'process raft request' (duration: 287.237429ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:26:40.59868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.468088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T00:26:40.598765Z","caller":"traceutil/trace.go:171","msg":"trace[1904972478] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:1219; }","duration":"316.601971ms","start":"2026-07-02T00:26:40.282144Z","end":"2026-07-02T00:26:40.598746Z","steps":["trace[1904972478] 'count revisions from in-memory index tree' (duration: 316.381165ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:26:40.598703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.653612ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-02T00:26:40.598828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:26:40.282128Z","time spent":"316.687464ms","remote":"127.0.0.1:39040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true "} {"level":"info","ts":"2026-07-02T00:26:40.598834Z","caller":"traceutil/trace.go:171","msg":"trace[1607430572] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1219; }","duration":"294.802736ms","start":"2026-07-02T00:26:40.304014Z","end":"2026-07-02T00:26:40.598817Z","steps":["trace[1607430572] 'range keys from in-memory index tree' (duration: 294.636992ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:26:41.211415Z","caller":"traceutil/trace.go:171","msg":"trace[1002890109] linearizableReadLoop","detail":"{readStateIndex:1273; appliedIndex:1272; }","duration":"104.767753ms","start":"2026-07-02T00:26:41.106625Z","end":"2026-07-02T00:26:41.211393Z","steps":["trace[1002890109] 'read index received' (duration: 104.64479ms)","trace[1002890109] 'applied index is now lower than readState.Index' (duration: 121.793µs)"],"step_count":2} {"level":"warn","ts":"2026-07-02T00:26:41.211597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.950378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-07-02T00:26:41.211636Z","caller":"traceutil/trace.go:171","msg":"trace[1261091550] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1221; }","duration":"105.02679ms","start":"2026-07-02T00:26:41.106598Z","end":"2026-07-02T00:26:41.211625Z","steps":["trace[1261091550] 'agreement among raft nodes before linearized reading' (duration: 104.884076ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:26:41.211692Z","caller":"traceutil/trace.go:171","msg":"trace[207308207] transaction","detail":"{read_only:false; response_revision:1221; number_of_response:1; }","duration":"139.43007ms","start":"2026-07-02T00:26:41.072231Z","end":"2026-07-02T00:26:41.211661Z","steps":["trace[207308207] 'process raft request' (duration: 139.014399ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:26:58.605214Z","caller":"traceutil/trace.go:171","msg":"trace[183975544] transaction","detail":"{read_only:false; response_revision:1329; number_of_response:1; }","duration":"474.403974ms","start":"2026-07-02T00:26:58.130796Z","end":"2026-07-02T00:26:58.6052Z","steps":["trace[183975544] 'process raft request' (duration: 474.320712ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:26:58.605335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:26:58.130783Z","time spent":"474.497376ms","remote":"127.0.0.1:42138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T00:26:59.245826Z","caller":"traceutil/trace.go:171","msg":"trace[1248455613] transaction","detail":"{read_only:false; response_revision:1330; number_of_response:1; }","duration":"299.387571ms","start":"2026-07-02T00:26:58.946416Z","end":"2026-07-02T00:26:59.245803Z","steps":["trace[1248455613] 'process raft request' (duration: 299.242627ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:27:11.428963Z","caller":"traceutil/trace.go:171","msg":"trace[531435594] transaction","detail":"{read_only:false; response_revision:1370; number_of_response:1; }","duration":"140.352506ms","start":"2026-07-02T00:27:11.288579Z","end":"2026-07-02T00:27:11.428932Z","steps":["trace[531435594] 'process raft request' (duration: 140.125909ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:27:12.298967Z","caller":"traceutil/trace.go:171","msg":"trace[281807026] transaction","detail":"{read_only:false; response_revision:1374; number_of_response:1; }","duration":"187.523425ms","start":"2026-07-02T00:27:12.111421Z","end":"2026-07-02T00:27:12.298945Z","steps":["trace[281807026] 'process raft request' (duration: 187.382711ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:27:13.618226Z","caller":"traceutil/trace.go:171","msg":"trace[1334955308] linearizableReadLoop","detail":"{readStateIndex:1438; appliedIndex:1437; }","duration":"152.737634ms","start":"2026-07-02T00:27:13.465463Z","end":"2026-07-02T00:27:13.6182Z","steps":["trace[1334955308] 'read index received' (duration: 71.433622ms)","trace[1334955308] 'applied index is now lower than readState.Index' (duration: 81.302992ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:27:13.618272Z","caller":"traceutil/trace.go:171","msg":"trace[96149740] transaction","detail":"{read_only:false; response_revision:1377; number_of_response:1; }","duration":"155.104498ms","start":"2026-07-02T00:27:13.463139Z","end":"2026-07-02T00:27:13.618243Z","steps":["trace[96149740] 'process raft request' (duration: 73.825987ms)","trace[96149740] 'compare' (duration: 81.136567ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T00:27:13.618462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.97294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-02T00:27:13.618498Z","caller":"traceutil/trace.go:171","msg":"trace[1316417864] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1377; }","duration":"153.048892ms","start":"2026-07-02T00:27:13.465436Z","end":"2026-07-02T00:27:13.618485Z","steps":["trace[1316417864] 'agreement among raft nodes before linearized reading' (duration: 152.900338ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:27:13.618526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.352452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T00:27:13.618606Z","caller":"traceutil/trace.go:171","msg":"trace[793013224] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1377; }","duration":"145.474325ms","start":"2026-07-02T00:27:13.473109Z","end":"2026-07-02T00:27:13.618583Z","steps":["trace[793013224] 'agreement among raft nodes before linearized reading' (duration: 145.335251ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:27:14.067602Z","caller":"traceutil/trace.go:171","msg":"trace[1301157324] transaction","detail":"{read_only:false; response_revision:1378; number_of_response:1; }","duration":"444.590489ms","start":"2026-07-02T00:27:13.622982Z","end":"2026-07-02T00:27:14.067573Z","steps":["trace[1301157324] 'process raft request' (duration: 444.368213ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:27:14.067907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:27:13.622965Z","time spent":"444.730012ms","remote":"127.0.0.1:42138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T00:27:14.068172Z","caller":"traceutil/trace.go:171","msg":"trace[520909160] linearizableReadLoop","detail":"{readStateIndex:1440; appliedIndex:1438; }","duration":"110.209611ms","start":"2026-07-02T00:27:13.957941Z","end":"2026-07-02T00:27:14.068151Z","steps":["trace[520909160] 'read index received' (duration: 109.375658ms)","trace[520909160] 'applied index is now lower than readState.Index' (duration: 833.472µs)"],"step_count":2} {"level":"warn","ts":"2026-07-02T00:27:14.069712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.66828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-02T00:27:14.069786Z","caller":"traceutil/trace.go:171","msg":"trace[1770608558] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1379; }","duration":"111.832566ms","start":"2026-07-02T00:27:13.957934Z","end":"2026-07-02T00:27:14.069767Z","steps":["trace[1770608558] 'agreement among raft nodes before linearized reading' (duration: 111.63033ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:27:14.069838Z","caller":"traceutil/trace.go:171","msg":"trace[836286222] transaction","detail":"{read_only:false; response_revision:1379; number_of_response:1; }","duration":"242.64271ms","start":"2026-07-02T00:27:13.827169Z","end":"2026-07-02T00:27:14.069811Z","steps":["trace[836286222] 'process raft request' (duration: 240.899482ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:27:17.06567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.780851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-07-02T00:27:17.065748Z","caller":"traceutil/trace.go:171","msg":"trace[1303903112] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1407; }","duration":"318.910084ms","start":"2026-07-02T00:27:16.746819Z","end":"2026-07-02T00:27:17.065729Z","steps":["trace[1303903112] 'range keys from in-memory index tree' (duration: 318.614576ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:27:17.065819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:27:16.746779Z","time spent":"319.030118ms","remote":"127.0.0.1:42138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-02T00:27:17.066055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.503693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T00:27:17.066098Z","caller":"traceutil/trace.go:171","msg":"trace[98553625] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:1407; }","duration":"307.579175ms","start":"2026-07-02T00:27:16.758506Z","end":"2026-07-02T00:27:17.066085Z","steps":["trace[98553625] 'count revisions from in-memory index tree' (duration: 307.435141ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:27:17.066129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:27:16.758489Z","time spent":"307.631286ms","remote":"127.0.0.1:39128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"info","ts":"2026-07-02T00:27:17.631996Z","caller":"traceutil/trace.go:171","msg":"trace[428904609] transaction","detail":"{read_only:false; response_revision:1410; number_of_response:1; }","duration":"163.474666ms","start":"2026-07-02T00:27:17.468499Z","end":"2026-07-02T00:27:17.631974Z","steps":["trace[428904609] 'process raft request' (duration: 163.327342ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:27:18.497825Z","caller":"traceutil/trace.go:171","msg":"trace[1810932070] transaction","detail":"{read_only:false; response_revision:1421; number_of_response:1; }","duration":"110.048977ms","start":"2026-07-02T00:27:18.387741Z","end":"2026-07-02T00:27:18.49779Z","steps":["trace[1810932070] 'process raft request' (duration: 109.917933ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:27:18.497917Z","caller":"traceutil/trace.go:171","msg":"trace[1162185047] transaction","detail":"{read_only:false; response_revision:1420; number_of_response:1; }","duration":"111.906998ms","start":"2026-07-02T00:27:18.38594Z","end":"2026-07-02T00:27:18.497847Z","steps":["trace[1162185047] 'process raft request' (duration: 109.458181ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:27:19.193471Z","caller":"traceutil/trace.go:171","msg":"trace[2038781653] transaction","detail":"{read_only:false; response_revision:1422; number_of_response:1; }","duration":"103.011875ms","start":"2026-07-02T00:27:19.090434Z","end":"2026-07-02T00:27:19.193446Z","steps":["trace[2038781653] 'process raft request' (duration: 102.870211ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:27:19.923483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.47154ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T00:27:19.923661Z","caller":"traceutil/trace.go:171","msg":"trace[477372739] linearizableReadLoop","detail":"{readStateIndex:1485; appliedIndex:1484; }","duration":"251.02246ms","start":"2026-07-02T00:27:19.672623Z","end":"2026-07-02T00:27:19.923645Z","steps":["trace[477372739] 'read index received' (duration: 17.268322ms)","trace[477372739] 'applied index is now lower than readState.Index' (duration: 233.752808ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:27:19.924108Z","caller":"traceutil/trace.go:171","msg":"trace[2121470666] transaction","detail":"{read_only:false; response_revision:1423; number_of_response:1; }","duration":"287.798044ms","start":"2026-07-02T00:27:19.636278Z","end":"2026-07-02T00:27:19.924076Z","steps":["trace[2121470666] 'process raft request' (duration: 53.598235ms)","trace[2121470666] 'compare' (duration: 233.335986ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T00:27:19.924415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.78656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-02T00:27:19.92445Z","caller":"traceutil/trace.go:171","msg":"trace[1523439735] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1423; }","duration":"251.859932ms","start":"2026-07-02T00:27:19.672579Z","end":"2026-07-02T00:27:19.924439Z","steps":["trace[1523439735] 'agreement among raft nodes before linearized reading' (duration: 251.740519ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:27:20.312777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.189161ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T00:27:20.312892Z","caller":"traceutil/trace.go:171","msg":"trace[948878824] linearizableReadLoop","detail":"{readStateIndex:1486; appliedIndex:1485; }","duration":"216.175927ms","start":"2026-07-02T00:27:20.0967Z","end":"2026-07-02T00:27:20.312876Z","steps":["trace[948878824] 'read index received' (duration: 60.7563ms)","trace[948878824] 'applied index is now lower than readState.Index' (duration: 155.418327ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:27:20.312936Z","caller":"traceutil/trace.go:171","msg":"trace[1026809238] transaction","detail":"{read_only:false; response_revision:1424; number_of_response:1; }","duration":"384.333293ms","start":"2026-07-02T00:27:19.92857Z","end":"2026-07-02T00:27:20.312903Z","steps":["trace[1026809238] 'process raft request' (duration: 228.939247ms)","trace[1026809238] 'compare' (duration: 155.091328ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T00:27:20.313066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.378713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-07-02T00:27:20.313074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.407475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"warn","ts":"2026-07-02T00:27:20.313087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:27:19.92855Z","time spent":"384.455946ms","remote":"127.0.0.1:42138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T00:27:20.313099Z","caller":"traceutil/trace.go:171","msg":"trace[1109765199] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1424; }","duration":"216.461595ms","start":"2026-07-02T00:27:20.096627Z","end":"2026-07-02T00:27:20.313088Z","steps":["trace[1109765199] 'agreement among raft nodes before linearized reading' (duration: 216.334761ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:27:20.313119Z","caller":"traceutil/trace.go:171","msg":"trace[926230451] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1424; }","duration":"208.488547ms","start":"2026-07-02T00:27:20.104618Z","end":"2026-07-02T00:27:20.313107Z","steps":["trace[926230451] 'agreement among raft nodes before linearized reading' (duration: 208.369324ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:27:20.458037Z","caller":"traceutil/trace.go:171","msg":"trace[1425231809] transaction","detail":"{read_only:false; response_revision:1425; number_of_response:1; }","duration":"140.035837ms","start":"2026-07-02T00:27:20.317972Z","end":"2026-07-02T00:27:20.458007Z","steps":["trace[1425231809] 'process raft request' (duration: 97.378001ms)","trace[1425231809] 'compare' (duration: 42.549533ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:27:20.46246Z","caller":"traceutil/trace.go:171","msg":"trace[618200719] transaction","detail":"{read_only:false; response_revision:1426; number_of_response:1; }","duration":"143.987735ms","start":"2026-07-02T00:27:20.318452Z","end":"2026-07-02T00:27:20.46244Z","steps":["trace[618200719] 'process raft request' (duration: 143.777689ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:27:21.249172Z","caller":"traceutil/trace.go:171","msg":"trace[1160022761] transaction","detail":"{read_only:false; response_revision:1428; number_of_response:1; }","duration":"409.873129ms","start":"2026-07-02T00:27:20.839271Z","end":"2026-07-02T00:27:21.249144Z","steps":["trace[1160022761] 'process raft request' (duration: 409.700675ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:27:21.249374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:27:20.839246Z","time spent":"410.021694ms","remote":"127.0.0.1:42138","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-07-02T00:27:22.114816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.594207ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T00:27:22.114931Z","caller":"traceutil/trace.go:171","msg":"trace[1318633969] linearizableReadLoop","detail":"{readStateIndex:1491; appliedIndex:1490; }","duration":"640.682588ms","start":"2026-07-02T00:27:21.474233Z","end":"2026-07-02T00:27:22.114915Z","steps":["trace[1318633969] 'read index received' (duration: 239.798773ms)","trace[1318633969] 'applied index is now lower than readState.Index' (duration: 400.882315ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T00:27:22.114997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"640.77035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T00:27:22.11504Z","caller":"traceutil/trace.go:171","msg":"trace[1727240856] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1429; }","duration":"640.843302ms","start":"2026-07-02T00:27:21.474183Z","end":"2026-07-02T00:27:22.115026Z","steps":["trace[1727240856] 'agreement among raft nodes before linearized reading' (duration: 640.78151ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:27:22.115033Z","caller":"traceutil/trace.go:171","msg":"trace[1536328395] transaction","detail":"{read_only:false; response_revision:1429; number_of_response:1; }","duration":"861.314247ms","start":"2026-07-02T00:27:21.253688Z","end":"2026-07-02T00:27:22.115002Z","steps":["trace[1536328395] 'process raft request' (duration: 460.436462ms)","trace[1536328395] 'compare' (duration: 400.162645ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T00:27:22.115084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:27:21.474165Z","time spent":"640.909934ms","remote":"127.0.0.1:41856","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-07-02T00:27:22.115189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:27:21.253662Z","time spent":"861.44543ms","remote":"127.0.0.1:42138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T00:27:22.206821Z","caller":"traceutil/trace.go:171","msg":"trace[1005208620] transaction","detail":"{read_only:false; response_revision:1430; number_of_response:1; }","duration":"276.872036ms","start":"2026-07-02T00:27:21.929839Z","end":"2026-07-02T00:27:22.206712Z","steps":["trace[1005208620] 'process raft request' (duration: 276.673411ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:27:22.980635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.908929ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T00:27:22.980744Z","caller":"traceutil/trace.go:171","msg":"trace[808031577] transaction","detail":"{read_only:false; response_revision:1432; number_of_response:1; }","duration":"514.394647ms","start":"2026-07-02T00:27:22.466329Z","end":"2026-07-02T00:27:22.980724Z","steps":["trace[808031577] 'process raft request' (duration: 253.320443ms)","trace[808031577] 'compare' (duration: 260.783306ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T00:27:22.980802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:27:22.466314Z","time spent":"514.461148ms","remote":"127.0.0.1:42138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T00:27:23.010618Z","caller":"traceutil/trace.go:171","msg":"trace[714326418] linearizableReadLoop","detail":"{readStateIndex:1496; appliedIndex:1494; }","duration":"525.377696ms","start":"2026-07-02T00:27:22.485216Z","end":"2026-07-02T00:27:23.010594Z","steps":["trace[714326418] 'read index received' (duration: 234.552169ms)","trace[714326418] 'applied index is now lower than readState.Index' (duration: 290.824197ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:27:23.010787Z","caller":"traceutil/trace.go:171","msg":"trace[1148080070] transaction","detail":"{read_only:false; response_revision:1433; number_of_response:1; }","duration":"541.804775ms","start":"2026-07-02T00:27:22.468964Z","end":"2026-07-02T00:27:23.010769Z","steps":["trace[1148080070] 'process raft request' (duration: 541.491907ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:27:23.010806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"525.574992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-02T00:27:23.010845Z","caller":"traceutil/trace.go:171","msg":"trace[1919077692] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1433; }","duration":"525.656044ms","start":"2026-07-02T00:27:22.485176Z","end":"2026-07-02T00:27:23.010832Z","steps":["trace[1919077692] 'agreement among raft nodes before linearized reading' (duration: 525.51168ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:27:23.010867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:27:22.468949Z","time spent":"541.876438ms","remote":"127.0.0.1:42138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T00:27:23.010878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:27:22.485162Z","time spent":"525.708616ms","remote":"127.0.0.1:42138","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-07-02T00:27:23.505681Z","caller":"traceutil/trace.go:171","msg":"trace[1818832219] linearizableReadLoop","detail":"{readStateIndex:1498; appliedIndex:1497; }","duration":"278.83379ms","start":"2026-07-02T00:27:23.226825Z","end":"2026-07-02T00:27:23.505659Z","steps":["trace[1818832219] 'read index received' (duration: 278.734027ms)","trace[1818832219] 'applied index is now lower than readState.Index' (duration: 98.673µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:27:23.505755Z","caller":"traceutil/trace.go:171","msg":"trace[334953103] transaction","detail":"{read_only:false; response_revision:1435; number_of_response:1; }","duration":"468.069781ms","start":"2026-07-02T00:27:23.03765Z","end":"2026-07-02T00:27:23.50572Z","steps":["trace[334953103] 'process raft request' (duration: 467.865426ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:27:23.50585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.003554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-02T00:27:23.505877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.014915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T00:27:23.505914Z","caller":"traceutil/trace.go:171","msg":"trace[230739252] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1435; }","duration":"279.125717ms","start":"2026-07-02T00:27:23.226774Z","end":"2026-07-02T00:27:23.505899Z","steps":["trace[230739252] 'agreement among raft nodes before linearized reading' (duration: 278.981223ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:27:23.505923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:27:23.037631Z","time spent":"468.209205ms","remote":"127.0.0.1:42052","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6105,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T00:27:23.505929Z","caller":"traceutil/trace.go:171","msg":"trace[311719315] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1435; }","duration":"260.118619ms","start":"2026-07-02T00:27:23.245792Z","end":"2026-07-02T00:27:23.50591Z","steps":["trace[311719315] 'agreement among raft nodes before linearized reading' (duration: 260.032086ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:27:26.364209Z","caller":"traceutil/trace.go:171","msg":"trace[408571662] transaction","detail":"{read_only:false; response_revision:1451; number_of_response:1; }","duration":"232.234117ms","start":"2026-07-02T00:27:26.131951Z","end":"2026-07-02T00:27:26.364185Z","steps":["trace[408571662] 'process raft request' (duration: 232.107823ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:27:26.808211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.526888ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T00:27:26.808884Z","caller":"traceutil/trace.go:171","msg":"trace[1223932595] linearizableReadLoop","detail":"{readStateIndex:1515; appliedIndex:1513; }","duration":"571.140298ms","start":"2026-07-02T00:27:26.237727Z","end":"2026-07-02T00:27:26.808868Z","steps":["trace[1223932595] 'read index received' (duration: 126.341993ms)","trace[1223932595] 'applied index is now lower than readState.Index' (duration: 444.796705ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:27:26.808943Z","caller":"traceutil/trace.go:171","msg":"trace[601371264] transaction","detail":"{read_only:false; response_revision:1452; number_of_response:1; }","duration":"592.136062ms","start":"2026-07-02T00:27:26.216772Z","end":"2026-07-02T00:27:26.808908Z","steps":["trace[601371264] 'process raft request' (duration: 448.871196ms)","trace[601371264] 'compare' (duration: 141.009364ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T00:27:26.809047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.784878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T00:27:26.809132Z","caller":"traceutil/trace.go:171","msg":"trace[1963636924] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1452; }","duration":"334.83793ms","start":"2026-07-02T00:27:26.474235Z","end":"2026-07-02T00:27:26.809073Z","steps":["trace[1963636924] 'agreement among raft nodes before linearized reading' (duration: 334.794249ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:27:26.808998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"571.271672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-07-02T00:27:26.809143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:27:26.216747Z","time spent":"592.303286ms","remote":"127.0.0.1:42138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T00:27:26.809197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.015216ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-02T00:27:26.809206Z","caller":"traceutil/trace.go:171","msg":"trace[61861370] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:1452; }","duration":"571.497917ms","start":"2026-07-02T00:27:26.237679Z","end":"2026-07-02T00:27:26.809177Z","steps":["trace[61861370] 'agreement among raft nodes before linearized reading' (duration: 571.272731ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:27:26.809208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:27:26.474225Z","time spent":"334.970824ms","remote":"127.0.0.1:41856","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-02T00:27:26.809313Z","caller":"traceutil/trace.go:171","msg":"trace[847175647] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1452; }","duration":"376.18388ms","start":"2026-07-02T00:27:26.43311Z","end":"2026-07-02T00:27:26.809294Z","steps":["trace[847175647] 'agreement among raft nodes before linearized reading' (duration: 375.919033ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:27:26.809341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:27:26.237666Z","time spent":"571.641312ms","remote":"127.0.0.1:37886","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":4,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true "} {"level":"warn","ts":"2026-07-02T00:27:26.809366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:27:26.43309Z","time spent":"376.267142ms","remote":"127.0.0.1:42138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-02T00:27:27.02333Z","caller":"traceutil/trace.go:171","msg":"trace[605815782] transaction","detail":"{read_only:false; response_revision:1453; number_of_response:1; }","duration":"209.936477ms","start":"2026-07-02T00:27:26.813365Z","end":"2026-07-02T00:27:27.023301Z","steps":["trace[605815782] 'process raft request' (duration: 183.492075ms)","trace[605815782] 'compare' (duration: 26.114823ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:28:27.325759Z","caller":"traceutil/trace.go:171","msg":"trace[420147267] transaction","detail":"{read_only:false; response_revision:1753; number_of_response:1; }","duration":"176.339045ms","start":"2026-07-02T00:28:27.149343Z","end":"2026-07-02T00:28:27.325682Z","steps":["trace[420147267] 'process raft request' (duration: 152.777912ms)","trace[420147267] 'compare' (duration: 23.332367ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T00:31:01.975245Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5646844468482462369,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-02T00:31:02.027137Z","caller":"traceutil/trace.go:171","msg":"trace[1470549099] transaction","detail":"{read_only:false; response_revision:2482; number_of_response:1; }","duration":"621.868552ms","start":"2026-07-02T00:31:01.405213Z","end":"2026-07-02T00:31:02.027082Z","steps":["trace[1470549099] 'process raft request' (duration: 621.619315ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:31:02.027359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:31:01.405197Z","time spent":"622.021635ms","remote":"127.0.0.1:42138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T00:31:02.028302Z","caller":"traceutil/trace.go:171","msg":"trace[155982668] linearizableReadLoop","detail":"{readStateIndex:2590; appliedIndex:2588; }","duration":"553.31917ms","start":"2026-07-02T00:31:01.474952Z","end":"2026-07-02T00:31:02.028271Z","steps":["trace[155982668] 'read index received' (duration: 551.892322ms)","trace[155982668] 'applied index is now lower than readState.Index' (duration: 1.424938ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:31:02.028591Z","caller":"traceutil/trace.go:171","msg":"trace[340318774] transaction","detail":"{read_only:false; response_revision:2483; number_of_response:1; }","duration":"423.80212ms","start":"2026-07-02T00:31:01.604557Z","end":"2026-07-02T00:31:02.028359Z","steps":["trace[340318774] 'process raft request' (duration: 423.554823ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:31:02.028627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"553.655659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T00:31:02.028671Z","caller":"traceutil/trace.go:171","msg":"trace[179640074] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2483; }","duration":"553.754442ms","start":"2026-07-02T00:31:01.474907Z","end":"2026-07-02T00:31:02.028661Z","steps":["trace[179640074] 'agreement among raft nodes before linearized reading' (duration: 553.663509ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:31:02.02871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:31:01.474889Z","time spent":"553.812863ms","remote":"127.0.0.1:41856","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-07-02T00:31:02.028783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:31:01.604538Z","time spent":"424.135389ms","remote":"127.0.0.1:42138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T00:31:08.37935Z","caller":"traceutil/trace.go:171","msg":"trace[575149761] transaction","detail":"{read_only:false; response_revision:2520; number_of_response:1; }","duration":"116.755469ms","start":"2026-07-02T00:31:08.262555Z","end":"2026-07-02T00:31:08.379311Z","steps":["trace[575149761] 'process raft request' (duration: 116.474271ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:31:08.379409Z","caller":"traceutil/trace.go:171","msg":"trace[1525206777] transaction","detail":"{read_only:false; response_revision:2522; number_of_response:1; }","duration":"114.917829ms","start":"2026-07-02T00:31:08.264476Z","end":"2026-07-02T00:31:08.379394Z","steps":["trace[1525206777] 'process raft request' (duration: 114.667232ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:31:08.379423Z","caller":"traceutil/trace.go:171","msg":"trace[1612134408] linearizableReadLoop","detail":"{readStateIndex:2631; appliedIndex:2626; }","duration":"114.028365ms","start":"2026-07-02T00:31:08.265373Z","end":"2026-07-02T00:31:08.379401Z","steps":["trace[1612134408] 'read index received' (duration: 1.337015ms)","trace[1612134408] 'applied index is now lower than readState.Index' (duration: 112.69022ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T00:31:08.379528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.130838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-02T00:31:08.379562Z","caller":"traceutil/trace.go:171","msg":"trace[843113196] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:2523; }","duration":"114.20346ms","start":"2026-07-02T00:31:08.265348Z","end":"2026-07-02T00:31:08.379551Z","steps":["trace[843113196] 'agreement among raft nodes before linearized reading' (duration: 114.130868ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:31:08.379402Z","caller":"traceutil/trace.go:171","msg":"trace[1998465915] transaction","detail":"{read_only:false; response_revision:2519; number_of_response:1; }","duration":"117.56096ms","start":"2026-07-02T00:31:08.261811Z","end":"2026-07-02T00:31:08.379372Z","steps":["trace[1998465915] 'process raft request' (duration: 97.298409ms)","trace[1998465915] 'compare' (duration: 19.801458ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:31:08.379702Z","caller":"traceutil/trace.go:171","msg":"trace[1956814935] transaction","detail":"{read_only:false; response_revision:2521; number_of_response:1; }","duration":"117.002825ms","start":"2026-07-02T00:31:08.262577Z","end":"2026-07-02T00:31:08.379579Z","steps":["trace[1956814935] 'process raft request' (duration: 116.491962ms)"],"step_count":1}