{"level":"warn","ts":"2026-07-21T13:22:20.385997Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-21T13:22:20.386088Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.209: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.19.213.209:2380","--initial-cluster=instance=https://199.19.213.209:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.209:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.209:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-07-21T13:22:20.386168Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-21T13:22:20.386178Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.209:2380"]} {"level":"info","ts":"2026-07-21T13:22:20.3862Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-07-21T13:22:20.387046Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.209:2379"]} {"level":"info","ts":"2026-07-21T13:22:20.387143Z","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.19.213.209:2380"],"listen-peer-urls":["https://199.19.213.209:2380"],"advertise-client-urls":["https://199.19.213.209:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.209:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.209:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-07-21T13:22:20.390808Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.399829ms"} {"level":"info","ts":"2026-07-21T13:22:20.397144Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"9409e054be1d0d72","cluster-id":"ff5f9c0688884e7d"} {"level":"info","ts":"2026-07-21T13:22:20.397265Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9409e054be1d0d72 switched to configuration voters=()"} {"level":"info","ts":"2026-07-21T13:22:20.397311Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9409e054be1d0d72 became follower at term 0"} {"level":"info","ts":"2026-07-21T13:22:20.397335Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 9409e054be1d0d72 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-21T13:22:20.397349Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9409e054be1d0d72 became follower at term 1"} {"level":"info","ts":"2026-07-21T13:22:20.397399Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9409e054be1d0d72 switched to configuration voters=(10667303846975180146)"} {"level":"warn","ts":"2026-07-21T13:22:20.402971Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-21T13:22:20.404487Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-21T13:22:20.405592Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-07-21T13:22:20.407742Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"9409e054be1d0d72","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-21T13:22:20.408043Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"9409e054be1d0d72","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-21T13:22:20.408165Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-21T13:22:20.408206Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-21T13:22:20.408216Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-21T13:22:20.408325Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9409e054be1d0d72 switched to configuration voters=(10667303846975180146)"} {"level":"info","ts":"2026-07-21T13:22:20.408389Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ff5f9c0688884e7d","local-member-id":"9409e054be1d0d72","added-peer-id":"9409e054be1d0d72","added-peer-peer-urls":["https://199.19.213.209:2380"]} {"level":"info","ts":"2026-07-21T13:22:20.413065Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-07-21T13:22:20.413237Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"9409e054be1d0d72","initial-advertise-peer-urls":["https://199.19.213.209:2380"],"listen-peer-urls":["https://199.19.213.209:2380"],"advertise-client-urls":["https://199.19.213.209:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.209:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-21T13:22:20.413268Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-21T13:22:20.413333Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.209:2380"} {"level":"info","ts":"2026-07-21T13:22:20.413349Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.209:2380"} {"level":"info","ts":"2026-07-21T13:22:21.298964Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9409e054be1d0d72 is starting a new election at term 1"} {"level":"info","ts":"2026-07-21T13:22:21.299005Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9409e054be1d0d72 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-21T13:22:21.299027Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9409e054be1d0d72 received MsgPreVoteResp from 9409e054be1d0d72 at term 1"} {"level":"info","ts":"2026-07-21T13:22:21.29904Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9409e054be1d0d72 became candidate at term 2"} {"level":"info","ts":"2026-07-21T13:22:21.299045Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9409e054be1d0d72 received MsgVoteResp from 9409e054be1d0d72 at term 2"} {"level":"info","ts":"2026-07-21T13:22:21.299053Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9409e054be1d0d72 became leader at term 2"} {"level":"info","ts":"2026-07-21T13:22:21.299059Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 9409e054be1d0d72 elected leader 9409e054be1d0d72 at term 2"} {"level":"info","ts":"2026-07-21T13:22:21.300131Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-21T13:22:21.300706Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"9409e054be1d0d72","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.209:2379]}","request-path":"/0/members/9409e054be1d0d72/attributes","cluster-id":"ff5f9c0688884e7d","publish-timeout":"7s"} {"level":"info","ts":"2026-07-21T13:22:21.300981Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-21T13:22:21.30106Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-21T13:22:21.301229Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-21T13:22:21.301272Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-21T13:22:21.301509Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ff5f9c0688884e7d","local-member-id":"9409e054be1d0d72","cluster-version":"3.5"} {"level":"info","ts":"2026-07-21T13:22:21.301656Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-21T13:22:21.301734Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-21T13:22:21.303101Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.209:2379"} {"level":"info","ts":"2026-07-21T13:22:21.304698Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-21T13:22:24.516205Z","caller":"traceutil/trace.go:171","msg":"trace[1966988910] transaction","detail":"{read_only:false; response_revision:200; number_of_response:1; }","duration":"112.532233ms","start":"2026-07-21T13:22:24.403628Z","end":"2026-07-21T13:22:24.51616Z","steps":["trace[1966988910] 'process raft request' (duration: 111.838245ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:22:43.118289Z","caller":"traceutil/trace.go:171","msg":"trace[1441962509] transaction","detail":"{read_only:false; response_revision:383; number_of_response:1; }","duration":"267.405726ms","start":"2026-07-21T13:22:42.85085Z","end":"2026-07-21T13:22:43.118256Z","steps":["trace[1441962509] 'process raft request' (duration: 267.16867ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:22:43.124092Z","caller":"traceutil/trace.go:171","msg":"trace[1846825070] linearizableReadLoop","detail":"{readStateIndex:400; appliedIndex:398; }","duration":"121.578754ms","start":"2026-07-21T13:22:43.002487Z","end":"2026-07-21T13:22:43.124066Z","steps":["trace[1846825070] 'read index received' (duration: 115.509823ms)","trace[1846825070] 'applied index is now lower than readState.Index' (duration: 6.067711ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T13:22:43.124245Z","caller":"traceutil/trace.go:171","msg":"trace[730481007] transaction","detail":"{read_only:false; response_revision:384; number_of_response:1; }","duration":"166.887857ms","start":"2026-07-21T13:22:42.957342Z","end":"2026-07-21T13:22:43.12423Z","steps":["trace[730481007] 'process raft request' (duration: 166.62224ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:22:43.124348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.82102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-21T13:22:43.124445Z","caller":"traceutil/trace.go:171","msg":"trace[1250263919] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:384; }","duration":"121.998515ms","start":"2026-07-21T13:22:43.002428Z","end":"2026-07-21T13:22:43.124426Z","steps":["trace[1250263919] 'agreement among raft nodes before linearized reading' (duration: 121.79327ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:22:47.460433Z","caller":"traceutil/trace.go:171","msg":"trace[1186852464] linearizableReadLoop","detail":"{readStateIndex:443; appliedIndex:442; }","duration":"312.565546ms","start":"2026-07-21T13:22:47.147838Z","end":"2026-07-21T13:22:47.460404Z","steps":["trace[1186852464] 'read index received' (duration: 312.419081ms)","trace[1186852464] 'applied index is now lower than readState.Index' (duration: 145.525µs)"],"step_count":2} {"level":"info","ts":"2026-07-21T13:22:47.460546Z","caller":"traceutil/trace.go:171","msg":"trace[1365619210] transaction","detail":"{read_only:false; response_revision:424; number_of_response:1; }","duration":"324.062209ms","start":"2026-07-21T13:22:47.136449Z","end":"2026-07-21T13:22:47.460511Z","steps":["trace[1365619210] 'process raft request' (duration: 323.805751ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:22:47.460612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.75553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-07-21T13:22:47.460679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.787118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-07-21T13:22:47.460718Z","caller":"traceutil/trace.go:171","msg":"trace[1127095247] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:424; }","duration":"310.845599ms","start":"2026-07-21T13:22:47.149861Z","end":"2026-07-21T13:22:47.460707Z","steps":["trace[1127095247] 'agreement among raft nodes before linearized reading' (duration: 310.749047ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:22:47.460736Z","caller":"traceutil/trace.go:171","msg":"trace[608414947] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:424; }","duration":"312.887244ms","start":"2026-07-21T13:22:47.147805Z","end":"2026-07-21T13:22:47.460693Z","steps":["trace[608414947] 'agreement among raft nodes before linearized reading' (duration: 312.749601ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:22:47.460742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:22:47.149855Z","time spent":"310.882681ms","remote":"127.0.0.1:38852","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-07-21T13:22:47.460789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:22:47.147792Z","time spent":"312.985246ms","remote":"127.0.0.1:38852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-21T13:22:47.461048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:22:47.136431Z","time spent":"324.172921ms","remote":"127.0.0.1:38852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-21T13:22:48.723869Z","caller":"traceutil/trace.go:171","msg":"trace[71893221] transaction","detail":"{read_only:false; response_revision:427; number_of_response:1; }","duration":"537.912662ms","start":"2026-07-21T13:22:48.185934Z","end":"2026-07-21T13:22:48.723846Z","steps":["trace[71893221] 'process raft request' (duration: 537.763638ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:22:48.724015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:22:48.185907Z","time spent":"538.034315ms","remote":"127.0.0.1:38852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-21T13:23:00.215698Z","caller":"traceutil/trace.go:171","msg":"trace[854853845] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"670.281139ms","start":"2026-07-21T13:22:59.545392Z","end":"2026-07-21T13:23:00.215673Z","steps":["trace[854853845] 'process raft request' (duration: 660.82545ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:23:00.215867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:22:59.545367Z","time spent":"670.423493ms","remote":"127.0.0.1:38658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":31102,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-21T13:23:00.216587Z","caller":"traceutil/trace.go:171","msg":"trace[1256428759] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"670.962737ms","start":"2026-07-21T13:22:59.545609Z","end":"2026-07-21T13:23:00.216571Z","steps":["trace[1256428759] 'process raft request' (duration: 670.009153ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:23:00.216696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:22:59.545591Z","time spent":"671.051279ms","remote":"127.0.0.1:38658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29555,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-21T13:23:00.216964Z","caller":"traceutil/trace.go:171","msg":"trace[264427753] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"601.60614ms","start":"2026-07-21T13:22:59.615345Z","end":"2026-07-21T13:23:00.216951Z","steps":["trace[264427753] 'process raft request' (duration: 601.171078ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:23:00.217044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:22:59.615314Z","time spent":"601.698863ms","remote":"127.0.0.1:38658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-21T13:23:00.217228Z","caller":"traceutil/trace.go:171","msg":"trace[1619245924] linearizableReadLoop","detail":"{readStateIndex:547; appliedIndex:544; }","duration":"404.676641ms","start":"2026-07-21T13:22:59.812207Z","end":"2026-07-21T13:23:00.216883Z","steps":["trace[1619245924] 'read index received' (duration: 394.026621ms)","trace[1619245924] 'applied index is now lower than readState.Index' (duration: 10.64899ms)"],"step_count":2} {"level":"warn","ts":"2026-07-21T13:23:00.217406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.105182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-21T13:23:00.217463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.815959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-21T13:23:00.217486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.277028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-21T13:23:00.217528Z","caller":"traceutil/trace.go:171","msg":"trace[1648406316] 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:524; }","duration":"405.337449ms","start":"2026-07-21T13:22:59.812176Z","end":"2026-07-21T13:23:00.217513Z","steps":["trace[1648406316] 'agreement among raft nodes before linearized reading' (duration: 405.289378ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:23:00.217545Z","caller":"traceutil/trace.go:171","msg":"trace[39885502] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:524; }","duration":"362.862ms","start":"2026-07-21T13:22:59.854628Z","end":"2026-07-21T13:23:00.21749Z","steps":["trace[39885502] 'agreement among raft nodes before linearized reading' (duration: 362.811349ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:23:00.217571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:22:59.812157Z","time spent":"405.402791ms","remote":"127.0.0.1:41368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 "} {"level":"warn","ts":"2026-07-21T13:23:00.217684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.545799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-21T13:23:00.217745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.885337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-21T13:23:00.217788Z","caller":"traceutil/trace.go:171","msg":"trace[1773895968] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:524; }","duration":"363.933328ms","start":"2026-07-21T13:22:59.853838Z","end":"2026-07-21T13:23:00.217771Z","steps":["trace[1773895968] 'agreement among raft nodes before linearized reading' (duration: 363.883657ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:23:00.217843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:22:59.853835Z","time spent":"363.99886ms","remote":"127.0.0.1:41390","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"warn","ts":"2026-07-21T13:23:00.217812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.736404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-21T13:23:00.217899Z","caller":"traceutil/trace.go:171","msg":"trace[652816647] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:524; }","duration":"379.838006ms","start":"2026-07-21T13:22:59.838054Z","end":"2026-07-21T13:23:00.217892Z","steps":["trace[652816647] 'agreement among raft nodes before linearized reading' (duration: 379.710113ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:23:00.217961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:22:59.838049Z","time spent":"379.902909ms","remote":"127.0.0.1:41382","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true "} {"level":"warn","ts":"2026-07-21T13:23:00.217981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.403794ms","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":"info","ts":"2026-07-21T13:23:00.218011Z","caller":"traceutil/trace.go:171","msg":"trace[778661423] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:524; }","duration":"344.443955ms","start":"2026-07-21T13:22:59.873558Z","end":"2026-07-21T13:23:00.218002Z","steps":["trace[778661423] 'agreement among raft nodes before linearized reading' (duration: 344.396694ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:23:00.218021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.219815ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-21T13:23:00.218058Z","caller":"traceutil/trace.go:171","msg":"trace[1252819833] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:524; }","duration":"364.280007ms","start":"2026-07-21T13:22:59.853769Z","end":"2026-07-21T13:23:00.218049Z","steps":["trace[1252819833] 'agreement among raft nodes before linearized reading' (duration: 364.226916ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:23:00.218102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:22:59.853755Z","time spent":"364.337518ms","remote":"127.0.0.1:41390","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 "} {"level":"warn","ts":"2026-07-21T13:23:00.2181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.412061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-21T13:23:00.218101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.063855ms","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-07-21T13:23:00.218154Z","caller":"traceutil/trace.go:171","msg":"trace[1540310786] 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:524; }","duration":"405.517494ms","start":"2026-07-21T13:22:59.812621Z","end":"2026-07-21T13:23:00.218138Z","steps":["trace[1540310786] 'agreement among raft nodes before linearized reading' (duration: 405.406371ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:23:00.217687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:22:59.854624Z","time spent":"363.024755ms","remote":"127.0.0.1:41390","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 "} {"level":"warn","ts":"2026-07-21T13:23:00.218193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:22:59.812613Z","time spent":"405.571186ms","remote":"127.0.0.1:41368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 "} {"level":"warn","ts":"2026-07-21T13:23:00.218035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:22:59.873554Z","time spent":"344.473996ms","remote":"127.0.0.1:41400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-07-21T13:23:00.218063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.884071ms","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":"info","ts":"2026-07-21T13:23:00.218326Z","caller":"traceutil/trace.go:171","msg":"trace[1651212725] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:524; }","duration":"330.159389ms","start":"2026-07-21T13:22:59.888157Z","end":"2026-07-21T13:23:00.218316Z","steps":["trace[1651212725] 'agreement among raft nodes before linearized reading' (duration: 329.890981ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:23:00.218371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:22:59.88815Z","time spent":"330.20417ms","remote":"127.0.0.1:41412","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"info","ts":"2026-07-21T13:23:00.217732Z","caller":"traceutil/trace.go:171","msg":"trace[288229699] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:524; }","duration":"379.646192ms","start":"2026-07-21T13:22:59.838078Z","end":"2026-07-21T13:23:00.217724Z","steps":["trace[288229699] 'agreement among raft nodes before linearized reading' (duration: 379.55487ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:23:00.218428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:22:59.838064Z","time spent":"380.35247ms","remote":"127.0.0.1:41382","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 "} {"level":"warn","ts":"2026-07-21T13:23:00.217442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.860459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-21T13:23:00.217412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.463241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-21T13:23:00.218546Z","caller":"traceutil/trace.go:171","msg":"trace[314101036] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:524; }","duration":"379.625821ms","start":"2026-07-21T13:22:59.838912Z","end":"2026-07-21T13:23:00.218538Z","steps":["trace[314101036] 'agreement among raft nodes before linearized reading' (duration: 378.424049ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:23:00.218573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:22:59.838904Z","time spent":"379.659162ms","remote":"127.0.0.1:41382","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 "} {"level":"info","ts":"2026-07-21T13:23:00.218518Z","caller":"traceutil/trace.go:171","msg":"trace[1346577941] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:524; }","duration":"344.97657ms","start":"2026-07-21T13:22:59.873532Z","end":"2026-07-21T13:23:00.218509Z","steps":["trace[1346577941] 'agreement among raft nodes before linearized reading' (duration: 343.794428ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:23:00.218637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:22:59.873525Z","time spent":"345.102173ms","remote":"127.0.0.1:41400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"info","ts":"2026-07-21T13:23:00.217507Z","caller":"traceutil/trace.go:171","msg":"trace[1761004931] 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:524; }","duration":"405.234026ms","start":"2026-07-21T13:22:59.812245Z","end":"2026-07-21T13:23:00.217479Z","steps":["trace[1761004931] 'agreement among raft nodes before linearized reading' (duration: 405.080121ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:23:00.21819Z","caller":"traceutil/trace.go:171","msg":"trace[1159375366] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:524; }","duration":"330.160929ms","start":"2026-07-21T13:22:59.888016Z","end":"2026-07-21T13:23:00.218177Z","steps":["trace[1159375366] 'agreement among raft nodes before linearized reading' (duration: 330.069396ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:23:00.218842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:22:59.888005Z","time spent":"330.819407ms","remote":"127.0.0.1:41412","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-07-21T13:23:00.218856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:22:59.81224Z","time spent":"406.550641ms","remote":"127.0.0.1:41368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"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-07-21T13:23:00.219337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.464837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-21T13:23:00.219412Z","caller":"traceutil/trace.go:171","msg":"trace[245401176] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:524; }","duration":"330.58888ms","start":"2026-07-21T13:22:59.888812Z","end":"2026-07-21T13:23:00.219401Z","steps":["trace[245401176] 'agreement among raft nodes before linearized reading' (duration: 329.07905ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:23:00.219451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:22:59.888787Z","time spent":"330.654331ms","remote":"127.0.0.1:41400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 "} {"level":"info","ts":"2026-07-21T13:23:07.124349Z","caller":"traceutil/trace.go:171","msg":"trace[437465974] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"558.856934ms","start":"2026-07-21T13:23:06.565454Z","end":"2026-07-21T13:23:07.124311Z","steps":["trace[437465974] 'process raft request' (duration: 551.944352ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:23:07.125444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:23:06.565417Z","time spent":"559.945412ms","remote":"127.0.0.1:38688","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-21T13:23:07.186307Z","caller":"traceutil/trace.go:171","msg":"trace[643575237] linearizableReadLoop","detail":"{readStateIndex:621; appliedIndex:619; }","duration":"374.830236ms","start":"2026-07-21T13:23:06.811413Z","end":"2026-07-21T13:23:07.186243Z","steps":["trace[643575237] 'read index received' (duration: 305.529531ms)","trace[643575237] 'applied index is now lower than readState.Index' (duration: 69.299735ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T13:23:07.186363Z","caller":"traceutil/trace.go:171","msg":"trace[131936205] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"432.745192ms","start":"2026-07-21T13:23:06.7536Z","end":"2026-07-21T13:23:07.186345Z","steps":["trace[131936205] 'process raft request' (duration: 432.515825ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:23:07.18655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:23:06.753564Z","time spent":"432.919016ms","remote":"127.0.0.1:38852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-21T13:23:07.186602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.142294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-21T13:23:07.186653Z","caller":"traceutil/trace.go:171","msg":"trace[267277035] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:597; }","duration":"375.317918ms","start":"2026-07-21T13:23:06.811322Z","end":"2026-07-21T13:23:07.18664Z","steps":["trace[267277035] 'agreement among raft nodes before linearized reading' (duration: 375.109483ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:23:07.18669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:23:06.811288Z","time spent":"375.39447ms","remote":"127.0.0.1:38852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-21T13:23:07.488229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.113632ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-21T13:23:07.488377Z","caller":"traceutil/trace.go:171","msg":"trace[1698655556] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"298.065974ms","start":"2026-07-21T13:23:07.190288Z","end":"2026-07-21T13:23:07.488354Z","steps":["trace[1698655556] 'process raft request' (duration: 157.536021ms)","trace[1698655556] 'compare' (duration: 139.909676ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T13:23:07.493643Z","caller":"traceutil/trace.go:171","msg":"trace[1877447566] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"290.652058ms","start":"2026-07-21T13:23:07.202977Z","end":"2026-07-21T13:23:07.493629Z","steps":["trace[1877447566] 'process raft request' (duration: 290.570986ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:23:07.493785Z","caller":"traceutil/trace.go:171","msg":"trace[47859192] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"299.980835ms","start":"2026-07-21T13:23:07.193758Z","end":"2026-07-21T13:23:07.493738Z","steps":["trace[47859192] 'process raft request' (duration: 299.709487ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:23:07.49395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:23:07.193467Z","time spent":"300.402135ms","remote":"127.0.0.1:38832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-21T13:23:08.080767Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":969012262737310478,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-21T13:23:08.581788Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":969012262737310478,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-21T13:23:08.65832Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.148703234s","expected-duration":"1s"} {"level":"info","ts":"2026-07-21T13:23:08.717874Z","caller":"traceutil/trace.go:171","msg":"trace[859713746] linearizableReadLoop","detail":"{readStateIndex:625; appliedIndex:624; }","duration":"1.138179556s","start":"2026-07-21T13:23:07.579658Z","end":"2026-07-21T13:23:08.717837Z","steps":["trace[859713746] 'read index received' (duration: 1.078930386s)","trace[859713746] 'applied index is now lower than readState.Index' (duration: 59.24716ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T13:23:08.718018Z","caller":"traceutil/trace.go:171","msg":"trace[1040040697] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"1.208504881s","start":"2026-07-21T13:23:07.509478Z","end":"2026-07-21T13:23:08.717983Z","steps":["trace[1040040697] 'process raft request' (duration: 1.149193008s)","trace[1040040697] 'compare' (duration: 58.615435ms)"],"step_count":2} {"level":"warn","ts":"2026-07-21T13:23:08.718284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.138589277s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-21T13:23:08.718347Z","caller":"traceutil/trace.go:171","msg":"trace[534715074] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:601; }","duration":"1.138715391s","start":"2026-07-21T13:23:07.579618Z","end":"2026-07-21T13:23:08.718333Z","steps":["trace[534715074] 'agreement among raft nodes before linearized reading' (duration: 1.138414453s)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:23:08.71839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:23:07.579599Z","time spent":"1.138782214s","remote":"127.0.0.1:38852","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-07-21T13:23:08.718602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"572.713129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-21T13:23:08.718728Z","caller":"traceutil/trace.go:171","msg":"trace[1861075900] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:601; }","duration":"572.887605ms","start":"2026-07-21T13:23:08.145805Z","end":"2026-07-21T13:23:08.718693Z","steps":["trace[1861075900] 'agreement among raft nodes before linearized reading' (duration: 572.633127ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:23:08.718795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:23:08.145789Z","time spent":"572.992027ms","remote":"127.0.0.1:38598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-21T13:23:08.718979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.113024865s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-21T13:23:08.719086Z","caller":"traceutil/trace.go:171","msg":"trace[1601960759] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:601; }","duration":"1.113171289s","start":"2026-07-21T13:23:07.605883Z","end":"2026-07-21T13:23:08.719054Z","steps":["trace[1601960759] 'agreement among raft nodes before linearized reading' (duration: 1.112866911s)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:23:08.719162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:23:07.605867Z","time spent":"1.113280881s","remote":"127.0.0.1:38852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-21T13:23:08.719432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.13943009s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-21T13:23:08.719561Z","caller":"traceutil/trace.go:171","msg":"trace[1776732398] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:601; }","duration":"1.139621916s","start":"2026-07-21T13:23:07.57992Z","end":"2026-07-21T13:23:08.719542Z","steps":["trace[1776732398] 'agreement among raft nodes before linearized reading' (duration: 1.138380433s)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:23:08.719727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:23:07.579887Z","time spent":"1.139818361s","remote":"127.0.0.1:38852","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-07-21T13:23:08.719817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:23:07.509455Z","time spent":"1.208628704s","remote":"127.0.0.1:38768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-21T13:23:09.5625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"518.517772ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-21T13:23:09.562698Z","caller":"traceutil/trace.go:171","msg":"trace[1218317172] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:601; }","duration":"518.757258ms","start":"2026-07-21T13:23:09.043911Z","end":"2026-07-21T13:23:09.562668Z","steps":["trace[1218317172] 'range keys from in-memory index tree' (duration: 518.48591ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:23:09.563746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.298397ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-21T13:23:09.564007Z","caller":"traceutil/trace.go:171","msg":"trace[1352317609] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"840.082563ms","start":"2026-07-21T13:23:08.723892Z","end":"2026-07-21T13:23:09.563975Z","steps":["trace[1352317609] 'process raft request' (duration: 650.441077ms)","trace[1352317609] 'compare' (duration: 188.994849ms)"],"step_count":2} {"level":"warn","ts":"2026-07-21T13:23:09.564366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:23:08.723863Z","time spent":"840.33419ms","remote":"127.0.0.1:38852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-21T13:23:09.564667Z","caller":"traceutil/trace.go:171","msg":"trace[1553186986] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"839.19919ms","start":"2026-07-21T13:23:08.725455Z","end":"2026-07-21T13:23:09.564654Z","steps":["trace[1553186986] 'process raft request' (duration: 838.490612ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:23:09.564762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:23:08.725438Z","time spent":"839.273362ms","remote":"127.0.0.1:38852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-21T13:23:09.564887Z","caller":"traceutil/trace.go:171","msg":"trace[108069782] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"837.919857ms","start":"2026-07-21T13:23:08.726947Z","end":"2026-07-21T13:23:09.564867Z","steps":["trace[108069782] 'process raft request' (duration: 837.224118ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:23:09.564962Z","caller":"traceutil/trace.go:171","msg":"trace[1336054147] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"837.68397ms","start":"2026-07-21T13:23:08.727266Z","end":"2026-07-21T13:23:09.56495Z","steps":["trace[1336054147] 'process raft request' (duration: 836.962931ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:23:09.565031Z","caller":"traceutil/trace.go:171","msg":"trace[1954167033] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"839.224679ms","start":"2026-07-21T13:23:08.725796Z","end":"2026-07-21T13:23:09.565021Z","steps":["trace[1954167033] 'process raft request' (duration: 838.220093ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:23:09.565112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:23:08.725788Z","time spent":"839.284632ms","remote":"127.0.0.1:38768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3209,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-21T13:23:09.564367Z","caller":"traceutil/trace.go:171","msg":"trace[156487063] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"836.666354ms","start":"2026-07-21T13:23:08.727681Z","end":"2026-07-21T13:23:09.564347Z","steps":["trace[156487063] 'process raft request' (duration: 836.600622ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:23:09.56497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:23:08.726923Z","time spent":"838.015158ms","remote":"127.0.0.1:38852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-21T13:23:09.565316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:23:08.727672Z","time spent":"837.537227ms","remote":"127.0.0.1:38832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-21T13:23:09.565028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:23:08.727253Z","time spent":"837.743961ms","remote":"127.0.0.1:38680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":775,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-21T13:23:09.565736Z","caller":"traceutil/trace.go:171","msg":"trace[534025883] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"840.984197ms","start":"2026-07-21T13:23:08.724731Z","end":"2026-07-21T13:23:09.565715Z","steps":["trace[534025883] 'process raft request' (duration: 839.119288ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:23:09.566048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:23:08.724715Z","time spent":"841.289865ms","remote":"127.0.0.1:38680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":905,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-21T13:23:11.549198Z","caller":"traceutil/trace.go:171","msg":"trace[829062792] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"247.248455ms","start":"2026-07-21T13:23:11.301909Z","end":"2026-07-21T13:23:11.549157Z","steps":["trace[829062792] 'process raft request' (duration: 246.933726ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:23:26.804866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.499505ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-21T13:23:26.804988Z","caller":"traceutil/trace.go:171","msg":"trace[407839362] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:762; }","duration":"265.67518ms","start":"2026-07-21T13:23:26.539294Z","end":"2026-07-21T13:23:26.804969Z","steps":["trace[407839362] 'count revisions from in-memory index tree' (duration: 265.422943ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:23:26.805083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.14511166s","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-07-21T13:23:26.80509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.088101678s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-21T13:23:26.80641Z","caller":"traceutil/trace.go:171","msg":"trace[1748932751] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:762; }","duration":"1.089473255s","start":"2026-07-21T13:23:25.716914Z","end":"2026-07-21T13:23:26.806387Z","steps":["trace[1748932751] 'count revisions from in-memory index tree' (duration: 1.087992095s)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:23:26.805221Z","caller":"traceutil/trace.go:171","msg":"trace[1990224049] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:762; }","duration":"1.145322806s","start":"2026-07-21T13:23:25.65987Z","end":"2026-07-21T13:23:26.805193Z","steps":["trace[1990224049] 'range keys from in-memory index tree' (duration: 1.144842302s)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:23:26.806482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:23:25.716899Z","time spent":"1.089561316s","remote":"127.0.0.1:38982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":29,"request content":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true "} {"level":"warn","ts":"2026-07-21T13:23:26.805121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.124313442s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-21T13:23:26.806613Z","caller":"traceutil/trace.go:171","msg":"trace[1922816023] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:762; }","duration":"1.125835772s","start":"2026-07-21T13:23:25.680757Z","end":"2026-07-21T13:23:26.806593Z","steps":["trace[1922816023] 'range keys from in-memory index tree' (duration: 1.124094977s)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:23:26.806671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:23:25.680738Z","time spent":"1.125916494s","remote":"127.0.0.1:38852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-21T13:23:26.805236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"657.581225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-21T13:23:26.806696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:23:25.659852Z","time spent":"1.146718062s","remote":"127.0.0.1:38852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-21T13:23:26.806931Z","caller":"traceutil/trace.go:171","msg":"trace[1362410715] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:762; }","duration":"659.134265ms","start":"2026-07-21T13:23:26.147606Z","end":"2026-07-21T13:23:26.80674Z","steps":["trace[1362410715] 'range keys from in-memory index tree' (duration: 657.501282ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:23:26.807029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:23:26.147586Z","time spent":"659.429483ms","remote":"127.0.0.1:38598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-21T13:23:26.805595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.146853955s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-21T13:23:26.807147Z","caller":"traceutil/trace.go:171","msg":"trace[400542762] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:762; }","duration":"1.148423078s","start":"2026-07-21T13:23:25.658696Z","end":"2026-07-21T13:23:26.807119Z","steps":["trace[400542762] 'range keys from in-memory index tree' (duration: 1.146726653s)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:23:26.807225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:23:25.658679Z","time spent":"1.14852569s","remote":"127.0.0.1:38852","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-07-21T13:23:26.805639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.35162266s","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-07-21T13:23:26.807411Z","caller":"traceutil/trace.go:171","msg":"trace[758637198] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:762; }","duration":"1.353405847s","start":"2026-07-21T13:23:25.453942Z","end":"2026-07-21T13:23:26.807348Z","steps":["trace[758637198] 'count revisions from in-memory index tree' (duration: 1.351503967s)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:23:26.805741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.145727086s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-07-21T13:23:26.807544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:23:25.453918Z","time spent":"1.353603593s","remote":"127.0.0.1:39030","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":31,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"info","ts":"2026-07-21T13:23:26.80766Z","caller":"traceutil/trace.go:171","msg":"trace[2117098761] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:762; }","duration":"1.147651347s","start":"2026-07-21T13:23:25.659988Z","end":"2026-07-21T13:23:26.807639Z","steps":["trace[2117098761] 'range keys from in-memory index tree' (duration: 1.145588523s)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:23:26.807722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:23:25.659981Z","time spent":"1.147724968s","remote":"127.0.0.1:38852","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-07-21T13:23:26.80576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"974.615508ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-21T13:23:26.807837Z","caller":"traceutil/trace.go:171","msg":"trace[202580436] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:762; }","duration":"976.716863ms","start":"2026-07-21T13:23:25.831104Z","end":"2026-07-21T13:23:26.807821Z","steps":["trace[202580436] 'count revisions from in-memory index tree' (duration: 974.522276ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:23:26.807885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:23:25.831086Z","time spent":"976.783114ms","remote":"127.0.0.1:38832","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":1,"response size":31,"request content":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true "} {"level":"warn","ts":"2026-07-21T13:23:26.80543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.54100646s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-cw2v9\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-07-21T13:23:26.808137Z","caller":"traceutil/trace.go:171","msg":"trace[975271683] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-cw2v9; range_end:; response_count:1; response_revision:762; }","duration":"1.543958048s","start":"2026-07-21T13:23:25.264163Z","end":"2026-07-21T13:23:26.808121Z","steps":["trace[975271683] 'range keys from in-memory index tree' (duration: 1.540801225s)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:23:26.808343Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:23:25.26413Z","time spent":"1.544194644s","remote":"127.0.0.1:38768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3989,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-cw2v9\" "} {"level":"info","ts":"2026-07-21T13:23:30.687201Z","caller":"traceutil/trace.go:171","msg":"trace[1504553122] transaction","detail":"{read_only:false; response_revision:796; number_of_response:1; }","duration":"104.35879ms","start":"2026-07-21T13:23:30.582819Z","end":"2026-07-21T13:23:30.687178Z","steps":["trace[1504553122] 'process raft request' (duration: 102.82376ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:23:49.888957Z","caller":"traceutil/trace.go:171","msg":"trace[991575355] transaction","detail":"{read_only:false; response_revision:936; number_of_response:1; }","duration":"153.730274ms","start":"2026-07-21T13:23:49.73521Z","end":"2026-07-21T13:23:49.88894Z","steps":["trace[991575355] 'process raft request' (duration: 153.585811ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:24:03.507349Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":969012262737311315,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-21T13:24:04.007771Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":969012262737311315,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-21T13:24:04.508941Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":969012262737311315,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-21T13:24:04.616171Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.613635808s","expected-duration":"1s"} {"level":"info","ts":"2026-07-21T13:24:04.616545Z","caller":"traceutil/trace.go:171","msg":"trace[939916999] transaction","detail":"{read_only:false; response_revision:980; number_of_response:1; }","duration":"1.614108691s","start":"2026-07-21T13:24:03.002416Z","end":"2026-07-21T13:24:04.616525Z","steps":["trace[939916999] 'process raft request' (duration: 1.613948787s)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:24:04.61673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:24:03.002395Z","time spent":"1.614218794s","remote":"127.0.0.1:38852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-21T13:24:04.617049Z","caller":"traceutil/trace.go:171","msg":"trace[744342577] linearizableReadLoop","detail":"{readStateIndex:1020; appliedIndex:1018; }","duration":"1.610124405s","start":"2026-07-21T13:24:03.006905Z","end":"2026-07-21T13:24:04.617029Z","steps":["trace[744342577] 'read index received' (duration: 1.609486878s)","trace[744342577] 'applied index is now lower than readState.Index' (duration: 636.547µs)"],"step_count":2} {"level":"info","ts":"2026-07-21T13:24:04.617151Z","caller":"traceutil/trace.go:171","msg":"trace[1647373231] transaction","detail":"{read_only:false; response_revision:981; number_of_response:1; }","duration":"637.042708ms","start":"2026-07-21T13:24:03.980079Z","end":"2026-07-21T13:24:04.617122Z","steps":["trace[1647373231] 'process raft request' (duration: 636.828812ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:24:04.617251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.61032978s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-21T13:24:04.617291Z","caller":"traceutil/trace.go:171","msg":"trace[1812543206] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:981; }","duration":"1.610417292s","start":"2026-07-21T13:24:03.006864Z","end":"2026-07-21T13:24:04.617282Z","steps":["trace[1812543206] 'agreement among raft nodes before linearized reading' (duration: 1.610253658s)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:24:04.617325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:24:03.006847Z","time spent":"1.610469334s","remote":"127.0.0.1:38852","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-07-21T13:24:04.617323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:24:03.980061Z","time spent":"637.177631ms","remote":"127.0.0.1:38852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-21T13:24:04.617498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.60697377s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-21T13:24:04.617525Z","caller":"traceutil/trace.go:171","msg":"trace[1733878066] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:981; }","duration":"1.607022972s","start":"2026-07-21T13:24:03.010496Z","end":"2026-07-21T13:24:04.617519Z","steps":["trace[1733878066] 'agreement among raft nodes before linearized reading' (duration: 1.60695325s)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:24:04.617543Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:24:03.010486Z","time spent":"1.607053603s","remote":"127.0.0.1:38852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-21T13:24:04.617638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.947438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.209\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-07-21T13:24:04.617691Z","caller":"traceutil/trace.go:171","msg":"trace[530731494] range","detail":"{range_begin:/registry/masterleases/199.19.213.209; range_end:; response_count:1; response_revision:981; }","duration":"385.01196ms","start":"2026-07-21T13:24:04.232642Z","end":"2026-07-21T13:24:04.617654Z","steps":["trace[530731494] 'agreement among raft nodes before linearized reading' (duration: 384.955649ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:24:04.617714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:24:04.232621Z","time spent":"385.088573ms","remote":"127.0.0.1:38642","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":159,"request content":"key:\"/registry/masterleases/199.19.213.209\" "} {"level":"warn","ts":"2026-07-21T13:24:04.617847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.381433939s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-07-21T13:24:04.617906Z","caller":"traceutil/trace.go:171","msg":"trace[2124990822] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:981; }","duration":"1.38149045s","start":"2026-07-21T13:24:03.236399Z","end":"2026-07-21T13:24:04.617889Z","steps":["trace[2124990822] 'agreement among raft nodes before linearized reading' (duration: 1.381350377s)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:24:04.617937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.450438092s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-07-21T13:24:04.617958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:24:03.236362Z","time spent":"1.381583613s","remote":"127.0.0.1:38852","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-07-21T13:24:04.618028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.585162482s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-07-21T13:24:04.618057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.135772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-21T13:24:04.618084Z","caller":"traceutil/trace.go:171","msg":"trace[2056170108] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:981; }","duration":"467.199924ms","start":"2026-07-21T13:24:04.150875Z","end":"2026-07-21T13:24:04.618075Z","steps":["trace[2056170108] 'agreement among raft nodes before linearized reading' (duration: 467.160883ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:24:04.61811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:24:04.150856Z","time spent":"467.249526ms","remote":"127.0.0.1:38598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-21T13:24:04.618058Z","caller":"traceutil/trace.go:171","msg":"trace[525137071] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:981; }","duration":"1.585219283s","start":"2026-07-21T13:24:03.032832Z","end":"2026-07-21T13:24:04.618051Z","steps":["trace[525137071] 'agreement among raft nodes before linearized reading' (duration: 1.585154332s)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:24:04.618224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:24:03.032817Z","time spent":"1.585396097s","remote":"127.0.0.1:38852","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":"info","ts":"2026-07-21T13:24:04.617972Z","caller":"traceutil/trace.go:171","msg":"trace[1648950013] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:981; }","duration":"1.450508723s","start":"2026-07-21T13:24:03.167457Z","end":"2026-07-21T13:24:04.617965Z","steps":["trace[1648950013] 'agreement among raft nodes before linearized reading' (duration: 1.450439931s)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:24:04.61831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:24:03.16744Z","time spent":"1.450858733s","remote":"127.0.0.1:38910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":16,"response size":31,"request content":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true "} {"level":"info","ts":"2026-07-21T13:24:26.930065Z","caller":"traceutil/trace.go:171","msg":"trace[273535449] linearizableReadLoop","detail":"{readStateIndex:1098; appliedIndex:1097; }","duration":"112.472329ms","start":"2026-07-21T13:24:26.81757Z","end":"2026-07-21T13:24:26.930042Z","steps":["trace[273535449] 'read index received' (duration: 112.262674ms)","trace[273535449] 'applied index is now lower than readState.Index' (duration: 208.905µs)"],"step_count":2} {"level":"info","ts":"2026-07-21T13:24:26.93028Z","caller":"traceutil/trace.go:171","msg":"trace[1651528705] transaction","detail":"{read_only:false; response_revision:1054; number_of_response:1; }","duration":"133.768655ms","start":"2026-07-21T13:24:26.7964Z","end":"2026-07-21T13:24:26.930168Z","steps":["trace[1651528705] 'process raft request' (duration: 133.505878ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:24:26.930305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.720615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-21T13:24:26.930499Z","caller":"traceutil/trace.go:171","msg":"trace[301537680] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1054; }","duration":"112.978063ms","start":"2026-07-21T13:24:26.817512Z","end":"2026-07-21T13:24:26.93049Z","steps":["trace[301537680] 'agreement among raft nodes before linearized reading' (duration: 112.650253ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:24:26.930658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.735212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-21T13:24:26.930731Z","caller":"traceutil/trace.go:171","msg":"trace[1850743397] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1054; }","duration":"110.853255ms","start":"2026-07-21T13:24:26.819858Z","end":"2026-07-21T13:24:26.930711Z","steps":["trace[1850743397] 'agreement among raft nodes before linearized reading' (duration: 110.370762ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:24:27.048658Z","caller":"traceutil/trace.go:171","msg":"trace[425539281] transaction","detail":"{read_only:false; response_revision:1059; number_of_response:1; }","duration":"111.439191ms","start":"2026-07-21T13:24:26.937144Z","end":"2026-07-21T13:24:27.048583Z","steps":["trace[425539281] 'process raft request' (duration: 111.39176ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:24:27.04922Z","caller":"traceutil/trace.go:171","msg":"trace[684021888] transaction","detail":"{read_only:false; response_revision:1056; number_of_response:1; }","duration":"112.208512ms","start":"2026-07-21T13:24:26.936995Z","end":"2026-07-21T13:24:27.049204Z","steps":["trace[684021888] 'process raft request' (duration: 111.296798ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:24:27.049389Z","caller":"traceutil/trace.go:171","msg":"trace[1351626402] transaction","detail":"{read_only:false; response_revision:1057; number_of_response:1; }","duration":"112.339455ms","start":"2026-07-21T13:24:26.937038Z","end":"2026-07-21T13:24:27.049377Z","steps":["trace[1351626402] 'process raft request' (duration: 111.38583ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:24:27.049528Z","caller":"traceutil/trace.go:171","msg":"trace[106477283] transaction","detail":"{read_only:false; response_revision:1058; number_of_response:1; }","duration":"112.435138ms","start":"2026-07-21T13:24:26.93708Z","end":"2026-07-21T13:24:27.049515Z","steps":["trace[106477283] 'process raft request' (duration: 111.413221ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:24:28.862581Z","caller":"traceutil/trace.go:171","msg":"trace[1598330347] transaction","detail":"{read_only:false; response_revision:1060; number_of_response:1; }","duration":"100.027638ms","start":"2026-07-21T13:24:28.762535Z","end":"2026-07-21T13:24:28.862563Z","steps":["trace[1598330347] 'process raft request' (duration: 99.926875ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:24:29.251055Z","caller":"traceutil/trace.go:171","msg":"trace[1665071963] linearizableReadLoop","detail":"{readStateIndex:1105; appliedIndex:1104; }","duration":"225.515762ms","start":"2026-07-21T13:24:29.025501Z","end":"2026-07-21T13:24:29.251017Z","steps":["trace[1665071963] 'read index received' (duration: 225.272876ms)","trace[1665071963] 'applied index is now lower than readState.Index' (duration: 241.096µs)"],"step_count":2} {"level":"info","ts":"2026-07-21T13:24:29.251183Z","caller":"traceutil/trace.go:171","msg":"trace[83000223] transaction","detail":"{read_only:false; response_revision:1061; number_of_response:1; }","duration":"314.021004ms","start":"2026-07-21T13:24:28.937107Z","end":"2026-07-21T13:24:29.251128Z","steps":["trace[83000223] 'process raft request' (duration: 313.660535ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:24:29.251488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:24:28.937083Z","time spent":"314.23433ms","remote":"127.0.0.1:38852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-21T13:24:29.251658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.535354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-21T13:24:29.251474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.811557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-07-21T13:24:29.251719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.261958ms","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-07-21T13:24:29.251732Z","caller":"traceutil/trace.go:171","msg":"trace[203402315] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1061; }","duration":"105.643388ms","start":"2026-07-21T13:24:29.146067Z","end":"2026-07-21T13:24:29.25171Z","steps":["trace[203402315] 'agreement among raft nodes before linearized reading' (duration: 105.482674ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:24:29.251726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.224537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-21T13:24:29.251777Z","caller":"traceutil/trace.go:171","msg":"trace[976084299] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1061; }","duration":"195.373301ms","start":"2026-07-21T13:24:29.05639Z","end":"2026-07-21T13:24:29.251763Z","steps":["trace[976084299] 'agreement among raft nodes before linearized reading' (duration: 194.856947ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:24:29.251776Z","caller":"traceutil/trace.go:171","msg":"trace[1797407192] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1061; }","duration":"195.136625ms","start":"2026-07-21T13:24:29.05659Z","end":"2026-07-21T13:24:29.251727Z","steps":["trace[1797407192] 'agreement among raft nodes before linearized reading' (duration: 194.666122ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:24:29.251795Z","caller":"traceutil/trace.go:171","msg":"trace[932324666] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1061; }","duration":"195.390891ms","start":"2026-07-21T13:24:29.056387Z","end":"2026-07-21T13:24:29.251778Z","steps":["trace[932324666] 'agreement among raft nodes before linearized reading' (duration: 195.071813ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:24:29.252092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.442114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-21T13:24:29.252249Z","caller":"traceutil/trace.go:171","msg":"trace[733757301] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1061; }","duration":"195.557567ms","start":"2026-07-21T13:24:29.056568Z","end":"2026-07-21T13:24:29.252125Z","steps":["trace[733757301] 'agreement among raft nodes before linearized reading' (duration: 194.817017ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:24:29.252308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.809966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-21T13:24:29.252892Z","caller":"traceutil/trace.go:171","msg":"trace[448724173] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1061; }","duration":"227.434593ms","start":"2026-07-21T13:24:29.025442Z","end":"2026-07-21T13:24:29.252876Z","steps":["trace[448724173] 'agreement among raft nodes before linearized reading' (duration: 225.753088ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:24:45.215158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:24:44.236141Z","time spent":"979.014157ms","remote":"127.0.0.1:38642","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-07-21T13:24:45.659506Z","caller":"traceutil/trace.go:171","msg":"trace[1640960436] linearizableReadLoop","detail":"{readStateIndex:1214; appliedIndex:1213; }","duration":"308.277024ms","start":"2026-07-21T13:24:45.351213Z","end":"2026-07-21T13:24:45.65949Z","steps":["trace[1640960436] 'read index received' (duration: 305.522131ms)","trace[1640960436] 'applied index is now lower than readState.Index' (duration: 2.754093ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T13:24:45.659584Z","caller":"traceutil/trace.go:171","msg":"trace[1329106706] transaction","detail":"{read_only:false; response_revision:1164; number_of_response:1; }","duration":"352.661294ms","start":"2026-07-21T13:24:45.306914Z","end":"2026-07-21T13:24:45.659575Z","steps":["trace[1329106706] 'process raft request' (duration: 349.784668ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:24:45.659653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:24:45.30689Z","time spent":"352.707645ms","remote":"127.0.0.1:38852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-21T13:24:45.659763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.556831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-21T13:24:45.659806Z","caller":"traceutil/trace.go:171","msg":"trace[308801296] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1164; }","duration":"308.626532ms","start":"2026-07-21T13:24:45.351176Z","end":"2026-07-21T13:24:45.659802Z","steps":["trace[308801296] 'agreement among raft nodes before linearized reading' (duration: 308.533539ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:24:45.65982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:24:45.351162Z","time spent":"308.655823ms","remote":"127.0.0.1:38852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-21T13:24:45.659897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.784696ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-21T13:24:45.659909Z","caller":"traceutil/trace.go:171","msg":"trace[1156928900] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1164; }","duration":"272.834807ms","start":"2026-07-21T13:24:45.38707Z","end":"2026-07-21T13:24:45.659905Z","steps":["trace[1156928900] 'agreement among raft nodes before linearized reading' (duration: 272.798386ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:24:45.660025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.266117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-21T13:24:45.660037Z","caller":"traceutil/trace.go:171","msg":"trace[1228703408] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1164; }","duration":"268.321648ms","start":"2026-07-21T13:24:45.391712Z","end":"2026-07-21T13:24:45.660033Z","steps":["trace[1228703408] 'agreement among raft nodes before linearized reading' (duration: 268.282887ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:24:45.660082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.800404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-21T13:24:45.660151Z","caller":"traceutil/trace.go:171","msg":"trace[1209113602] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1164; }","duration":"267.898818ms","start":"2026-07-21T13:24:45.392231Z","end":"2026-07-21T13:24:45.66013Z","steps":["trace[1209113602] 'agreement among raft nodes before linearized reading' (duration: 267.732993ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:24:45.660202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.874168ms","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-07-21T13:24:45.660218Z","caller":"traceutil/trace.go:171","msg":"trace[1040698671] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1164; }","duration":"267.923568ms","start":"2026-07-21T13:24:45.39229Z","end":"2026-07-21T13:24:45.660214Z","steps":["trace[1040698671] 'agreement among raft nodes before linearized reading' (duration: 267.883127ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:24:53.944628Z","caller":"traceutil/trace.go:171","msg":"trace[191652079] transaction","detail":"{read_only:false; response_revision:1191; number_of_response:1; }","duration":"199.684068ms","start":"2026-07-21T13:24:53.744908Z","end":"2026-07-21T13:24:53.944592Z","steps":["trace[191652079] 'process raft request' (duration: 162.511917ms)","trace[191652079] 'compare' (duration: 37.022967ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T13:24:53.945441Z","caller":"traceutil/trace.go:171","msg":"trace[1080035914] transaction","detail":"{read_only:false; response_revision:1193; number_of_response:1; }","duration":"198.968148ms","start":"2026-07-21T13:24:53.746454Z","end":"2026-07-21T13:24:53.945422Z","steps":["trace[1080035914] 'process raft request' (duration: 198.774124ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:24:53.945429Z","caller":"traceutil/trace.go:171","msg":"trace[1882035574] transaction","detail":"{read_only:false; response_revision:1195; number_of_response:1; }","duration":"197.83792ms","start":"2026-07-21T13:24:53.747561Z","end":"2026-07-21T13:24:53.945399Z","steps":["trace[1882035574] 'process raft request' (duration: 197.786519ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:24:53.945534Z","caller":"traceutil/trace.go:171","msg":"trace[1223365855] transaction","detail":"{read_only:false; response_revision:1192; number_of_response:1; }","duration":"199.099012ms","start":"2026-07-21T13:24:53.746411Z","end":"2026-07-21T13:24:53.94551Z","steps":["trace[1223365855] 'process raft request' (duration: 198.654251ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:24:53.945514Z","caller":"traceutil/trace.go:171","msg":"trace[1643680825] transaction","detail":"{read_only:false; response_revision:1194; number_of_response:1; }","duration":"198.899207ms","start":"2026-07-21T13:24:53.746584Z","end":"2026-07-21T13:24:53.945483Z","steps":["trace[1643680825] 'process raft request' (duration: 198.721803ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:24:58.067046Z","caller":"traceutil/trace.go:171","msg":"trace[1422979370] transaction","detail":"{read_only:false; response_revision:1206; number_of_response:1; }","duration":"101.671552ms","start":"2026-07-21T13:24:57.965347Z","end":"2026-07-21T13:24:58.067018Z","steps":["trace[1422979370] 'process raft request' (duration: 101.455757ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:24:58.067296Z","caller":"traceutil/trace.go:171","msg":"trace[1560060891] transaction","detail":"{read_only:false; response_revision:1207; number_of_response:1; }","duration":"101.771786ms","start":"2026-07-21T13:24:57.965509Z","end":"2026-07-21T13:24:58.06728Z","steps":["trace[1560060891] 'process raft request' (duration: 101.422276ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:24:58.067424Z","caller":"traceutil/trace.go:171","msg":"trace[869314830] transaction","detail":"{read_only:false; response_revision:1208; number_of_response:1; }","duration":"101.881778ms","start":"2026-07-21T13:24:57.965532Z","end":"2026-07-21T13:24:58.067414Z","steps":["trace[869314830] 'process raft request' (duration: 101.436966ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:25:02.584034Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":969012262737311905,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-21T13:25:02.744248Z","caller":"traceutil/trace.go:171","msg":"trace[886536880] transaction","detail":"{read_only:false; response_revision:1238; number_of_response:1; }","duration":"674.522825ms","start":"2026-07-21T13:25:02.069697Z","end":"2026-07-21T13:25:02.74422Z","steps":["trace[886536880] 'process raft request' (duration: 674.374671ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:25:02.744414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:25:02.069643Z","time spent":"674.687039ms","remote":"127.0.0.1:38852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-21T13:25:02.745052Z","caller":"traceutil/trace.go:171","msg":"trace[1121609318] linearizableReadLoop","detail":"{readStateIndex:1291; appliedIndex:1291; }","duration":"662.109336ms","start":"2026-07-21T13:25:02.082927Z","end":"2026-07-21T13:25:02.745036Z","steps":["trace[1121609318] 'read index received' (duration: 662.103546ms)","trace[1121609318] 'applied index is now lower than readState.Index' (duration: 4.7µs)"],"step_count":2} {"level":"warn","ts":"2026-07-21T13:25:02.74527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"662.304863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-07-21T13:25:02.745318Z","caller":"traceutil/trace.go:171","msg":"trace[288170351] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1238; }","duration":"662.389175ms","start":"2026-07-21T13:25:02.082915Z","end":"2026-07-21T13:25:02.745304Z","steps":["trace[288170351] 'agreement among raft nodes before linearized reading' (duration: 662.21912ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:25:02.745371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:25:02.082897Z","time spent":"662.462727ms","remote":"127.0.0.1:38852","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-07-21T13:25:02.745497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"662.550849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-07-21T13:25:02.745558Z","caller":"traceutil/trace.go:171","msg":"trace[548447513] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1238; }","duration":"662.660963ms","start":"2026-07-21T13:25:02.082882Z","end":"2026-07-21T13:25:02.745543Z","steps":["trace[548447513] 'agreement among raft nodes before linearized reading' (duration: 662.466148ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:25:02.745582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:25:02.082861Z","time spent":"662.715804ms","remote":"127.0.0.1:38852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-21T13:25:02.745576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"540.362055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-21T13:25:02.745623Z","caller":"traceutil/trace.go:171","msg":"trace[2139897381] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1238; }","duration":"540.438367ms","start":"2026-07-21T13:25:02.205171Z","end":"2026-07-21T13:25:02.74561Z","steps":["trace[2139897381] 'agreement among raft nodes before linearized reading' (duration: 540.357295ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:25:02.74572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:25:02.205155Z","time spent":"540.547131ms","remote":"127.0.0.1:39026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":31,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"warn","ts":"2026-07-21T13:25:02.745861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"662.869807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-21T13:25:02.745887Z","caller":"traceutil/trace.go:171","msg":"trace[1202647697] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1238; }","duration":"662.908487ms","start":"2026-07-21T13:25:02.082972Z","end":"2026-07-21T13:25:02.745881Z","steps":["trace[1202647697] 'agreement among raft nodes before linearized reading' (duration: 662.840235ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:25:02.745906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:25:02.082966Z","time spent":"662.93524ms","remote":"127.0.0.1:38852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-21T13:25:02.745996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"599.225118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-21T13:25:02.746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"663.037322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-07-21T13:25:02.746044Z","caller":"traceutil/trace.go:171","msg":"trace[1565474033] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1238; }","duration":"663.110784ms","start":"2026-07-21T13:25:02.082921Z","end":"2026-07-21T13:25:02.746031Z","steps":["trace[1565474033] 'agreement among raft nodes before linearized reading' (duration: 662.988831ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:25:02.746082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:25:02.082904Z","time spent":"663.168235ms","remote":"127.0.0.1:38852","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-07-21T13:25:02.746018Z","caller":"traceutil/trace.go:171","msg":"trace[60298100] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1238; }","duration":"599.285549ms","start":"2026-07-21T13:25:02.146726Z","end":"2026-07-21T13:25:02.746012Z","steps":["trace[60298100] 'agreement among raft nodes before linearized reading' (duration: 599.249389ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:25:02.746213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:25:02.146678Z","time spent":"599.518866ms","remote":"127.0.0.1:38598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-21T13:25:04.488028Z","caller":"traceutil/trace.go:171","msg":"trace[1754289862] linearizableReadLoop","detail":"{readStateIndex:1297; appliedIndex:1296; }","duration":"342.741192ms","start":"2026-07-21T13:25:04.145267Z","end":"2026-07-21T13:25:04.488008Z","steps":["trace[1754289862] 'read index received' (duration: 342.382752ms)","trace[1754289862] 'applied index is now lower than readState.Index' (duration: 357.46µs)"],"step_count":2} {"level":"info","ts":"2026-07-21T13:25:04.488412Z","caller":"traceutil/trace.go:171","msg":"trace[1192530417] transaction","detail":"{read_only:false; response_revision:1244; number_of_response:1; }","duration":"719.650114ms","start":"2026-07-21T13:25:03.768753Z","end":"2026-07-21T13:25:04.488403Z","steps":["trace[1192530417] 'process raft request' (duration: 719.110301ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:25:04.488501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:25:03.768736Z","time spent":"719.705137ms","remote":"127.0.0.1:38852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-21T13:25:04.488669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.40362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-21T13:25:04.488697Z","caller":"traceutil/trace.go:171","msg":"trace[1713007905] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1244; }","duration":"343.458781ms","start":"2026-07-21T13:25:04.145232Z","end":"2026-07-21T13:25:04.48869Z","steps":["trace[1713007905] 'agreement among raft nodes before linearized reading' (duration: 343.41435ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:25:04.488717Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:25:04.145215Z","time spent":"343.498442ms","remote":"127.0.0.1:38598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-21T13:25:04.488934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.911162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.209\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-07-21T13:25:04.488963Z","caller":"traceutil/trace.go:171","msg":"trace[69967546] range","detail":"{range_begin:/registry/masterleases/199.19.213.209; range_end:; response_count:1; response_revision:1244; }","duration":"252.979534ms","start":"2026-07-21T13:25:04.235976Z","end":"2026-07-21T13:25:04.488956Z","steps":["trace[69967546] 'agreement among raft nodes before linearized reading' (duration: 252.868621ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:25:05.063916Z","caller":"traceutil/trace.go:171","msg":"trace[1012974966] linearizableReadLoop","detail":"{readStateIndex:1300; appliedIndex:1299; }","duration":"299.564172ms","start":"2026-07-21T13:25:04.764333Z","end":"2026-07-21T13:25:05.063897Z","steps":["trace[1012974966] 'read index received' (duration: 224.816281ms)","trace[1012974966] 'applied index is now lower than readState.Index' (duration: 74.747261ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T13:25:05.064028Z","caller":"traceutil/trace.go:171","msg":"trace[1213583841] transaction","detail":"{read_only:false; response_revision:1246; number_of_response:1; }","duration":"309.389082ms","start":"2026-07-21T13:25:04.75459Z","end":"2026-07-21T13:25:05.063979Z","steps":["trace[1213583841] 'process raft request' (duration: 234.555058ms)","trace[1213583841] 'compare' (duration: 74.654009ms)"],"step_count":2} {"level":"warn","ts":"2026-07-21T13:25:05.064136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.789399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-07-21T13:25:05.064162Z","caller":"traceutil/trace.go:171","msg":"trace[895326967] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1246; }","duration":"299.866731ms","start":"2026-07-21T13:25:04.764287Z","end":"2026-07-21T13:25:05.064154Z","steps":["trace[895326967] 'agreement among raft nodes before linearized reading' (duration: 299.722897ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:25:05.06424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:25:04.754573Z","time spent":"309.545726ms","remote":"127.0.0.1:38852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-21T13:25:05.064346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.90807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-21T13:25:05.064387Z","caller":"traceutil/trace.go:171","msg":"trace[1661282557] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1246; }","duration":"280.981782ms","start":"2026-07-21T13:25:04.783394Z","end":"2026-07-21T13:25:05.064376Z","steps":["trace[1661282557] 'agreement among raft nodes before linearized reading' (duration: 280.783417ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:25:05.064386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.893335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-07-21T13:25:05.064414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.018449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-21T13:25:05.064454Z","caller":"traceutil/trace.go:171","msg":"trace[2013245028] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:1246; }","duration":"202.097361ms","start":"2026-07-21T13:25:04.862343Z","end":"2026-07-21T13:25:05.064441Z","steps":["trace[2013245028] 'agreement among raft nodes before linearized reading' (duration: 202.038269ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:25:05.064453Z","caller":"traceutil/trace.go:171","msg":"trace[1060910280] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1246; }","duration":"279.995127ms","start":"2026-07-21T13:25:04.784442Z","end":"2026-07-21T13:25:05.064437Z","steps":["trace[1060910280] 'agreement among raft nodes before linearized reading' (duration: 279.779571ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:25:05.064551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.080424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-07-21T13:25:05.064581Z","caller":"traceutil/trace.go:171","msg":"trace[1985343730] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1246; }","duration":"281.124246ms","start":"2026-07-21T13:25:04.783449Z","end":"2026-07-21T13:25:05.064574Z","steps":["trace[1985343730] 'agreement among raft nodes before linearized reading' (duration: 281.050274ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:25:05.368674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.185514ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-21T13:25:05.369342Z","caller":"traceutil/trace.go:171","msg":"trace[1483088831] transaction","detail":"{read_only:false; response_revision:1250; number_of_response:1; }","duration":"299.985455ms","start":"2026-07-21T13:25:05.069314Z","end":"2026-07-21T13:25:05.369299Z","steps":["trace[1483088831] 'process raft request' (duration: 299.42604ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:25:05.369433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:25:05.069282Z","time spent":"300.106547ms","remote":"127.0.0.1:38852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-21T13:25:05.369902Z","caller":"traceutil/trace.go:171","msg":"trace[1886458935] transaction","detail":"{read_only:false; response_revision:1249; number_of_response:1; }","duration":"300.627251ms","start":"2026-07-21T13:25:05.069195Z","end":"2026-07-21T13:25:05.369822Z","steps":["trace[1886458935] 'process raft request' (duration: 183.234735ms)","trace[1886458935] 'compare' (duration: 116.085762ms)"],"step_count":2} {"level":"warn","ts":"2026-07-21T13:25:05.370112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:25:05.069182Z","time spent":"300.833196ms","remote":"127.0.0.1:38852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-21T13:25:06.399811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.570523ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-07-21T13:25:06.399888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.181183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-21T13:25:06.399954Z","caller":"traceutil/trace.go:171","msg":"trace[2087827454] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1251; }","duration":"180.738958ms","start":"2026-07-21T13:25:06.219183Z","end":"2026-07-21T13:25:06.399922Z","steps":["trace[2087827454] 'count revisions from in-memory index tree' (duration: 180.509482ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:25:06.399952Z","caller":"traceutil/trace.go:171","msg":"trace[2089092072] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1251; }","duration":"252.265915ms","start":"2026-07-21T13:25:06.147669Z","end":"2026-07-21T13:25:06.399935Z","steps":["trace[2089092072] 'range keys from in-memory index tree' (duration: 252.128501ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:25:06.399853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.210526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-21T13:25:06.400133Z","caller":"traceutil/trace.go:171","msg":"trace[1589922398] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1251; }","duration":"348.536475ms","start":"2026-07-21T13:25:06.051585Z","end":"2026-07-21T13:25:06.400122Z","steps":["trace[1589922398] 'range keys from in-memory index tree' (duration: 348.137555ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:25:06.400175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:25:06.051569Z","time spent":"348.593546ms","remote":"127.0.0.1:38852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":0,"response size":29,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-07-21T13:25:10.732022Z","caller":"traceutil/trace.go:171","msg":"trace[1336706547] transaction","detail":"{read_only:false; response_revision:1285; number_of_response:1; }","duration":"223.523598ms","start":"2026-07-21T13:25:10.50848Z","end":"2026-07-21T13:25:10.732004Z","steps":["trace[1336706547] 'process raft request' (duration: 223.370543ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:25:17.156705Z","caller":"traceutil/trace.go:171","msg":"trace[1639354879] transaction","detail":"{read_only:false; response_revision:1330; number_of_response:1; }","duration":"405.146078ms","start":"2026-07-21T13:25:16.75154Z","end":"2026-07-21T13:25:17.156686Z","steps":["trace[1639354879] 'process raft request' (duration: 405.024824ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:25:17.15688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:25:16.751516Z","time spent":"405.299893ms","remote":"127.0.0.1:38852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-21T13:25:17.518916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.048212ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-21T13:25:17.519043Z","caller":"traceutil/trace.go:171","msg":"trace[1467548611] linearizableReadLoop","detail":"{readStateIndex:1387; appliedIndex:1385; }","duration":"452.215329ms","start":"2026-07-21T13:25:17.066808Z","end":"2026-07-21T13:25:17.519023Z","steps":["trace[1467548611] 'read index received' (duration: 89.754777ms)","trace[1467548611] 'applied index is now lower than readState.Index' (duration: 362.459342ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T13:25:17.51932Z","caller":"traceutil/trace.go:171","msg":"trace[806290170] transaction","detail":"{read_only:false; response_revision:1331; number_of_response:1; }","duration":"522.136605ms","start":"2026-07-21T13:25:16.997169Z","end":"2026-07-21T13:25:17.519306Z","steps":["trace[806290170] 'process raft request' (duration: 372.567658ms)","trace[806290170] 'compare' (duration: 148.926809ms)"],"step_count":2} {"level":"warn","ts":"2026-07-21T13:25:17.519383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:25:16.997146Z","time spent":"522.208697ms","remote":"127.0.0.1:38852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-21T13:25:17.519275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.433235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-21T13:25:17.519507Z","caller":"traceutil/trace.go:171","msg":"trace[277247657] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1331; }","duration":"452.732464ms","start":"2026-07-21T13:25:17.066748Z","end":"2026-07-21T13:25:17.519481Z","steps":["trace[277247657] 'agreement among raft nodes before linearized reading' (duration: 452.393234ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:25:17.519521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.601949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-21T13:25:17.51966Z","caller":"traceutil/trace.go:171","msg":"trace[398562363] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1331; }","duration":"372.745443ms","start":"2026-07-21T13:25:17.146896Z","end":"2026-07-21T13:25:17.519642Z","steps":["trace[398562363] 'agreement among raft nodes before linearized reading' (duration: 372.553468ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:25:17.519673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.603536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-07-21T13:25:17.519757Z","caller":"traceutil/trace.go:171","msg":"trace[897550706] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1331; }","duration":"387.733129ms","start":"2026-07-21T13:25:17.132006Z","end":"2026-07-21T13:25:17.519739Z","steps":["trace[897550706] 'agreement among raft nodes before linearized reading' (duration: 387.509994ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:25:17.519804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:25:17.131993Z","time spent":"387.802771ms","remote":"127.0.0.1:38852","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-07-21T13:25:17.519729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:25:17.066718Z","time spent":"452.912608ms","remote":"127.0.0.1:38784","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":5,"response size":31,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true "} {"level":"warn","ts":"2026-07-21T13:25:17.519705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:25:17.146847Z","time spent":"372.850585ms","remote":"127.0.0.1:38598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-21T13:25:17.52047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.163629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-07-21T13:25:17.520511Z","caller":"traceutil/trace.go:171","msg":"trace[303351569] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1331; }","duration":"405.450015ms","start":"2026-07-21T13:25:17.115051Z","end":"2026-07-21T13:25:17.520501Z","steps":["trace[303351569] 'agreement among raft nodes before linearized reading' (duration: 404.320356ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:25:17.520578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:25:17.115037Z","time spent":"405.491367ms","remote":"127.0.0.1:38852","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-07-21T13:25:17.529971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.16033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-07-21T13:25:17.530063Z","caller":"traceutil/trace.go:171","msg":"trace[1310521166] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1331; }","duration":"402.292232ms","start":"2026-07-21T13:25:17.127753Z","end":"2026-07-21T13:25:17.530046Z","steps":["trace[1310521166] 'agreement among raft nodes before linearized reading' (duration: 391.849067ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:25:17.530102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:25:17.12774Z","time spent":"402.354255ms","remote":"127.0.0.1:38852","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-07-21T13:25:18.74942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.029747525s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-21T13:25:18.749782Z","caller":"traceutil/trace.go:171","msg":"trace[6375445] linearizableReadLoop","detail":"{readStateIndex:1392; appliedIndex:1387; }","duration":"1.193097775s","start":"2026-07-21T13:25:17.556668Z","end":"2026-07-21T13:25:18.749766Z","steps":["trace[6375445] 'read index received' (duration: 162.928869ms)","trace[6375445] 'applied index is now lower than readState.Index' (duration: 1.030165896s)"],"step_count":2} {"level":"info","ts":"2026-07-21T13:25:18.749867Z","caller":"traceutil/trace.go:171","msg":"trace[453671197] transaction","detail":"{read_only:false; response_revision:1336; number_of_response:1; }","duration":"1.215553677s","start":"2026-07-21T13:25:17.534306Z","end":"2026-07-21T13:25:18.749859Z","steps":["trace[453671197] 'process raft request' (duration: 1.215429204s)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:25:18.749877Z","caller":"traceutil/trace.go:171","msg":"trace[898890552] transaction","detail":"{read_only:false; response_revision:1335; number_of_response:1; }","duration":"1.223532467s","start":"2026-07-21T13:25:17.526326Z","end":"2026-07-21T13:25:18.749858Z","steps":["trace[898890552] 'process raft request' (duration: 1.223383374s)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:25:18.749928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:25:17.526317Z","time spent":"1.223584809s","remote":"127.0.0.1:38852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-21T13:25:18.749915Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:25:17.534281Z","time spent":"1.215609819s","remote":"127.0.0.1:38852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-21T13:25:18.750061Z","caller":"traceutil/trace.go:171","msg":"trace[1051780344] transaction","detail":"{read_only:false; response_revision:1332; number_of_response:1; }","duration":"1.22440047s","start":"2026-07-21T13:25:17.525652Z","end":"2026-07-21T13:25:18.750052Z","steps":["trace[1051780344] 'process raft request' (duration: 193.933396ms)","trace[1051780344] 'compare' (duration: 1.029421267s)"],"step_count":2} {"level":"warn","ts":"2026-07-21T13:25:18.75009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.193420574s","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-07-21T13:25:18.750129Z","caller":"traceutil/trace.go:171","msg":"trace[400429813] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1336; }","duration":"1.193495266s","start":"2026-07-21T13:25:17.556624Z","end":"2026-07-21T13:25:18.750119Z","steps":["trace[400429813] 'agreement among raft nodes before linearized reading' (duration: 1.193369712s)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:25:18.750157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:25:17.556598Z","time spent":"1.193552668s","remote":"127.0.0.1:38852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":556,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"info","ts":"2026-07-21T13:25:18.7502Z","caller":"traceutil/trace.go:171","msg":"trace[1637250105] transaction","detail":"{read_only:false; response_revision:1333; number_of_response:1; }","duration":"1.224370141s","start":"2026-07-21T13:25:17.525823Z","end":"2026-07-21T13:25:18.750194Z","steps":["trace[1637250105] 'process raft request' (duration: 1.223696533s)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:25:18.750244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:25:17.525814Z","time spent":"1.224404941s","remote":"127.0.0.1:38852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-21T13:25:18.750298Z","caller":"traceutil/trace.go:171","msg":"trace[841566538] transaction","detail":"{read_only:false; response_revision:1334; number_of_response:1; }","duration":"1.224103054s","start":"2026-07-21T13:25:17.526189Z","end":"2026-07-21T13:25:18.750292Z","steps":["trace[841566538] 'process raft request' (duration: 1.223397896s)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:25:18.7501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:25:17.525634Z","time spent":"1.224447623s","remote":"127.0.0.1:38852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-21T13:25:18.750333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:25:17.526158Z","time spent":"1.224156605s","remote":"127.0.0.1:38852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-21T13:25:18.750445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"575.088631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-07-21T13:25:18.750542Z","caller":"traceutil/trace.go:171","msg":"trace[901772058] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1336; }","duration":"575.205565ms","start":"2026-07-21T13:25:18.175302Z","end":"2026-07-21T13:25:18.750508Z","steps":["trace[901772058] 'agreement among raft nodes before linearized reading' (duration: 574.973429ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:25:18.7506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:25:18.175288Z","time spent":"575.299857ms","remote":"127.0.0.1:38852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-07-21T13:28:13.69689Z","caller":"traceutil/trace.go:171","msg":"trace[235350367] transaction","detail":"{read_only:false; response_revision:2134; number_of_response:1; }","duration":"111.867853ms","start":"2026-07-21T13:28:13.584988Z","end":"2026-07-21T13:28:13.696856Z","steps":["trace[235350367] 'process raft request' (duration: 111.636176ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:29:39.714634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.628622ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-07-21T13:30:10.424966Z","caller":"traceutil/trace.go:171","msg":"trace[1578683186] transaction","detail":"{read_only:false; response_revision:2704; number_of_response:1; }","duration":"157.990991ms","start":"2026-07-21T13:30:10.266944Z","end":"2026-07-21T13:30:10.424935Z","steps":["trace[1578683186] 'process raft request' (duration: 157.776874ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:30:10.714803Z","caller":"traceutil/trace.go:171","msg":"trace[418826751] linearizableReadLoop","detail":"{readStateIndex:2822; appliedIndex:2820; }","duration":"425.29941ms","start":"2026-07-21T13:30:10.289478Z","end":"2026-07-21T13:30:10.714777Z","steps":["trace[418826751] 'read index received' (duration: 135.274662ms)","trace[418826751] 'applied index is now lower than readState.Index' (duration: 290.023758ms)"],"step_count":2} {"level":"warn","ts":"2026-07-21T13:30:10.715059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.178205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-07-21T13:30:10.7151Z","caller":"traceutil/trace.go:171","msg":"trace[483074250] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2705; }","duration":"425.239516ms","start":"2026-07-21T13:30:10.289847Z","end":"2026-07-21T13:30:10.715086Z","steps":["trace[483074250] 'agreement among raft nodes before linearized reading' (duration: 425.097323ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:30:10.715053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.553806ms","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-07-21T13:30:10.715142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.555964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/default/kubernetes\" ","response":"range_response_count:1 size:704"} {"level":"warn","ts":"2026-07-21T13:30:10.715133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:30:10.289841Z","time spent":"425.285478ms","remote":"127.0.0.1:38852","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-07-21T13:30:10.715167Z","caller":"traceutil/trace.go:171","msg":"trace[318988319] range","detail":"{range_begin:/registry/services/specs/default/kubernetes; range_end:; response_count:1; response_revision:2705; }","duration":"371.619205ms","start":"2026-07-21T13:30:10.343541Z","end":"2026-07-21T13:30:10.71516Z","steps":["trace[318988319] 'agreement among raft nodes before linearized reading' (duration: 371.572634ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:30:10.71516Z","caller":"traceutil/trace.go:171","msg":"trace[1780552966] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2705; }","duration":"425.694139ms","start":"2026-07-21T13:30:10.289449Z","end":"2026-07-21T13:30:10.715143Z","steps":["trace[1780552966] 'agreement among raft nodes before linearized reading' (duration: 425.443283ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:30:10.715186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:30:10.343526Z","time spent":"371.656557ms","remote":"127.0.0.1:38784","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":728,"request content":"key:\"/registry/services/specs/default/kubernetes\" "} {"level":"warn","ts":"2026-07-21T13:30:10.715212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:30:10.289432Z","time spent":"425.768921ms","remote":"127.0.0.1:38852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-21T13:30:10.7153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.724524ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-node-lease/kube-root-ca.crt\" ","response":"range_response_count:1 size:1754"} {"level":"info","ts":"2026-07-21T13:30:10.715318Z","caller":"traceutil/trace.go:171","msg":"trace[269977130] range","detail":"{range_begin:/registry/configmaps/kube-node-lease/kube-root-ca.crt; range_end:; response_count:1; response_revision:2705; }","duration":"331.774266ms","start":"2026-07-21T13:30:10.383538Z","end":"2026-07-21T13:30:10.715313Z","steps":["trace[269977130] 'agreement among raft nodes before linearized reading' (duration: 331.740555ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:30:10.715316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.16258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/kube-public/\" range_end:\"/registry/statefulsets/kube-public0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-21T13:30:10.715332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:30:10.383502Z","time spent":"331.826398ms","remote":"127.0.0.1:38700","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":1778,"request content":"key:\"/registry/configmaps/kube-node-lease/kube-root-ca.crt\" "} {"level":"info","ts":"2026-07-21T13:30:10.715348Z","caller":"traceutil/trace.go:171","msg":"trace[1818886650] range","detail":"{range_begin:/registry/statefulsets/kube-public/; range_end:/registry/statefulsets/kube-public0; response_count:0; response_revision:2705; }","duration":"380.221402ms","start":"2026-07-21T13:30:10.335114Z","end":"2026-07-21T13:30:10.715336Z","steps":["trace[1818886650] 'agreement among raft nodes before linearized reading' (duration: 380.174751ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:30:10.715384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:30:10.335099Z","time spent":"380.277493ms","remote":"127.0.0.1:39046","response type":"/etcdserverpb.KV/Range","request count":0,"request size":77,"response count":0,"response size":29,"request content":"key:\"/registry/statefulsets/kube-public/\" range_end:\"/registry/statefulsets/kube-public0\" limit:500 "} {"level":"warn","ts":"2026-07-21T13:30:10.715324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.68544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/kube-node-lease/\" range_end:\"/registry/statefulsets/kube-node-lease0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-21T13:30:10.715531Z","caller":"traceutil/trace.go:171","msg":"trace[1478549741] range","detail":"{range_begin:/registry/statefulsets/kube-node-lease/; range_end:/registry/statefulsets/kube-node-lease0; response_count:0; response_revision:2705; }","duration":"310.920016ms","start":"2026-07-21T13:30:10.404604Z","end":"2026-07-21T13:30:10.715524Z","steps":["trace[1478549741] 'agreement among raft nodes before linearized reading' (duration: 310.629568ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:30:10.71555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:30:10.40454Z","time spent":"311.00433ms","remote":"127.0.0.1:39046","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":0,"response size":29,"request content":"key:\"/registry/statefulsets/kube-node-lease/\" range_end:\"/registry/statefulsets/kube-node-lease0\" limit:500 "} {"level":"warn","ts":"2026-07-21T13:30:10.715558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.434933ms","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":"warn","ts":"2026-07-21T13:30:10.715574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.328568ms","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:533"} {"level":"warn","ts":"2026-07-21T13:30:10.715577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.955724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:535"} {"level":"info","ts":"2026-07-21T13:30:10.715591Z","caller":"traceutil/trace.go:171","msg":"trace[533922687] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2705; }","duration":"425.484044ms","start":"2026-07-21T13:30:10.290098Z","end":"2026-07-21T13:30:10.715582Z","steps":["trace[533922687] 'agreement among raft nodes before linearized reading' (duration: 425.400142ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:30:10.71563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:30:10.290089Z","time spent":"425.535035ms","remote":"127.0.0.1:38852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-07-21T13:30:10.715638Z","caller":"traceutil/trace.go:171","msg":"trace[979003234] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2705; }","duration":"386.036246ms","start":"2026-07-21T13:30:10.329583Z","end":"2026-07-21T13:30:10.71562Z","steps":["trace[979003234] 'agreement among raft nodes before linearized reading' (duration: 385.889122ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:30:10.715609Z","caller":"traceutil/trace.go:171","msg":"trace[736284576] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2705; }","duration":"420.37885ms","start":"2026-07-21T13:30:10.295217Z","end":"2026-07-21T13:30:10.715596Z","steps":["trace[736284576] 'agreement among raft nodes before linearized reading' (duration: 420.187375ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:30:10.715678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:30:10.329567Z","time spent":"386.102537ms","remote":"127.0.0.1:38852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":559,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-07-21T13:30:10.715687Z","caller":"traceutil/trace.go:171","msg":"trace[507173520] transaction","detail":"{read_only:false; response_revision:2705; number_of_response:1; }","duration":"446.667641ms","start":"2026-07-21T13:30:10.268173Z","end":"2026-07-21T13:30:10.714841Z","steps":["trace[507173520] 'process raft request' (duration: 353.364264ms)","trace[507173520] 'compare' (duration: 93.109722ms)"],"step_count":2} {"level":"warn","ts":"2026-07-21T13:30:10.715729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:30:10.295206Z","time spent":"420.515203ms","remote":"127.0.0.1:38852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":557,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-07-21T13:30:10.715769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:30:10.268136Z","time spent":"447.591115ms","remote":"127.0.0.1:38852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-21T13:30:10.945255Z","caller":"traceutil/trace.go:171","msg":"trace[94591351] transaction","detail":"{read_only:false; response_revision:2706; number_of_response:1; }","duration":"225.042747ms","start":"2026-07-21T13:30:10.720182Z","end":"2026-07-21T13:30:10.945225Z","steps":["trace[94591351] 'process raft request' (duration: 165.890999ms)","trace[94591351] 'compare' (duration: 58.756857ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T13:30:10.975412Z","caller":"traceutil/trace.go:171","msg":"trace[2120636464] linearizableReadLoop","detail":"{readStateIndex:2827; appliedIndex:2822; }","duration":"252.508869ms","start":"2026-07-21T13:30:10.722884Z","end":"2026-07-21T13:30:10.975393Z","steps":["trace[2120636464] 'read index received' (duration: 163.203247ms)","trace[2120636464] 'applied index is now lower than readState.Index' (duration: 89.304882ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T13:30:10.975735Z","caller":"traceutil/trace.go:171","msg":"trace[166461390] transaction","detail":"{read_only:false; response_revision:2708; number_of_response:1; }","duration":"254.775528ms","start":"2026-07-21T13:30:10.720947Z","end":"2026-07-21T13:30:10.975723Z","steps":["trace[166461390] 'process raft request' (duration: 254.329707ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:30:10.975746Z","caller":"traceutil/trace.go:171","msg":"trace[1948023122] transaction","detail":"{read_only:false; response_revision:2710; number_of_response:1; }","duration":"253.641479ms","start":"2026-07-21T13:30:10.722069Z","end":"2026-07-21T13:30:10.975711Z","steps":["trace[1948023122] 'process raft request' (duration: 253.29072ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:30:10.975868Z","caller":"traceutil/trace.go:171","msg":"trace[1477402405] transaction","detail":"{read_only:false; response_revision:2707; number_of_response:1; }","duration":"255.271642ms","start":"2026-07-21T13:30:10.72059Z","end":"2026-07-21T13:30:10.975861Z","steps":["trace[1477402405] 'process raft request' (duration: 254.590964ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:30:10.975895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.90897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-node-lease/\" range_end:\"/registry/events/kube-node-lease0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-21T13:30:10.97595Z","caller":"traceutil/trace.go:171","msg":"trace[615354692] range","detail":"{range_begin:/registry/events/kube-node-lease/; range_end:/registry/events/kube-node-lease0; response_count:0; response_revision:2710; }","duration":"252.960621ms","start":"2026-07-21T13:30:10.722973Z","end":"2026-07-21T13:30:10.975933Z","steps":["trace[615354692] 'agreement among raft nodes before linearized reading' (duration: 252.89165ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:30:10.976029Z","caller":"traceutil/trace.go:171","msg":"trace[1480354632] transaction","detail":"{read_only:false; response_revision:2709; number_of_response:1; }","duration":"254.379199ms","start":"2026-07-21T13:30:10.72164Z","end":"2026-07-21T13:30:10.976019Z","steps":["trace[1480354632] 'process raft request' (duration: 253.6622ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:30:10.976086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.539021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/kube-system/\" range_end:\"/registry/cronjobs/kube-system0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-21T13:30:10.97612Z","caller":"traceutil/trace.go:171","msg":"trace[1125460054] range","detail":"{range_begin:/registry/cronjobs/kube-system/; range_end:/registry/cronjobs/kube-system0; response_count:0; response_revision:2710; }","duration":"167.574682ms","start":"2026-07-21T13:30:10.808537Z","end":"2026-07-21T13:30:10.976112Z","steps":["trace[1125460054] 'agreement among raft nodes before linearized reading' (duration: 167.51769ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:30:10.97581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.900979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"info","ts":"2026-07-21T13:30:10.976201Z","caller":"traceutil/trace.go:171","msg":"trace[1839310322] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:2710; }","duration":"253.331491ms","start":"2026-07-21T13:30:10.722859Z","end":"2026-07-21T13:30:10.97619Z","steps":["trace[1839310322] 'agreement among raft nodes before linearized reading' (duration: 252.849308ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:30:10.976455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.029993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/\" range_end:\"/registry/configmaps/kube-system0\" limit:500 ","response":"range_response_count:11 size:19225"} {"level":"info","ts":"2026-07-21T13:30:10.976493Z","caller":"traceutil/trace.go:171","msg":"trace[1633684956] range","detail":"{range_begin:/registry/configmaps/kube-system/; range_end:/registry/configmaps/kube-system0; response_count:11; response_revision:2710; }","duration":"171.105705ms","start":"2026-07-21T13:30:10.805379Z","end":"2026-07-21T13:30:10.976484Z","steps":["trace[1633684956] 'agreement among raft nodes before linearized reading' (duration: 170.945521ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:30:12.355004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.121337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/cilium-config\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-07-21T13:30:12.355198Z","caller":"traceutil/trace.go:171","msg":"trace[452535377] range","detail":"{range_begin:/registry/configmaps/kube-system/cilium-config; range_end:; response_count:1; response_revision:2712; }","duration":"146.349464ms","start":"2026-07-21T13:30:12.208832Z","end":"2026-07-21T13:30:12.355182Z","steps":["trace[452535377] 'range keys from in-memory index tree' (duration: 146.035285ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:30:12.355797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.198252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/\" range_end:\"/registry/events/kube-system0\" limit:500 ","response":"range_response_count:115 size:88927"} {"level":"info","ts":"2026-07-21T13:30:12.355966Z","caller":"traceutil/trace.go:171","msg":"trace[12063960] range","detail":"{range_begin:/registry/events/kube-system/; range_end:/registry/events/kube-system0; response_count:115; response_revision:2712; }","duration":"154.312664ms","start":"2026-07-21T13:30:12.201551Z","end":"2026-07-21T13:30:12.355863Z","steps":["trace[12063960] 'range keys from in-memory index tree' (duration: 153.393299ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:30:12.613927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.383048ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-21T13:30:12.614008Z","caller":"traceutil/trace.go:171","msg":"trace[1048286654] linearizableReadLoop","detail":"{readStateIndex:2831; appliedIndex:2830; }","duration":"180.078942ms","start":"2026-07-21T13:30:12.433915Z","end":"2026-07-21T13:30:12.613994Z","steps":["trace[1048286654] 'read index received' (duration: 34.505828ms)","trace[1048286654] 'applied index is now lower than readState.Index' (duration: 145.572314ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T13:30:12.614163Z","caller":"traceutil/trace.go:171","msg":"trace[975434415] transaction","detail":"{read_only:false; response_revision:2714; number_of_response:1; }","duration":"182.996479ms","start":"2026-07-21T13:30:12.431157Z","end":"2026-07-21T13:30:12.614153Z","steps":["trace[975434415] 'process raft request' (duration: 37.321793ms)","trace[975434415] 'compare' (duration: 145.245935ms)"],"step_count":2} {"level":"warn","ts":"2026-07-21T13:30:12.614193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.249857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/cilium-config\" ","response":"range_response_count:1 size:6531"} {"level":"warn","ts":"2026-07-21T13:30:12.61424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.918805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/coredns\" ","response":"range_response_count:1 size:612"} {"level":"info","ts":"2026-07-21T13:30:12.61428Z","caller":"traceutil/trace.go:171","msg":"trace[2129705049] range","detail":"{range_begin:/registry/configmaps/kube-system/cilium-config; range_end:; response_count:1; response_revision:2714; }","duration":"180.36723ms","start":"2026-07-21T13:30:12.433894Z","end":"2026-07-21T13:30:12.614261Z","steps":["trace[2129705049] 'agreement among raft nodes before linearized reading' (duration: 180.184406ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:30:12.614304Z","caller":"traceutil/trace.go:171","msg":"trace[1785909570] range","detail":"{range_begin:/registry/configmaps/kube-system/coredns; range_end:; response_count:1; response_revision:2714; }","duration":"170.020067ms","start":"2026-07-21T13:30:12.444271Z","end":"2026-07-21T13:30:12.614292Z","steps":["trace[1785909570] 'agreement among raft nodes before linearized reading' (duration: 169.887874ms)"],"step_count":1}