{"level":"warn","ts":"2026-08-16T12:53:44.240269Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-16T12:53:44.240401Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.74:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.74:2380","--initial-cluster=instance=https://199.204.45.74:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.74:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.74:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-08-16T12:53:44.240465Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-16T12:53:44.240476Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.74:2380"]} {"level":"info","ts":"2026-08-16T12:53:44.240498Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-08-16T12:53:44.241158Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.74:2379"]} {"level":"info","ts":"2026-08-16T12:53:44.241283Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.74:2380"],"listen-peer-urls":["https://199.204.45.74:2380"],"advertise-client-urls":["https://199.204.45.74:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.74:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.74:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-08-16T12:53:44.244421Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.954005ms"} {"level":"info","ts":"2026-08-16T12:53:44.252999Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"89ba38f964b95aa0","cluster-id":"54492f71bf65c400"} {"level":"info","ts":"2026-08-16T12:53:44.253087Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 switched to configuration voters=()"} {"level":"info","ts":"2026-08-16T12:53:44.253109Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became follower at term 0"} {"level":"info","ts":"2026-08-16T12:53:44.253119Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 89ba38f964b95aa0 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-16T12:53:44.253126Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became follower at term 1"} {"level":"info","ts":"2026-08-16T12:53:44.253157Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 switched to configuration voters=(9924307372652190368)"} {"level":"warn","ts":"2026-08-16T12:53:44.259838Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-16T12:53:44.263304Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-16T12:53:44.264677Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-08-16T12:53:44.267275Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"89ba38f964b95aa0","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-16T12:53:44.267811Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"89ba38f964b95aa0","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-16T12:53:44.267839Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-08-16T12:53:44.267916Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-08-16T12:53:44.26793Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-08-16T12:53:44.26895Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 switched to configuration voters=(9924307372652190368)"} {"level":"info","ts":"2026-08-16T12:53:44.269034Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"54492f71bf65c400","local-member-id":"89ba38f964b95aa0","added-peer-id":"89ba38f964b95aa0","added-peer-peer-urls":["https://199.204.45.74:2380"]} {"level":"info","ts":"2026-08-16T12:53:44.279661Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-08-16T12:53:44.279882Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"89ba38f964b95aa0","initial-advertise-peer-urls":["https://199.204.45.74:2380"],"listen-peer-urls":["https://199.204.45.74:2380"],"advertise-client-urls":["https://199.204.45.74:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.74:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-16T12:53:44.280012Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-16T12:53:44.280477Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.74:2380"} {"level":"info","ts":"2026-08-16T12:53:44.28051Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.74:2380"} {"level":"info","ts":"2026-08-16T12:53:45.254042Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 is starting a new election at term 1"} {"level":"info","ts":"2026-08-16T12:53:45.254083Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-16T12:53:45.254097Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 received MsgPreVoteResp from 89ba38f964b95aa0 at term 1"} {"level":"info","ts":"2026-08-16T12:53:45.254108Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became candidate at term 2"} {"level":"info","ts":"2026-08-16T12:53:45.254117Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 received MsgVoteResp from 89ba38f964b95aa0 at term 2"} {"level":"info","ts":"2026-08-16T12:53:45.254126Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became leader at term 2"} {"level":"info","ts":"2026-08-16T12:53:45.254134Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 89ba38f964b95aa0 elected leader 89ba38f964b95aa0 at term 2"} {"level":"info","ts":"2026-08-16T12:53:45.255018Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"89ba38f964b95aa0","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.74:2379]}","request-path":"/0/members/89ba38f964b95aa0/attributes","cluster-id":"54492f71bf65c400","publish-timeout":"7s"} {"level":"info","ts":"2026-08-16T12:53:45.255067Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-16T12:53:45.255117Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-16T12:53:45.255374Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-16T12:53:45.255455Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-16T12:53:45.255342Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-16T12:53:45.256035Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"54492f71bf65c400","local-member-id":"89ba38f964b95aa0","cluster-version":"3.5"} {"level":"info","ts":"2026-08-16T12:53:45.256193Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-16T12:53:45.256264Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-16T12:53:45.257177Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.74:2379"} {"level":"info","ts":"2026-08-16T12:53:45.259487Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-16T12:54:03.088909Z","caller":"traceutil/trace.go:171","msg":"trace[82749668] linearizableReadLoop","detail":"{readStateIndex:388; appliedIndex:387; }","duration":"358.813455ms","start":"2026-08-16T12:54:02.730071Z","end":"2026-08-16T12:54:03.088885Z","steps":["trace[82749668] 'read index received' (duration: 358.616629ms)","trace[82749668] 'applied index is now lower than readState.Index' (duration: 196.036µs)"],"step_count":2} {"level":"warn","ts":"2026-08-16T12:54:03.08931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.095767ms","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-08-16T12:54:03.089547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.419832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6961"} {"level":"info","ts":"2026-08-16T12:54:03.089723Z","caller":"traceutil/trace.go:171","msg":"trace[841179947] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:374; }","duration":"145.65511ms","start":"2026-08-16T12:54:02.944045Z","end":"2026-08-16T12:54:03.0897Z","steps":["trace[841179947] 'agreement among raft nodes before linearized reading' (duration: 145.315069ms)"],"step_count":1} {"level":"info","ts":"2026-08-16T12:54:03.090006Z","caller":"traceutil/trace.go:171","msg":"trace[1380152507] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"578.518733ms","start":"2026-08-16T12:54:02.511453Z","end":"2026-08-16T12:54:03.089971Z","steps":["trace[1380152507] 'process raft request' (duration: 577.301224ms)"],"step_count":1} {"level":"warn","ts":"2026-08-16T12:54:03.089295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.194738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-16T12:54:03.090234Z","caller":"traceutil/trace.go:171","msg":"trace[207648163] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:374; }","duration":"360.160709ms","start":"2026-08-16T12:54:02.730037Z","end":"2026-08-16T12:54:03.090197Z","steps":["trace[207648163] 'agreement among raft nodes before linearized reading' (duration: 359.054073ms)"],"step_count":1} {"level":"warn","ts":"2026-08-16T12:54:03.090302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-16T12:54:02.730025Z","time spent":"360.263043ms","remote":"127.0.0.1:43644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-08-16T12:54:03.090071Z","caller":"traceutil/trace.go:171","msg":"trace[1906058471] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:374; }","duration":"205.922283ms","start":"2026-08-16T12:54:02.884137Z","end":"2026-08-16T12:54:03.090059Z","steps":["trace[1906058471] 'agreement among raft nodes before linearized reading' (duration: 205.103557ms)"],"step_count":1} {"level":"warn","ts":"2026-08-16T12:54:03.09067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-16T12:54:02.511437Z","time spent":"578.662067ms","remote":"127.0.0.1:43644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-16T12:54:03.408777Z","caller":"traceutil/trace.go:171","msg":"trace[912397893] transaction","detail":"{read_only:false; response_revision:378; number_of_response:1; }","duration":"238.258517ms","start":"2026-08-16T12:54:03.170452Z","end":"2026-08-16T12:54:03.40871Z","steps":["trace[912397893] 'process raft request' (duration: 207.534046ms)","trace[912397893] 'compare' (duration: 30.490603ms)"],"step_count":2} {"level":"info","ts":"2026-08-16T12:54:03.642177Z","caller":"traceutil/trace.go:171","msg":"trace[1959428219] transaction","detail":"{read_only:false; response_revision:379; number_of_response:1; }","duration":"198.973649ms","start":"2026-08-16T12:54:03.443164Z","end":"2026-08-16T12:54:03.642138Z","steps":["trace[1959428219] 'process raft request' (duration: 198.660069ms)"],"step_count":1} {"level":"warn","ts":"2026-08-16T12:54:04.646751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.932103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-16T12:54:04.646817Z","caller":"traceutil/trace.go:171","msg":"trace[1738819445] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:379; }","duration":"361.047487ms","start":"2026-08-16T12:54:04.285755Z","end":"2026-08-16T12:54:04.646803Z","steps":["trace[1738819445] 'range keys from in-memory index tree' (duration: 360.870722ms)"],"step_count":1} {"level":"warn","ts":"2026-08-16T12:54:04.646859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-16T12:54:04.285739Z","time spent":"361.11163ms","remote":"127.0.0.1:43320","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-16T12:54:24.409757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.496257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-16T12:54:24.409854Z","caller":"traceutil/trace.go:171","msg":"trace[440198661] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:564; }","duration":"408.623101ms","start":"2026-08-16T12:54:24.001211Z","end":"2026-08-16T12:54:24.409834Z","steps":["trace[440198661] 'count revisions from in-memory index tree' (duration: 408.428855ms)"],"step_count":1} {"level":"warn","ts":"2026-08-16T12:54:24.409823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"483.422867ms","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":"warn","ts":"2026-08-16T12:54:24.409865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.35251ms","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":"warn","ts":"2026-08-16T12:54:24.409936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.929933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-16T12:54:24.409954Z","caller":"traceutil/trace.go:171","msg":"trace[256997758] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:564; }","duration":"112.496804ms","start":"2026-08-16T12:54:24.297439Z","end":"2026-08-16T12:54:24.409936Z","steps":["trace[256997758] 'count revisions from in-memory index tree' (duration: 112.229716ms)"],"step_count":1} {"level":"warn","ts":"2026-08-16T12:54:24.409993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.915182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-16T12:54:24.410013Z","caller":"traceutil/trace.go:171","msg":"trace[549455076] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:564; }","duration":"452.943194ms","start":"2026-08-16T12:54:23.957065Z","end":"2026-08-16T12:54:24.410008Z","steps":["trace[549455076] 'count revisions from in-memory index tree' (duration: 452.857341ms)"],"step_count":1} {"level":"warn","ts":"2026-08-16T12:54:24.410002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.786521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-16T12:54:24.410074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.953603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-16T12:54:24.410078Z","caller":"traceutil/trace.go:171","msg":"trace[203968229] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:564; }","duration":"111.902245ms","start":"2026-08-16T12:54:24.298159Z","end":"2026-08-16T12:54:24.410062Z","steps":["trace[203968229] 'range keys from in-memory index tree' (duration: 111.72239ms)"],"step_count":1} {"level":"info","ts":"2026-08-16T12:54:24.410111Z","caller":"traceutil/trace.go:171","msg":"trace[2016024341] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:564; }","duration":"408.978023ms","start":"2026-08-16T12:54:24.001114Z","end":"2026-08-16T12:54:24.410092Z","steps":["trace[2016024341] 'range keys from in-memory index tree' (duration: 408.90803ms)"],"step_count":1} {"level":"warn","ts":"2026-08-16T12:54:24.410133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-16T12:54:24.001106Z","time spent":"409.020624ms","remote":"127.0.0.1:58008","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-08-16T12:54:24.410146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.392934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-16T12:54:24.410167Z","caller":"traceutil/trace.go:171","msg":"trace[226257563] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:564; }","duration":"408.425735ms","start":"2026-08-16T12:54:24.001735Z","end":"2026-08-16T12:54:24.41016Z","steps":["trace[226257563] 'range keys from in-memory index tree' (duration: 408.369434ms)"],"step_count":1} {"level":"warn","ts":"2026-08-16T12:54:24.410186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-16T12:54:24.00173Z","time spent":"408.450036ms","remote":"127.0.0.1:58008","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 "} {"level":"warn","ts":"2026-08-16T12:54:24.410264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"483.921284ms","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":"warn","ts":"2026-08-16T12:54:24.41029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.292849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-16T12:54:24.410292Z","caller":"traceutil/trace.go:171","msg":"trace[119699390] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:564; }","duration":"483.995697ms","start":"2026-08-16T12:54:23.92629Z","end":"2026-08-16T12:54:24.410285Z","steps":["trace[119699390] 'range keys from in-memory index tree' (duration: 483.8237ms)"],"step_count":1} {"level":"info","ts":"2026-08-16T12:54:24.410305Z","caller":"traceutil/trace.go:171","msg":"trace[1022963066] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:564; }","duration":"264.33983ms","start":"2026-08-16T12:54:24.145961Z","end":"2026-08-16T12:54:24.4103Z","steps":["trace[1022963066] 'range keys from in-memory index tree' (duration: 264.203655ms)"],"step_count":1} {"level":"warn","ts":"2026-08-16T12:54:24.410318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-16T12:54:23.92626Z","time spent":"484.049208ms","remote":"127.0.0.1:57988","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 "} {"level":"warn","ts":"2026-08-16T12:54:24.41035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"484.10569ms","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":"warn","ts":"2026-08-16T12:54:24.410385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.406032ms","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-08-16T12:54:24.410403Z","caller":"traceutil/trace.go:171","msg":"trace[230868133] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:564; }","duration":"264.463314ms","start":"2026-08-16T12:54:24.145935Z","end":"2026-08-16T12:54:24.410398Z","steps":["trace[230868133] 'count revisions from in-memory index tree' (duration: 264.285159ms)"],"step_count":1} {"level":"info","ts":"2026-08-16T12:54:24.410424Z","caller":"traceutil/trace.go:171","msg":"trace[1371162326] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:564; }","duration":"484.179542ms","start":"2026-08-16T12:54:23.926209Z","end":"2026-08-16T12:54:24.410388Z","steps":["trace[1371162326] 'range keys from in-memory index tree' (duration: 484.040818ms)"],"step_count":1} {"level":"warn","ts":"2026-08-16T12:54:24.410462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.536078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-16T12:54:24.410481Z","caller":"traceutil/trace.go:171","msg":"trace[1609530145] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:564; }","duration":"113.57767ms","start":"2026-08-16T12:54:24.296897Z","end":"2026-08-16T12:54:24.410475Z","steps":["trace[1609530145] 'range keys from in-memory index tree' (duration: 113.456016ms)"],"step_count":1} {"level":"warn","ts":"2026-08-16T12:54:24.410477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-16T12:54:23.926192Z","time spent":"484.271825ms","remote":"127.0.0.1:57988","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 "} {"level":"warn","ts":"2026-08-16T12:54:24.409903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-16T12:54:24.001182Z","time spent":"408.709444ms","remote":"127.0.0.1:58008","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"info","ts":"2026-08-16T12:54:24.40996Z","caller":"traceutil/trace.go:171","msg":"trace[451072018] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:564; }","duration":"452.970974ms","start":"2026-08-16T12:54:23.956982Z","end":"2026-08-16T12:54:24.409953Z","steps":["trace[451072018] 'range keys from in-memory index tree' (duration: 452.85489ms)"],"step_count":1} {"level":"warn","ts":"2026-08-16T12:54:24.41062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.17132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-16T12:54:24.41063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-16T12:54:23.956967Z","time spent":"453.655966ms","remote":"127.0.0.1:57994","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 "} {"level":"info","ts":"2026-08-16T12:54:24.410648Z","caller":"traceutil/trace.go:171","msg":"trace[1599671246] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:564; }","duration":"453.211592ms","start":"2026-08-16T12:54:23.957429Z","end":"2026-08-16T12:54:24.41064Z","steps":["trace[1599671246] 'range keys from in-memory index tree' (duration: 453.133249ms)"],"step_count":1} {"level":"warn","ts":"2026-08-16T12:54:24.410679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-16T12:54:23.957423Z","time spent":"453.245773ms","remote":"127.0.0.1:57994","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 "} {"level":"info","ts":"2026-08-16T12:54:24.409946Z","caller":"traceutil/trace.go:171","msg":"trace[1139061910] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:564; }","duration":"483.602074ms","start":"2026-08-16T12:54:23.926315Z","end":"2026-08-16T12:54:24.409917Z","steps":["trace[1139061910] 'count revisions from in-memory index tree' (duration: 483.288543ms)"],"step_count":1} {"level":"warn","ts":"2026-08-16T12:54:24.410736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-16T12:54:23.92626Z","time spent":"484.469632ms","remote":"127.0.0.1:57988","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true "} {"level":"warn","ts":"2026-08-16T12:54:24.410044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-16T12:54:23.957041Z","time spent":"452.997035ms","remote":"127.0.0.1:57994","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true "} {"level":"warn","ts":"2026-08-16T12:54:24.410662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-16T12:54:23.974864Z","time spent":"435.739168ms","remote":"127.0.0.1:58002","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-08-16T12:54:29.95086Z","caller":"traceutil/trace.go:171","msg":"trace[47248674] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"188.737618ms","start":"2026-08-16T12:54:29.762093Z","end":"2026-08-16T12:54:29.95083Z","steps":["trace[47248674] 'process raft request' (duration: 188.534031ms)"],"step_count":1} {"level":"info","ts":"2026-08-16T12:54:30.883885Z","caller":"traceutil/trace.go:171","msg":"trace[1738870067] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"147.820325ms","start":"2026-08-16T12:54:30.736038Z","end":"2026-08-16T12:54:30.883858Z","steps":["trace[1738870067] 'process raft request' (duration: 147.673781ms)"],"step_count":1} {"level":"warn","ts":"2026-08-16T12:54:31.74096Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6530395427225518667,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-16T12:54:32.124307Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.011509808s","expected-duration":"1s"} {"level":"info","ts":"2026-08-16T12:54:32.124849Z","caller":"traceutil/trace.go:171","msg":"trace[512447465] linearizableReadLoop","detail":"{readStateIndex:630; appliedIndex:629; }","duration":"883.909636ms","start":"2026-08-16T12:54:31.2409Z","end":"2026-08-16T12:54:32.12481Z","steps":["trace[512447465] 'read index received' (duration: 883.607626ms)","trace[512447465] 'applied index is now lower than readState.Index' (duration: 300.73µs)"],"step_count":2} {"level":"info","ts":"2026-08-16T12:54:32.124928Z","caller":"traceutil/trace.go:171","msg":"trace[1665136484] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"1.012287084s","start":"2026-08-16T12:54:31.112611Z","end":"2026-08-16T12:54:32.124898Z","steps":["trace[1665136484] 'process raft request' (duration: 1.011980684s)"],"step_count":1} {"level":"warn","ts":"2026-08-16T12:54:32.125179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-16T12:54:31.112574Z","time spent":"1.01248028s","remote":"127.0.0.1:43544","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-16T12:54:32.125236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"884.211896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-08-16T12:54:32.125301Z","caller":"traceutil/trace.go:171","msg":"trace[1951507119] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:606; }","duration":"884.285758ms","start":"2026-08-16T12:54:31.240997Z","end":"2026-08-16T12:54:32.125283Z","steps":["trace[1951507119] 'agreement among raft nodes before linearized reading' (duration: 883.997529ms)"],"step_count":1} {"level":"warn","ts":"2026-08-16T12:54:32.125354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-16T12:54:31.240904Z","time spent":"884.437413ms","remote":"127.0.0.1:43644","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-08-16T12:54:32.125421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"884.422213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-08-16T12:54:32.125526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"838.729176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-16T12:54:32.125595Z","caller":"traceutil/trace.go:171","msg":"trace[557864805] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:606; }","duration":"838.854591ms","start":"2026-08-16T12:54:31.286723Z","end":"2026-08-16T12:54:32.125577Z","steps":["trace[557864805] 'agreement among raft nodes before linearized reading' (duration: 838.691155ms)"],"step_count":1} {"level":"warn","ts":"2026-08-16T12:54:32.1256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.172697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-08-16T12:54:32.125651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-16T12:54:31.2867Z","time spent":"838.939494ms","remote":"127.0.0.1:43644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-08-16T12:54:32.125699Z","caller":"traceutil/trace.go:171","msg":"trace[624091477] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:606; }","duration":"170.277972ms","start":"2026-08-16T12:54:31.955394Z","end":"2026-08-16T12:54:32.125672Z","steps":["trace[624091477] 'agreement among raft nodes before linearized reading' (duration: 169.982902ms)"],"step_count":1} {"level":"info","ts":"2026-08-16T12:54:32.125552Z","caller":"traceutil/trace.go:171","msg":"trace[1985643545] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:606; }","duration":"884.6362ms","start":"2026-08-16T12:54:31.240892Z","end":"2026-08-16T12:54:32.125528Z","steps":["trace[1985643545] 'agreement among raft nodes before linearized reading' (duration: 884.190296ms)"],"step_count":1} {"level":"warn","ts":"2026-08-16T12:54:32.125806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-16T12:54:31.240827Z","time spent":"884.95009ms","remote":"127.0.0.1:43644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-16T12:54:33.468004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.659181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-16T12:54:33.46808Z","caller":"traceutil/trace.go:171","msg":"trace[336954447] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:617; }","duration":"182.813077ms","start":"2026-08-16T12:54:33.28525Z","end":"2026-08-16T12:54:33.468063Z","steps":["trace[336954447] 'range keys from in-memory index tree' (duration: 182.559538ms)"],"step_count":1} {"level":"warn","ts":"2026-08-16T12:54:48.455291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.084416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-08-16T12:54:48.455364Z","caller":"traceutil/trace.go:171","msg":"trace[2108833251] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:764; }","duration":"227.184599ms","start":"2026-08-16T12:54:48.228165Z","end":"2026-08-16T12:54:48.45535Z","steps":["trace[2108833251] 'range keys from in-memory index tree' (duration: 226.867289ms)"],"step_count":1} {"level":"warn","ts":"2026-08-16T12:54:48.455672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.663069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.74\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-08-16T12:54:48.455687Z","caller":"traceutil/trace.go:171","msg":"trace[992699294] range","detail":"{range_begin:/registry/masterleases/199.204.45.74; range_end:; response_count:1; response_revision:764; }","duration":"376.720691ms","start":"2026-08-16T12:54:48.078962Z","end":"2026-08-16T12:54:48.455683Z","steps":["trace[992699294] 'range keys from in-memory index tree' (duration: 376.574546ms)"],"step_count":1} {"level":"warn","ts":"2026-08-16T12:54:48.455702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-16T12:54:48.078938Z","time spent":"376.759532ms","remote":"127.0.0.1:43362","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.74\" "} {"level":"info","ts":"2026-08-16T12:54:48.468628Z","caller":"traceutil/trace.go:171","msg":"trace[474605477] linearizableReadLoop","detail":"{readStateIndex:793; appliedIndex:792; }","duration":"239.785476ms","start":"2026-08-16T12:54:48.228813Z","end":"2026-08-16T12:54:48.468598Z","steps":["trace[474605477] 'read index received' (duration: 235.834459ms)","trace[474605477] 'applied index is now lower than readState.Index' (duration: 3.949357ms)"],"step_count":2} {"level":"warn","ts":"2026-08-16T12:54:48.468922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.078147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-08-16T12:54:48.469031Z","caller":"traceutil/trace.go:171","msg":"trace[2001205291] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:765; }","duration":"240.234062ms","start":"2026-08-16T12:54:48.228778Z","end":"2026-08-16T12:54:48.469012Z","steps":["trace[2001205291] 'agreement among raft nodes before linearized reading' (duration: 239.957463ms)"],"step_count":1} {"level":"info","ts":"2026-08-16T12:54:48.469405Z","caller":"traceutil/trace.go:171","msg":"trace[289285091] transaction","detail":"{read_only:false; response_revision:765; number_of_response:1; }","duration":"240.569902ms","start":"2026-08-16T12:54:48.228778Z","end":"2026-08-16T12:54:48.469348Z","steps":["trace[289285091] 'process raft request' (duration: 235.806289ms)"],"step_count":1} {"level":"info","ts":"2026-08-16T12:54:48.472845Z","caller":"traceutil/trace.go:171","msg":"trace[1899077634] transaction","detail":"{read_only:false; response_revision:766; number_of_response:1; }","duration":"121.196866ms","start":"2026-08-16T12:54:48.351638Z","end":"2026-08-16T12:54:48.472835Z","steps":["trace[1899077634] 'process raft request' (duration: 121.056602ms)"],"step_count":1} {"level":"warn","ts":"2026-08-16T12:54:48.473163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.040652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-08-16T12:54:48.473188Z","caller":"traceutil/trace.go:171","msg":"trace[714451542] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:767; }","duration":"239.077234ms","start":"2026-08-16T12:54:48.234104Z","end":"2026-08-16T12:54:48.473181Z","steps":["trace[714451542] 'agreement among raft nodes before linearized reading' (duration: 238.964411ms)"],"step_count":1} {"level":"warn","ts":"2026-08-16T12:54:48.473329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.450294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-16T12:54:48.473346Z","caller":"traceutil/trace.go:171","msg":"trace[1917836842] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:767; }","duration":"186.509965ms","start":"2026-08-16T12:54:48.286831Z","end":"2026-08-16T12:54:48.473341Z","steps":["trace[1917836842] 'agreement among raft nodes before linearized reading' (duration: 186.481995ms)"],"step_count":1} {"level":"warn","ts":"2026-08-16T12:54:48.473458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.499725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-08-16T12:54:48.473477Z","caller":"traceutil/trace.go:171","msg":"trace[1470274261] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:767; }","duration":"238.537587ms","start":"2026-08-16T12:54:48.234934Z","end":"2026-08-16T12:54:48.473472Z","steps":["trace[1470274261] 'agreement among raft nodes before linearized reading' (duration: 238.485265ms)"],"step_count":1} {"level":"info","ts":"2026-08-16T12:55:02.881387Z","caller":"traceutil/trace.go:171","msg":"trace[405452702] linearizableReadLoop","detail":"{readStateIndex:930; appliedIndex:929; }","duration":"346.72111ms","start":"2026-08-16T12:55:02.534562Z","end":"2026-08-16T12:55:02.881284Z","steps":["trace[405452702] 'read index received' (duration: 346.572455ms)","trace[405452702] 'applied index is now lower than readState.Index' (duration: 147.715µs)"],"step_count":2} {"level":"info","ts":"2026-08-16T12:55:02.881395Z","caller":"traceutil/trace.go:171","msg":"trace[240124596] transaction","detail":"{read_only:false; response_revision:898; number_of_response:1; }","duration":"347.686042ms","start":"2026-08-16T12:55:02.533677Z","end":"2026-08-16T12:55:02.881363Z","steps":["trace[240124596] 'process raft request' (duration: 347.473235ms)"],"step_count":1} {"level":"warn","ts":"2026-08-16T12:55:02.881559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-16T12:55:02.533666Z","time spent":"347.811445ms","remote":"127.0.0.1:43644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-16T12:55:02.881654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.066312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-16T12:55:02.88174Z","caller":"traceutil/trace.go:171","msg":"trace[2091075250] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:898; }","duration":"347.209686ms","start":"2026-08-16T12:55:02.534511Z","end":"2026-08-16T12:55:02.881721Z","steps":["trace[2091075250] 'agreement among raft nodes before linearized reading' (duration: 346.945398ms)"],"step_count":1} {"level":"warn","ts":"2026-08-16T12:55:02.88179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-16T12:55:02.534483Z","time spent":"347.297749ms","remote":"127.0.0.1:43644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-08-16T12:55:02.914932Z","caller":"traceutil/trace.go:171","msg":"trace[275264613] transaction","detail":"{read_only:false; response_revision:899; number_of_response:1; }","duration":"351.619289ms","start":"2026-08-16T12:55:02.563299Z","end":"2026-08-16T12:55:02.914919Z","steps":["trace[275264613] 'process raft request' (duration: 351.553887ms)"],"step_count":1} {"level":"warn","ts":"2026-08-16T12:55:02.915031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-16T12:55:02.563263Z","time spent":"351.711402ms","remote":"127.0.0.1:43412","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":811,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-16T12:55:02.915064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.51776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-16T12:55:02.915119Z","caller":"traceutil/trace.go:171","msg":"trace[136946465] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:899; }","duration":"379.602923ms","start":"2026-08-16T12:55:02.535503Z","end":"2026-08-16T12:55:02.915106Z","steps":["trace[136946465] 'agreement among raft nodes before linearized reading' (duration: 379.450238ms)"],"step_count":1} {"level":"warn","ts":"2026-08-16T12:55:02.915159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-16T12:55:02.535488Z","time spent":"379.662845ms","remote":"127.0.0.1:43644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-16T12:55:02.915157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.308323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-5phlx\" ","response":"range_response_count:1 size:5676"} {"level":"info","ts":"2026-08-16T12:55:02.915236Z","caller":"traceutil/trace.go:171","msg":"trace[491556410] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-5phlx; range_end:; response_count:1; response_revision:899; }","duration":"279.458157ms","start":"2026-08-16T12:55:02.635757Z","end":"2026-08-16T12:55:02.915216Z","steps":["trace[491556410] 'agreement among raft nodes before linearized reading' (duration: 279.23831ms)"],"step_count":1} {"level":"warn","ts":"2026-08-16T12:55:02.915367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.348955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-16T12:55:02.915405Z","caller":"traceutil/trace.go:171","msg":"trace[670546737] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:899; }","duration":"379.423257ms","start":"2026-08-16T12:55:02.535972Z","end":"2026-08-16T12:55:02.915396Z","steps":["trace[670546737] 'agreement among raft nodes before linearized reading' (duration: 379.334934ms)"],"step_count":1} {"level":"warn","ts":"2026-08-16T12:55:02.915432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-16T12:55:02.535953Z","time spent":"379.473319ms","remote":"127.0.0.1:43644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-08-16T12:55:03.078347Z","caller":"traceutil/trace.go:171","msg":"trace[1070005156] transaction","detail":"{read_only:false; response_revision:900; number_of_response:1; }","duration":"192.399036ms","start":"2026-08-16T12:55:02.885926Z","end":"2026-08-16T12:55:03.078325Z","steps":["trace[1070005156] 'process raft request' (duration: 138.499155ms)","trace[1070005156] 'compare' (duration: 53.791238ms)"],"step_count":2} {"level":"info","ts":"2026-08-16T12:55:03.148301Z","caller":"traceutil/trace.go:171","msg":"trace[1277113052] transaction","detail":"{read_only:false; response_revision:903; number_of_response:1; }","duration":"223.967976ms","start":"2026-08-16T12:55:02.924308Z","end":"2026-08-16T12:55:03.148276Z","steps":["trace[1277113052] 'process raft request' (duration: 223.925214ms)"],"step_count":1} {"level":"info","ts":"2026-08-16T12:55:03.148343Z","caller":"traceutil/trace.go:171","msg":"trace[1141188074] transaction","detail":"{read_only:false; response_revision:902; number_of_response:1; }","duration":"225.828916ms","start":"2026-08-16T12:55:02.92248Z","end":"2026-08-16T12:55:03.148309Z","steps":["trace[1141188074] 'process raft request' (duration: 225.717632ms)"],"step_count":1} {"level":"info","ts":"2026-08-16T12:55:03.148377Z","caller":"traceutil/trace.go:171","msg":"trace[1118514275] transaction","detail":"{read_only:false; response_revision:901; number_of_response:1; }","duration":"225.94734ms","start":"2026-08-16T12:55:02.9224Z","end":"2026-08-16T12:55:03.148347Z","steps":["trace[1118514275] 'process raft request' (duration: 225.705862ms)"],"step_count":1} {"level":"info","ts":"2026-08-16T12:55:03.275508Z","caller":"traceutil/trace.go:171","msg":"trace[274456810] transaction","detail":"{read_only:false; response_revision:904; number_of_response:1; }","duration":"122.628912ms","start":"2026-08-16T12:55:03.152853Z","end":"2026-08-16T12:55:03.275482Z","steps":["trace[274456810] 'process raft request' (duration: 104.548228ms)","trace[274456810] 'compare' (duration: 17.937539ms)"],"step_count":2} {"level":"info","ts":"2026-08-16T12:55:03.605534Z","caller":"traceutil/trace.go:171","msg":"trace[2134548640] transaction","detail":"{read_only:false; response_revision:906; number_of_response:1; }","duration":"448.378036ms","start":"2026-08-16T12:55:03.157139Z","end":"2026-08-16T12:55:03.605517Z","steps":["trace[2134548640] 'process raft request' (duration: 448.332725ms)"],"step_count":1} {"level":"warn","ts":"2026-08-16T12:55:03.605658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-16T12:55:03.157126Z","time spent":"448.471189ms","remote":"127.0.0.1:43864","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5192,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-16T12:55:03.605642Z","caller":"traceutil/trace.go:171","msg":"trace[1348546845] transaction","detail":"{read_only:false; response_revision:905; number_of_response:1; }","duration":"452.028094ms","start":"2026-08-16T12:55:03.153571Z","end":"2026-08-16T12:55:03.6056Z","steps":["trace[1348546845] 'process raft request' (duration: 451.781096ms)"],"step_count":1} {"level":"warn","ts":"2026-08-16T12:55:03.605808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-16T12:55:03.153555Z","time spent":"452.162959ms","remote":"127.0.0.1:43646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1628,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-16T12:55:03.609503Z","caller":"traceutil/trace.go:171","msg":"trace[110416163] linearizableReadLoop","detail":"{readStateIndex:939; appliedIndex:936; }","duration":"323.272794ms","start":"2026-08-16T12:55:03.286213Z","end":"2026-08-16T12:55:03.609485Z","steps":["trace[110416163] 'read index received' (duration: 319.196683ms)","trace[110416163] 'applied index is now lower than readState.Index' (duration: 4.075291ms)"],"step_count":2} {"level":"warn","ts":"2026-08-16T12:55:03.609622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.398678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-16T12:55:03.609642Z","caller":"traceutil/trace.go:171","msg":"trace[26640739] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:907; }","duration":"323.47427ms","start":"2026-08-16T12:55:03.286161Z","end":"2026-08-16T12:55:03.609636Z","steps":["trace[26640739] 'agreement among raft nodes before linearized reading' (duration: 323.391918ms)"],"step_count":1} {"level":"warn","ts":"2026-08-16T12:55:03.609678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-16T12:55:03.286154Z","time spent":"323.518702ms","remote":"127.0.0.1:43320","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-16T12:55:03.609947Z","caller":"traceutil/trace.go:171","msg":"trace[1410142608] transaction","detail":"{read_only:false; response_revision:907; number_of_response:1; }","duration":"329.391402ms","start":"2026-08-16T12:55:03.280545Z","end":"2026-08-16T12:55:03.609937Z","steps":["trace[1410142608] 'process raft request' (duration: 328.810453ms)"],"step_count":1} {"level":"warn","ts":"2026-08-16T12:55:03.61001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-16T12:55:03.280522Z","time spent":"329.444464ms","remote":"127.0.0.1:43644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-16T12:55:04.00931Z","caller":"traceutil/trace.go:171","msg":"trace[240546938] transaction","detail":"{read_only:false; response_revision:909; number_of_response:1; }","duration":"329.393462ms","start":"2026-08-16T12:55:03.679896Z","end":"2026-08-16T12:55:04.009289Z","steps":["trace[240546938] 'process raft request' (duration: 299.642251ms)","trace[240546938] 'compare' (duration: 29.443181ms)"],"step_count":2} {"level":"warn","ts":"2026-08-16T12:55:04.009451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-16T12:55:03.679879Z","time spent":"329.481515ms","remote":"127.0.0.1:43644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-16T12:55:11.150339Z","caller":"traceutil/trace.go:171","msg":"trace[1263342079] transaction","detail":"{read_only:false; response_revision:935; number_of_response:1; }","duration":"233.036328ms","start":"2026-08-16T12:55:10.917284Z","end":"2026-08-16T12:55:11.15032Z","steps":["trace[1263342079] 'process raft request' (duration: 232.539952ms)"],"step_count":1} {"level":"info","ts":"2026-08-16T12:55:33.475219Z","caller":"traceutil/trace.go:171","msg":"trace[1243522227] linearizableReadLoop","detail":"{readStateIndex:1051; appliedIndex:1050; }","duration":"232.473653ms","start":"2026-08-16T12:55:33.242723Z","end":"2026-08-16T12:55:33.475197Z","steps":["trace[1243522227] 'read index received' (duration: 232.447032ms)","trace[1243522227] 'applied index is now lower than readState.Index' (duration: 25.561µs)"],"step_count":2} {"level":"info","ts":"2026-08-16T12:55:33.475331Z","caller":"traceutil/trace.go:171","msg":"trace[1751415095] transaction","detail":"{read_only:false; response_revision:1012; number_of_response:1; }","duration":"233.486765ms","start":"2026-08-16T12:55:33.241806Z","end":"2026-08-16T12:55:33.475293Z","steps":["trace[1751415095] 'process raft request' (duration: 233.258537ms)"],"step_count":1} {"level":"warn","ts":"2026-08-16T12:55:33.47547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.72206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-08-16T12:55:33.475556Z","caller":"traceutil/trace.go:171","msg":"trace[1092292567] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1012; }","duration":"232.867295ms","start":"2026-08-16T12:55:33.242667Z","end":"2026-08-16T12:55:33.475535Z","steps":["trace[1092292567] 'agreement among raft nodes before linearized reading' (duration: 232.625267ms)"],"step_count":1} {"level":"warn","ts":"2026-08-16T12:55:34.063071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.861153ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-08-16T12:55:34.063318Z","caller":"traceutil/trace.go:171","msg":"trace[566816615] linearizableReadLoop","detail":"{readStateIndex:1052; appliedIndex:1051; }","duration":"587.942761ms","start":"2026-08-16T12:55:33.47535Z","end":"2026-08-16T12:55:34.063293Z","steps":["trace[566816615] 'read index received' (duration: 336.622153ms)","trace[566816615] 'applied index is now lower than readState.Index' (duration: 251.317748ms)"],"step_count":2} {"level":"warn","ts":"2026-08-16T12:55:34.063529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"762.967595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-16T12:55:34.063589Z","caller":"traceutil/trace.go:171","msg":"trace[809516706] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1012; }","duration":"763.070108ms","start":"2026-08-16T12:55:33.3005Z","end":"2026-08-16T12:55:34.06357Z","steps":["trace[809516706] 'agreement among raft nodes before linearized reading' (duration: 762.81002ms)"],"step_count":1} {"level":"warn","ts":"2026-08-16T12:55:34.063591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"772.072298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-16T12:55:34.063788Z","caller":"traceutil/trace.go:171","msg":"trace[336470608] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1012; }","duration":"772.288255ms","start":"2026-08-16T12:55:33.291483Z","end":"2026-08-16T12:55:34.063771Z","steps":["trace[336470608] 'agreement among raft nodes before linearized reading' (duration: 771.908293ms)"],"step_count":1} {"level":"warn","ts":"2026-08-16T12:55:34.063828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-16T12:55:33.29146Z","time spent":"772.360577ms","remote":"127.0.0.1:43644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-16T12:55:34.06373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-16T12:55:33.300481Z","time spent":"763.200923ms","remote":"127.0.0.1:43644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-08-16T12:55:34.064293Z","caller":"traceutil/trace.go:171","msg":"trace[1083005235] transaction","detail":"{read_only:false; response_revision:1013; number_of_response:1; }","duration":"584.737669ms","start":"2026-08-16T12:55:33.479541Z","end":"2026-08-16T12:55:34.064278Z","steps":["trace[1083005235] 'process raft request' (duration: 583.671595ms)"],"step_count":1} {"level":"info","ts":"2026-08-16T12:55:34.064315Z","caller":"traceutil/trace.go:171","msg":"trace[1142801175] transaction","detail":"{read_only:false; response_revision:1014; number_of_response:1; }","duration":"365.822383ms","start":"2026-08-16T12:55:33.698481Z","end":"2026-08-16T12:55:34.064303Z","steps":["trace[1142801175] 'process raft request' (duration: 365.670398ms)"],"step_count":1} {"level":"warn","ts":"2026-08-16T12:55:34.064406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-16T12:55:33.698462Z","time spent":"365.876265ms","remote":"127.0.0.1:43644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-16T12:55:34.064428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-16T12:55:33.47952Z","time spent":"584.814631ms","remote":"127.0.0.1:43644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-16T12:55:34.065148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"568.27715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-16T12:55:34.065316Z","caller":"traceutil/trace.go:171","msg":"trace[1352059117] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1014; }","duration":"568.354002ms","start":"2026-08-16T12:55:33.496828Z","end":"2026-08-16T12:55:34.065182Z","steps":["trace[1352059117] 'agreement among raft nodes before linearized reading' (duration: 567.408392ms)"],"step_count":1} {"level":"warn","ts":"2026-08-16T12:55:34.065494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-16T12:55:33.496816Z","time spent":"568.666292ms","remote":"127.0.0.1:43320","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-16T12:55:38.212954Z","caller":"traceutil/trace.go:171","msg":"trace[1283583780] transaction","detail":"{read_only:false; response_revision:1027; number_of_response:1; }","duration":"102.901852ms","start":"2026-08-16T12:55:38.110021Z","end":"2026-08-16T12:55:38.212923Z","steps":["trace[1283583780] 'process raft request' (duration: 78.471156ms)","trace[1283583780] 'compare' (duration: 24.215079ms)"],"step_count":2} {"level":"info","ts":"2026-08-16T12:55:38.352526Z","caller":"traceutil/trace.go:171","msg":"trace[273790668] linearizableReadLoop","detail":"{readStateIndex:1070; appliedIndex:1069; }","duration":"133.658272ms","start":"2026-08-16T12:55:38.218836Z","end":"2026-08-16T12:55:38.352495Z","steps":["trace[273790668] 'read index received' (duration: 104.977209ms)","trace[273790668] 'applied index is now lower than readState.Index' (duration: 28.679183ms)"],"step_count":2} {"level":"info","ts":"2026-08-16T12:55:38.352654Z","caller":"traceutil/trace.go:171","msg":"trace[1657544392] transaction","detail":"{read_only:false; response_revision:1029; number_of_response:1; }","duration":"135.339646ms","start":"2026-08-16T12:55:38.217247Z","end":"2026-08-16T12:55:38.352587Z","steps":["trace[1657544392] 'process raft request' (duration: 106.629792ms)","trace[1657544392] 'compare' (duration: 28.438425ms)"],"step_count":2} {"level":"warn","ts":"2026-08-16T12:55:38.352979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.127417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-08-16T12:55:38.353072Z","caller":"traceutil/trace.go:171","msg":"trace[1785179744] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:1029; }","duration":"134.23785ms","start":"2026-08-16T12:55:38.218814Z","end":"2026-08-16T12:55:38.353052Z","steps":["trace[1785179744] 'agreement among raft nodes before linearized reading' (duration: 133.804496ms)"],"step_count":1} {"level":"warn","ts":"2026-08-16T12:55:38.353707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.233396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-08-16T12:55:38.353773Z","caller":"traceutil/trace.go:171","msg":"trace[443948054] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1029; }","duration":"127.817404ms","start":"2026-08-16T12:55:38.225938Z","end":"2026-08-16T12:55:38.353756Z","steps":["trace[443948054] 'agreement among raft nodes before linearized reading' (duration: 126.932205ms)"],"step_count":1} {"level":"warn","ts":"2026-08-16T12:55:50.573659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.802137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-16T12:55:50.573742Z","caller":"traceutil/trace.go:171","msg":"trace[1450686582] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1118; }","duration":"289.926401ms","start":"2026-08-16T12:55:50.283798Z","end":"2026-08-16T12:55:50.573724Z","steps":["trace[1450686582] 'range keys from in-memory index tree' (duration: 289.647192ms)"],"step_count":1} {"level":"warn","ts":"2026-08-16T12:55:50.574021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.071534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-08-16T12:55:50.574066Z","caller":"traceutil/trace.go:171","msg":"trace[329845469] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1118; }","duration":"266.131705ms","start":"2026-08-16T12:55:50.307925Z","end":"2026-08-16T12:55:50.574057Z","steps":["trace[329845469] 'range keys from in-memory index tree' (duration: 265.924688ms)"],"step_count":1} {"level":"warn","ts":"2026-08-16T12:55:50.574242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.29669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-16T12:55:50.574871Z","caller":"traceutil/trace.go:171","msg":"trace[1458180172] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1118; }","duration":"165.952701ms","start":"2026-08-16T12:55:50.408908Z","end":"2026-08-16T12:55:50.574861Z","steps":["trace[1458180172] 'range keys from in-memory index tree' (duration: 165.180697ms)"],"step_count":1} {"level":"warn","ts":"2026-08-16T12:55:50.575299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.417208ms","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-08-16T12:55:50.575346Z","caller":"traceutil/trace.go:171","msg":"trace[800313088] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1118; }","duration":"107.49862ms","start":"2026-08-16T12:55:50.467834Z","end":"2026-08-16T12:55:50.575332Z","steps":["trace[800313088] 'count revisions from in-memory index tree' (duration: 107.348945ms)"],"step_count":1} {"level":"info","ts":"2026-08-16T12:55:51.905902Z","caller":"traceutil/trace.go:171","msg":"trace[1428158901] transaction","detail":"{read_only:false; response_revision:1122; number_of_response:1; }","duration":"258.715126ms","start":"2026-08-16T12:55:51.647161Z","end":"2026-08-16T12:55:51.905876Z","steps":["trace[1428158901] 'process raft request' (duration: 258.563651ms)"],"step_count":1} {"level":"info","ts":"2026-08-16T12:55:52.365273Z","caller":"traceutil/trace.go:171","msg":"trace[2077840624] transaction","detail":"{read_only:false; response_revision:1123; number_of_response:1; }","duration":"221.826529ms","start":"2026-08-16T12:55:52.143411Z","end":"2026-08-16T12:55:52.365238Z","steps":["trace[2077840624] 'process raft request' (duration: 219.291437ms)"],"step_count":1} {"level":"info","ts":"2026-08-16T12:55:52.365795Z","caller":"traceutil/trace.go:171","msg":"trace[1281140102] linearizableReadLoop","detail":"{readStateIndex:1167; appliedIndex:1166; }","duration":"208.19171ms","start":"2026-08-16T12:55:52.157592Z","end":"2026-08-16T12:55:52.365784Z","steps":["trace[1281140102] 'read index received' (duration: 205.125112ms)","trace[1281140102] 'applied index is now lower than readState.Index' (duration: 3.063518ms)"],"step_count":2} {"level":"info","ts":"2026-08-16T12:55:52.365842Z","caller":"traceutil/trace.go:171","msg":"trace[2007153193] transaction","detail":"{read_only:false; response_revision:1124; number_of_response:1; }","duration":"203.774928ms","start":"2026-08-16T12:55:52.162032Z","end":"2026-08-16T12:55:52.365807Z","steps":["trace[2007153193] 'process raft request' (duration: 203.140018ms)"],"step_count":1} {"level":"warn","ts":"2026-08-16T12:55:52.366018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.418887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-08-16T12:55:52.366045Z","caller":"traceutil/trace.go:171","msg":"trace[1956768128] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1124; }","duration":"208.49733ms","start":"2026-08-16T12:55:52.15754Z","end":"2026-08-16T12:55:52.366038Z","steps":["trace[1956768128] 'agreement among raft nodes before linearized reading' (duration: 208.315895ms)"],"step_count":1} {"level":"info","ts":"2026-08-16T12:56:04.590877Z","caller":"traceutil/trace.go:171","msg":"trace[1779859620] linearizableReadLoop","detail":"{readStateIndex:1210; appliedIndex:1209; }","duration":"171.436728ms","start":"2026-08-16T12:56:04.419417Z","end":"2026-08-16T12:56:04.590854Z","steps":["trace[1779859620] 'read index received' (duration: 171.243351ms)","trace[1779859620] 'applied index is now lower than readState.Index' (duration: 192.546µs)"],"step_count":2} {"level":"warn","ts":"2026-08-16T12:56:04.591096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.655234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-16T12:56:04.591135Z","caller":"traceutil/trace.go:171","msg":"trace[357642945] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1163; }","duration":"171.739187ms","start":"2026-08-16T12:56:04.419386Z","end":"2026-08-16T12:56:04.591125Z","steps":["trace[357642945] 'agreement among raft nodes before linearized reading' (duration: 171.566652ms)"],"step_count":1} {"level":"info","ts":"2026-08-16T12:56:04.591451Z","caller":"traceutil/trace.go:171","msg":"trace[1558904757] transaction","detail":"{read_only:false; response_revision:1163; number_of_response:1; }","duration":"189.392795ms","start":"2026-08-16T12:56:04.402045Z","end":"2026-08-16T12:56:04.591438Z","steps":["trace[1558904757] 'process raft request' (duration: 188.663062ms)"],"step_count":1} {"level":"info","ts":"2026-08-16T12:56:07.911302Z","caller":"traceutil/trace.go:171","msg":"trace[408640168] transaction","detail":"{read_only:false; response_revision:1190; number_of_response:1; }","duration":"404.213809ms","start":"2026-08-16T12:56:07.507058Z","end":"2026-08-16T12:56:07.911272Z","steps":["trace[408640168] 'process raft request' (duration: 404.030323ms)"],"step_count":1} {"level":"warn","ts":"2026-08-16T12:56:07.9115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-16T12:56:07.507033Z","time spent":"404.366244ms","remote":"127.0.0.1:43544","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11371,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-16T12:56:09.197939Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6530395427225519949,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-16T12:56:09.642535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.821341ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-16T12:56:09.642672Z","caller":"traceutil/trace.go:171","msg":"trace[500978156] linearizableReadLoop","detail":"{readStateIndex:1246; appliedIndex:1245; }","duration":"945.659795ms","start":"2026-08-16T12:56:08.696992Z","end":"2026-08-16T12:56:09.642652Z","steps":["trace[500978156] 'read index received' (duration: 658.564585ms)","trace[500978156] 'applied index is now lower than readState.Index' (duration: 287.0937ms)"],"step_count":2} {"level":"info","ts":"2026-08-16T12:56:09.643055Z","caller":"traceutil/trace.go:171","msg":"trace[666708711] transaction","detail":"{read_only:false; response_revision:1197; number_of_response:1; }","duration":"954.54404ms","start":"2026-08-16T12:56:08.688497Z","end":"2026-08-16T12:56:09.643041Z","steps":["trace[666708711] 'process raft request' (duration: 667.11013ms)","trace[666708711] 'compare' (duration: 286.670336ms)"],"step_count":2} {"level":"warn","ts":"2026-08-16T12:56:09.643124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-16T12:56:08.68847Z","time spent":"954.616873ms","remote":"127.0.0.1:43644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-16T12:56:09.643113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.685319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-16T12:56:09.643114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"902.686632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-08-16T12:56:09.643193Z","caller":"traceutil/trace.go:171","msg":"trace[414735511] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1197; }","duration":"356.852585ms","start":"2026-08-16T12:56:09.28632Z","end":"2026-08-16T12:56:09.643173Z","steps":["trace[414735511] 'agreement among raft nodes before linearized reading' (duration: 356.71133ms)"],"step_count":1} {"level":"info","ts":"2026-08-16T12:56:09.643204Z","caller":"traceutil/trace.go:171","msg":"trace[1895369360] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1197; }","duration":"902.834306ms","start":"2026-08-16T12:56:08.74035Z","end":"2026-08-16T12:56:09.643184Z","steps":["trace[1895369360] 'agreement among raft nodes before linearized reading' (duration: 902.569698ms)"],"step_count":1} {"level":"warn","ts":"2026-08-16T12:56:09.643236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-16T12:56:09.286298Z","time spent":"356.930808ms","remote":"127.0.0.1:43320","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-16T12:56:09.643132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"902.160265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-08-16T12:56:09.643247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-16T12:56:08.74033Z","time spent":"902.908149ms","remote":"127.0.0.1:43644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-08-16T12:56:09.643224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"946.206332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-16T12:56:09.643383Z","caller":"traceutil/trace.go:171","msg":"trace[1031996548] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1197; }","duration":"946.420439ms","start":"2026-08-16T12:56:08.696951Z","end":"2026-08-16T12:56:09.643372Z","steps":["trace[1031996548] 'agreement among raft nodes before linearized reading' (duration: 946.074478ms)"],"step_count":1} {"level":"warn","ts":"2026-08-16T12:56:09.643412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-16T12:56:08.696934Z","time spent":"946.469281ms","remote":"127.0.0.1:43644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-08-16T12:56:09.643439Z","caller":"traceutil/trace.go:171","msg":"trace[422978608] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1197; }","duration":"902.3469ms","start":"2026-08-16T12:56:08.740935Z","end":"2026-08-16T12:56:09.643282Z","steps":["trace[422978608] 'agreement among raft nodes before linearized reading' (duration: 902.091772ms)"],"step_count":1} {"level":"warn","ts":"2026-08-16T12:56:09.643758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-16T12:56:08.740922Z","time spent":"902.820606ms","remote":"127.0.0.1:43644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-08-16T12:56:10.657474Z","caller":"traceutil/trace.go:171","msg":"trace[1640075051] transaction","detail":"{read_only:false; response_revision:1209; number_of_response:1; }","duration":"307.776585ms","start":"2026-08-16T12:56:10.34967Z","end":"2026-08-16T12:56:10.657447Z","steps":["trace[1640075051] 'process raft request' (duration: 241.658987ms)","trace[1640075051] 'compare' (duration: 65.827569ms)"],"step_count":2} {"level":"warn","ts":"2026-08-16T12:56:10.657615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-16T12:56:10.349658Z","time spent":"307.877789ms","remote":"127.0.0.1:43644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-16T12:56:11.132978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.309235ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-16T12:56:11.13309Z","caller":"traceutil/trace.go:171","msg":"trace[1490256579] transaction","detail":"{read_only:false; response_revision:1210; number_of_response:1; }","duration":"444.045789ms","start":"2026-08-16T12:56:10.689024Z","end":"2026-08-16T12:56:11.13307Z","steps":["trace[1490256579] 'process raft request' (duration: 271.556448ms)","trace[1490256579] 'compare' (duration: 172.180111ms)"],"step_count":2} {"level":"warn","ts":"2026-08-16T12:56:11.133184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-16T12:56:10.688994Z","time spent":"444.161783ms","remote":"127.0.0.1:43644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-16T12:56:12.368162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.409564ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-08-16T12:56:12.368241Z","caller":"traceutil/trace.go:171","msg":"trace[1915483270] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1214; }","duration":"312.536288ms","start":"2026-08-16T12:56:12.055686Z","end":"2026-08-16T12:56:12.368223Z","steps":["trace[1915483270] 'range keys from in-memory index tree' (duration: 312.216988ms)"],"step_count":1} {"level":"warn","ts":"2026-08-16T12:56:12.36828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-16T12:56:12.055666Z","time spent":"312.605351ms","remote":"127.0.0.1:43644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-16T12:56:12.368596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.337515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-16T12:56:12.368633Z","caller":"traceutil/trace.go:171","msg":"trace[2033717677] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:1214; }","duration":"295.399507ms","start":"2026-08-16T12:56:12.073223Z","end":"2026-08-16T12:56:12.368622Z","steps":["trace[2033717677] 'count revisions from in-memory index tree' (duration: 295.278853ms)"],"step_count":1} {"level":"info","ts":"2026-08-16T12:56:12.493728Z","caller":"traceutil/trace.go:171","msg":"trace[904488180] transaction","detail":"{read_only:false; response_revision:1215; number_of_response:1; }","duration":"121.236452ms","start":"2026-08-16T12:56:12.372475Z","end":"2026-08-16T12:56:12.493712Z","steps":["trace[904488180] 'process raft request' (duration: 121.125438ms)"],"step_count":1} {"level":"warn","ts":"2026-08-16T12:56:13.014889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.825874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-16T12:56:13.015005Z","caller":"traceutil/trace.go:171","msg":"trace[1996397303] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:1215; }","duration":"278.986109ms","start":"2026-08-16T12:56:12.735988Z","end":"2026-08-16T12:56:13.014975Z","steps":["trace[1996397303] 'count revisions from in-memory index tree' (duration: 278.70055ms)"],"step_count":1} {"level":"warn","ts":"2026-08-16T12:56:13.01498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.460471ms","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-08-16T12:56:13.015092Z","caller":"traceutil/trace.go:171","msg":"trace[10550413] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:1215; }","duration":"438.641367ms","start":"2026-08-16T12:56:12.576424Z","end":"2026-08-16T12:56:13.015066Z","steps":["trace[10550413] 'count revisions from in-memory index tree' (duration: 438.334817ms)"],"step_count":1} {"level":"warn","ts":"2026-08-16T12:56:13.015142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-16T12:56:12.576398Z","time spent":"438.73076ms","remote":"127.0.0.1:43884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":1,"response size":30,"request content":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-08-16T12:56:13.378321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.896931ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-16T12:56:13.378439Z","caller":"traceutil/trace.go:171","msg":"trace[1393316774] transaction","detail":"{read_only:false; response_revision:1217; number_of_response:1; }","duration":"239.983313ms","start":"2026-08-16T12:56:13.138437Z","end":"2026-08-16T12:56:13.37842Z","steps":["trace[1393316774] 'process raft request' (duration: 118.881596ms)","trace[1393316774] 'compare' (duration: 120.587481ms)"],"step_count":2} {"level":"warn","ts":"2026-08-16T12:56:13.740442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.050832ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-08-16T12:56:38.008074Z","caller":"traceutil/trace.go:171","msg":"trace[199582031] linearizableReadLoop","detail":"{readStateIndex:1409; appliedIndex:1408; }","duration":"116.289674ms","start":"2026-08-16T12:56:37.891756Z","end":"2026-08-16T12:56:38.008046Z","steps":["trace[199582031] 'read index received' (duration: 116.134539ms)","trace[199582031] 'applied index is now lower than readState.Index' (duration: 153.785µs)"],"step_count":2} {"level":"info","ts":"2026-08-16T12:56:38.008154Z","caller":"traceutil/trace.go:171","msg":"trace[113469257] transaction","detail":"{read_only:false; response_revision:1355; number_of_response:1; }","duration":"156.162628ms","start":"2026-08-16T12:56:37.851959Z","end":"2026-08-16T12:56:38.008122Z","steps":["trace[113469257] 'process raft request' (duration: 155.896909ms)"],"step_count":1} {"level":"warn","ts":"2026-08-16T12:56:38.008371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.590544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-16T12:56:38.008432Z","caller":"traceutil/trace.go:171","msg":"trace[1930310971] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1355; }","duration":"116.716578ms","start":"2026-08-16T12:56:37.8917Z","end":"2026-08-16T12:56:38.008416Z","steps":["trace[1930310971] 'agreement among raft nodes before linearized reading' (duration: 116.503621ms)"],"step_count":1} {"level":"warn","ts":"2026-08-16T12:56:38.008513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.79751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-16T12:56:38.008603Z","caller":"traceutil/trace.go:171","msg":"trace[1090692553] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1355; }","duration":"102.963206ms","start":"2026-08-16T12:56:37.905618Z","end":"2026-08-16T12:56:38.008581Z","steps":["trace[1090692553] 'agreement among raft nodes before linearized reading' (duration: 102.625785ms)"],"step_count":1} {"level":"warn","ts":"2026-08-16T12:56:38.008544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.543715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-08-16T12:56:38.008684Z","caller":"traceutil/trace.go:171","msg":"trace[429888379] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1355; }","duration":"108.745992ms","start":"2026-08-16T12:56:37.899927Z","end":"2026-08-16T12:56:38.008673Z","steps":["trace[429888379] 'agreement among raft nodes before linearized reading' (duration: 108.287297ms)"],"step_count":1} {"level":"info","ts":"2026-08-16T12:56:38.306716Z","caller":"traceutil/trace.go:171","msg":"trace[146060352] transaction","detail":"{read_only:false; response_revision:1359; number_of_response:1; }","duration":"196.433835ms","start":"2026-08-16T12:56:38.110232Z","end":"2026-08-16T12:56:38.306666Z","steps":["trace[146060352] 'process raft request' (duration: 150.241608ms)","trace[146060352] 'compare' (duration: 45.951269ms)"],"step_count":2} {"level":"info","ts":"2026-08-16T12:57:23.455042Z","caller":"traceutil/trace.go:171","msg":"trace[478876500] transaction","detail":"{read_only:false; response_revision:1564; number_of_response:1; }","duration":"106.464108ms","start":"2026-08-16T12:57:23.348552Z","end":"2026-08-16T12:57:23.455016Z","steps":["trace[478876500] 'process raft request' (duration: 106.317654ms)"],"step_count":1}