{"level":"warn","ts":"2026-04-25T09:32:57.103947Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-25T09:32:57.104046Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.227: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.227:2380","--initial-cluster=instance=https://199.204.45.227:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.227:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.227: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-04-25T09:32:57.104122Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-25T09:32:57.104131Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.227:2380"]} {"level":"info","ts":"2026-04-25T09:32:57.104153Z","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-04-25T09:32:57.104885Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.227:2379"]} {"level":"info","ts":"2026-04-25T09:32:57.104979Z","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.227:2380"],"listen-peer-urls":["https://199.204.45.227:2380"],"advertise-client-urls":["https://199.204.45.227:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.227:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.227: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-04-25T09:32:57.114492Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.824338ms"} {"level":"info","ts":"2026-04-25T09:32:57.126667Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"572db18442eba1c2","cluster-id":"fb1028a037bf3cd6"} {"level":"info","ts":"2026-04-25T09:32:57.126787Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 switched to configuration voters=()"} {"level":"info","ts":"2026-04-25T09:32:57.12682Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became follower at term 0"} {"level":"info","ts":"2026-04-25T09:32:57.126835Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 572db18442eba1c2 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-25T09:32:57.126848Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became follower at term 1"} {"level":"info","ts":"2026-04-25T09:32:57.1269Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 switched to configuration voters=(6281872236868248002)"} {"level":"warn","ts":"2026-04-25T09:32:57.137634Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-25T09:32:57.142837Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-25T09:32:57.144178Z","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-04-25T09:32:57.149048Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"572db18442eba1c2","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-25T09:32:57.150709Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"572db18442eba1c2","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-25T09:32:57.154953Z","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-04-25T09:32:57.155378Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 switched to configuration voters=(6281872236868248002)"} {"level":"info","ts":"2026-04-25T09:32:57.157125Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"fb1028a037bf3cd6","local-member-id":"572db18442eba1c2","added-peer-id":"572db18442eba1c2","added-peer-peer-urls":["https://199.204.45.227:2380"]} {"level":"info","ts":"2026-04-25T09:32:57.157278Z","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-04-25T09:32:57.157538Z","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-04-25T09:32:57.170847Z","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-04-25T09:32:57.170935Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.227:2380"} {"level":"info","ts":"2026-04-25T09:32:57.170967Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.227:2380"} {"level":"info","ts":"2026-04-25T09:32:57.17106Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"572db18442eba1c2","initial-advertise-peer-urls":["https://199.204.45.227:2380"],"listen-peer-urls":["https://199.204.45.227:2380"],"advertise-client-urls":["https://199.204.45.227:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.227:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-25T09:32:57.171085Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-25T09:32:57.628432Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 is starting a new election at term 1"} {"level":"info","ts":"2026-04-25T09:32:57.628547Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-25T09:32:57.628604Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 received MsgPreVoteResp from 572db18442eba1c2 at term 1"} {"level":"info","ts":"2026-04-25T09:32:57.628635Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became candidate at term 2"} {"level":"info","ts":"2026-04-25T09:32:57.628647Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 received MsgVoteResp from 572db18442eba1c2 at term 2"} {"level":"info","ts":"2026-04-25T09:32:57.628666Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became leader at term 2"} {"level":"info","ts":"2026-04-25T09:32:57.628686Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 572db18442eba1c2 elected leader 572db18442eba1c2 at term 2"} {"level":"info","ts":"2026-04-25T09:32:57.630453Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-25T09:32:57.630985Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-25T09:32:57.630986Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"572db18442eba1c2","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.227:2379]}","request-path":"/0/members/572db18442eba1c2/attributes","cluster-id":"fb1028a037bf3cd6","publish-timeout":"7s"} {"level":"info","ts":"2026-04-25T09:32:57.631022Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-25T09:32:57.631507Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"fb1028a037bf3cd6","local-member-id":"572db18442eba1c2","cluster-version":"3.5"} {"level":"info","ts":"2026-04-25T09:32:57.63169Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-25T09:32:57.631741Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-25T09:32:57.632311Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-25T09:32:57.632364Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-25T09:32:57.633373Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-25T09:32:57.634275Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.227:2379"} {"level":"warn","ts":"2026-04-25T09:33:00.621712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.838945ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-25T09:33:00.621871Z","caller":"traceutil/trace.go:171","msg":"trace[846120239] transaction","detail":"{read_only:false; response_revision:166; number_of_response:1; }","duration":"151.3727ms","start":"2026-04-25T09:33:00.470476Z","end":"2026-04-25T09:33:00.621849Z","steps":["trace[846120239] 'process raft request' (duration: 31.764041ms)","trace[846120239] 'compare' (duration: 118.632219ms)"],"step_count":2} {"level":"info","ts":"2026-04-25T09:33:01.145187Z","caller":"traceutil/trace.go:171","msg":"trace[589375859] linearizableReadLoop","detail":"{readStateIndex:178; appliedIndex:177; }","duration":"157.758154ms","start":"2026-04-25T09:33:00.98739Z","end":"2026-04-25T09:33:01.145148Z","steps":["trace[589375859] 'read index received' (duration: 157.551357ms)","trace[589375859] 'applied index is now lower than readState.Index' (duration: 205.597µs)"],"step_count":2} {"level":"info","ts":"2026-04-25T09:33:01.145315Z","caller":"traceutil/trace.go:171","msg":"trace[84353594] transaction","detail":"{read_only:false; response_revision:173; number_of_response:1; }","duration":"165.564843ms","start":"2026-04-25T09:33:00.979689Z","end":"2026-04-25T09:33:01.145253Z","steps":["trace[84353594] 'process raft request' (duration: 165.282714ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:01.145419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.004613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-25T09:33:01.145462Z","caller":"traceutil/trace.go:171","msg":"trace[1334663313] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:173; }","duration":"158.098216ms","start":"2026-04-25T09:33:00.98735Z","end":"2026-04-25T09:33:01.145449Z","steps":["trace[1334663313] 'agreement among raft nodes before linearized reading' (duration: 157.987742ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:01.145499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.44865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-25T09:33:01.145623Z","caller":"traceutil/trace.go:171","msg":"trace[1317261686] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:173; }","duration":"114.563194ms","start":"2026-04-25T09:33:01.031007Z","end":"2026-04-25T09:33:01.14557Z","steps":["trace[1317261686] 'agreement among raft nodes before linearized reading' (duration: 114.390669ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:33:01.304641Z","caller":"traceutil/trace.go:171","msg":"trace[2109992814] transaction","detail":"{read_only:false; response_revision:174; number_of_response:1; }","duration":"153.99446ms","start":"2026-04-25T09:33:01.150612Z","end":"2026-04-25T09:33:01.304606Z","steps":["trace[2109992814] 'process raft request' (duration: 133.302958ms)","trace[2109992814] 'compare' (duration: 20.471125ms)"],"step_count":2} {"level":"info","ts":"2026-04-25T09:33:01.530271Z","caller":"traceutil/trace.go:171","msg":"trace[1657690933] transaction","detail":"{read_only:false; response_revision:176; number_of_response:1; }","duration":"152.39324ms","start":"2026-04-25T09:33:01.377858Z","end":"2026-04-25T09:33:01.530251Z","steps":["trace[1657690933] 'process raft request' (duration: 68.202875ms)","trace[1657690933] 'compare' (duration: 83.854155ms)"],"step_count":2} {"level":"info","ts":"2026-04-25T09:33:12.941333Z","caller":"traceutil/trace.go:171","msg":"trace[2129397273] transaction","detail":"{read_only:false; response_revision:429; number_of_response:1; }","duration":"354.516656ms","start":"2026-04-25T09:33:12.586758Z","end":"2026-04-25T09:33:12.941274Z","steps":["trace[2129397273] 'process raft request' (duration: 282.731013ms)","trace[2129397273] 'compare' (duration: 71.670786ms)"],"step_count":2} {"level":"warn","ts":"2026-04-25T09:33:12.941732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:12.586737Z","time spent":"354.679981ms","remote":"127.0.0.1:33116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6740,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-25T09:33:19.169547Z","caller":"traceutil/trace.go:171","msg":"trace[872963125] transaction","detail":"{read_only:false; response_revision:449; number_of_response:1; }","duration":"123.488294ms","start":"2026-04-25T09:33:19.046027Z","end":"2026-04-25T09:33:19.169516Z","steps":["trace[872963125] 'process raft request' (duration: 123.323118ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:33:24.947144Z","caller":"traceutil/trace.go:171","msg":"trace[1466235310] linearizableReadLoop","detail":"{readStateIndex:508; appliedIndex:507; }","duration":"389.778494ms","start":"2026-04-25T09:33:24.557339Z","end":"2026-04-25T09:33:24.947118Z","steps":["trace[1466235310] 'read index received' (duration: 389.692135ms)","trace[1466235310] 'applied index is now lower than readState.Index' (duration: 84.619µs)"],"step_count":2} {"level":"info","ts":"2026-04-25T09:33:24.947409Z","caller":"traceutil/trace.go:171","msg":"trace[1185595490] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"412.035484ms","start":"2026-04-25T09:33:24.535366Z","end":"2026-04-25T09:33:24.947401Z","steps":["trace[1185595490] 'process raft request' (duration: 411.621023ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:24.9475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:24.535353Z","time spent":"412.072202ms","remote":"127.0.0.1:33206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-25T09:33:24.947615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.273002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-25T09:33:24.947633Z","caller":"traceutil/trace.go:171","msg":"trace[383570740] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:495; }","duration":"390.32504ms","start":"2026-04-25T09:33:24.557301Z","end":"2026-04-25T09:33:24.947627Z","steps":["trace[383570740] 'agreement among raft nodes before linearized reading' (duration: 390.292891ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:24.947647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:24.557287Z","time spent":"390.35682ms","remote":"127.0.0.1:33020","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" "} {"level":"warn","ts":"2026-04-25T09:33:24.947735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.069477ms","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-04-25T09:33:24.947748Z","caller":"traceutil/trace.go:171","msg":"trace[260915285] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:495; }","duration":"219.114508ms","start":"2026-04-25T09:33:24.728629Z","end":"2026-04-25T09:33:24.947744Z","steps":["trace[260915285] 'agreement among raft nodes before linearized reading' (duration: 219.090289ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:25.46115Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656052250663299913,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-25T09:33:25.715015Z","caller":"traceutil/trace.go:171","msg":"trace[1857284338] linearizableReadLoop","detail":"{readStateIndex:509; appliedIndex:508; }","duration":"754.426929ms","start":"2026-04-25T09:33:24.960553Z","end":"2026-04-25T09:33:25.71498Z","steps":["trace[1857284338] 'read index received' (duration: 675.334997ms)","trace[1857284338] 'applied index is now lower than readState.Index' (duration: 79.089422ms)"],"step_count":2} {"level":"warn","ts":"2026-04-25T09:33:25.715173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"754.603385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-25T09:33:25.715254Z","caller":"traceutil/trace.go:171","msg":"trace[1355058055] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:496; }","duration":"754.7491ms","start":"2026-04-25T09:33:24.960483Z","end":"2026-04-25T09:33:25.715232Z","steps":["trace[1355058055] 'agreement among raft nodes before linearized reading' (duration: 754.602144ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:25.715282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:24.960462Z","time spent":"754.814019ms","remote":"127.0.0.1:33020","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" "} {"level":"warn","ts":"2026-04-25T09:33:25.715278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.900326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-04-25T09:33:25.715281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.121522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-25T09:33:25.715331Z","caller":"traceutil/trace.go:171","msg":"trace[176356190] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:496; }","duration":"470.995423ms","start":"2026-04-25T09:33:25.244322Z","end":"2026-04-25T09:33:25.715317Z","steps":["trace[176356190] 'agreement among raft nodes before linearized reading' (duration: 470.885856ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:33:25.715341Z","caller":"traceutil/trace.go:171","msg":"trace[13584404] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:496; }","duration":"456.237139ms","start":"2026-04-25T09:33:25.259087Z","end":"2026-04-25T09:33:25.715324Z","steps":["trace[13584404] 'agreement among raft nodes before linearized reading' (duration: 456.129092ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:25.715379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:25.259062Z","time spent":"456.308397ms","remote":"127.0.0.1:32920","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-04-25T09:33:25.715377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:25.244301Z","time spent":"471.063241ms","remote":"127.0.0.1:33206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-25T09:33:25.716081Z","caller":"traceutil/trace.go:171","msg":"trace[768348853] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"763.191102ms","start":"2026-04-25T09:33:24.951835Z","end":"2026-04-25T09:33:25.715026Z","steps":["trace[768348853] 'process raft request' (duration: 684.052031ms)","trace[768348853] 'compare' (duration: 78.740681ms)"],"step_count":2} {"level":"warn","ts":"2026-04-25T09:33:25.716234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:24.951813Z","time spent":"764.345274ms","remote":"127.0.0.1:33206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-25T09:33:26.203743Z","caller":"traceutil/trace.go:171","msg":"trace[884310715] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"485.003506ms","start":"2026-04-25T09:33:25.718714Z","end":"2026-04-25T09:33:26.203718Z","steps":["trace[884310715] 'process raft request' (duration: 484.813551ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:26.203905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:25.7187Z","time spent":"485.125223ms","remote":"127.0.0.1:33206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-25T09:33:26.776541Z","caller":"traceutil/trace.go:171","msg":"trace[298937993] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"886.408892ms","start":"2026-04-25T09:33:25.890046Z","end":"2026-04-25T09:33:26.776455Z","steps":["trace[298937993] 'process raft request' (duration: 886.061141ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:33:26.776664Z","caller":"traceutil/trace.go:171","msg":"trace[2051273363] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"886.45996ms","start":"2026-04-25T09:33:25.890164Z","end":"2026-04-25T09:33:26.776624Z","steps":["trace[2051273363] 'process raft request' (duration: 886.166448ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:26.776774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:25.890024Z","time spent":"886.642716ms","remote":"127.0.0.1:32974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-25T09:33:26.776828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:25.890158Z","time spent":"886.597737ms","remote":"127.0.0.1:32974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-25T09:33:26.776991Z","caller":"traceutil/trace.go:171","msg":"trace[1056854902] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"882.757633ms","start":"2026-04-25T09:33:25.894218Z","end":"2026-04-25T09:33:26.776976Z","steps":["trace[1056854902] 'process raft request' (duration: 882.275814ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:26.777051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:25.894193Z","time spent":"882.829601ms","remote":"127.0.0.1:32974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-25T09:33:26.777379Z","caller":"traceutil/trace.go:171","msg":"trace[951631911] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"880.323203ms","start":"2026-04-25T09:33:25.897003Z","end":"2026-04-25T09:33:26.777326Z","steps":["trace[951631911] 'process raft request' (duration: 879.631539ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:26.777561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:25.89697Z","time spent":"880.509158ms","remote":"127.0.0.1:32974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-25T09:33:26.778063Z","caller":"traceutil/trace.go:171","msg":"trace[1414450212] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"878.532756ms","start":"2026-04-25T09:33:25.899512Z","end":"2026-04-25T09:33:26.778045Z","steps":["trace[1414450212] 'process raft request' (duration: 877.432934ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:26.778142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:25.899488Z","time spent":"878.621254ms","remote":"127.0.0.1:32974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-25T09:33:26.778123Z","caller":"traceutil/trace.go:171","msg":"trace[1817821523] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"878.498517ms","start":"2026-04-25T09:33:25.899595Z","end":"2026-04-25T09:33:26.778094Z","steps":["trace[1817821523] 'process raft request' (duration: 878.342931ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:26.778233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:25.89959Z","time spent":"878.597665ms","remote":"127.0.0.1:32974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-25T09:33:26.778249Z","caller":"traceutil/trace.go:171","msg":"trace[1689488279] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"867.90724ms","start":"2026-04-25T09:33:25.910326Z","end":"2026-04-25T09:33:26.778234Z","steps":["trace[1689488279] 'process raft request' (duration: 867.709835ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:33:26.778233Z","caller":"traceutil/trace.go:171","msg":"trace[885447748] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"886.758824ms","start":"2026-04-25T09:33:25.890194Z","end":"2026-04-25T09:33:26.776952Z","steps":["trace[885447748] 'process raft request' (duration: 886.218047ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:26.778326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:25.910324Z","time spent":"867.962047ms","remote":"127.0.0.1:32974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-25T09:33:26.778345Z","caller":"traceutil/trace.go:171","msg":"trace[290661543] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"866.155903ms","start":"2026-04-25T09:33:25.912178Z","end":"2026-04-25T09:33:26.778334Z","steps":["trace[290661543] 'process raft request' (duration: 865.88833ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:26.778395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:25.912161Z","time spent":"866.211942ms","remote":"127.0.0.1:32974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-25T09:33:26.778448Z","caller":"traceutil/trace.go:171","msg":"trace[566274066] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"868.184294ms","start":"2026-04-25T09:33:25.910251Z","end":"2026-04-25T09:33:26.778436Z","steps":["trace[566274066] 'process raft request' (duration: 867.745545ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:26.778467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:25.890191Z","time spent":"888.15422ms","remote":"127.0.0.1:32974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-25T09:33:26.778512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:25.910225Z","time spent":"868.260412ms","remote":"127.0.0.1:32974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-25T09:33:26.778726Z","caller":"traceutil/trace.go:171","msg":"trace[95871542] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"830.697382ms","start":"2026-04-25T09:33:25.948006Z","end":"2026-04-25T09:33:26.778703Z","steps":["trace[95871542] 'process raft request' (duration: 830.106026ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:26.778802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:25.947565Z","time spent":"831.208779ms","remote":"127.0.0.1:32974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-25T09:33:26.781686Z","caller":"traceutil/trace.go:171","msg":"trace[1251709806] linearizableReadLoop","detail":"{readStateIndex:521; appliedIndex:509; }","duration":"778.809275ms","start":"2026-04-25T09:33:26.002857Z","end":"2026-04-25T09:33:26.781666Z","steps":["trace[1251709806] 'read index received' (duration: 200.759121ms)","trace[1251709806] 'applied index is now lower than readState.Index' (duration: 578.049174ms)"],"step_count":2} {"level":"info","ts":"2026-04-25T09:33:26.781798Z","caller":"traceutil/trace.go:171","msg":"trace[39009428] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"744.761138ms","start":"2026-04-25T09:33:26.037029Z","end":"2026-04-25T09:33:26.78179Z","steps":["trace[39009428] 'process raft request' (duration: 741.326623ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:26.781874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:26.036982Z","time spent":"744.840015ms","remote":"127.0.0.1:32974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-25T09:33:26.782102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"779.240683ms","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-04-25T09:33:26.782142Z","caller":"traceutil/trace.go:171","msg":"trace[165648912] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:509; }","duration":"779.312982ms","start":"2026-04-25T09:33:26.002814Z","end":"2026-04-25T09:33:26.782127Z","steps":["trace[165648912] 'agreement among raft nodes before linearized reading' (duration: 779.214595ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:26.782196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:26.002797Z","time spent":"779.39235ms","remote":"127.0.0.1:33206","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-04-25T09:33:26.782354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"520.374621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-25T09:33:26.78238Z","caller":"traceutil/trace.go:171","msg":"trace[1819511039] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:509; }","duration":"520.450388ms","start":"2026-04-25T09:33:26.261923Z","end":"2026-04-25T09:33:26.782374Z","steps":["trace[1819511039] 'agreement among raft nodes before linearized reading' (duration: 520.407589ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:26.782426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:26.261898Z","time spent":"520.521737ms","remote":"127.0.0.1:32920","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-04-25T09:33:27.196995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.406374ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-25T09:33:27.197136Z","caller":"traceutil/trace.go:171","msg":"trace[9353544] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"410.229767ms","start":"2026-04-25T09:33:26.786881Z","end":"2026-04-25T09:33:27.197111Z","steps":["trace[9353544] 'process raft request' (duration: 309.620137ms)","trace[9353544] 'compare' (duration: 100.147991ms)"],"step_count":2} {"level":"warn","ts":"2026-04-25T09:33:27.197259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:26.786871Z","time spent":"410.307125ms","remote":"127.0.0.1:33490","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":980,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-25T09:33:27.249431Z","caller":"traceutil/trace.go:171","msg":"trace[1019535138] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"459.907508ms","start":"2026-04-25T09:33:26.789478Z","end":"2026-04-25T09:33:27.249386Z","steps":["trace[1019535138] 'process raft request' (duration: 459.634305ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:27.249664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:26.789455Z","time spent":"460.089843ms","remote":"127.0.0.1:33490","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1004,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-25T09:33:27.24978Z","caller":"traceutil/trace.go:171","msg":"trace[956394858] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"455.803519ms","start":"2026-04-25T09:33:26.793922Z","end":"2026-04-25T09:33:27.249725Z","steps":["trace[956394858] 'process raft request' (duration: 455.402739ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:27.250173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:26.793905Z","time spent":"455.971275ms","remote":"127.0.0.1:33206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-25T09:33:27.250172Z","caller":"traceutil/trace.go:171","msg":"trace[344520868] transaction","detail":"{read_only:false; number_of_response:1; response_revision:515; }","duration":"456.033863ms","start":"2026-04-25T09:33:26.794096Z","end":"2026-04-25T09:33:27.25013Z","steps":["trace[344520868] 'process raft request' (duration: 455.422279ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:27.250356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:26.794089Z","time spent":"456.1661ms","remote":"127.0.0.1:32974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":6937,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-25T09:33:27.250358Z","caller":"traceutil/trace.go:171","msg":"trace[744653836] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"460.6014ms","start":"2026-04-25T09:33:26.789737Z","end":"2026-04-25T09:33:27.250338Z","steps":["trace[744653836] 'process raft request' (duration: 459.545546ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:27.250506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:26.789731Z","time spent":"460.742487ms","remote":"127.0.0.1:33490","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":995,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-25T09:33:27.250704Z","caller":"traceutil/trace.go:171","msg":"trace[891189848] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"456.625349ms","start":"2026-04-25T09:33:26.794065Z","end":"2026-04-25T09:33:27.25069Z","steps":["trace[891189848] 'process raft request' (duration: 455.407379ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:33:27.250747Z","caller":"traceutil/trace.go:171","msg":"trace[40876993] linearizableReadLoop","detail":"{readStateIndex:535; appliedIndex:522; }","duration":"299.007ms","start":"2026-04-25T09:33:26.951729Z","end":"2026-04-25T09:33:27.250736Z","steps":["trace[40876993] 'read index received' (duration: 144.810946ms)","trace[40876993] 'applied index is now lower than readState.Index' (duration: 154.195174ms)"],"step_count":2} {"level":"info","ts":"2026-04-25T09:33:27.250764Z","caller":"traceutil/trace.go:171","msg":"trace[1060558899] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"456.735606ms","start":"2026-04-25T09:33:26.794012Z","end":"2026-04-25T09:33:27.250747Z","steps":["trace[1060558899] 'process raft request' (duration: 455.399109ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:27.250822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.096398ms","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-04-25T09:33:27.250852Z","caller":"traceutil/trace.go:171","msg":"trace[235433070] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:521; }","duration":"299.179566ms","start":"2026-04-25T09:33:26.951665Z","end":"2026-04-25T09:33:27.250844Z","steps":["trace[235433070] 'agreement among raft nodes before linearized reading' (duration: 299.111268ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:27.250853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:26.794002Z","time spent":"456.807514ms","remote":"127.0.0.1:32974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6888,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-25T09:33:27.250787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:26.794061Z","time spent":"456.677308ms","remote":"127.0.0.1:32974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10063,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-25T09:33:27.250968Z","caller":"traceutil/trace.go:171","msg":"trace[469216117] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"415.899537ms","start":"2026-04-25T09:33:26.835062Z","end":"2026-04-25T09:33:27.250962Z","steps":["trace[469216117] 'process raft request' (duration: 415.572186ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:27.251008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:26.835036Z","time spent":"415.950216ms","remote":"127.0.0.1:32974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17062,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-25T09:33:27.251049Z","caller":"traceutil/trace.go:171","msg":"trace[2145991128] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"451.208502ms","start":"2026-04-25T09:33:26.799828Z","end":"2026-04-25T09:33:27.251036Z","steps":["trace[2145991128] 'process raft request' (duration: 450.147488ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:33:27.250723Z","caller":"traceutil/trace.go:171","msg":"trace[668039912] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"446.623126ms","start":"2026-04-25T09:33:26.804069Z","end":"2026-04-25T09:33:27.250692Z","steps":["trace[668039912] 'process raft request' (duration: 446.45061ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:27.251119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:26.799817Z","time spent":"451.266881ms","remote":"127.0.0.1:32974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30393,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-25T09:33:27.251197Z","caller":"traceutil/trace.go:171","msg":"trace[913497644] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"453.915145ms","start":"2026-04-25T09:33:26.797273Z","end":"2026-04-25T09:33:27.251188Z","steps":["trace[913497644] 'process raft request' (duration: 452.643827ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:27.25124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:26.797267Z","time spent":"453.954095ms","remote":"127.0.0.1:33490","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-25T09:33:27.251216Z","caller":"traceutil/trace.go:171","msg":"trace[2066907151] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"450.401753ms","start":"2026-04-25T09:33:26.800671Z","end":"2026-04-25T09:33:27.251073Z","steps":["trace[2066907151] 'process raft request' (duration: 449.367459ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:27.25141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:26.804061Z","time spent":"447.091874ms","remote":"127.0.0.1:32974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28739,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-25T09:33:27.251597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:26.80066Z","time spent":"450.786734ms","remote":"127.0.0.1:32974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30374,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-25T09:33:27.252113Z","caller":"traceutil/trace.go:171","msg":"trace[1569626664] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"454.770175ms","start":"2026-04-25T09:33:26.795813Z","end":"2026-04-25T09:33:27.250583Z","steps":["trace[1569626664] 'process raft request' (duration: 454.052502ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:27.252358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:26.795788Z","time spent":"456.381016ms","remote":"127.0.0.1:33490","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-25T09:33:27.692821Z","caller":"traceutil/trace.go:171","msg":"trace[1661056341] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"127.379537ms","start":"2026-04-25T09:33:27.5654Z","end":"2026-04-25T09:33:27.69278Z","steps":["trace[1661056341] 'process raft request' (duration: 112.145634ms)","trace[1661056341] 'compare' (duration: 15.008348ms)"],"step_count":2} {"level":"info","ts":"2026-04-25T09:33:27.69822Z","caller":"traceutil/trace.go:171","msg":"trace[639721202] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"102.420255ms","start":"2026-04-25T09:33:27.595762Z","end":"2026-04-25T09:33:27.698182Z","steps":["trace[639721202] 'process raft request' (duration: 102.271808ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:33:27.698711Z","caller":"traceutil/trace.go:171","msg":"trace[1696495575] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"131.672181ms","start":"2026-04-25T09:33:27.567011Z","end":"2026-04-25T09:33:27.698683Z","steps":["trace[1696495575] 'process raft request' (duration: 130.799322ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:28.150905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.104409ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-25T09:33:28.151049Z","caller":"traceutil/trace.go:171","msg":"trace[690404858] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"142.395107ms","start":"2026-04-25T09:33:28.008631Z","end":"2026-04-25T09:33:28.151026Z","steps":["trace[690404858] 'process raft request' (duration: 33.066432ms)","trace[690404858] 'compare' (duration: 108.906735ms)"],"step_count":2} {"level":"info","ts":"2026-04-25T09:33:28.387899Z","caller":"traceutil/trace.go:171","msg":"trace[1166757619] linearizableReadLoop","detail":"{readStateIndex:587; appliedIndex:586; }","duration":"126.008042ms","start":"2026-04-25T09:33:28.261874Z","end":"2026-04-25T09:33:28.387882Z","steps":["trace[1166757619] 'read index received' (duration: 108.395488ms)","trace[1166757619] 'applied index is now lower than readState.Index' (duration: 17.610724ms)"],"step_count":2} {"level":"warn","ts":"2026-04-25T09:33:28.388359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.46068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-25T09:33:28.388403Z","caller":"traceutil/trace.go:171","msg":"trace[1765955652] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:569; }","duration":"126.551258ms","start":"2026-04-25T09:33:28.26184Z","end":"2026-04-25T09:33:28.388392Z","steps":["trace[1765955652] 'agreement among raft nodes before linearized reading' (duration: 126.140868ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:33:28.387863Z","caller":"traceutil/trace.go:171","msg":"trace[1196009190] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"154.504036ms","start":"2026-04-25T09:33:28.233324Z","end":"2026-04-25T09:33:28.387828Z","steps":["trace[1196009190] 'process raft request' (duration: 136.869342ms)","trace[1196009190] 'compare' (duration: 17.358791ms)"],"step_count":2} {"level":"info","ts":"2026-04-25T09:33:29.07087Z","caller":"traceutil/trace.go:171","msg":"trace[256568010] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"465.620327ms","start":"2026-04-25T09:33:28.605222Z","end":"2026-04-25T09:33:29.070842Z","steps":["trace[256568010] 'process raft request' (duration: 465.376783ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:29.070985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:28.6052Z","time spent":"465.734354ms","remote":"127.0.0.1:32974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":207462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-25T09:33:29.993967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"731.828998ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-25T09:33:29.99412Z","caller":"traceutil/trace.go:171","msg":"trace[1546631435] linearizableReadLoop","detail":"{readStateIndex:591; appliedIndex:590; }","duration":"873.207788ms","start":"2026-04-25T09:33:29.12089Z","end":"2026-04-25T09:33:29.994098Z","steps":["trace[1546631435] 'read index received' (duration: 141.068078ms)","trace[1546631435] 'applied index is now lower than readState.Index' (duration: 732.13804ms)"],"step_count":2} {"level":"info","ts":"2026-04-25T09:33:29.994432Z","caller":"traceutil/trace.go:171","msg":"trace[1631583373] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"1.353870073s","start":"2026-04-25T09:33:28.640465Z","end":"2026-04-25T09:33:29.994335Z","steps":["trace[1631583373] 'process raft request' (duration: 621.546287ms)","trace[1631583373] 'compare' (duration: 731.099696ms)"],"step_count":2} {"level":"warn","ts":"2026-04-25T09:33:29.994654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:28.640439Z","time spent":"1.354091917s","remote":"127.0.0.1:32974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570090,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-25T09:33:29.994748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"873.802654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:29570"} {"level":"info","ts":"2026-04-25T09:33:29.994863Z","caller":"traceutil/trace.go:171","msg":"trace[1824398695] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:573; }","duration":"873.987879ms","start":"2026-04-25T09:33:29.12085Z","end":"2026-04-25T09:33:29.994838Z","steps":["trace[1824398695] 'agreement among raft nodes before linearized reading' (duration: 873.622589ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:29.994925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:29.120832Z","time spent":"874.082207ms","remote":"127.0.0.1:32974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":103,"response count":1,"response size":29593,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io\" "} {"level":"info","ts":"2026-04-25T09:33:30.03745Z","caller":"traceutil/trace.go:171","msg":"trace[1961544010] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"873.996559ms","start":"2026-04-25T09:33:29.163434Z","end":"2026-04-25T09:33:30.03743Z","steps":["trace[1961544010] 'process raft request' (duration: 873.725515ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:30.037706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:29.163391Z","time spent":"874.124965ms","remote":"127.0.0.1:32974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":208461,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-25T09:33:30.042091Z","caller":"traceutil/trace.go:171","msg":"trace[1174322606] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"177.259083ms","start":"2026-04-25T09:33:29.864802Z","end":"2026-04-25T09:33:30.042061Z","steps":["trace[1174322606] 'process raft request' (duration: 176.858313ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:30.042522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"781.699963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-25T09:33:30.042606Z","caller":"traceutil/trace.go:171","msg":"trace[22552390] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:575; }","duration":"781.80953ms","start":"2026-04-25T09:33:29.260777Z","end":"2026-04-25T09:33:30.042587Z","steps":["trace[22552390] 'agreement among raft nodes before linearized reading' (duration: 781.660134ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:30.042655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:29.260707Z","time spent":"781.935187ms","remote":"127.0.0.1:32920","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-04-25T09:33:30.042941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.665471ms","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-04-25T09:33:30.043004Z","caller":"traceutil/trace.go:171","msg":"trace[1736191800] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:575; }","duration":"291.755189ms","start":"2026-04-25T09:33:29.751232Z","end":"2026-04-25T09:33:30.042987Z","steps":["trace[1736191800] 'agreement among raft nodes before linearized reading' (duration: 291.630672ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:30.043166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"778.073923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-25T09:33:30.043233Z","caller":"traceutil/trace.go:171","msg":"trace[1510952387] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:575; }","duration":"778.191039ms","start":"2026-04-25T09:33:29.265027Z","end":"2026-04-25T09:33:30.043218Z","steps":["trace[1510952387] 'agreement among raft nodes before linearized reading' (duration: 778.035183ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:30.043282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:29.265001Z","time spent":"778.269118ms","remote":"127.0.0.1:33206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-25T09:33:30.043436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"738.149672ms","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-04-25T09:33:30.043488Z","caller":"traceutil/trace.go:171","msg":"trace[2073495969] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:575; }","duration":"738.23375ms","start":"2026-04-25T09:33:29.305241Z","end":"2026-04-25T09:33:30.043474Z","steps":["trace[2073495969] 'agreement among raft nodes before linearized reading' (duration: 738.138142ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:30.043536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:29.305223Z","time spent":"738.297198ms","remote":"127.0.0.1:33206","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":"warn","ts":"2026-04-25T09:33:30.692933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.560383ms","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-04-25T09:33:30.693049Z","caller":"traceutil/trace.go:171","msg":"trace[763955928] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:580; }","duration":"472.75159ms","start":"2026-04-25T09:33:30.220272Z","end":"2026-04-25T09:33:30.693023Z","steps":["trace[763955928] 'range keys from in-memory index tree' (duration: 472.399028ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:30.692956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"477.714936ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/xbackendtrafficpolicies.gateway.networking.x-k8s.io\" ","response":"range_response_count:1 size:23081"} {"level":"warn","ts":"2026-04-25T09:33:30.693118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:30.220245Z","time spent":"472.861607ms","remote":"127.0.0.1:33206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-25T09:33:30.693666Z","caller":"traceutil/trace.go:171","msg":"trace[412639507] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/xbackendtrafficpolicies.gateway.networking.x-k8s.io; range_end:; response_count:1; response_revision:580; }","duration":"478.470228ms","start":"2026-04-25T09:33:30.215165Z","end":"2026-04-25T09:33:30.693635Z","steps":["trace[412639507] 'range keys from in-memory index tree' (duration: 477.508852ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:30.693764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:30.215141Z","time spent":"478.605225ms","remote":"127.0.0.1:32974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":1,"response size":23104,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/xbackendtrafficpolicies.gateway.networking.x-k8s.io\" "} {"level":"info","ts":"2026-04-25T09:33:32.308441Z","caller":"traceutil/trace.go:171","msg":"trace[741326458] linearizableReadLoop","detail":"{readStateIndex:600; appliedIndex:599; }","duration":"242.055199ms","start":"2026-04-25T09:33:32.066348Z","end":"2026-04-25T09:33:32.308403Z","steps":["trace[741326458] 'read index received' (duration: 241.827145ms)","trace[741326458] 'applied index is now lower than readState.Index' (duration: 226.154µs)"],"step_count":2} {"level":"warn","ts":"2026-04-25T09:33:32.308569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:31.93354Z","time spent":"375.023748ms","remote":"127.0.0.1:32958","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-04-25T09:33:32.308773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.397212ms","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-04-25T09:33:32.308813Z","caller":"traceutil/trace.go:171","msg":"trace[1259189392] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:581; }","duration":"242.47828ms","start":"2026-04-25T09:33:32.066323Z","end":"2026-04-25T09:33:32.308801Z","steps":["trace[1259189392] 'agreement among raft nodes before linearized reading' (duration: 242.281094ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:32.308827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.649501ms","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-04-25T09:33:32.308897Z","caller":"traceutil/trace.go:171","msg":"trace[421609819] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:581; }","duration":"241.787936ms","start":"2026-04-25T09:33:32.067095Z","end":"2026-04-25T09:33:32.308883Z","steps":["trace[421609819] 'agreement among raft nodes before linearized reading' (duration: 241.563442ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:32.308926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.977742ms","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-04-25T09:33:32.309027Z","caller":"traceutil/trace.go:171","msg":"trace[1870253782] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:581; }","duration":"242.132588ms","start":"2026-04-25T09:33:32.066871Z","end":"2026-04-25T09:33:32.309004Z","steps":["trace[1870253782] 'agreement among raft nodes before linearized reading' (duration: 241.782577ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:33:32.417272Z","caller":"traceutil/trace.go:171","msg":"trace[2001020449] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"107.338144ms","start":"2026-04-25T09:33:32.309909Z","end":"2026-04-25T09:33:32.417248Z","steps":["trace[2001020449] 'process raft request' (duration: 106.938664ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:33:32.42191Z","caller":"traceutil/trace.go:171","msg":"trace[1391779675] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"107.872411ms","start":"2026-04-25T09:33:32.31402Z","end":"2026-04-25T09:33:32.421893Z","steps":["trace[1391779675] 'process raft request' (duration: 107.816432ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:33:32.422007Z","caller":"traceutil/trace.go:171","msg":"trace[251229467] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"108.120844ms","start":"2026-04-25T09:33:32.313835Z","end":"2026-04-25T09:33:32.421956Z","steps":["trace[251229467] 'process raft request' (duration: 107.89257ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:33:32.422176Z","caller":"traceutil/trace.go:171","msg":"trace[903784176] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"106.732219ms","start":"2026-04-25T09:33:32.315411Z","end":"2026-04-25T09:33:32.422143Z","steps":["trace[903784176] 'process raft request' (duration: 106.452805ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:33:33.710985Z","caller":"traceutil/trace.go:171","msg":"trace[343277876] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"325.477155ms","start":"2026-04-25T09:33:33.385477Z","end":"2026-04-25T09:33:33.710955Z","steps":["trace[343277876] 'process raft request' (duration: 323.987372ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:33.711213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:33.385434Z","time spent":"325.694068ms","remote":"127.0.0.1:33020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036101,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-25T09:33:34.560281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.491132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-04-25T09:33:34.560452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.047767ms","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-04-25T09:33:34.560498Z","caller":"traceutil/trace.go:171","msg":"trace[1044034992] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:594; }","duration":"133.119015ms","start":"2026-04-25T09:33:34.427358Z","end":"2026-04-25T09:33:34.560477Z","steps":["trace[1044034992] 'range keys from in-memory index tree' (duration: 132.490511ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:34.560486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.408724ms","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-04-25T09:33:34.560643Z","caller":"traceutil/trace.go:171","msg":"trace[758349458] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:594; }","duration":"134.617948ms","start":"2026-04-25T09:33:34.425988Z","end":"2026-04-25T09:33:34.560606Z","steps":["trace[758349458] 'range keys from in-memory index tree' (duration: 133.902256ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:33:34.560826Z","caller":"traceutil/trace.go:171","msg":"trace[152366241] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:594; }","duration":"132.697976ms","start":"2026-04-25T09:33:34.427695Z","end":"2026-04-25T09:33:34.560393Z","steps":["trace[152366241] 'range keys from in-memory index tree' (duration: 132.0884ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:33:35.443442Z","caller":"traceutil/trace.go:171","msg":"trace[707616426] linearizableReadLoop","detail":"{readStateIndex:620; appliedIndex:619; }","duration":"182.557514ms","start":"2026-04-25T09:33:35.260835Z","end":"2026-04-25T09:33:35.443393Z","steps":["trace[707616426] 'read index received' (duration: 182.305729ms)","trace[707616426] 'applied index is now lower than readState.Index' (duration: 250.665µs)"],"step_count":2} {"level":"info","ts":"2026-04-25T09:33:35.443502Z","caller":"traceutil/trace.go:171","msg":"trace[66619659] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"642.084245ms","start":"2026-04-25T09:33:34.801367Z","end":"2026-04-25T09:33:35.443451Z","steps":["trace[66619659] 'process raft request' (duration: 641.87294ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:35.443603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.755199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-25T09:33:35.443643Z","caller":"traceutil/trace.go:171","msg":"trace[977376635] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:601; }","duration":"182.871231ms","start":"2026-04-25T09:33:35.26076Z","end":"2026-04-25T09:33:35.443631Z","steps":["trace[977376635] 'agreement among raft nodes before linearized reading' (duration: 182.765519ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:35.44371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:34.801334Z","time spent":"642.279457ms","remote":"127.0.0.1:33272","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1044,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-25T09:33:36.039016Z","caller":"traceutil/trace.go:171","msg":"trace[1284478338] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"105.639482ms","start":"2026-04-25T09:33:35.933345Z","end":"2026-04-25T09:33:36.038984Z","steps":["trace[1284478338] 'process raft request' (duration: 76.348661ms)","trace[1284478338] 'compare' (duration: 29.105768ms)"],"step_count":2} {"level":"info","ts":"2026-04-25T09:33:36.749019Z","caller":"traceutil/trace.go:171","msg":"trace[1766535495] linearizableReadLoop","detail":"{readStateIndex:623; appliedIndex:622; }","duration":"144.010967ms","start":"2026-04-25T09:33:36.604985Z","end":"2026-04-25T09:33:36.748996Z","steps":["trace[1766535495] 'read index received' (duration: 143.16247ms)","trace[1766535495] 'applied index is now lower than readState.Index' (duration: 847.907µs)"],"step_count":2} {"level":"warn","ts":"2026-04-25T09:33:36.749156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.15816ms","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-04-25T09:33:36.749131Z","caller":"traceutil/trace.go:171","msg":"trace[150773294] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"330.942865ms","start":"2026-04-25T09:33:36.418151Z","end":"2026-04-25T09:33:36.749094Z","steps":["trace[150773294] 'process raft request' (duration: 330.1554ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:33:36.749183Z","caller":"traceutil/trace.go:171","msg":"trace[1277679745] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:604; }","duration":"144.230021ms","start":"2026-04-25T09:33:36.604946Z","end":"2026-04-25T09:33:36.749176Z","steps":["trace[1277679745] 'agreement among raft nodes before linearized reading' (duration: 144.143869ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:36.749205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.560489ms","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-04-25T09:33:36.749256Z","caller":"traceutil/trace.go:171","msg":"trace[1065714528] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:604; }","duration":"142.655171ms","start":"2026-04-25T09:33:36.606588Z","end":"2026-04-25T09:33:36.749243Z","steps":["trace[1065714528] 'agreement among raft nodes before linearized reading' (duration: 142.56715ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:36.7493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:36.418122Z","time spent":"331.084768ms","remote":"127.0.0.1:33020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036253,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-25T09:33:36.749692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.717731ms","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-04-25T09:33:36.749792Z","caller":"traceutil/trace.go:171","msg":"trace[211061934] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:604; }","duration":"142.878766ms","start":"2026-04-25T09:33:36.606893Z","end":"2026-04-25T09:33:36.749771Z","steps":["trace[211061934] 'agreement among raft nodes before linearized reading' (duration: 142.376346ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:33:36.903006Z","caller":"traceutil/trace.go:171","msg":"trace[951716458] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"124.757148ms","start":"2026-04-25T09:33:36.778172Z","end":"2026-04-25T09:33:36.902929Z","steps":["trace[951716458] 'process raft request' (duration: 33.273217ms)","trace[951716458] 'compare' (duration: 91.203416ms)"],"step_count":2} {"level":"info","ts":"2026-04-25T09:33:37.532705Z","caller":"traceutil/trace.go:171","msg":"trace[1959171140] linearizableReadLoop","detail":"{readStateIndex:631; appliedIndex:630; }","duration":"351.57962ms","start":"2026-04-25T09:33:37.181096Z","end":"2026-04-25T09:33:37.532675Z","steps":["trace[1959171140] 'read index received' (duration: 272.74186ms)","trace[1959171140] 'applied index is now lower than readState.Index' (duration: 78.8362ms)"],"step_count":2} {"level":"warn","ts":"2026-04-25T09:33:37.532892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.765593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-04-25T09:33:37.532969Z","caller":"traceutil/trace.go:171","msg":"trace[573069835] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:611; }","duration":"351.886126ms","start":"2026-04-25T09:33:37.181056Z","end":"2026-04-25T09:33:37.532942Z","steps":["trace[573069835] 'agreement among raft nodes before linearized reading' (duration: 351.727263ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:37.533007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:37.181036Z","time spent":"351.964747ms","remote":"127.0.0.1:33036","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-04-25T09:33:37.534204Z","caller":"traceutil/trace.go:171","msg":"trace[545286632] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"207.206457ms","start":"2026-04-25T09:33:37.326978Z","end":"2026-04-25T09:33:37.534185Z","steps":["trace[545286632] 'process raft request' (duration: 206.772078ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:37.538949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.882419ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-25T09:33:37.539024Z","caller":"traceutil/trace.go:171","msg":"trace[299393005] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:613; }","duration":"279.011351ms","start":"2026-04-25T09:33:37.259996Z","end":"2026-04-25T09:33:37.539007Z","steps":["trace[299393005] 'agreement among raft nodes before linearized reading' (duration: 278.881129ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:38.055571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.355809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-25T09:33:38.055589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.666064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-25T09:33:38.055611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.794213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-25T09:33:38.055634Z","caller":"traceutil/trace.go:171","msg":"trace[604627217] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:614; }","duration":"313.444481ms","start":"2026-04-25T09:33:37.742175Z","end":"2026-04-25T09:33:38.055619Z","steps":["trace[604627217] 'count revisions from in-memory index tree' (duration: 313.299418ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:33:38.055667Z","caller":"traceutil/trace.go:171","msg":"trace[1620732163] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:614; }","duration":"340.859585ms","start":"2026-04-25T09:33:37.71479Z","end":"2026-04-25T09:33:38.055649Z","steps":["trace[1620732163] 'range keys from in-memory index tree' (duration: 340.763353ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:38.055669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:37.742168Z","time spent":"313.493092ms","remote":"127.0.0.1:35450","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "} {"level":"warn","ts":"2026-04-25T09:33:38.055701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:37.714787Z","time spent":"340.903376ms","remote":"127.0.0.1:35434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-25T09:33:38.055693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.191079ms","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":"warn","ts":"2026-04-25T09:33:38.05573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.704069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-rp26x\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-25T09:33:38.055758Z","caller":"traceutil/trace.go:171","msg":"trace[392014331] range","detail":"{range_begin:/registry/pods/kube-system/cilium-rp26x; range_end:; response_count:1; response_revision:614; }","duration":"402.734529ms","start":"2026-04-25T09:33:37.653015Z","end":"2026-04-25T09:33:38.05575Z","steps":["trace[392014331] 'range keys from in-memory index tree' (duration: 402.633587ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:33:38.055755Z","caller":"traceutil/trace.go:171","msg":"trace[1932186850] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:614; }","duration":"122.27268ms","start":"2026-04-25T09:33:37.933467Z","end":"2026-04-25T09:33:38.05574Z","steps":["trace[1932186850] 'count revisions from in-memory index tree' (duration: 122.122317ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:38.055786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:37.652994Z","time spent":"402.78402ms","remote":"127.0.0.1:33116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-rp26x\" "} {"level":"warn","ts":"2026-04-25T09:33:38.055851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.095749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-25T09:33:38.055872Z","caller":"traceutil/trace.go:171","msg":"trace[549811794] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:614; }","duration":"341.13636ms","start":"2026-04-25T09:33:37.71473Z","end":"2026-04-25T09:33:38.055866Z","steps":["trace[549811794] 'count revisions from in-memory index tree' (duration: 341.006568ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:38.055892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:37.714717Z","time spent":"341.169291ms","remote":"127.0.0.1:35434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-25T09:33:38.055892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.035991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-25T09:33:38.055896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.444774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-25T09:33:38.055952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.633005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-25T09:33:38.055962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.01366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-25T09:33:38.055978Z","caller":"traceutil/trace.go:171","msg":"trace[223258727] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:614; }","duration":"121.553496ms","start":"2026-04-25T09:33:37.934405Z","end":"2026-04-25T09:33:38.055959Z","steps":["trace[223258727] 'range keys from in-memory index tree' (duration: 121.387503ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:33:38.055986Z","caller":"traceutil/trace.go:171","msg":"trace[1369336862] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:614; }","duration":"313.680245ms","start":"2026-04-25T09:33:37.742296Z","end":"2026-04-25T09:33:38.055977Z","steps":["trace[1369336862] 'range keys from in-memory index tree' (duration: 313.546323ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:38.055997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.323179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-25T09:33:38.056028Z","caller":"traceutil/trace.go:171","msg":"trace[1559361943] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:614; }","duration":"393.37352ms","start":"2026-04-25T09:33:37.662645Z","end":"2026-04-25T09:33:38.056019Z","steps":["trace[1559361943] 'range keys from in-memory index tree' (duration: 393.185877ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:38.056027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:37.742279Z","time spent":"313.737576ms","remote":"127.0.0.1:35450","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 "} {"level":"warn","ts":"2026-04-25T09:33:38.056057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:37.662605Z","time spent":"393.442342ms","remote":"127.0.0.1:35418","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-25T09:33:38.056178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.38367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-25T09:33:38.055994Z","caller":"traceutil/trace.go:171","msg":"trace[291918556] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:614; }","duration":"362.046091ms","start":"2026-04-25T09:33:37.69394Z","end":"2026-04-25T09:33:38.055986Z","steps":["trace[291918556] 'range keys from in-memory index tree' (duration: 361.991529ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:33:38.056213Z","caller":"traceutil/trace.go:171","msg":"trace[457949494] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:614; }","duration":"313.431661ms","start":"2026-04-25T09:33:37.742769Z","end":"2026-04-25T09:33:38.0562Z","steps":["trace[457949494] 'range keys from in-memory index tree' (duration: 313.325699ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:38.056239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:37.693931Z","time spent":"362.292236ms","remote":"127.0.0.1:35430","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-25T09:33:38.056244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:37.74276Z","time spent":"313.474911ms","remote":"127.0.0.1:35450","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 "} {"level":"warn","ts":"2026-04-25T09:33:38.056297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.460363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-25T09:33:38.056282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.842554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-25T09:33:38.05632Z","caller":"traceutil/trace.go:171","msg":"trace[1111312026] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:614; }","duration":"217.500435ms","start":"2026-04-25T09:33:37.838814Z","end":"2026-04-25T09:33:38.056314Z","steps":["trace[1111312026] 'count revisions from in-memory index tree' (duration: 217.437013ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:33:38.055927Z","caller":"traceutil/trace.go:171","msg":"trace[1136773710] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:614; }","duration":"362.094241ms","start":"2026-04-25T09:33:37.693821Z","end":"2026-04-25T09:33:38.055915Z","steps":["trace[1136773710] 'range keys from in-memory index tree' (duration: 361.920908ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:33:38.056347Z","caller":"traceutil/trace.go:171","msg":"trace[876613013] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:614; }","duration":"166.959327ms","start":"2026-04-25T09:33:37.889372Z","end":"2026-04-25T09:33:38.056331Z","steps":["trace[876613013] 'range keys from in-memory index tree' (duration: 166.757622ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:38.055991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.399517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-25T09:33:38.056364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.66099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-25T09:33:38.056377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:37.693807Z","time spent":"362.555921ms","remote":"127.0.0.1:35430","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 "} {"level":"info","ts":"2026-04-25T09:33:38.056401Z","caller":"traceutil/trace.go:171","msg":"trace[2047671962] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:614; }","duration":"340.808125ms","start":"2026-04-25T09:33:37.715579Z","end":"2026-04-25T09:33:38.056387Z","steps":["trace[2047671962] 'range keys from in-memory index tree' (duration: 340.378686ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:38.056418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.719328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-25T09:33:38.055937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.439264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-25T09:33:38.056438Z","caller":"traceutil/trace.go:171","msg":"trace[1887142809] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:614; }","duration":"217.757809ms","start":"2026-04-25T09:33:37.838673Z","end":"2026-04-25T09:33:38.056431Z","steps":["trace[1887142809] 'range keys from in-memory index tree' (duration: 217.662167ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:38.056444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.003845ms","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":"warn","ts":"2026-04-25T09:33:38.056447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:37.715575Z","time spent":"340.855476ms","remote":"127.0.0.1:35434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 "} {"level":"info","ts":"2026-04-25T09:33:38.056456Z","caller":"traceutil/trace.go:171","msg":"trace[1508759325] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:614; }","duration":"402.979035ms","start":"2026-04-25T09:33:37.653466Z","end":"2026-04-25T09:33:38.056445Z","steps":["trace[1508759325] 'range keys from in-memory index tree' (duration: 402.386602ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:33:38.056469Z","caller":"traceutil/trace.go:171","msg":"trace[508638336] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:614; }","duration":"123.069346ms","start":"2026-04-25T09:33:37.933393Z","end":"2026-04-25T09:33:38.056462Z","steps":["trace[508638336] 'range keys from in-memory index tree' (duration: 122.960654ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:38.056493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:37.653456Z","time spent":"403.026956ms","remote":"127.0.0.1:33176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-04-25T09:33:38.056494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.213698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-25T09:33:38.056535Z","caller":"traceutil/trace.go:171","msg":"trace[1687295903] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:614; }","duration":"217.252618ms","start":"2026-04-25T09:33:37.839267Z","end":"2026-04-25T09:33:38.056519Z","steps":["trace[1687295903] 'range keys from in-memory index tree' (duration: 217.119927ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:33:38.056405Z","caller":"traceutil/trace.go:171","msg":"trace[1576742356] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:614; }","duration":"166.749872ms","start":"2026-04-25T09:33:37.889642Z","end":"2026-04-25T09:33:38.056392Z","steps":["trace[1576742356] 'range keys from in-memory index tree' (duration: 166.571558ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:38.055968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.221497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-25T09:33:38.056613Z","caller":"traceutil/trace.go:171","msg":"trace[1265592535] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:614; }","duration":"393.89066ms","start":"2026-04-25T09:33:37.662715Z","end":"2026-04-25T09:33:38.056605Z","steps":["trace[1265592535] 'count revisions from in-memory index tree' (duration: 393.180076ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:38.056641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:37.662707Z","time spent":"393.925031ms","remote":"127.0.0.1:35418","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"info","ts":"2026-04-25T09:33:38.05566Z","caller":"traceutil/trace.go:171","msg":"trace[1067744773] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:614; }","duration":"361.753925ms","start":"2026-04-25T09:33:37.693887Z","end":"2026-04-25T09:33:38.05564Z","steps":["trace[1067744773] 'count revisions from in-memory index tree' (duration: 361.633093ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:38.056696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.344793ms","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":"warn","ts":"2026-04-25T09:33:38.056709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:37.693883Z","time spent":"362.813106ms","remote":"127.0.0.1:35430","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true "} {"level":"info","ts":"2026-04-25T09:33:38.056733Z","caller":"traceutil/trace.go:171","msg":"trace[1164399341] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:614; }","duration":"167.397775ms","start":"2026-04-25T09:33:37.889326Z","end":"2026-04-25T09:33:38.056724Z","steps":["trace[1164399341] 'count revisions from in-memory index tree' (duration: 167.280422ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:33:38.633488Z","caller":"traceutil/trace.go:171","msg":"trace[827077134] linearizableReadLoop","detail":"{readStateIndex:636; appliedIndex:635; }","duration":"172.38829ms","start":"2026-04-25T09:33:38.461071Z","end":"2026-04-25T09:33:38.633459Z","steps":["trace[827077134] 'read index received' (duration: 171.167377ms)","trace[827077134] 'applied index is now lower than readState.Index' (duration: 1.219743ms)"],"step_count":2} {"level":"info","ts":"2026-04-25T09:33:38.633574Z","caller":"traceutil/trace.go:171","msg":"trace[171446671] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"183.967271ms","start":"2026-04-25T09:33:38.449573Z","end":"2026-04-25T09:33:38.63354Z","steps":["trace[171446671] 'process raft request' (duration: 183.045754ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:38.633848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.603014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-25T09:33:38.633875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.763677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-25T09:33:38.633965Z","caller":"traceutil/trace.go:171","msg":"trace[734999604] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:616; }","duration":"172.899329ms","start":"2026-04-25T09:33:38.461041Z","end":"2026-04-25T09:33:38.63394Z","steps":["trace[734999604] 'agreement among raft nodes before linearized reading' (duration: 172.710875ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:33:38.633926Z","caller":"traceutil/trace.go:171","msg":"trace[1412502900] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:616; }","duration":"172.864318ms","start":"2026-04-25T09:33:38.461048Z","end":"2026-04-25T09:33:38.633912Z","steps":["trace[1412502900] 'agreement among raft nodes before linearized reading' (duration: 172.587393ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:38.980693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.326558ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"warn","ts":"2026-04-25T09:33:38.980699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.750009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-rp26x\" ","response":"range_response_count:1 size:17149"} {"level":"info","ts":"2026-04-25T09:33:38.980873Z","caller":"traceutil/trace.go:171","msg":"trace[1775543096] range","detail":"{range_begin:/registry/pods/kube-system/cilium-rp26x; range_end:; response_count:1; response_revision:616; }","duration":"322.975094ms","start":"2026-04-25T09:33:38.657878Z","end":"2026-04-25T09:33:38.980853Z","steps":["trace[1775543096] 'range keys from in-memory index tree' (duration: 322.569566ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:33:38.980886Z","caller":"traceutil/trace.go:171","msg":"trace[1092335822] linearizableReadLoop","detail":"{readStateIndex:638; appliedIndex:636; }","duration":"204.021746ms","start":"2026-04-25T09:33:38.776847Z","end":"2026-04-25T09:33:38.980868Z","steps":["trace[1092335822] 'read index received' (duration: 15.200441ms)","trace[1092335822] 'applied index is now lower than readState.Index' (duration: 188.820425ms)"],"step_count":2} {"level":"warn","ts":"2026-04-25T09:33:38.980928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:38.657859Z","time spent":"323.056885ms","remote":"127.0.0.1:33116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":17172,"request content":"key:\"/registry/pods/kube-system/cilium-rp26x\" "} {"level":"info","ts":"2026-04-25T09:33:38.980983Z","caller":"traceutil/trace.go:171","msg":"trace[580045806] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"321.978974ms","start":"2026-04-25T09:33:38.658985Z","end":"2026-04-25T09:33:38.980964Z","steps":["trace[580045806] 'process raft request' (duration: 43.308509ms)","trace[580045806] 'compare' (duration: 278.186106ms)"],"step_count":2} {"level":"info","ts":"2026-04-25T09:33:38.980998Z","caller":"traceutil/trace.go:171","msg":"trace[1880844058] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"282.507148ms","start":"2026-04-25T09:33:38.698444Z","end":"2026-04-25T09:33:38.980952Z","steps":["trace[1880844058] 'process raft request' (duration: 282.367046ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:38.981128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:38.658967Z","time spent":"322.068656ms","remote":"127.0.0.1:33004","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":765,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-25T09:33:38.981111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.2592ms","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-04-25T09:33:38.981185Z","caller":"traceutil/trace.go:171","msg":"trace[730038399] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:618; }","duration":"204.358202ms","start":"2026-04-25T09:33:38.776806Z","end":"2026-04-25T09:33:38.981165Z","steps":["trace[730038399] 'agreement among raft nodes before linearized reading' (duration: 204.142268ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:38.981441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.775932ms","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-04-25T09:33:38.981501Z","caller":"traceutil/trace.go:171","msg":"trace[1586443337] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:618; }","duration":"178.875613ms","start":"2026-04-25T09:33:38.80261Z","end":"2026-04-25T09:33:38.981485Z","steps":["trace[1586443337] 'agreement among raft nodes before linearized reading' (duration: 178.741351ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:38.981454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.893864ms","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-04-25T09:33:38.981585Z","caller":"traceutil/trace.go:171","msg":"trace[1889713666] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:618; }","duration":"179.039468ms","start":"2026-04-25T09:33:38.802532Z","end":"2026-04-25T09:33:38.981571Z","steps":["trace[1889713666] 'agreement among raft nodes before linearized reading' (duration: 178.792892ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:33:39.24624Z","caller":"traceutil/trace.go:171","msg":"trace[333128515] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"259.696492ms","start":"2026-04-25T09:33:38.986508Z","end":"2026-04-25T09:33:39.246205Z","steps":["trace[333128515] 'process raft request' (duration: 202.534327ms)","trace[333128515] 'compare' (duration: 57.009121ms)"],"step_count":2} {"level":"info","ts":"2026-04-25T09:33:39.246538Z","caller":"traceutil/trace.go:171","msg":"trace[275018441] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"259.58366ms","start":"2026-04-25T09:33:38.986928Z","end":"2026-04-25T09:33:39.246512Z","steps":["trace[275018441] 'process raft request' (duration: 259.240184ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:33:39.246883Z","caller":"traceutil/trace.go:171","msg":"trace[1319282286] linearizableReadLoop","detail":"{readStateIndex:643; appliedIndex:639; }","duration":"199.173153ms","start":"2026-04-25T09:33:39.047688Z","end":"2026-04-25T09:33:39.246861Z","steps":["trace[1319282286] 'read index received' (duration: 141.354396ms)","trace[1319282286] 'applied index is now lower than readState.Index' (duration: 57.817877ms)"],"step_count":2} {"level":"info","ts":"2026-04-25T09:33:39.247003Z","caller":"traceutil/trace.go:171","msg":"trace[1568362512] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"249.144719ms","start":"2026-04-25T09:33:38.997846Z","end":"2026-04-25T09:33:39.246991Z","steps":["trace[1568362512] 'process raft request' (duration: 248.936295ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:39.247206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.619452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-25T09:33:39.246936Z","caller":"traceutil/trace.go:171","msg":"trace[103607936] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"259.129371ms","start":"2026-04-25T09:33:38.987786Z","end":"2026-04-25T09:33:39.246916Z","steps":["trace[103607936] 'process raft request' (duration: 258.905147ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:33:39.247263Z","caller":"traceutil/trace.go:171","msg":"trace[1605163686] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:623; }","duration":"116.716564ms","start":"2026-04-25T09:33:39.130531Z","end":"2026-04-25T09:33:39.247248Z","steps":["trace[1605163686] 'agreement among raft nodes before linearized reading' (duration: 116.620122ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:39.247404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.699032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-04-25T09:33:39.248521Z","caller":"traceutil/trace.go:171","msg":"trace[1124219278] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:623; }","duration":"200.792093ms","start":"2026-04-25T09:33:39.047675Z","end":"2026-04-25T09:33:39.248467Z","steps":["trace[1124219278] 'agreement among raft nodes before linearized reading' (duration: 199.354396ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:33:39.508439Z","caller":"traceutil/trace.go:171","msg":"trace[1107683281] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"247.540069ms","start":"2026-04-25T09:33:39.260876Z","end":"2026-04-25T09:33:39.508416Z","steps":["trace[1107683281] 'process raft request' (duration: 247.362986ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:33:40.652586Z","caller":"traceutil/trace.go:171","msg":"trace[30268338] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"242.056064ms","start":"2026-04-25T09:33:40.410499Z","end":"2026-04-25T09:33:40.652555Z","steps":["trace[30268338] 'process raft request' (duration: 241.862861ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:33:40.834068Z","caller":"traceutil/trace.go:171","msg":"trace[1347343435] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"161.214687ms","start":"2026-04-25T09:33:40.672823Z","end":"2026-04-25T09:33:40.834038Z","steps":["trace[1347343435] 'process raft request' (duration: 85.092839ms)","trace[1347343435] 'compare' (duration: 75.972044ms)"],"step_count":2} {"level":"warn","ts":"2026-04-25T09:33:41.148507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.889041ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-25T09:33:41.148714Z","caller":"traceutil/trace.go:171","msg":"trace[50897769] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"464.621884ms","start":"2026-04-25T09:33:40.68406Z","end":"2026-04-25T09:33:41.148682Z","steps":["trace[50897769] 'process raft request' (duration: 269.444289ms)","trace[50897769] 'compare' (duration: 194.744317ms)"],"step_count":2} {"level":"warn","ts":"2026-04-25T09:33:41.148885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:40.684042Z","time spent":"464.754937ms","remote":"127.0.0.1:33116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-25T09:33:41.352203Z","caller":"traceutil/trace.go:171","msg":"trace[343698239] linearizableReadLoop","detail":"{readStateIndex:654; appliedIndex:653; }","duration":"101.370891ms","start":"2026-04-25T09:33:41.250815Z","end":"2026-04-25T09:33:41.352186Z","steps":["trace[343698239] 'read index received' (duration: 101.205628ms)","trace[343698239] 'applied index is now lower than readState.Index' (duration: 164.703µs)"],"step_count":2} {"level":"info","ts":"2026-04-25T09:33:41.352263Z","caller":"traceutil/trace.go:171","msg":"trace[1906368335] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"198.909198ms","start":"2026-04-25T09:33:41.153319Z","end":"2026-04-25T09:33:41.352228Z","steps":["trace[1906368335] 'process raft request' (duration: 198.740655ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:41.352424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.476463ms","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-04-25T09:33:41.352434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.602175ms","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-04-25T09:33:41.352464Z","caller":"traceutil/trace.go:171","msg":"trace[18889783] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:634; }","duration":"101.674227ms","start":"2026-04-25T09:33:41.250782Z","end":"2026-04-25T09:33:41.352456Z","steps":["trace[18889783] 'agreement among raft nodes before linearized reading' (duration: 101.494884ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:33:41.352462Z","caller":"traceutil/trace.go:171","msg":"trace[1561846532] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:634; }","duration":"101.569985ms","start":"2026-04-25T09:33:41.250883Z","end":"2026-04-25T09:33:41.352453Z","steps":["trace[1561846532] 'agreement among raft nodes before linearized reading' (duration: 101.422782ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:41.352514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.573895ms","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-04-25T09:33:41.352556Z","caller":"traceutil/trace.go:171","msg":"trace[1705396582] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:634; }","duration":"101.660937ms","start":"2026-04-25T09:33:41.250884Z","end":"2026-04-25T09:33:41.352545Z","steps":["trace[1705396582] 'agreement among raft nodes before linearized reading' (duration: 101.541884ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:33:41.919519Z","caller":"traceutil/trace.go:171","msg":"trace[535579427] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"202.737761ms","start":"2026-04-25T09:33:41.716764Z","end":"2026-04-25T09:33:41.919502Z","steps":["trace[535579427] 'process raft request' (duration: 202.622299ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:33:42.458702Z","caller":"traceutil/trace.go:171","msg":"trace[1754439244] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"324.264208ms","start":"2026-04-25T09:33:42.134408Z","end":"2026-04-25T09:33:42.458672Z","steps":["trace[1754439244] 'process raft request' (duration: 324.118605ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:33:42.458722Z","caller":"traceutil/trace.go:171","msg":"trace[529665471] linearizableReadLoop","detail":"{readStateIndex:672; appliedIndex:672; }","duration":"197.960099ms","start":"2026-04-25T09:33:42.260733Z","end":"2026-04-25T09:33:42.458693Z","steps":["trace[529665471] 'read index received' (duration: 197.947739ms)","trace[529665471] 'applied index is now lower than readState.Index' (duration: 9.75µs)"],"step_count":2} {"level":"warn","ts":"2026-04-25T09:33:42.458862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:42.134367Z","time spent":"324.420751ms","remote":"127.0.0.1:32974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3353,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-25T09:33:42.458958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.204713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-25T09:33:42.459073Z","caller":"traceutil/trace.go:171","msg":"trace[622349510] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:651; }","duration":"198.364147ms","start":"2026-04-25T09:33:42.260697Z","end":"2026-04-25T09:33:42.459061Z","steps":["trace[622349510] 'agreement among raft nodes before linearized reading' (duration: 198.106292ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:33:42.468038Z","caller":"traceutil/trace.go:171","msg":"trace[1606367792] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"133.575128ms","start":"2026-04-25T09:33:42.33445Z","end":"2026-04-25T09:33:42.468025Z","steps":["trace[1606367792] 'process raft request' (duration: 133.509517ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:33:53.583103Z","caller":"traceutil/trace.go:171","msg":"trace[1797273936] transaction","detail":"{read_only:false; response_revision:770; number_of_response:1; }","duration":"124.515694ms","start":"2026-04-25T09:33:53.458564Z","end":"2026-04-25T09:33:53.58308Z","steps":["trace[1797273936] 'process raft request' (duration: 84.466808ms)","trace[1797273936] 'compare' (duration: 39.804841ms)"],"step_count":2} {"level":"info","ts":"2026-04-25T09:33:53.583228Z","caller":"traceutil/trace.go:171","msg":"trace[1608115537] transaction","detail":"{read_only:false; response_revision:771; number_of_response:1; }","duration":"124.540404ms","start":"2026-04-25T09:33:53.458661Z","end":"2026-04-25T09:33:53.583202Z","steps":["trace[1608115537] 'process raft request' (duration: 124.359861ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:55.503574Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656052250663300496,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-25T09:33:55.994111Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.169981217s","expected-duration":"1s"} {"level":"info","ts":"2026-04-25T09:33:55.994466Z","caller":"traceutil/trace.go:171","msg":"trace[2095249176] linearizableReadLoop","detail":"{readStateIndex:805; appliedIndex:804; }","duration":"991.640483ms","start":"2026-04-25T09:33:55.00281Z","end":"2026-04-25T09:33:55.99445Z","steps":["trace[2095249176] 'read index received' (duration: 991.4731ms)","trace[2095249176] 'applied index is now lower than readState.Index' (duration: 166.663µs)"],"step_count":2} {"level":"info","ts":"2026-04-25T09:33:55.994725Z","caller":"traceutil/trace.go:171","msg":"trace[2042729502] transaction","detail":"{read_only:false; response_revision:781; number_of_response:1; }","duration":"1.170673202s","start":"2026-04-25T09:33:54.824042Z","end":"2026-04-25T09:33:55.994715Z","steps":["trace[2042729502] 'process raft request' (duration: 1.170288814s)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:55.994904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:54.824019Z","time spent":"1.170806504s","remote":"127.0.0.1:33206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-25T09:33:55.995169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"992.361078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-w9j8f\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-04-25T09:33:55.995252Z","caller":"traceutil/trace.go:171","msg":"trace[1981117909] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-w9j8f; range_end:; response_count:1; response_revision:781; }","duration":"992.496711ms","start":"2026-04-25T09:33:55.002745Z","end":"2026-04-25T09:33:55.995241Z","steps":["trace[1981117909] 'agreement among raft nodes before linearized reading' (duration: 992.329158ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:55.995298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:55.002716Z","time spent":"992.573442ms","remote":"127.0.0.1:33116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3988,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-w9j8f\" "} {"level":"warn","ts":"2026-04-25T09:33:55.995468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"732.36457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-25T09:33:55.995543Z","caller":"traceutil/trace.go:171","msg":"trace[1737847674] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:781; }","duration":"732.474732ms","start":"2026-04-25T09:33:55.26306Z","end":"2026-04-25T09:33:55.995534Z","steps":["trace[1737847674] 'agreement among raft nodes before linearized reading' (duration: 732.38698ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:55.995589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:55.263039Z","time spent":"732.543103ms","remote":"127.0.0.1:32920","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-04-25T09:33:55.995963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"407.737645ms","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-04-25T09:33:55.99644Z","caller":"traceutil/trace.go:171","msg":"trace[410546875] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:781; }","duration":"408.238956ms","start":"2026-04-25T09:33:55.588193Z","end":"2026-04-25T09:33:55.996432Z","steps":["trace[410546875] 'agreement among raft nodes before linearized reading' (duration: 407.726565ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:55.996527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:55.588178Z","time spent":"408.340587ms","remote":"127.0.0.1:33206","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":"warn","ts":"2026-04-25T09:33:55.996157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.644123ms","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-04-25T09:33:55.9966Z","caller":"traceutil/trace.go:171","msg":"trace[1869053546] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:781; }","duration":"409.116881ms","start":"2026-04-25T09:33:55.587464Z","end":"2026-04-25T09:33:55.99658Z","steps":["trace[1869053546] 'agreement among raft nodes before linearized reading' (duration: 408.635003ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:55.996656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:55.587443Z","time spent":"409.197554ms","remote":"127.0.0.1:33206","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-04-25T09:33:55.99621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"486.097847ms","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-04-25T09:33:55.996832Z","caller":"traceutil/trace.go:171","msg":"trace[368832667] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:781; }","duration":"486.758419ms","start":"2026-04-25T09:33:55.510066Z","end":"2026-04-25T09:33:55.996824Z","steps":["trace[368832667] 'agreement among raft nodes before linearized reading' (duration: 486.106607ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:55.996988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:55.510042Z","time spent":"486.936582ms","remote":"127.0.0.1:33206","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-04-25T09:33:55.996338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"538.777445ms","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-04-25T09:33:55.997217Z","caller":"traceutil/trace.go:171","msg":"trace[1895852087] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:781; }","duration":"539.723912ms","start":"2026-04-25T09:33:55.457485Z","end":"2026-04-25T09:33:55.997209Z","steps":["trace[1895852087] 'agreement among raft nodes before linearized reading' (duration: 538.706673ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:33:55.997287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:33:55.457455Z","time spent":"539.821223ms","remote":"127.0.0.1:33206","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-04-25T09:33:56.125849Z","caller":"traceutil/trace.go:171","msg":"trace[21329149] transaction","detail":"{read_only:false; response_revision:782; number_of_response:1; }","duration":"125.664186ms","start":"2026-04-25T09:33:56.000149Z","end":"2026-04-25T09:33:56.125813Z","steps":["trace[21329149] 'process raft request' (duration: 123.798941ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:33:56.138975Z","caller":"traceutil/trace.go:171","msg":"trace[1653878309] transaction","detail":"{read_only:false; response_revision:787; number_of_response:1; }","duration":"132.422595ms","start":"2026-04-25T09:33:56.006542Z","end":"2026-04-25T09:33:56.138965Z","steps":["trace[1653878309] 'process raft request' (duration: 132.390615ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:33:56.139196Z","caller":"traceutil/trace.go:171","msg":"trace[1439955722] transaction","detail":"{read_only:false; response_revision:784; number_of_response:1; }","duration":"138.244607ms","start":"2026-04-25T09:33:56.000943Z","end":"2026-04-25T09:33:56.139188Z","steps":["trace[1439955722] 'process raft request' (duration: 137.920951ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:33:56.139468Z","caller":"traceutil/trace.go:171","msg":"trace[448435666] transaction","detail":"{read_only:false; response_revision:785; number_of_response:1; }","duration":"138.284058ms","start":"2026-04-25T09:33:56.001174Z","end":"2026-04-25T09:33:56.139458Z","steps":["trace[448435666] 'process raft request' (duration: 137.711557ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:33:56.13896Z","caller":"traceutil/trace.go:171","msg":"trace[405919371] transaction","detail":"{read_only:false; response_revision:783; number_of_response:1; }","duration":"138.085814ms","start":"2026-04-25T09:33:56.000852Z","end":"2026-04-25T09:33:56.138938Z","steps":["trace[405919371] 'process raft request' (duration: 137.944291ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:33:56.139509Z","caller":"traceutil/trace.go:171","msg":"trace[1661629355] transaction","detail":"{read_only:false; response_revision:786; number_of_response:1; }","duration":"138.287097ms","start":"2026-04-25T09:33:56.001211Z","end":"2026-04-25T09:33:56.139498Z","steps":["trace[1661629355] 'process raft request' (duration: 137.696126ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:33:57.138789Z","caller":"traceutil/trace.go:171","msg":"trace[371424309] transaction","detail":"{read_only:false; response_revision:788; number_of_response:1; }","duration":"123.110387ms","start":"2026-04-25T09:33:57.015653Z","end":"2026-04-25T09:33:57.138764Z","steps":["trace[371424309] 'process raft request' (duration: 122.948284ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:34:22.757131Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656052250663300868,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-25T09:34:22.857833Z","caller":"traceutil/trace.go:171","msg":"trace[445695245] transaction","detail":"{read_only:false; response_revision:963; number_of_response:1; }","duration":"607.486092ms","start":"2026-04-25T09:34:22.25032Z","end":"2026-04-25T09:34:22.857806Z","steps":["trace[445695245] 'process raft request' (duration: 607.261668ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:34:22.858284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:34:22.250292Z","time spent":"607.683225ms","remote":"127.0.0.1:33206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-25T09:34:23.042962Z","caller":"traceutil/trace.go:171","msg":"trace[125411281] transaction","detail":"{read_only:false; response_revision:964; number_of_response:1; }","duration":"790.543828ms","start":"2026-04-25T09:34:22.252384Z","end":"2026-04-25T09:34:23.042928Z","steps":["trace[125411281] 'process raft request' (duration: 724.499173ms)","trace[125411281] 'compare' (duration: 65.891922ms)"],"step_count":2} {"level":"warn","ts":"2026-04-25T09:34:23.04314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"786.473249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-04-25T09:34:23.043138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:34:22.25237Z","time spent":"790.656449ms","remote":"127.0.0.1:33206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-25T09:34:23.043206Z","caller":"traceutil/trace.go:171","msg":"trace[1593303314] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:964; }","duration":"786.609741ms","start":"2026-04-25T09:34:22.256584Z","end":"2026-04-25T09:34:23.043194Z","steps":["trace[1593303314] 'agreement among raft nodes before linearized reading' (duration: 786.417538ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:34:23.043251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:34:22.256564Z","time spent":"786.679703ms","remote":"127.0.0.1:33206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-25T09:34:23.042963Z","caller":"traceutil/trace.go:171","msg":"trace[344375731] linearizableReadLoop","detail":"{readStateIndex:996; appliedIndex:994; }","duration":"786.246135ms","start":"2026-04-25T09:34:22.256656Z","end":"2026-04-25T09:34:23.042902Z","steps":["trace[344375731] 'read index received' (duration: 600.907797ms)","trace[344375731] 'applied index is now lower than readState.Index' (duration: 185.337068ms)"],"step_count":2} {"level":"warn","ts":"2026-04-25T09:34:23.043971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"783.906609ms","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-04-25T09:34:23.044006Z","caller":"traceutil/trace.go:171","msg":"trace[466741104] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:964; }","duration":"783.974261ms","start":"2026-04-25T09:34:22.26002Z","end":"2026-04-25T09:34:23.043994Z","steps":["trace[466741104] 'agreement among raft nodes before linearized reading' (duration: 783.879709ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:34:23.044035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:34:22.260007Z","time spent":"784.021592ms","remote":"127.0.0.1:33206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-25T09:34:23.044046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"782.795809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-25T09:34:23.044117Z","caller":"traceutil/trace.go:171","msg":"trace[776642077] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:964; }","duration":"782.88584ms","start":"2026-04-25T09:34:22.261212Z","end":"2026-04-25T09:34:23.044098Z","steps":["trace[776642077] 'agreement among raft nodes before linearized reading' (duration: 782.778058ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:34:23.04417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:34:22.261195Z","time spent":"782.963331ms","remote":"127.0.0.1:32920","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-04-25T09:34:23.04413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"780.930583ms","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-04-25T09:34:23.044273Z","caller":"traceutil/trace.go:171","msg":"trace[1412195532] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:964; }","duration":"781.116326ms","start":"2026-04-25T09:34:22.26314Z","end":"2026-04-25T09:34:23.044257Z","steps":["trace[1412195532] 'agreement among raft nodes before linearized reading' (duration: 780.77182ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:34:23.044443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:34:22.263132Z","time spent":"781.298169ms","remote":"127.0.0.1:33206","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-04-25T09:34:23.61176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.357967ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-25T09:34:23.611871Z","caller":"traceutil/trace.go:171","msg":"trace[1752042219] transaction","detail":"{read_only:false; response_revision:968; number_of_response:1; }","duration":"349.224086ms","start":"2026-04-25T09:34:23.262627Z","end":"2026-04-25T09:34:23.611851Z","steps":["trace[1752042219] 'process raft request' (duration: 162.681075ms)","trace[1752042219] 'compare' (duration: 185.96786ms)"],"step_count":2} {"level":"warn","ts":"2026-04-25T09:34:23.611942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:34:23.2626Z","time spent":"349.303957ms","remote":"127.0.0.1:33206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-25T09:35:03.23399Z","caller":"traceutil/trace.go:171","msg":"trace[226264367] transaction","detail":"{read_only:false; response_revision:1099; number_of_response:1; }","duration":"131.04627ms","start":"2026-04-25T09:35:03.102913Z","end":"2026-04-25T09:35:03.233959Z","steps":["trace[226264367] 'process raft request' (duration: 130.909257ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:35:17.552485Z","caller":"traceutil/trace.go:171","msg":"trace[264185584] transaction","detail":"{read_only:false; response_revision:1145; number_of_response:1; }","duration":"128.307567ms","start":"2026-04-25T09:35:17.424151Z","end":"2026-04-25T09:35:17.552459Z","steps":["trace[264185584] 'process raft request' (duration: 101.611576ms)","trace[264185584] 'compare' (duration: 26.480016ms)"],"step_count":2} {"level":"info","ts":"2026-04-25T09:35:17.552745Z","caller":"traceutil/trace.go:171","msg":"trace[1436158307] transaction","detail":"{read_only:false; response_revision:1146; number_of_response:1; }","duration":"127.025953ms","start":"2026-04-25T09:35:17.425658Z","end":"2026-04-25T09:35:17.552684Z","steps":["trace[1436158307] 'process raft request' (duration: 126.755468ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:35:17.553058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.736714ms","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-04-25T09:35:17.553174Z","caller":"traceutil/trace.go:171","msg":"trace[2120511259] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1146; }","duration":"117.915307ms","start":"2026-04-25T09:35:17.435239Z","end":"2026-04-25T09:35:17.553155Z","steps":["trace[2120511259] 'agreement among raft nodes before linearized reading' (duration: 117.545141ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:35:17.552651Z","caller":"traceutil/trace.go:171","msg":"trace[1185292883] linearizableReadLoop","detail":"{readStateIndex:1190; appliedIndex:1188; }","duration":"117.356158ms","start":"2026-04-25T09:35:17.435261Z","end":"2026-04-25T09:35:17.552617Z","steps":["trace[1185292883] 'read index received' (duration: 90.389301ms)","trace[1185292883] 'applied index is now lower than readState.Index' (duration: 26.964366ms)"],"step_count":2} {"level":"warn","ts":"2026-04-25T09:35:17.553649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.000212ms","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-04-25T09:35:17.553693Z","caller":"traceutil/trace.go:171","msg":"trace[707882779] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1146; }","duration":"113.068274ms","start":"2026-04-25T09:35:17.440613Z","end":"2026-04-25T09:35:17.553682Z","steps":["trace[707882779] 'agreement among raft nodes before linearized reading' (duration: 112.86701ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:35:19.643452Z","caller":"traceutil/trace.go:171","msg":"trace[965892717] transaction","detail":"{read_only:false; response_revision:1151; number_of_response:1; }","duration":"207.083985ms","start":"2026-04-25T09:35:19.436332Z","end":"2026-04-25T09:35:19.643416Z","steps":["trace[965892717] 'process raft request' (duration: 206.897142ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:35:29.916202Z","caller":"traceutil/trace.go:171","msg":"trace[56062278] transaction","detail":"{read_only:false; response_revision:1186; number_of_response:1; }","duration":"171.827141ms","start":"2026-04-25T09:35:29.744068Z","end":"2026-04-25T09:35:29.915896Z","steps":["trace[56062278] 'process raft request' (duration: 171.681958ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:37:22.586163Z","caller":"traceutil/trace.go:171","msg":"trace[28469474] transaction","detail":"{read_only:false; response_revision:1554; number_of_response:1; }","duration":"238.703682ms","start":"2026-04-25T09:37:22.347397Z","end":"2026-04-25T09:37:22.5861Z","steps":["trace[28469474] 'process raft request' (duration: 238.450338ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:37:22.606247Z","caller":"traceutil/trace.go:171","msg":"trace[897062163] transaction","detail":"{read_only:false; response_revision:1556; number_of_response:1; }","duration":"243.388912ms","start":"2026-04-25T09:37:22.362837Z","end":"2026-04-25T09:37:22.606226Z","steps":["trace[897062163] 'process raft request' (duration: 243.322061ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:37:22.606246Z","caller":"traceutil/trace.go:171","msg":"trace[899062261] transaction","detail":"{read_only:false; response_revision:1555; number_of_response:1; }","duration":"256.224081ms","start":"2026-04-25T09:37:22.350003Z","end":"2026-04-25T09:37:22.606227Z","steps":["trace[899062261] 'process raft request' (duration: 256.038067ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:37:23.493301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.68514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-25T09:37:23.493378Z","caller":"traceutil/trace.go:171","msg":"trace[1302782947] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:1559; }","duration":"476.844433ms","start":"2026-04-25T09:37:23.016518Z","end":"2026-04-25T09:37:23.493362Z","steps":["trace[1302782947] 'count revisions from in-memory index tree' (duration: 476.502557ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:37:23.49342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:37:23.016491Z","time spent":"476.917114ms","remote":"127.0.0.1:40018","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":3,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true "} {"level":"warn","ts":"2026-04-25T09:37:23.493609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.263068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-25T09:37:23.493705Z","caller":"traceutil/trace.go:171","msg":"trace[1252589246] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1559; }","duration":"232.442971ms","start":"2026-04-25T09:37:23.26124Z","end":"2026-04-25T09:37:23.493683Z","steps":["trace[1252589246] 'range keys from in-memory index tree' (duration: 232.149595ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:37:46.985681Z","caller":"traceutil/trace.go:171","msg":"trace[1617303905] transaction","detail":"{read_only:false; response_revision:1634; number_of_response:1; }","duration":"282.329594ms","start":"2026-04-25T09:37:46.703309Z","end":"2026-04-25T09:37:46.985639Z","steps":["trace[1617303905] 'process raft request' (duration: 229.776578ms)","trace[1617303905] 'compare' (duration: 52.178969ms)"],"step_count":2} {"level":"warn","ts":"2026-04-25T09:37:47.767937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"658.882512ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-25T09:37:47.768544Z","caller":"traceutil/trace.go:171","msg":"trace[1807784357] linearizableReadLoop","detail":"{readStateIndex:1708; appliedIndex:1706; }","duration":"1.04953595s","start":"2026-04-25T09:37:46.718967Z","end":"2026-04-25T09:37:47.768503Z","steps":["trace[1807784357] 'read index received' (duration: 214.142449ms)","trace[1807784357] 'applied index is now lower than readState.Index' (duration: 835.389881ms)"],"step_count":2} {"level":"info","ts":"2026-04-25T09:37:47.76858Z","caller":"traceutil/trace.go:171","msg":"trace[2071222911] transaction","detail":"{read_only:false; response_revision:1635; number_of_response:1; }","duration":"1.063540588s","start":"2026-04-25T09:37:46.704961Z","end":"2026-04-25T09:37:47.768502Z","steps":["trace[2071222911] 'process raft request' (duration: 403.959322ms)","trace[2071222911] 'compare' (duration: 658.617687ms)"],"step_count":2} {"level":"warn","ts":"2026-04-25T09:37:47.768894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:37:46.704941Z","time spent":"1.063814553s","remote":"127.0.0.1:33206","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-04-25T09:37:47.799696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"537.832085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-25T09:37:47.799764Z","caller":"traceutil/trace.go:171","msg":"trace[493307363] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1635; }","duration":"537.958667ms","start":"2026-04-25T09:37:47.261786Z","end":"2026-04-25T09:37:47.799745Z","steps":["trace[493307363] 'agreement among raft nodes before linearized reading' (duration: 537.823794ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:37:47.799801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:37:47.261761Z","time spent":"538.032529ms","remote":"127.0.0.1:32920","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-04-25T09:37:47.799872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.063555438s","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":"warn","ts":"2026-04-25T09:37:47.799854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.072720423s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-25T09:37:47.799981Z","caller":"traceutil/trace.go:171","msg":"trace[1920645783] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1635; }","duration":"1.063711421s","start":"2026-04-25T09:37:46.736247Z","end":"2026-04-25T09:37:47.799958Z","steps":["trace[1920645783] 'agreement among raft nodes before linearized reading' (duration: 1.063434876s)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:37:47.800035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:37:46.736227Z","time spent":"1.063798962s","remote":"127.0.0.1:33206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-25T09:37:47.800037Z","caller":"traceutil/trace.go:171","msg":"trace[1642750130] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1635; }","duration":"1.072997188s","start":"2026-04-25T09:37:46.727016Z","end":"2026-04-25T09:37:47.800013Z","steps":["trace[1642750130] 'agreement among raft nodes before linearized reading' (duration: 1.07258966s)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:37:47.800185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:37:46.727Z","time spent":"1.07313861s","remote":"127.0.0.1:33206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-25T09:37:47.799713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.080715016s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-25T09:37:47.800596Z","caller":"traceutil/trace.go:171","msg":"trace[699922741] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1635; }","duration":"1.081609763s","start":"2026-04-25T09:37:46.718896Z","end":"2026-04-25T09:37:47.800505Z","steps":["trace[699922741] 'agreement among raft nodes before linearized reading' (duration: 1.049732174s)","trace[699922741] 'range keys from in-memory index tree' (duration: 30.664807ms)"],"step_count":2} {"level":"warn","ts":"2026-04-25T09:37:47.80079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:37:46.718875Z","time spent":"1.081883428s","remote":"127.0.0.1:33206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-25T09:37:48.942796Z","caller":"traceutil/trace.go:171","msg":"trace[636634834] linearizableReadLoop","detail":"{readStateIndex:1713; appliedIndex:1712; }","duration":"141.695252ms","start":"2026-04-25T09:37:48.801076Z","end":"2026-04-25T09:37:48.942772Z","steps":["trace[636634834] 'read index received' (duration: 141.528459ms)","trace[636634834] 'applied index is now lower than readState.Index' (duration: 165.523µs)"],"step_count":2} {"level":"info","ts":"2026-04-25T09:37:48.942928Z","caller":"traceutil/trace.go:171","msg":"trace[1578087326] transaction","detail":"{read_only:false; response_revision:1639; number_of_response:1; }","duration":"243.877878ms","start":"2026-04-25T09:37:48.699039Z","end":"2026-04-25T09:37:48.942917Z","steps":["trace[1578087326] 'process raft request' (duration: 243.577252ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:37:48.943089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.003258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-25T09:37:48.943122Z","caller":"traceutil/trace.go:171","msg":"trace[1423072866] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1639; }","duration":"142.101509ms","start":"2026-04-25T09:37:48.801011Z","end":"2026-04-25T09:37:48.943112Z","steps":["trace[1423072866] 'agreement among raft nodes before linearized reading' (duration: 142.024408ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:37:49.767113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.439701ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-25T09:37:49.767228Z","caller":"traceutil/trace.go:171","msg":"trace[345950958] linearizableReadLoop","detail":"{readStateIndex:1714; appliedIndex:1713; }","duration":"528.726941ms","start":"2026-04-25T09:37:49.23848Z","end":"2026-04-25T09:37:49.767207Z","steps":["trace[345950958] 'read index received' (duration: 159.096585ms)","trace[345950958] 'applied index is now lower than readState.Index' (duration: 369.628626ms)"],"step_count":2} {"level":"info","ts":"2026-04-25T09:37:49.767463Z","caller":"traceutil/trace.go:171","msg":"trace[1768232635] transaction","detail":"{read_only:false; response_revision:1640; number_of_response:1; }","duration":"772.101968ms","start":"2026-04-25T09:37:48.995348Z","end":"2026-04-25T09:37:49.767449Z","steps":["trace[1768232635] 'process raft request' (duration: 402.202678ms)","trace[1768232635] 'compare' (duration: 369.259528ms)"],"step_count":2} {"level":"warn","ts":"2026-04-25T09:37:49.767632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"506.468073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-25T09:37:49.76767Z","caller":"traceutil/trace.go:171","msg":"trace[115735926] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1640; }","duration":"506.576945ms","start":"2026-04-25T09:37:49.261083Z","end":"2026-04-25T09:37:49.76766Z","steps":["trace[115735926] 'agreement among raft nodes before linearized reading' (duration: 506.512964ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:37:49.767699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:37:49.261044Z","time spent":"506.648317ms","remote":"127.0.0.1:32914","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-04-25T09:37:49.767775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"529.283941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-25T09:37:49.76799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:37:48.995331Z","time spent":"772.173069ms","remote":"127.0.0.1:33206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-25T09:37:49.768232Z","caller":"traceutil/trace.go:171","msg":"trace[577423464] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:1640; }","duration":"529.812662ms","start":"2026-04-25T09:37:49.23839Z","end":"2026-04-25T09:37:49.768203Z","steps":["trace[577423464] 'agreement among raft nodes before linearized reading' (duration: 529.275351ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:37:49.768441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:37:49.238355Z","time spent":"530.041095ms","remote":"127.0.0.1:33460","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":2,"response size":30,"request content":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true "} {"level":"info","ts":"2026-04-25T09:37:49.942126Z","caller":"traceutil/trace.go:171","msg":"trace[385241693] linearizableReadLoop","detail":"{readStateIndex:1715; appliedIndex:1714; }","duration":"110.152719ms","start":"2026-04-25T09:37:49.831935Z","end":"2026-04-25T09:37:49.942087Z","steps":["trace[385241693] 'read index received' (duration: 109.879404ms)","trace[385241693] 'applied index is now lower than readState.Index' (duration: 272.005µs)"],"step_count":2} {"level":"info","ts":"2026-04-25T09:37:49.942193Z","caller":"traceutil/trace.go:171","msg":"trace[2077291707] transaction","detail":"{read_only:false; response_revision:1641; number_of_response:1; }","duration":"164.845015ms","start":"2026-04-25T09:37:49.777316Z","end":"2026-04-25T09:37:49.942161Z","steps":["trace[2077291707] 'process raft request' (duration: 164.55483ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:37:49.942503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.545436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-25T09:37:49.942593Z","caller":"traceutil/trace.go:171","msg":"trace[1866318203] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1641; }","duration":"110.701739ms","start":"2026-04-25T09:37:49.831872Z","end":"2026-04-25T09:37:49.942573Z","steps":["trace[1866318203] 'agreement among raft nodes before linearized reading' (duration: 110.416784ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:37:49.942589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.980802ms","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":"warn","ts":"2026-04-25T09:37:49.942603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.984022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-25T09:37:49.942659Z","caller":"traceutil/trace.go:171","msg":"trace[2095306072] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1641; }","duration":"102.129215ms","start":"2026-04-25T09:37:49.840511Z","end":"2026-04-25T09:37:49.94264Z","steps":["trace[2095306072] 'agreement among raft nodes before linearized reading' (duration: 101.85285ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:37:49.942673Z","caller":"traceutil/trace.go:171","msg":"trace[1464939335] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1641; }","duration":"102.100014ms","start":"2026-04-25T09:37:49.840555Z","end":"2026-04-25T09:37:49.942655Z","steps":["trace[1464939335] 'agreement among raft nodes before linearized reading' (duration: 101.910801ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:37:51.802717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"540.526767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-25T09:37:51.802804Z","caller":"traceutil/trace.go:171","msg":"trace[1623906220] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1646; }","duration":"540.67437ms","start":"2026-04-25T09:37:51.262111Z","end":"2026-04-25T09:37:51.802785Z","steps":["trace[1623906220] 'range keys from in-memory index tree' (duration: 539.933146ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:37:51.802847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:37:51.26209Z","time spent":"540.747751ms","remote":"127.0.0.1:32920","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-04-25T09:37:52.30995Z","caller":"traceutil/trace.go:171","msg":"trace[1128814893] linearizableReadLoop","detail":"{readStateIndex:1721; appliedIndex:1720; }","duration":"422.485718ms","start":"2026-04-25T09:37:51.887429Z","end":"2026-04-25T09:37:52.309914Z","steps":["trace[1128814893] 'read index received' (duration: 422.131921ms)","trace[1128814893] 'applied index is now lower than readState.Index' (duration: 352.687µs)"],"step_count":2} {"level":"info","ts":"2026-04-25T09:37:52.310101Z","caller":"traceutil/trace.go:171","msg":"trace[786643683] transaction","detail":"{read_only:false; response_revision:1647; number_of_response:1; }","duration":"502.664522ms","start":"2026-04-25T09:37:51.807421Z","end":"2026-04-25T09:37:52.310085Z","steps":["trace[786643683] 'process raft request' (duration: 502.275505ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:37:52.310247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:37:51.807401Z","time spent":"502.733653ms","remote":"127.0.0.1:33206","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-04-25T09:37:52.310298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.833976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-25T09:37:52.310639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.600091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-04-25T09:37:52.310612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.977659ms","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":"warn","ts":"2026-04-25T09:37:52.310667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.232922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-25T09:37:52.310699Z","caller":"traceutil/trace.go:171","msg":"trace[103545599] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1647; }","duration":"362.714153ms","start":"2026-04-25T09:37:51.947975Z","end":"2026-04-25T09:37:52.310689Z","steps":["trace[103545599] 'agreement among raft nodes before linearized reading' (duration: 362.511298ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:37:52.310748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:37:51.947924Z","time spent":"362.815855ms","remote":"127.0.0.1:33206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-25T09:37:52.310762Z","caller":"traceutil/trace.go:171","msg":"trace[339126602] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:1647; }","duration":"423.340654ms","start":"2026-04-25T09:37:51.887366Z","end":"2026-04-25T09:37:52.310706Z","steps":["trace[339126602] 'agreement among raft nodes before linearized reading' (duration: 423.209372ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:37:52.310719Z","caller":"traceutil/trace.go:171","msg":"trace[139153688] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1647; }","duration":"327.146102ms","start":"2026-04-25T09:37:51.983546Z","end":"2026-04-25T09:37:52.310692Z","steps":["trace[139153688] 'agreement among raft nodes before linearized reading' (duration: 326.745684ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:37:52.310998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.186282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.227\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-25T09:37:52.311046Z","caller":"traceutil/trace.go:171","msg":"trace[2021141964] range","detail":"{range_begin:/registry/masterleases/199.204.45.227; range_end:; response_count:1; response_revision:1647; }","duration":"363.292444ms","start":"2026-04-25T09:37:51.94774Z","end":"2026-04-25T09:37:52.311032Z","steps":["trace[2021141964] 'agreement among raft nodes before linearized reading' (duration: 363.111741ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:37:52.311052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:37:51.983518Z","time spent":"327.506979ms","remote":"127.0.0.1:33206","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-04-25T09:37:52.311081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:37:51.947703Z","time spent":"363.370316ms","remote":"127.0.0.1:32958","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.227\" "} {"level":"warn","ts":"2026-04-25T09:37:52.311165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.214362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-04-25T09:37:52.311128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:37:51.887341Z","time spent":"423.763021ms","remote":"127.0.0.1:39982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":3,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true "} {"level":"info","ts":"2026-04-25T09:37:52.31121Z","caller":"traceutil/trace.go:171","msg":"trace[567599485] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1647; }","duration":"328.283133ms","start":"2026-04-25T09:37:51.982917Z","end":"2026-04-25T09:37:52.3112Z","steps":["trace[567599485] 'agreement among raft nodes before linearized reading' (duration: 328.141811ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:37:52.311241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:37:51.982907Z","time spent":"328.328394ms","remote":"127.0.0.1:33206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-25T09:37:52.311464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.929309ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-25T09:37:52.311509Z","caller":"traceutil/trace.go:171","msg":"trace[1488607410] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1647; }","duration":"290.99594ms","start":"2026-04-25T09:37:52.020504Z","end":"2026-04-25T09:37:52.3115Z","steps":["trace[1488607410] 'agreement among raft nodes before linearized reading' (duration: 290.889908ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:37:52.310408Z","caller":"traceutil/trace.go:171","msg":"trace[86852596] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:1647; }","duration":"396.999608ms","start":"2026-04-25T09:37:51.913386Z","end":"2026-04-25T09:37:52.310386Z","steps":["trace[86852596] 'agreement among raft nodes before linearized reading' (duration: 396.795815ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:37:52.311693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:37:51.913375Z","time spent":"398.302254ms","remote":"127.0.0.1:35582","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-25T09:37:52.766214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.481588ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-25T09:37:52.766623Z","caller":"traceutil/trace.go:171","msg":"trace[418540006] transaction","detail":"{read_only:false; response_revision:1649; number_of_response:1; }","duration":"449.392341ms","start":"2026-04-25T09:37:52.317187Z","end":"2026-04-25T09:37:52.766579Z","steps":["trace[418540006] 'process raft request' (duration: 449.181437ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:37:52.766666Z","caller":"traceutil/trace.go:171","msg":"trace[730216779] transaction","detail":"{read_only:false; response_revision:1652; number_of_response:1; }","duration":"372.556601ms","start":"2026-04-25T09:37:52.394088Z","end":"2026-04-25T09:37:52.766645Z","steps":["trace[730216779] 'process raft request' (duration: 372.489219ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:37:52.76669Z","caller":"traceutil/trace.go:171","msg":"trace[405178354] transaction","detail":"{read_only:false; response_revision:1650; number_of_response:1; }","duration":"449.28758ms","start":"2026-04-25T09:37:52.31736Z","end":"2026-04-25T09:37:52.766648Z","steps":["trace[405178354] 'process raft request' (duration: 449.101746ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:37:52.766737Z","caller":"traceutil/trace.go:171","msg":"trace[1384238863] transaction","detail":"{read_only:false; response_revision:1648; number_of_response:1; }","duration":"450.595885ms","start":"2026-04-25T09:37:52.31609Z","end":"2026-04-25T09:37:52.766686Z","steps":["trace[1384238863] 'process raft request' (duration: 169.478995ms)","trace[1384238863] 'compare' (duration: 280.285095ms)"],"step_count":2} {"level":"warn","ts":"2026-04-25T09:37:52.766745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:37:52.317179Z","time spent":"449.520065ms","remote":"127.0.0.1:33206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-25T09:37:52.766771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:37:52.394062Z","time spent":"372.653623ms","remote":"127.0.0.1:32958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-25T09:37:52.766897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:37:52.31606Z","time spent":"450.752328ms","remote":"127.0.0.1:33206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-25T09:37:52.766947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:37:52.317353Z","time spent":"449.421462ms","remote":"127.0.0.1:33206","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-04-25T09:37:52.76693Z","caller":"traceutil/trace.go:171","msg":"trace[1900201434] transaction","detail":"{read_only:false; response_revision:1651; number_of_response:1; }","duration":"449.562125ms","start":"2026-04-25T09:37:52.317357Z","end":"2026-04-25T09:37:52.766919Z","steps":["trace[1900201434] 'process raft request' (duration: 449.160217ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:37:52.767126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:37:52.317331Z","time spent":"449.76178ms","remote":"127.0.0.1:33206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-25T09:37:53.302785Z","caller":"traceutil/trace.go:171","msg":"trace[740099918] transaction","detail":"{read_only:false; response_revision:1653; number_of_response:1; }","duration":"260.413884ms","start":"2026-04-25T09:37:53.042338Z","end":"2026-04-25T09:37:53.302752Z","steps":["trace[740099918] 'process raft request' (duration: 260.127039ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:38:05.082875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.99539ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-25T09:38:05.083051Z","caller":"traceutil/trace.go:171","msg":"trace[488138518] transaction","detail":"{read_only:false; response_revision:1742; number_of_response:1; }","duration":"245.487578ms","start":"2026-04-25T09:38:04.837516Z","end":"2026-04-25T09:38:05.083004Z","steps":["trace[488138518] 'process raft request' (duration: 70.261504ms)","trace[488138518] 'compare' (duration: 174.853457ms)"],"step_count":2} {"level":"info","ts":"2026-04-25T09:38:05.083091Z","caller":"traceutil/trace.go:171","msg":"trace[506818156] transaction","detail":"{read_only:false; response_revision:1743; number_of_response:1; }","duration":"186.608251ms","start":"2026-04-25T09:38:04.896455Z","end":"2026-04-25T09:38:05.083064Z","steps":["trace[506818156] 'process raft request' (duration: 186.53967ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:38:05.083095Z","caller":"traceutil/trace.go:171","msg":"trace[882183913] linearizableReadLoop","detail":"{readStateIndex:1821; appliedIndex:1820; }","duration":"190.448855ms","start":"2026-04-25T09:38:04.892614Z","end":"2026-04-25T09:38:05.083062Z","steps":["trace[882183913] 'read index received' (duration: 15.15816ms)","trace[882183913] 'applied index is now lower than readState.Index' (duration: 175.286835ms)"],"step_count":2} {"level":"warn","ts":"2026-04-25T09:38:05.083278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.781066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-25T09:38:05.083312Z","caller":"traceutil/trace.go:171","msg":"trace[1895578950] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1743; }","duration":"243.846988ms","start":"2026-04-25T09:38:04.839452Z","end":"2026-04-25T09:38:05.083299Z","steps":["trace[1895578950] 'agreement among raft nodes before linearized reading' (duration: 243.707025ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:38:06.928612Z","caller":"traceutil/trace.go:171","msg":"trace[1797360236] transaction","detail":"{read_only:false; response_revision:1746; number_of_response:1; }","duration":"551.954065ms","start":"2026-04-25T09:38:06.376629Z","end":"2026-04-25T09:38:06.928583Z","steps":["trace[1797360236] 'process raft request' (duration: 551.759762ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:38:06.928771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:38:06.37662Z","time spent":"552.067567ms","remote":"127.0.0.1:33206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-25T09:38:07.396365Z","caller":"traceutil/trace.go:171","msg":"trace[2013487284] linearizableReadLoop","detail":"{readStateIndex:1826; appliedIndex:1824; }","duration":"499.846847ms","start":"2026-04-25T09:38:06.896498Z","end":"2026-04-25T09:38:07.396345Z","steps":["trace[2013487284] 'read index received' (duration: 32.005933ms)","trace[2013487284] 'applied index is now lower than readState.Index' (duration: 467.839824ms)"],"step_count":2} {"level":"info","ts":"2026-04-25T09:38:07.396446Z","caller":"traceutil/trace.go:171","msg":"trace[1820755734] transaction","detail":"{read_only:false; response_revision:1747; number_of_response:1; }","duration":"730.138355ms","start":"2026-04-25T09:38:06.666293Z","end":"2026-04-25T09:38:07.396432Z","steps":["trace[1820755734] 'process raft request' (duration: 729.902421ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:38:07.396532Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:38:06.666269Z","time spent":"730.205406ms","remote":"127.0.0.1:33206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-25T09:38:07.396582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"500.087852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-25T09:38:07.396621Z","caller":"traceutil/trace.go:171","msg":"trace[532737957] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1747; }","duration":"500.131552ms","start":"2026-04-25T09:38:06.896479Z","end":"2026-04-25T09:38:07.396611Z","steps":["trace[532737957] 'agreement among raft nodes before linearized reading' (duration: 500.00229ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:38:07.396663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:38:06.896413Z","time spent":"500.242655ms","remote":"127.0.0.1:33206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-25T09:38:07.39788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.998932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-25T09:38:07.397936Z","caller":"traceutil/trace.go:171","msg":"trace[1335716235] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1748; }","duration":"137.096734ms","start":"2026-04-25T09:38:07.260826Z","end":"2026-04-25T09:38:07.397923Z","steps":["trace[1335716235] 'agreement among raft nodes before linearized reading' (duration: 136.983012ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:38:07.397974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.094164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-04-25T09:38:07.397899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.649769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-25T09:38:07.398016Z","caller":"traceutil/trace.go:171","msg":"trace[461317884] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1748; }","duration":"283.784751ms","start":"2026-04-25T09:38:07.114224Z","end":"2026-04-25T09:38:07.398009Z","steps":["trace[461317884] 'agreement among raft nodes before linearized reading' (duration: 283.621168ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:38:07.39802Z","caller":"traceutil/trace.go:171","msg":"trace[2012466541] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1748; }","duration":"311.172876ms","start":"2026-04-25T09:38:07.086835Z","end":"2026-04-25T09:38:07.398008Z","steps":["trace[2012466541] 'agreement among raft nodes before linearized reading' (duration: 310.995753ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:38:07.39805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:38:07.086821Z","time spent":"311.222367ms","remote":"127.0.0.1:33206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-25T09:38:07.398105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.095254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-25T09:38:07.398182Z","caller":"traceutil/trace.go:171","msg":"trace[1219740610] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1748; }","duration":"311.193376ms","start":"2026-04-25T09:38:07.08697Z","end":"2026-04-25T09:38:07.398164Z","steps":["trace[1219740610] 'agreement among raft nodes before linearized reading' (duration: 310.972342ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:38:07.398221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:38:07.086967Z","time spent":"311.246087ms","remote":"127.0.0.1:33206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-25T09:38:19.69488Z","caller":"traceutil/trace.go:171","msg":"trace[59080405] transaction","detail":"{read_only:false; response_revision:1791; number_of_response:1; }","duration":"179.464765ms","start":"2026-04-25T09:38:19.515389Z","end":"2026-04-25T09:38:19.694853Z","steps":["trace[59080405] 'process raft request' (duration: 179.421154ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:38:19.695291Z","caller":"traceutil/trace.go:171","msg":"trace[1019757198] transaction","detail":"{read_only:false; response_revision:1788; number_of_response:1; }","duration":"181.991774ms","start":"2026-04-25T09:38:19.513286Z","end":"2026-04-25T09:38:19.695278Z","steps":["trace[1019757198] 'process raft request' (duration: 176.722903ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:38:19.695422Z","caller":"traceutil/trace.go:171","msg":"trace[28668229] transaction","detail":"{read_only:false; response_revision:1789; number_of_response:1; }","duration":"181.843ms","start":"2026-04-25T09:38:19.51357Z","end":"2026-04-25T09:38:19.695413Z","steps":["trace[28668229] 'process raft request' (duration: 181.162748ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:38:19.695532Z","caller":"traceutil/trace.go:171","msg":"trace[2030738043] transaction","detail":"{read_only:false; response_revision:1790; number_of_response:1; }","duration":"181.84577ms","start":"2026-04-25T09:38:19.513678Z","end":"2026-04-25T09:38:19.695524Z","steps":["trace[2030738043] 'process raft request' (duration: 181.099016ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:38:23.858348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"822.29035ms","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-04-25T09:38:23.858404Z","caller":"traceutil/trace.go:171","msg":"trace[22813543] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1819; }","duration":"822.358521ms","start":"2026-04-25T09:38:23.036033Z","end":"2026-04-25T09:38:23.858391Z","steps":["trace[22813543] 'range keys from in-memory index tree' (duration: 822.148677ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:38:23.858428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:38:23.035978Z","time spent":"822.445213ms","remote":"127.0.0.1:33206","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":"info","ts":"2026-04-25T09:38:23.921044Z","caller":"traceutil/trace.go:171","msg":"trace[442290338] linearizableReadLoop","detail":"{readStateIndex:1903; appliedIndex:1902; }","duration":"213.117719ms","start":"2026-04-25T09:38:23.707901Z","end":"2026-04-25T09:38:23.921019Z","steps":["trace[442290338] 'read index received' (duration: 212.951416ms)","trace[442290338] 'applied index is now lower than readState.Index' (duration: 165.333µs)"],"step_count":2} {"level":"warn","ts":"2026-04-25T09:38:23.921287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.360303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-25T09:38:23.921109Z","caller":"traceutil/trace.go:171","msg":"trace[1834703614] transaction","detail":"{read_only:false; response_revision:1820; number_of_response:1; }","duration":"400.831472ms","start":"2026-04-25T09:38:23.520252Z","end":"2026-04-25T09:38:23.921084Z","steps":["trace[1834703614] 'process raft request' (duration: 400.615618ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:38:23.921347Z","caller":"traceutil/trace.go:171","msg":"trace[1737633317] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1820; }","duration":"213.465097ms","start":"2026-04-25T09:38:23.707865Z","end":"2026-04-25T09:38:23.92133Z","steps":["trace[1737633317] 'agreement among raft nodes before linearized reading' (duration: 213.291463ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:38:23.921526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:38:23.520224Z","time spent":"401.21642ms","remote":"127.0.0.1:33206","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-04-25T09:38:24.088286Z","caller":"traceutil/trace.go:171","msg":"trace[1460301807] transaction","detail":"{read_only:false; response_revision:1822; number_of_response:1; }","duration":"161.91207ms","start":"2026-04-25T09:38:23.926346Z","end":"2026-04-25T09:38:24.088258Z","steps":["trace[1460301807] 'process raft request' (duration: 161.862459ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:38:24.088691Z","caller":"traceutil/trace.go:171","msg":"trace[383512988] linearizableReadLoop","detail":"{readStateIndex:1904; appliedIndex:1903; }","duration":"167.549597ms","start":"2026-04-25T09:38:23.921129Z","end":"2026-04-25T09:38:24.088678Z","steps":["trace[383512988] 'read index received' (duration: 77.892461ms)","trace[383512988] 'applied index is now lower than readState.Index' (duration: 89.655336ms)"],"step_count":2} {"level":"info","ts":"2026-04-25T09:38:24.088702Z","caller":"traceutil/trace.go:171","msg":"trace[48804254] transaction","detail":"{read_only:false; response_revision:1821; number_of_response:1; }","duration":"223.211382ms","start":"2026-04-25T09:38:23.865461Z","end":"2026-04-25T09:38:24.088672Z","steps":["trace[48804254] 'process raft request' (duration: 133.539496ms)","trace[48804254] 'compare' (duration: 89.056495ms)"],"step_count":2} {"level":"warn","ts":"2026-04-25T09:38:24.088861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.916111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-25T09:38:24.088901Z","caller":"traceutil/trace.go:171","msg":"trace[1481503103] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1822; }","duration":"380.011383ms","start":"2026-04-25T09:38:23.70888Z","end":"2026-04-25T09:38:24.088892Z","steps":["trace[1481503103] 'agreement among raft nodes before linearized reading' (duration: 379.8411ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:38:24.088933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:38:23.70886Z","time spent":"380.064254ms","remote":"127.0.0.1:33206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-25T09:38:24.089041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.185742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/default/test-pvc\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-25T09:38:24.089072Z","caller":"traceutil/trace.go:171","msg":"trace[1202845197] range","detail":"{range_begin:/registry/persistentvolumeclaims/default/test-pvc; range_end:; response_count:0; response_revision:1822; }","duration":"223.238802ms","start":"2026-04-25T09:38:23.865825Z","end":"2026-04-25T09:38:24.089064Z","steps":["trace[1202845197] 'agreement among raft nodes before linearized reading' (duration: 223.190482ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:38:24.08929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.453966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-25T09:38:24.089325Z","caller":"traceutil/trace.go:171","msg":"trace[143542740] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1822; }","duration":"374.511838ms","start":"2026-04-25T09:38:23.714804Z","end":"2026-04-25T09:38:24.089316Z","steps":["trace[143542740] 'agreement among raft nodes before linearized reading' (duration: 374.420216ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:38:24.089353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:38:23.71479Z","time spent":"374.55643ms","remote":"127.0.0.1:33206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-25T09:38:24.089349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.938075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-25T09:38:24.089484Z","caller":"traceutil/trace.go:171","msg":"trace[863774228] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1822; }","duration":"377.127839ms","start":"2026-04-25T09:38:23.712347Z","end":"2026-04-25T09:38:24.089475Z","steps":["trace[863774228] 'agreement among raft nodes before linearized reading' (duration: 376.882243ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:38:24.089514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:38:23.712335Z","time spent":"377.17118ms","remote":"127.0.0.1:33206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-25T09:38:24.518911Z","caller":"traceutil/trace.go:171","msg":"trace[1528225817] linearizableReadLoop","detail":"{readStateIndex:1908; appliedIndex:1905; }","duration":"422.077168ms","start":"2026-04-25T09:38:24.096805Z","end":"2026-04-25T09:38:24.518882Z","steps":["trace[1528225817] 'read index received' (duration: 73.074959ms)","trace[1528225817] 'applied index is now lower than readState.Index' (duration: 349.000529ms)"],"step_count":2} {"level":"info","ts":"2026-04-25T09:38:24.519197Z","caller":"traceutil/trace.go:171","msg":"trace[260326902] transaction","detail":"{read_only:false; response_revision:1824; number_of_response:1; }","duration":"425.437653ms","start":"2026-04-25T09:38:24.093745Z","end":"2026-04-25T09:38:24.519182Z","steps":["trace[260326902] 'process raft request' (duration: 424.647037ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:38:24.519316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:38:24.093737Z","time spent":"425.498404ms","remote":"127.0.0.1:33206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-25T09:38:24.519507Z","caller":"traceutil/trace.go:171","msg":"trace[1713143443] transaction","detail":"{read_only:false; response_revision:1825; number_of_response:1; }","duration":"424.379783ms","start":"2026-04-25T09:38:24.095115Z","end":"2026-04-25T09:38:24.519495Z","steps":["trace[1713143443] 'process raft request' (duration: 423.663149ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:38:24.519569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:38:24.095095Z","time spent":"424.443373ms","remote":"127.0.0.1:33206","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-04-25T09:38:24.519774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.946195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/default/\" range_end:\"/registry/limitranges/default0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-25T09:38:24.519869Z","caller":"traceutil/trace.go:171","msg":"trace[22279957] range","detail":"{range_begin:/registry/limitranges/default/; range_end:/registry/limitranges/default0; response_count:0; response_revision:1825; }","duration":"423.097378ms","start":"2026-04-25T09:38:24.096749Z","end":"2026-04-25T09:38:24.519846Z","steps":["trace[22279957] 'agreement among raft nodes before linearized reading' (duration: 422.941285ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:38:24.519923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:38:24.096729Z","time spent":"423.183239ms","remote":"127.0.0.1:33070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":0,"response size":28,"request content":"key:\"/registry/limitranges/default/\" range_end:\"/registry/limitranges/default0\" "} {"level":"warn","ts":"2026-04-25T09:38:24.519959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.633109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-25T09:38:24.520012Z","caller":"traceutil/trace.go:171","msg":"trace[1497213393] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1825; }","duration":"259.718481ms","start":"2026-04-25T09:38:24.26028Z","end":"2026-04-25T09:38:24.519999Z","steps":["trace[1497213393] 'agreement among raft nodes before linearized reading' (duration: 259.633459ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:38:24.520019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.007876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-25T09:38:24.520106Z","caller":"traceutil/trace.go:171","msg":"trace[1921876820] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:1825; }","duration":"272.140648ms","start":"2026-04-25T09:38:24.247942Z","end":"2026-04-25T09:38:24.520083Z","steps":["trace[1921876820] 'agreement among raft nodes before linearized reading' (duration: 271.966045ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:38:24.825742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.605461ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-25T09:38:24.825897Z","caller":"traceutil/trace.go:171","msg":"trace[813048807] transaction","detail":"{read_only:false; response_revision:1827; number_of_response:1; }","duration":"225.64458ms","start":"2026-04-25T09:38:24.600215Z","end":"2026-04-25T09:38:24.825859Z","steps":["trace[813048807] 'process raft request' (duration: 83.753093ms)","trace[813048807] 'compare' (duration: 141.470748ms)"],"step_count":2} {"level":"info","ts":"2026-04-25T09:38:25.596763Z","caller":"traceutil/trace.go:171","msg":"trace[405006849] transaction","detail":"{read_only:false; response_revision:1830; number_of_response:1; }","duration":"265.759557ms","start":"2026-04-25T09:38:25.330975Z","end":"2026-04-25T09:38:25.596735Z","steps":["trace[405006849] 'process raft request' (duration: 265.542033ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:38:25.597151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.387107ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-25T09:38:25.597255Z","caller":"traceutil/trace.go:171","msg":"trace[182261683] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1830; }","duration":"211.62102ms","start":"2026-04-25T09:38:25.385575Z","end":"2026-04-25T09:38:25.597196Z","steps":["trace[182261683] 'agreement among raft nodes before linearized reading' (duration: 211.306465ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:38:25.596833Z","caller":"traceutil/trace.go:171","msg":"trace[1679944967] linearizableReadLoop","detail":"{readStateIndex:1913; appliedIndex:1912; }","duration":"210.973158ms","start":"2026-04-25T09:38:25.385678Z","end":"2026-04-25T09:38:25.596651Z","steps":["trace[1679944967] 'read index received' (duration: 210.721294ms)","trace[1679944967] 'applied index is now lower than readState.Index' (duration: 250.804µs)"],"step_count":2} {"level":"warn","ts":"2026-04-25T09:38:26.17609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"532.952741ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-25T09:38:26.176174Z","caller":"traceutil/trace.go:171","msg":"trace[1319494102] linearizableReadLoop","detail":"{readStateIndex:1914; appliedIndex:1913; }","duration":"574.234491ms","start":"2026-04-25T09:38:25.601924Z","end":"2026-04-25T09:38:26.176159Z","steps":["trace[1319494102] 'read index received' (duration: 41.79905ms)","trace[1319494102] 'applied index is now lower than readState.Index' (duration: 532.434561ms)"],"step_count":2} {"level":"info","ts":"2026-04-25T09:38:26.176223Z","caller":"traceutil/trace.go:171","msg":"trace[1765663097] transaction","detail":"{read_only:false; response_revision:1831; number_of_response:1; }","duration":"574.935395ms","start":"2026-04-25T09:38:25.60128Z","end":"2026-04-25T09:38:26.176215Z","steps":["trace[1765663097] 'process raft request' (duration: 41.801481ms)","trace[1765663097] 'compare' (duration: 532.86312ms)"],"step_count":2} {"level":"warn","ts":"2026-04-25T09:38:26.176256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:38:25.601253Z","time spent":"574.987916ms","remote":"127.0.0.1:33004","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":767,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-25T09:38:26.177015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"575.087558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/test-pvc-pod\" ","response":"range_response_count:1 size:1490"} {"level":"info","ts":"2026-04-25T09:38:26.177048Z","caller":"traceutil/trace.go:171","msg":"trace[1886081231] range","detail":"{range_begin:/registry/pods/default/test-pvc-pod; range_end:; response_count:1; response_revision:1831; }","duration":"575.130509ms","start":"2026-04-25T09:38:25.601911Z","end":"2026-04-25T09:38:26.177041Z","steps":["trace[1886081231] 'agreement among raft nodes before linearized reading' (duration: 574.466035ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:38:26.177069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:38:25.601844Z","time spent":"575.22033ms","remote":"127.0.0.1:33116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":1,"response size":1513,"request content":"key:\"/registry/pods/default/test-pvc-pod\" "} {"level":"info","ts":"2026-04-25T09:38:26.177087Z","caller":"traceutil/trace.go:171","msg":"trace[2031839239] transaction","detail":"{read_only:false; response_revision:1832; number_of_response:1; }","duration":"573.568219ms","start":"2026-04-25T09:38:25.603485Z","end":"2026-04-25T09:38:26.177053Z","steps":["trace[2031839239] 'process raft request' (duration: 573.077289ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:38:26.177259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:38:25.603471Z","time spent":"573.702521ms","remote":"127.0.0.1:33116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1933,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-25T09:38:26.249051Z","caller":"traceutil/trace.go:171","msg":"trace[1322053781] transaction","detail":"{read_only:false; response_revision:1833; number_of_response:1; }","duration":"322.328599ms","start":"2026-04-25T09:38:25.9267Z","end":"2026-04-25T09:38:26.249029Z","steps":["trace[1322053781] 'process raft request' (duration: 322.106755ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:38:26.249075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.593901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-25T09:38:26.249156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.251022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-25T09:38:26.249224Z","caller":"traceutil/trace.go:171","msg":"trace[172537178] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1833; }","duration":"154.332204ms","start":"2026-04-25T09:38:26.094879Z","end":"2026-04-25T09:38:26.249211Z","steps":["trace[172537178] 'agreement among raft nodes before linearized reading' (duration: 154.159701ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:38:26.249281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.213431ms","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-04-25T09:38:26.24915Z","caller":"traceutil/trace.go:171","msg":"trace[233300908] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:1833; }","duration":"303.702773ms","start":"2026-04-25T09:38:25.94543Z","end":"2026-04-25T09:38:26.249133Z","steps":["trace[233300908] 'agreement among raft nodes before linearized reading' (duration: 303.52193ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:38:26.249323Z","caller":"traceutil/trace.go:171","msg":"trace[1472281250] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1833; }","duration":"155.279023ms","start":"2026-04-25T09:38:26.094034Z","end":"2026-04-25T09:38:26.249313Z","steps":["trace[1472281250] 'agreement among raft nodes before linearized reading' (duration: 155.16523ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:38:26.249162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:38:25.926675Z","time spent":"322.431962ms","remote":"127.0.0.1:33206","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-04-25T09:38:26.249418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:38:25.945421Z","time spent":"303.911057ms","remote":"127.0.0.1:35570","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true "} {"level":"warn","ts":"2026-04-25T09:38:26.632093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.314883ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-25T09:38:26.632462Z","caller":"traceutil/trace.go:171","msg":"trace[677707806] linearizableReadLoop","detail":"{readStateIndex:1919; appliedIndex:1916; }","duration":"373.585191ms","start":"2026-04-25T09:38:26.25886Z","end":"2026-04-25T09:38:26.632445Z","steps":["trace[677707806] 'read index received' (duration: 183.008694ms)","trace[677707806] 'applied index is now lower than readState.Index' (duration: 190.575517ms)"],"step_count":2} {"level":"info","ts":"2026-04-25T09:38:26.632506Z","caller":"traceutil/trace.go:171","msg":"trace[191111227] transaction","detail":"{read_only:false; response_revision:1835; number_of_response:1; }","duration":"378.642068ms","start":"2026-04-25T09:38:26.253839Z","end":"2026-04-25T09:38:26.632481Z","steps":["trace[191111227] 'process raft request' (duration: 378.381193ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:38:26.632513Z","caller":"traceutil/trace.go:171","msg":"trace[456224525] transaction","detail":"{read_only:false; response_revision:1836; number_of_response:1; }","duration":"377.661879ms","start":"2026-04-25T09:38:26.254832Z","end":"2026-04-25T09:38:26.632493Z","steps":["trace[456224525] 'process raft request' (duration: 377.574668ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:38:26.632631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:38:26.253817Z","time spent":"378.744511ms","remote":"127.0.0.1:33206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-25T09:38:26.632644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:38:26.254817Z","time spent":"377.749791ms","remote":"127.0.0.1:33206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-25T09:38:26.632618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.750344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-25T09:38:26.632776Z","caller":"traceutil/trace.go:171","msg":"trace[467026192] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1836; }","duration":"373.925367ms","start":"2026-04-25T09:38:26.25884Z","end":"2026-04-25T09:38:26.632766Z","steps":["trace[467026192] 'agreement among raft nodes before linearized reading' (duration: 373.737614ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:38:26.632807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:38:26.258833Z","time spent":"373.966908ms","remote":"127.0.0.1:32914","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-04-25T09:38:26.632893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.498486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-25T09:38:26.632968Z","caller":"traceutil/trace.go:171","msg":"trace[2120074922] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1836; }","duration":"108.602358ms","start":"2026-04-25T09:38:26.524322Z","end":"2026-04-25T09:38:26.632925Z","steps":["trace[2120074922] 'agreement among raft nodes before linearized reading' (duration: 108.412115ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:38:26.632992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.654399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-25T09:38:26.632535Z","caller":"traceutil/trace.go:171","msg":"trace[871689569] transaction","detail":"{read_only:false; response_revision:1834; number_of_response:1; }","duration":"379.189608ms","start":"2026-04-25T09:38:26.253311Z","end":"2026-04-25T09:38:26.632501Z","steps":["trace[871689569] 'process raft request' (duration: 188.380136ms)","trace[871689569] 'compare' (duration: 190.014657ms)"],"step_count":2} {"level":"info","ts":"2026-04-25T09:38:26.633176Z","caller":"traceutil/trace.go:171","msg":"trace[1659680583] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1836; }","duration":"108.881444ms","start":"2026-04-25T09:38:26.524236Z","end":"2026-04-25T09:38:26.633117Z","steps":["trace[1659680583] 'agreement among raft nodes before linearized reading' (duration: 108.400685ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:38:26.633208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:38:26.25329Z","time spent":"379.85162ms","remote":"127.0.0.1:33206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-25T09:38:27.271879Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656052250663303088,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-25T09:38:27.2735Z","caller":"traceutil/trace.go:171","msg":"trace[84308750] transaction","detail":"{read_only:false; response_revision:1837; number_of_response:1; }","duration":"635.85455ms","start":"2026-04-25T09:38:26.637623Z","end":"2026-04-25T09:38:27.273478Z","steps":["trace[84308750] 'process raft request' (duration: 635.733428ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:38:27.273695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:38:26.637575Z","time spent":"635.976202ms","remote":"127.0.0.1:33206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-25T09:38:27.295693Z","caller":"traceutil/trace.go:171","msg":"trace[245441756] transaction","detail":"{read_only:false; response_revision:1838; number_of_response:1; }","duration":"657.709219ms","start":"2026-04-25T09:38:26.637938Z","end":"2026-04-25T09:38:27.295648Z","steps":["trace[245441756] 'process raft request' (duration: 657.529494ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:38:27.296048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:38:26.637918Z","time spent":"658.018885ms","remote":"127.0.0.1:33206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-25T09:38:27.376468Z","caller":"traceutil/trace.go:171","msg":"trace[237786112] linearizableReadLoop","detail":"{readStateIndex:1922; appliedIndex:1920; }","duration":"604.942639ms","start":"2026-04-25T09:38:26.771504Z","end":"2026-04-25T09:38:27.376446Z","steps":["trace[237786112] 'read index received' (duration: 501.965268ms)","trace[237786112] 'applied index is now lower than readState.Index' (duration: 102.976161ms)"],"step_count":2} {"level":"warn","ts":"2026-04-25T09:38:27.376582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"605.068191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-25T09:38:27.376655Z","caller":"traceutil/trace.go:171","msg":"trace[1285406054] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:1838; }","duration":"605.190333ms","start":"2026-04-25T09:38:26.771451Z","end":"2026-04-25T09:38:27.376641Z","steps":["trace[1285406054] 'agreement among raft nodes before linearized reading' (duration: 605.065511ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:38:27.376691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:38:26.771433Z","time spent":"605.250154ms","remote":"127.0.0.1:35604","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"warn","ts":"2026-04-25T09:38:27.390348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.876347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-25T09:38:27.390388Z","caller":"traceutil/trace.go:171","msg":"trace[425627012] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1839; }","duration":"128.955458ms","start":"2026-04-25T09:38:27.261422Z","end":"2026-04-25T09:38:27.390378Z","steps":["trace[425627012] 'agreement among raft nodes before linearized reading' (duration: 128.863167ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:38:27.636709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.626701ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-25T09:38:27.636941Z","caller":"traceutil/trace.go:171","msg":"trace[1287731187] transaction","detail":"{read_only:false; response_revision:1841; number_of_response:1; }","duration":"102.234157ms","start":"2026-04-25T09:38:27.534681Z","end":"2026-04-25T09:38:27.636916Z","steps":["trace[1287731187] 'process raft request' (duration: 102.144946ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:38:27.637013Z","caller":"traceutil/trace.go:171","msg":"trace[1809254435] transaction","detail":"{read_only:false; response_revision:1840; number_of_response:1; }","duration":"173.563162ms","start":"2026-04-25T09:38:27.463403Z","end":"2026-04-25T09:38:27.636966Z","steps":["trace[1809254435] 'process raft request' (duration: 32.610125ms)","trace[1809254435] 'compare' (duration: 140.479038ms)"],"step_count":2} {"level":"info","ts":"2026-04-25T09:38:27.946386Z","caller":"traceutil/trace.go:171","msg":"trace[1886819473] transaction","detail":"{read_only:false; response_revision:1842; number_of_response:1; }","duration":"304.60483ms","start":"2026-04-25T09:38:27.641751Z","end":"2026-04-25T09:38:27.946356Z","steps":["trace[1886819473] 'process raft request' (duration: 269.254864ms)","trace[1886819473] 'compare' (duration: 35.203533ms)"],"step_count":2} {"level":"warn","ts":"2026-04-25T09:38:27.946543Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:38:27.641736Z","time spent":"304.730242ms","remote":"127.0.0.1:33004","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":836,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-25T09:38:28.119287Z","caller":"traceutil/trace.go:171","msg":"trace[1982237292] transaction","detail":"{read_only:false; response_revision:1843; number_of_response:1; }","duration":"476.804537ms","start":"2026-04-25T09:38:27.642438Z","end":"2026-04-25T09:38:28.119243Z","steps":["trace[1982237292] 'process raft request' (duration: 464.98924ms)","trace[1982237292] 'compare' (duration: 11.450569ms)"],"step_count":2} {"level":"warn","ts":"2026-04-25T09:38:28.119468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:38:27.642425Z","time spent":"476.96078ms","remote":"127.0.0.1:33004","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":773,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-25T09:38:28.119456Z","caller":"traceutil/trace.go:171","msg":"trace[1044291984] transaction","detail":"{read_only:false; response_revision:1844; number_of_response:1; }","duration":"472.594767ms","start":"2026-04-25T09:38:27.646747Z","end":"2026-04-25T09:38:28.119341Z","steps":["trace[1044291984] 'process raft request' (duration: 472.347982ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:38:28.119615Z","caller":"traceutil/trace.go:171","msg":"trace[1712502213] linearizableReadLoop","detail":"{readStateIndex:1929; appliedIndex:1925; }","duration":"350.454738ms","start":"2026-04-25T09:38:27.769096Z","end":"2026-04-25T09:38:28.11955Z","steps":["trace[1712502213] 'read index received' (duration: 141.918226ms)","trace[1712502213] 'applied index is now lower than readState.Index' (duration: 208.533192ms)"],"step_count":2} {"level":"info","ts":"2026-04-25T09:38:28.119629Z","caller":"traceutil/trace.go:171","msg":"trace[756917961] transaction","detail":"{read_only:false; response_revision:1846; number_of_response:1; }","duration":"273.71796ms","start":"2026-04-25T09:38:27.845882Z","end":"2026-04-25T09:38:28.1196Z","steps":["trace[756917961] 'process raft request' (duration: 273.421974ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:38:28.119675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:38:27.646726Z","time spent":"472.845951ms","remote":"127.0.0.1:33206","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-04-25T09:38:28.120009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.710717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/csi-rbd-secret\" ","response":"range_response_count:1 size:880"} {"level":"info","ts":"2026-04-25T09:38:28.120006Z","caller":"traceutil/trace.go:171","msg":"trace[405703710] transaction","detail":"{read_only:false; response_revision:1845; number_of_response:1; }","duration":"355.332212ms","start":"2026-04-25T09:38:27.764023Z","end":"2026-04-25T09:38:28.119356Z","steps":["trace[405703710] 'process raft request' (duration: 355.21442ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:38:28.120079Z","caller":"traceutil/trace.go:171","msg":"trace[254905432] range","detail":"{range_begin:/registry/secrets/kube-system/csi-rbd-secret; range_end:; response_count:1; response_revision:1846; }","duration":"275.84166ms","start":"2026-04-25T09:38:27.844219Z","end":"2026-04-25T09:38:28.120061Z","steps":["trace[254905432] 'agreement among raft nodes before linearized reading' (duration: 275.560925ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:38:28.120338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:38:27.764006Z","time spent":"356.153047ms","remote":"127.0.0.1:33206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-25T09:38:28.12057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.464327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-25T09:38:28.120647Z","caller":"traceutil/trace.go:171","msg":"trace[1036346569] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:1846; }","duration":"351.59529ms","start":"2026-04-25T09:38:27.769033Z","end":"2026-04-25T09:38:28.120628Z","steps":["trace[1036346569] 'agreement among raft nodes before linearized reading' (duration: 350.690922ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:38:28.120686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:38:27.769012Z","time spent":"351.664021ms","remote":"127.0.0.1:33470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true "} {"level":"info","ts":"2026-04-25T09:38:28.445486Z","caller":"traceutil/trace.go:171","msg":"trace[2112240113] transaction","detail":"{read_only:false; response_revision:1847; number_of_response:1; }","duration":"189.953836ms","start":"2026-04-25T09:38:28.255501Z","end":"2026-04-25T09:38:28.445455Z","steps":["trace[2112240113] 'process raft request' (duration: 171.575124ms)","trace[2112240113] 'compare' (duration: 17.954573ms)"],"step_count":2} {"level":"warn","ts":"2026-04-25T09:38:28.905869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.459959ms","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-04-25T09:38:28.905974Z","caller":"traceutil/trace.go:171","msg":"trace[1491529457] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1847; }","duration":"267.615593ms","start":"2026-04-25T09:38:28.638327Z","end":"2026-04-25T09:38:28.905943Z","steps":["trace[1491529457] 'range keys from in-memory index tree' (duration: 267.274045ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:38:28.906053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.782715ms","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-04-25T09:38:28.906181Z","caller":"traceutil/trace.go:171","msg":"trace[1378457332] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1847; }","duration":"269.06474ms","start":"2026-04-25T09:38:28.637097Z","end":"2026-04-25T09:38:28.906162Z","steps":["trace[1378457332] 'range keys from in-memory index tree' (duration: 268.614231ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:38:28.905869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.783327ms","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-04-25T09:38:28.906374Z","caller":"traceutil/trace.go:171","msg":"trace[598591641] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1847; }","duration":"267.239935ms","start":"2026-04-25T09:38:28.639038Z","end":"2026-04-25T09:38:28.906278Z","steps":["trace[598591641] 'range keys from in-memory index tree' (duration: 266.639663ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:38:29.312284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.202419ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-25T09:38:29.312408Z","caller":"traceutil/trace.go:171","msg":"trace[230327148] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1850; }","duration":"181.373002ms","start":"2026-04-25T09:38:29.130999Z","end":"2026-04-25T09:38:29.312372Z","steps":["trace[230327148] 'range keys from in-memory index tree' (duration: 181.128987ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:38:29.441091Z","caller":"traceutil/trace.go:171","msg":"trace[933846591] transaction","detail":"{read_only:false; response_revision:1852; number_of_response:1; }","duration":"124.595574ms","start":"2026-04-25T09:38:29.316465Z","end":"2026-04-25T09:38:29.44106Z","steps":["trace[933846591] 'process raft request' (duration: 121.375363ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:38:30.578856Z","caller":"traceutil/trace.go:171","msg":"trace[320367307] transaction","detail":"{read_only:false; response_revision:1856; number_of_response:1; }","duration":"114.274177ms","start":"2026-04-25T09:38:30.46456Z","end":"2026-04-25T09:38:30.578834Z","steps":["trace[320367307] 'process raft request' (duration: 114.192495ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T09:38:30.712071Z","caller":"traceutil/trace.go:171","msg":"trace[1513758470] transaction","detail":"{read_only:false; response_revision:1859; number_of_response:1; }","duration":"114.016303ms","start":"2026-04-25T09:38:30.598005Z","end":"2026-04-25T09:38:30.712022Z","steps":["trace[1513758470] 'process raft request' (duration: 52.983814ms)","trace[1513758470] 'compare' (duration: 60.796444ms)"],"step_count":2} {"level":"info","ts":"2026-04-25T09:38:31.461898Z","caller":"traceutil/trace.go:171","msg":"trace[2018723361] transaction","detail":"{read_only:false; response_revision:1865; number_of_response:1; }","duration":"122.383572ms","start":"2026-04-25T09:38:31.339468Z","end":"2026-04-25T09:38:31.461852Z","steps":["trace[2018723361] 'process raft request' (duration: 122.169368ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:38:42.824168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.666435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-25T09:38:42.824255Z","caller":"traceutil/trace.go:171","msg":"trace[1096855696] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:1955; }","duration":"140.816428ms","start":"2026-04-25T09:38:42.683421Z","end":"2026-04-25T09:38:42.824238Z","steps":["trace[1096855696] 'count revisions from in-memory index tree' (duration: 140.529093ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:38:48.760629Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656052250663303408,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-25T09:38:49.261756Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656052250663303408,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-25T09:38:49.762188Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656052250663303408,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-25T09:38:50.056469Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.900700538s","expected-duration":"1s"} {"level":"info","ts":"2026-04-25T09:38:50.057155Z","caller":"traceutil/trace.go:171","msg":"trace[475299026] transaction","detail":"{read_only:false; response_revision:1986; number_of_response:1; }","duration":"1.901504013s","start":"2026-04-25T09:38:48.155626Z","end":"2026-04-25T09:38:50.05713Z","steps":["trace[475299026] 'process raft request' (duration: 1.901098786s)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:38:50.057295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:38:48.155602Z","time spent":"1.901614255s","remote":"127.0.0.1:33206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":458,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-25T09:38:50.084355Z","caller":"traceutil/trace.go:171","msg":"trace[1897082056] transaction","detail":"{read_only:false; response_revision:1987; number_of_response:1; }","duration":"1.58486455s","start":"2026-04-25T09:38:48.499477Z","end":"2026-04-25T09:38:50.084341Z","steps":["trace[1897082056] 'process raft request' (duration: 1.584746598s)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:38:50.084457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:38:48.499454Z","time spent":"1.584945502s","remote":"127.0.0.1:33206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-25T09:38:50.084573Z","caller":"traceutil/trace.go:171","msg":"trace[563200586] linearizableReadLoop","detail":"{readStateIndex:2076; appliedIndex:2073; }","duration":"1.824178862s","start":"2026-04-25T09:38:48.260367Z","end":"2026-04-25T09:38:50.084546Z","steps":["trace[563200586] 'read index received' (duration: 1.796524016s)","trace[563200586] 'applied index is now lower than readState.Index' (duration: 27.653736ms)"],"step_count":2} {"level":"info","ts":"2026-04-25T09:38:50.084725Z","caller":"traceutil/trace.go:171","msg":"trace[241841219] transaction","detail":"{read_only:false; response_revision:1988; number_of_response:1; }","duration":"1.466368215s","start":"2026-04-25T09:38:48.618347Z","end":"2026-04-25T09:38:50.084715Z","steps":["trace[241841219] 'process raft request' (duration: 1.465964908s)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:38:50.084847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:38:48.618327Z","time spent":"1.466441406s","remote":"127.0.0.1:33206","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-04-25T09:38:50.084864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.23478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-25T09:38:50.084904Z","caller":"traceutil/trace.go:171","msg":"trace[416844251] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1988; }","duration":"548.305292ms","start":"2026-04-25T09:38:49.536588Z","end":"2026-04-25T09:38:50.084893Z","steps":["trace[416844251] 'agreement among raft nodes before linearized reading' (duration: 548.171039ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:38:50.084944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:38:49.536564Z","time spent":"548.372543ms","remote":"127.0.0.1:33206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-25T09:38:50.084927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.824511478s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-25T09:38:50.085021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"528.397672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-04-25T09:38:50.085071Z","caller":"traceutil/trace.go:171","msg":"trace[1846903359] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1988; }","duration":"1.824700302s","start":"2026-04-25T09:38:48.260323Z","end":"2026-04-25T09:38:50.085023Z","steps":["trace[1846903359] 'agreement among raft nodes before linearized reading' (duration: 1.824496308s)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:38:50.085075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"543.784985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-25T09:38:50.085108Z","caller":"traceutil/trace.go:171","msg":"trace[2109839284] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1988; }","duration":"543.855176ms","start":"2026-04-25T09:38:49.541243Z","end":"2026-04-25T09:38:50.085098Z","steps":["trace[2109839284] 'agreement among raft nodes before linearized reading' (duration: 543.770945ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:38:50.085139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:38:49.541227Z","time spent":"543.905877ms","remote":"127.0.0.1:33206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-25T09:38:50.085102Z","caller":"traceutil/trace.go:171","msg":"trace[95545807] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1988; }","duration":"528.502574ms","start":"2026-04-25T09:38:49.556585Z","end":"2026-04-25T09:38:50.085087Z","steps":["trace[95545807] 'agreement among raft nodes before linearized reading' (duration: 528.204139ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:38:50.085127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:38:48.260309Z","time spent":"1.824809374s","remote":"127.0.0.1:32920","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-04-25T09:38:50.085192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:38:49.556574Z","time spent":"528.605916ms","remote":"127.0.0.1:33206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":555,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-04-25T09:38:50.085072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.650684942s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"} {"level":"warn","ts":"2026-04-25T09:38:50.085274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"955.920835ms","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-04-25T09:38:50.08533Z","caller":"traceutil/trace.go:171","msg":"trace[2120344165] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1988; }","duration":"956.004767ms","start":"2026-04-25T09:38:49.129315Z","end":"2026-04-25T09:38:50.08532Z","steps":["trace[2120344165] 'agreement among raft nodes before linearized reading' (duration: 955.885174ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:38:50.085374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:38:49.129298Z","time spent":"956.069398ms","remote":"127.0.0.1:33206","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-04-25T09:38:50.085341Z","caller":"traceutil/trace.go:171","msg":"trace[806597333] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1988; }","duration":"1.650994658s","start":"2026-04-25T09:38:48.434297Z","end":"2026-04-25T09:38:50.085292Z","steps":["trace[806597333] 'agreement among raft nodes before linearized reading' (duration: 1.650454738s)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:38:50.085471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:38:48.434281Z","time spent":"1.651174721s","remote":"127.0.0.1:33206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":549,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-04-25T09:38:50.08554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"956.196919ms","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":"warn","ts":"2026-04-25T09:38:50.085532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"955.816763ms","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-04-25T09:38:50.085572Z","caller":"traceutil/trace.go:171","msg":"trace[1829435407] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1988; }","duration":"956.267252ms","start":"2026-04-25T09:38:49.129297Z","end":"2026-04-25T09:38:50.085564Z","steps":["trace[1829435407] 'agreement among raft nodes before linearized reading' (duration: 956.18468ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:38:50.085631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:38:49.129278Z","time spent":"956.346784ms","remote":"127.0.0.1:33206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-25T09:38:50.085629Z","caller":"traceutil/trace.go:171","msg":"trace[369195791] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1988; }","duration":"955.953565ms","start":"2026-04-25T09:38:49.129621Z","end":"2026-04-25T09:38:50.085575Z","steps":["trace[369195791] 'agreement among raft nodes before linearized reading' (duration: 955.69425ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:38:50.085695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:38:49.129616Z","time spent":"956.064808ms","remote":"127.0.0.1:33206","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-04-25T09:38:50.085703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"987.928965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-25T09:38:50.086007Z","caller":"traceutil/trace.go:171","msg":"trace[1167672152] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1988; }","duration":"988.294562ms","start":"2026-04-25T09:38:49.097699Z","end":"2026-04-25T09:38:50.085994Z","steps":["trace[1167672152] 'agreement among raft nodes before linearized reading' (duration: 987.950906ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T09:38:50.086073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T09:38:49.09767Z","time spent":"988.360533ms","remote":"127.0.0.1:33084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":30,"request content":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true "}