{"level":"warn","ts":"2026-06-25T22:22:41.93291Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-25T22:22:41.933053Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.81: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.81:2380","--initial-cluster=instance=https://199.19.213.81:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.81:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.81: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-06-25T22:22:41.933147Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-25T22:22:41.933163Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.81:2380"]} {"level":"info","ts":"2026-06-25T22:22:41.933185Z","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-06-25T22:22:41.936055Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.81:2379"]} {"level":"info","ts":"2026-06-25T22:22:41.936308Z","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.81:2380"],"listen-peer-urls":["https://199.19.213.81:2380"],"advertise-client-urls":["https://199.19.213.81:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.81:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.81: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-06-25T22:22:41.947299Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"9.441866ms"} {"level":"info","ts":"2026-06-25T22:22:41.96077Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1627b0b72e417489","cluster-id":"d42e5eae8a1b814c"} {"level":"info","ts":"2026-06-25T22:22:41.960877Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1627b0b72e417489 switched to configuration voters=()"} {"level":"info","ts":"2026-06-25T22:22:41.960909Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1627b0b72e417489 became follower at term 0"} {"level":"info","ts":"2026-06-25T22:22:41.960924Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1627b0b72e417489 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-25T22:22:41.960941Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1627b0b72e417489 became follower at term 1"} {"level":"info","ts":"2026-06-25T22:22:41.960991Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1627b0b72e417489 switched to configuration voters=(1596438893727675529)"} {"level":"warn","ts":"2026-06-25T22:22:41.967529Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-25T22:22:41.968846Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-25T22:22:41.971854Z","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-06-25T22:22:41.974343Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1627b0b72e417489","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-25T22:22:41.975952Z","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-06-25T22:22:41.976133Z","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-06-25T22:22:41.976224Z","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-06-25T22:22:41.97624Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1627b0b72e417489","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-25T22:22:41.98857Z","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-06-25T22:22:41.988922Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1627b0b72e417489","initial-advertise-peer-urls":["https://199.19.213.81:2380"],"listen-peer-urls":["https://199.19.213.81:2380"],"advertise-client-urls":["https://199.19.213.81:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.81:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-25T22:22:41.988967Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-25T22:22:41.989068Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1627b0b72e417489 switched to configuration voters=(1596438893727675529)"} {"level":"info","ts":"2026-06-25T22:22:41.989247Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"d42e5eae8a1b814c","local-member-id":"1627b0b72e417489","added-peer-id":"1627b0b72e417489","added-peer-peer-urls":["https://199.19.213.81:2380"]} {"level":"info","ts":"2026-06-25T22:22:41.989298Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.81:2380"} {"level":"info","ts":"2026-06-25T22:22:41.98933Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.81:2380"} {"level":"info","ts":"2026-06-25T22:22:42.061777Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1627b0b72e417489 is starting a new election at term 1"} {"level":"info","ts":"2026-06-25T22:22:42.061877Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1627b0b72e417489 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-25T22:22:42.061905Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1627b0b72e417489 received MsgPreVoteResp from 1627b0b72e417489 at term 1"} {"level":"info","ts":"2026-06-25T22:22:42.061926Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1627b0b72e417489 became candidate at term 2"} {"level":"info","ts":"2026-06-25T22:22:42.061937Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1627b0b72e417489 received MsgVoteResp from 1627b0b72e417489 at term 2"} {"level":"info","ts":"2026-06-25T22:22:42.061954Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1627b0b72e417489 became leader at term 2"} {"level":"info","ts":"2026-06-25T22:22:42.061968Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1627b0b72e417489 elected leader 1627b0b72e417489 at term 2"} {"level":"info","ts":"2026-06-25T22:22:42.063068Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-25T22:22:42.063845Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-25T22:22:42.063839Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1627b0b72e417489","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.81:2379]}","request-path":"/0/members/1627b0b72e417489/attributes","cluster-id":"d42e5eae8a1b814c","publish-timeout":"7s"} {"level":"info","ts":"2026-06-25T22:22:42.064021Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-25T22:22:42.064298Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-25T22:22:42.064323Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-25T22:22:42.064549Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"d42e5eae8a1b814c","local-member-id":"1627b0b72e417489","cluster-version":"3.5"} {"level":"info","ts":"2026-06-25T22:22:42.064671Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-25T22:22:42.064704Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-25T22:22:42.066989Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-25T22:22:42.067178Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.81:2379"} {"level":"info","ts":"2026-06-25T22:23:26.767202Z","caller":"traceutil/trace.go:171","msg":"trace[674687804] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"244.758318ms","start":"2026-06-25T22:23:26.522419Z","end":"2026-06-25T22:23:26.767177Z","steps":["trace[674687804] 'process raft request' (duration: 244.632885ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:23:26.985399Z","caller":"traceutil/trace.go:171","msg":"trace[1939825779] linearizableReadLoop","detail":"{readStateIndex:660; appliedIndex:659; }","duration":"243.887318ms","start":"2026-06-25T22:23:26.741483Z","end":"2026-06-25T22:23:26.98537Z","steps":["trace[1939825779] 'read index received' (duration: 25.676424ms)","trace[1939825779] 'applied index is now lower than readState.Index' (duration: 218.209574ms)"],"step_count":2} {"level":"warn","ts":"2026-06-25T22:23:26.986505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.095082ms","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-06-25T22:23:26.986707Z","caller":"traceutil/trace.go:171","msg":"trace[1274684933] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:635; }","duration":"245.269029ms","start":"2026-06-25T22:23:26.74141Z","end":"2026-06-25T22:23:26.986679Z","steps":["trace[1274684933] 'agreement among raft nodes before linearized reading' (duration: 244.102672ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:23:26.986753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.633599ms","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-06-25T22:23:26.989378Z","caller":"traceutil/trace.go:171","msg":"trace[383783950] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:635; }","duration":"223.318439ms","start":"2026-06-25T22:23:26.766019Z","end":"2026-06-25T22:23:26.989337Z","steps":["trace[383783950] 'agreement among raft nodes before linearized reading' (duration: 220.25555ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:23:26.985584Z","caller":"traceutil/trace.go:171","msg":"trace[1918889661] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"329.451073ms","start":"2026-06-25T22:23:26.656083Z","end":"2026-06-25T22:23:26.985534Z","steps":["trace[1918889661] 'process raft request' (duration: 327.661703ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:23:26.990422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:23:26.656042Z","time spent":"333.551557ms","remote":"127.0.0.1:49220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036297,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-25T22:23:27.681089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"611.384477ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-25T22:23:27.681488Z","caller":"traceutil/trace.go:171","msg":"trace[1584057353] linearizableReadLoop","detail":"{readStateIndex:663; appliedIndex:661; }","duration":"413.71116ms","start":"2026-06-25T22:23:27.267757Z","end":"2026-06-25T22:23:27.681468Z","steps":["trace[1584057353] 'read index received' (duration: 408.451801ms)","trace[1584057353] 'applied index is now lower than readState.Index' (duration: 5.258389ms)"],"step_count":2} {"level":"info","ts":"2026-06-25T22:23:27.681602Z","caller":"traceutil/trace.go:171","msg":"trace[1058723600] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"621.225811ms","start":"2026-06-25T22:23:27.060362Z","end":"2026-06-25T22:23:27.681588Z","steps":["trace[1058723600] 'process raft request' (duration: 621.053497ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:23:27.681677Z","caller":"traceutil/trace.go:171","msg":"trace[1327989365] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"685.472032ms","start":"2026-06-25T22:23:26.99616Z","end":"2026-06-25T22:23:27.681633Z","steps":["trace[1327989365] 'process raft request' (duration: 73.259996ms)","trace[1327989365] 'compare' (duration: 611.166832ms)"],"step_count":2} {"level":"warn","ts":"2026-06-25T22:23:27.68188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:23:27.060327Z","time spent":"621.500416ms","remote":"127.0.0.1:49614","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-25T22:23:27.681749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.996446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-25T22:23:27.682027Z","caller":"traceutil/trace.go:171","msg":"trace[1415697675] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:638; }","duration":"414.321505ms","start":"2026-06-25T22:23:27.267694Z","end":"2026-06-25T22:23:27.682015Z","steps":["trace[1415697675] 'agreement among raft nodes before linearized reading' (duration: 413.944666ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:23:27.682057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:23:27.267673Z","time spent":"414.377345ms","remote":"127.0.0.1:49168","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-25T22:23:27.682053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:23:26.996152Z","time spent":"685.772259ms","remote":"127.0.0.1:49416","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-25T22:23:41.210624Z","caller":"traceutil/trace.go:171","msg":"trace[824221317] transaction","detail":"{read_only:false; response_revision:779; number_of_response:1; }","duration":"112.868177ms","start":"2026-06-25T22:23:41.097726Z","end":"2026-06-25T22:23:41.210594Z","steps":["trace[824221317] 'process raft request' (duration: 79.994169ms)","trace[824221317] 'compare' (duration: 32.650603ms)"],"step_count":2} {"level":"warn","ts":"2026-06-25T22:23:43.76112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.909467ms","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-06-25T22:23:43.761206Z","caller":"traceutil/trace.go:171","msg":"trace[391872274] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:800; }","duration":"196.056079ms","start":"2026-06-25T22:23:43.565132Z","end":"2026-06-25T22:23:43.761188Z","steps":["trace[391872274] 'count revisions from in-memory index tree' (duration: 195.821894ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:23:43.761221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.782171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-7k6wg\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-06-25T22:23:43.761276Z","caller":"traceutil/trace.go:171","msg":"trace[80466001] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-7k6wg; range_end:; response_count:1; response_revision:800; }","duration":"143.876974ms","start":"2026-06-25T22:23:43.617383Z","end":"2026-06-25T22:23:43.76126Z","steps":["trace[80466001] 'range keys from in-memory index tree' (duration: 143.609067ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:24:05.433968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.520697ms","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-06-25T22:24:05.434085Z","caller":"traceutil/trace.go:171","msg":"trace[1234959187] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:964; }","duration":"111.66771ms","start":"2026-06-25T22:24:05.322377Z","end":"2026-06-25T22:24:05.434045Z","steps":["trace[1234959187] 'range keys from in-memory index tree' (duration: 111.341353ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:24:44.26326Z","caller":"traceutil/trace.go:171","msg":"trace[1327360069] linearizableReadLoop","detail":"{readStateIndex:1140; appliedIndex:1139; }","duration":"106.723184ms","start":"2026-06-25T22:24:44.156505Z","end":"2026-06-25T22:24:44.263228Z","steps":["trace[1327360069] 'read index received' (duration: 106.399247ms)","trace[1327360069] 'applied index is now lower than readState.Index' (duration: 322.707µs)"],"step_count":2} {"level":"info","ts":"2026-06-25T22:24:44.263741Z","caller":"traceutil/trace.go:171","msg":"trace[236433583] transaction","detail":"{read_only:false; response_revision:1097; number_of_response:1; }","duration":"116.073025ms","start":"2026-06-25T22:24:44.147616Z","end":"2026-06-25T22:24:44.263689Z","steps":["trace[236433583] 'process raft request' (duration: 115.368329ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:24:44.263849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.305877ms","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-06-25T22:24:44.263907Z","caller":"traceutil/trace.go:171","msg":"trace[1216562473] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1097; }","duration":"107.41483ms","start":"2026-06-25T22:24:44.156474Z","end":"2026-06-25T22:24:44.263889Z","steps":["trace[1216562473] 'agreement among raft nodes before linearized reading' (duration: 107.202345ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:25:02.232292Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8397417806329754372,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-25T22:25:02.298844Z","caller":"traceutil/trace.go:171","msg":"trace[2043557282] transaction","detail":"{read_only:false; response_revision:1154; number_of_response:1; }","duration":"735.740494ms","start":"2026-06-25T22:25:01.563076Z","end":"2026-06-25T22:25:02.298817Z","steps":["trace[2043557282] 'process raft request' (duration: 735.52476ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:25:02.29903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:25:01.563054Z","time spent":"735.859747ms","remote":"127.0.0.1:49416","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-25T22:25:02.299451Z","caller":"traceutil/trace.go:171","msg":"trace[2001680427] transaction","detail":"{read_only:false; response_revision:1155; number_of_response:1; }","duration":"569.480389ms","start":"2026-06-25T22:25:01.729952Z","end":"2026-06-25T22:25:02.299432Z","steps":["trace[2001680427] 'process raft request' (duration: 569.276754ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:25:02.299545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:25:01.729928Z","time spent":"569.55664ms","remote":"127.0.0.1:49416","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-25T22:25:02.299379Z","caller":"traceutil/trace.go:171","msg":"trace[554927644] linearizableReadLoop","detail":"{readStateIndex:1202; appliedIndex:1200; }","duration":"567.104755ms","start":"2026-06-25T22:25:01.732254Z","end":"2026-06-25T22:25:02.299358Z","steps":["trace[554927644] 'read index received' (duration: 566.43502ms)","trace[554927644] 'applied index is now lower than readState.Index' (duration: 668.995µs)"],"step_count":2} {"level":"warn","ts":"2026-06-25T22:25:02.299707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"567.443733ms","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-06-25T22:25:02.299764Z","caller":"traceutil/trace.go:171","msg":"trace[1363766650] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1155; }","duration":"567.528245ms","start":"2026-06-25T22:25:01.732223Z","end":"2026-06-25T22:25:02.299752Z","steps":["trace[1363766650] 'agreement among raft nodes before linearized reading' (duration: 567.342681ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:25:02.299801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:25:01.732212Z","time spent":"567.580776ms","remote":"127.0.0.1:49416","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-06-25T22:25:02.7222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.162381ms","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-06-25T22:25:02.722271Z","caller":"traceutil/trace.go:171","msg":"trace[1965418185] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1156; }","duration":"371.277294ms","start":"2026-06-25T22:25:02.350977Z","end":"2026-06-25T22:25:02.722254Z","steps":["trace[1965418185] 'range keys from in-memory index tree' (duration: 370.995558ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:25:02.72231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:25:02.350959Z","time spent":"371.342575ms","remote":"127.0.0.1:49416","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-06-25T22:25:02.722459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.117823ms","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-06-25T22:25:02.722529Z","caller":"traceutil/trace.go:171","msg":"trace[1682768293] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1156; }","duration":"368.239526ms","start":"2026-06-25T22:25:02.354272Z","end":"2026-06-25T22:25:02.722512Z","steps":["trace[1682768293] 'range keys from in-memory index tree' (duration: 367.941769ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:25:02.722633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:25:02.354253Z","time spent":"368.322087ms","remote":"127.0.0.1:49416","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-06-25T22:25:08.592759Z","caller":"traceutil/trace.go:171","msg":"trace[1818418409] linearizableReadLoop","detail":"{readStateIndex:1222; appliedIndex:1221; }","duration":"269.851738ms","start":"2026-06-25T22:25:08.322886Z","end":"2026-06-25T22:25:08.592738Z","steps":["trace[1818418409] 'read index received' (duration: 269.693144ms)","trace[1818418409] 'applied index is now lower than readState.Index' (duration: 157.654µs)"],"step_count":2} {"level":"info","ts":"2026-06-25T22:25:08.592888Z","caller":"traceutil/trace.go:171","msg":"trace[324101978] transaction","detail":"{read_only:false; response_revision:1174; number_of_response:1; }","duration":"273.93101ms","start":"2026-06-25T22:25:08.318916Z","end":"2026-06-25T22:25:08.592847Z","steps":["trace[324101978] 'process raft request' (duration: 273.669305ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:25:08.592967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.060463ms","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-06-25T22:25:08.592993Z","caller":"traceutil/trace.go:171","msg":"trace[950389699] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1174; }","duration":"270.130614ms","start":"2026-06-25T22:25:08.322855Z","end":"2026-06-25T22:25:08.592985Z","steps":["trace[950389699] 'agreement among raft nodes before linearized reading' (duration: 270.013902ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:25:08.593088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.615173ms","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-06-25T22:25:08.593148Z","caller":"traceutil/trace.go:171","msg":"trace[2044060434] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1174; }","duration":"269.704395ms","start":"2026-06-25T22:25:08.32343Z","end":"2026-06-25T22:25:08.593134Z","steps":["trace[2044060434] 'agreement among raft nodes before linearized reading' (duration: 269.544531ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:25:08.816828Z","caller":"traceutil/trace.go:171","msg":"trace[888298423] transaction","detail":"{read_only:false; response_revision:1175; number_of_response:1; }","duration":"220.355625ms","start":"2026-06-25T22:25:08.596451Z","end":"2026-06-25T22:25:08.816806Z","steps":["trace[888298423] 'process raft request' (duration: 185.92046ms)","trace[888298423] 'compare' (duration: 34.092347ms)"],"step_count":2} {"level":"info","ts":"2026-06-25T22:25:08.817135Z","caller":"traceutil/trace.go:171","msg":"trace[693860776] transaction","detail":"{read_only:false; response_revision:1176; number_of_response:1; }","duration":"218.40272ms","start":"2026-06-25T22:25:08.598725Z","end":"2026-06-25T22:25:08.817128Z","steps":["trace[693860776] 'process raft request' (duration: 217.835297ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:25:18.894668Z","caller":"traceutil/trace.go:171","msg":"trace[1056982718] transaction","detail":"{read_only:false; response_revision:1207; number_of_response:1; }","duration":"272.814151ms","start":"2026-06-25T22:25:18.621835Z","end":"2026-06-25T22:25:18.894649Z","steps":["trace[1056982718] 'process raft request' (duration: 272.520515ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:25:19.040805Z","caller":"traceutil/trace.go:171","msg":"trace[521341143] transaction","detail":"{read_only:false; response_revision:1209; number_of_response:1; }","duration":"142.5939ms","start":"2026-06-25T22:25:18.898182Z","end":"2026-06-25T22:25:19.040776Z","steps":["trace[521341143] 'process raft request' (duration: 103.860673ms)","trace[521341143] 'compare' (duration: 38.451031ms)"],"step_count":2} {"level":"info","ts":"2026-06-25T22:25:19.040801Z","caller":"traceutil/trace.go:171","msg":"trace[65652212] linearizableReadLoop","detail":"{readStateIndex:1259; appliedIndex:1258; }","duration":"116.498759ms","start":"2026-06-25T22:25:18.924264Z","end":"2026-06-25T22:25:19.040763Z","steps":["trace[65652212] 'read index received' (duration: 32.549047ms)","trace[65652212] 'applied index is now lower than readState.Index' (duration: 83.945372ms)"],"step_count":2} {"level":"warn","ts":"2026-06-25T22:25:19.040988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.704195ms","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-06-25T22:25:19.041026Z","caller":"traceutil/trace.go:171","msg":"trace[971302259] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1209; }","duration":"116.800257ms","start":"2026-06-25T22:25:18.924216Z","end":"2026-06-25T22:25:19.041016Z","steps":["trace[971302259] 'agreement among raft nodes before linearized reading' (duration: 116.645292ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:25:19.041091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.64084ms","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-06-25T22:25:19.04114Z","caller":"traceutil/trace.go:171","msg":"trace[1935538522] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1209; }","duration":"100.712962ms","start":"2026-06-25T22:25:18.940412Z","end":"2026-06-25T22:25:19.041125Z","steps":["trace[1935538522] 'agreement among raft nodes before linearized reading' (duration: 100.59805ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:25:19.041237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.512057ms","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-06-25T22:25:19.041287Z","caller":"traceutil/trace.go:171","msg":"trace[434215955] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1209; }","duration":"100.611519ms","start":"2026-06-25T22:25:18.940664Z","end":"2026-06-25T22:25:19.041276Z","steps":["trace[434215955] 'agreement among raft nodes before linearized reading' (duration: 100.464556ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:25:35.525929Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8397417806329754736,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-25T22:25:35.856855Z","caller":"traceutil/trace.go:171","msg":"trace[628831217] linearizableReadLoop","detail":"{readStateIndex:1365; appliedIndex:1364; }","duration":"831.289816ms","start":"2026-06-25T22:25:35.025547Z","end":"2026-06-25T22:25:35.856837Z","steps":["trace[628831217] 'read index received' (duration: 831.146142ms)","trace[628831217] 'applied index is now lower than readState.Index' (duration: 143.003µs)"],"step_count":2} {"level":"info","ts":"2026-06-25T22:25:35.856898Z","caller":"traceutil/trace.go:171","msg":"trace[565087885] transaction","detail":"{read_only:false; response_revision:1310; number_of_response:1; }","duration":"891.484549ms","start":"2026-06-25T22:25:34.965389Z","end":"2026-06-25T22:25:35.856874Z","steps":["trace[565087885] 'process raft request' (duration: 891.341496ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:25:35.857059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"744.054689ms","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-06-25T22:25:35.857092Z","caller":"traceutil/trace.go:171","msg":"trace[858920474] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1310; }","duration":"744.134871ms","start":"2026-06-25T22:25:35.112948Z","end":"2026-06-25T22:25:35.857083Z","steps":["trace[858920474] 'agreement among raft nodes before linearized reading' (duration: 744.004308ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:25:35.857099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"592.069385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-25T22:25:35.857153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"655.85314ms","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-06-25T22:25:35.85719Z","caller":"traceutil/trace.go:171","msg":"trace[1911431205] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1310; }","duration":"655.923092ms","start":"2026-06-25T22:25:35.201259Z","end":"2026-06-25T22:25:35.857182Z","steps":["trace[1911431205] 'agreement among raft nodes before linearized reading' (duration: 655.771319ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:25:35.857206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:25:35.201242Z","time spent":"655.960483ms","remote":"127.0.0.1:49416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-25T22:25:35.857202Z","caller":"traceutil/trace.go:171","msg":"trace[1348376767] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1310; }","duration":"592.233639ms","start":"2026-06-25T22:25:35.264943Z","end":"2026-06-25T22:25:35.857176Z","steps":["trace[1348376767] 'agreement among raft nodes before linearized reading' (duration: 592.016864ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:25:35.857187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"709.850854ms","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-06-25T22:25:35.857214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"500.371427ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-25T22:25:35.857253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:25:35.264925Z","time spent":"592.321121ms","remote":"127.0.0.1:49176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-25T22:25:35.857277Z","caller":"traceutil/trace.go:171","msg":"trace[1005088010] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1310; }","duration":"709.986427ms","start":"2026-06-25T22:25:35.147269Z","end":"2026-06-25T22:25:35.857255Z","steps":["trace[1005088010] 'agreement among raft nodes before linearized reading' (duration: 709.774532ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:25:35.857303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"652.207158ms","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-06-25T22:25:35.857327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:25:35.147251Z","time spent":"710.067068ms","remote":"127.0.0.1:49416","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-06-25T22:25:35.857347Z","caller":"traceutil/trace.go:171","msg":"trace[1511786710] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1310; }","duration":"652.251588ms","start":"2026-06-25T22:25:35.205075Z","end":"2026-06-25T22:25:35.857327Z","steps":["trace[1511786710] 'agreement among raft nodes before linearized reading' (duration: 652.184287ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:25:35.857388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:25:35.205065Z","time spent":"652.31518ms","remote":"127.0.0.1:49416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-25T22:25:35.85728Z","caller":"traceutil/trace.go:171","msg":"trace[1432375556] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:1310; }","duration":"500.50602ms","start":"2026-06-25T22:25:35.356757Z","end":"2026-06-25T22:25:35.857263Z","steps":["trace[1432375556] 'agreement among raft nodes before linearized reading' (duration: 500.391157ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:25:35.857492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:25:35.356726Z","time spent":"500.758136ms","remote":"127.0.0.1:49400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":30,"request content":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true "} {"level":"warn","ts":"2026-06-25T22:25:35.857196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.440427ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.81\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-06-25T22:25:35.857581Z","caller":"traceutil/trace.go:171","msg":"trace[1500718905] range","detail":"{range_begin:/registry/masterleases/199.19.213.81; range_end:; response_count:1; response_revision:1310; }","duration":"341.875698ms","start":"2026-06-25T22:25:35.515699Z","end":"2026-06-25T22:25:35.857575Z","steps":["trace[1500718905] 'agreement among raft nodes before linearized reading' (duration: 341.321275ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:25:35.857596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:25:35.515685Z","time spent":"341.906718ms","remote":"127.0.0.1:49180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.19.213.81\" "} {"level":"warn","ts":"2026-06-25T22:25:35.857847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"832.264138ms","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-06-25T22:25:35.857887Z","caller":"traceutil/trace.go:171","msg":"trace[1635863451] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1310; }","duration":"832.383912ms","start":"2026-06-25T22:25:35.025492Z","end":"2026-06-25T22:25:35.857876Z","steps":["trace[1635863451] 'agreement among raft nodes before linearized reading' (duration: 831.416669ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:25:35.857861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:25:34.965365Z","time spent":"891.583722ms","remote":"127.0.0.1:49416","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-25T22:25:35.857929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:25:35.025468Z","time spent":"832.453904ms","remote":"127.0.0.1:49416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-25T22:25:35.858435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:25:35.112929Z","time spent":"744.182182ms","remote":"127.0.0.1:49416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-25T22:25:36.094492Z","caller":"traceutil/trace.go:171","msg":"trace[893838901] transaction","detail":"{read_only:false; response_revision:1311; number_of_response:1; }","duration":"234.038013ms","start":"2026-06-25T22:25:35.860425Z","end":"2026-06-25T22:25:36.094463Z","steps":["trace[893838901] 'process raft request' (duration: 233.764797ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:25:36.0945Z","caller":"traceutil/trace.go:171","msg":"trace[1507134047] transaction","detail":"{read_only:false; response_revision:1312; number_of_response:1; }","duration":"233.804897ms","start":"2026-06-25T22:25:35.860663Z","end":"2026-06-25T22:25:36.094468Z","steps":["trace[1507134047] 'process raft request' (duration: 233.727075ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:25:36.094775Z","caller":"traceutil/trace.go:171","msg":"trace[433664024] transaction","detail":"{read_only:false; response_revision:1313; number_of_response:1; }","duration":"233.378028ms","start":"2026-06-25T22:25:35.861379Z","end":"2026-06-25T22:25:36.094757Z","steps":["trace[433664024] 'process raft request' (duration: 233.0486ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:25:36.094871Z","caller":"traceutil/trace.go:171","msg":"trace[200428022] transaction","detail":"{read_only:false; response_revision:1314; number_of_response:1; }","duration":"232.530789ms","start":"2026-06-25T22:25:35.862324Z","end":"2026-06-25T22:25:36.094855Z","steps":["trace[200428022] 'process raft request' (duration: 232.350985ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:25:36.09486Z","caller":"traceutil/trace.go:171","msg":"trace[235747000] transaction","detail":"{read_only:false; response_revision:1315; number_of_response:1; }","duration":"232.193481ms","start":"2026-06-25T22:25:35.862635Z","end":"2026-06-25T22:25:36.094829Z","steps":["trace[235747000] 'process raft request' (duration: 232.14354ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:25:40.385227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.617856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-25T22:25:40.385316Z","caller":"traceutil/trace.go:171","msg":"trace[1333677322] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1329; }","duration":"117.773239ms","start":"2026-06-25T22:25:40.267523Z","end":"2026-06-25T22:25:40.385296Z","steps":["trace[1333677322] 'range keys from in-memory index tree' (duration: 117.489432ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:25:54.194253Z","caller":"traceutil/trace.go:171","msg":"trace[661738680] transaction","detail":"{read_only:false; response_revision:1390; number_of_response:1; }","duration":"151.85154ms","start":"2026-06-25T22:25:54.042375Z","end":"2026-06-25T22:25:54.194227Z","steps":["trace[661738680] 'process raft request' (duration: 151.695247ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:25:54.740016Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8397417806329754923,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-25T22:25:55.181484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.307828ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-25T22:25:55.181616Z","caller":"traceutil/trace.go:171","msg":"trace[1106158564] linearizableReadLoop","detail":"{readStateIndex:1450; appliedIndex:1449; }","duration":"942.482186ms","start":"2026-06-25T22:25:54.239112Z","end":"2026-06-25T22:25:55.181594Z","steps":["trace[1106158564] 'read index received' (duration: 519.902531ms)","trace[1106158564] 'applied index is now lower than readState.Index' (duration: 422.577785ms)"],"step_count":2} {"level":"warn","ts":"2026-06-25T22:25:55.182014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"915.822342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-06-25T22:25:55.182009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"942.878185ms","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-06-25T22:25:55.18208Z","caller":"traceutil/trace.go:171","msg":"trace[1699296896] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1391; }","duration":"915.906454ms","start":"2026-06-25T22:25:54.266156Z","end":"2026-06-25T22:25:55.182063Z","steps":["trace[1699296896] 'agreement among raft nodes before linearized reading' (duration: 915.72887ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:25:55.182098Z","caller":"traceutil/trace.go:171","msg":"trace[1462545933] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1391; }","duration":"943.022548ms","start":"2026-06-25T22:25:54.239057Z","end":"2026-06-25T22:25:55.18208Z","steps":["trace[1462545933] 'agreement among raft nodes before linearized reading' (duration: 942.743472ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:25:55.182137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:25:54.266146Z","time spent":"915.979905ms","remote":"127.0.0.1:49416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-25T22:25:55.182142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.666854ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-25T22:25:55.182155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:25:54.239038Z","time spent":"943.10425ms","remote":"127.0.0.1:49416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-25T22:25:55.182157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"909.001727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-06-25T22:25:55.182182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"915.597317ms","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-06-25T22:25:55.1822Z","caller":"traceutil/trace.go:171","msg":"trace[1603779150] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:1391; }","duration":"180.715615ms","start":"2026-06-25T22:25:55.001466Z","end":"2026-06-25T22:25:55.182181Z","steps":["trace[1603779150] 'agreement among raft nodes before linearized reading' (duration: 180.646394ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:25:55.182225Z","caller":"traceutil/trace.go:171","msg":"trace[336346256] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1391; }","duration":"909.090179ms","start":"2026-06-25T22:25:54.273118Z","end":"2026-06-25T22:25:55.182208Z","steps":["trace[336346256] 'agreement among raft nodes before linearized reading' (duration: 908.913715ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:25:55.18224Z","caller":"traceutil/trace.go:171","msg":"trace[1480123007] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1391; }","duration":"915.710009ms","start":"2026-06-25T22:25:54.266516Z","end":"2026-06-25T22:25:55.182226Z","steps":["trace[1480123007] 'agreement among raft nodes before linearized reading' (duration: 915.561136ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:25:55.18228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:25:54.273095Z","time spent":"909.175191ms","remote":"127.0.0.1:49416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-25T22:25:55.182006Z","caller":"traceutil/trace.go:171","msg":"trace[125210089] transaction","detail":"{read_only:false; response_revision:1391; number_of_response:1; }","duration":"975.74937ms","start":"2026-06-25T22:25:54.206216Z","end":"2026-06-25T22:25:55.181965Z","steps":["trace[125210089] 'process raft request' (duration: 552.858298ms)","trace[125210089] 'compare' (duration: 421.235814ms)"],"step_count":2} {"level":"warn","ts":"2026-06-25T22:25:55.182426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"915.217319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-25T22:25:55.182529Z","caller":"traceutil/trace.go:171","msg":"trace[1228903741] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1391; }","duration":"915.593086ms","start":"2026-06-25T22:25:54.266917Z","end":"2026-06-25T22:25:55.18251Z","steps":["trace[1228903741] 'agreement among raft nodes before linearized reading' (duration: 915.094265ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:25:55.182059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.283823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-25T22:25:55.182612Z","caller":"traceutil/trace.go:171","msg":"trace[891649494] 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:1391; }","duration":"232.903947ms","start":"2026-06-25T22:25:54.949695Z","end":"2026-06-25T22:25:55.182599Z","steps":["trace[891649494] 'agreement among raft nodes before linearized reading' (duration: 232.253453ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:25:55.182447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:25:54.206203Z","time spent":"976.122858ms","remote":"127.0.0.1:49416","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-25T22:25:55.182284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:25:54.26649Z","time spent":"915.783691ms","remote":"127.0.0.1:49416","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-06-25T22:25:55.182744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:25:54.266872Z","time spent":"915.861602ms","remote":"127.0.0.1:49168","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-25T22:25:55.595773Z","caller":"traceutil/trace.go:171","msg":"trace[143388178] transaction","detail":"{read_only:false; response_revision:1392; number_of_response:1; }","duration":"408.431874ms","start":"2026-06-25T22:25:55.187294Z","end":"2026-06-25T22:25:55.595725Z","steps":["trace[143388178] 'process raft request' (duration: 383.239883ms)","trace[143388178] 'compare' (duration: 25.068768ms)"],"step_count":2} {"level":"warn","ts":"2026-06-25T22:25:55.596184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:25:55.187277Z","time spent":"408.839124ms","remote":"127.0.0.1:49416","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-25T22:25:55.928843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.961675ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-25T22:25:55.929111Z","caller":"traceutil/trace.go:171","msg":"trace[2007618265] linearizableReadLoop","detail":"{readStateIndex:1454; appliedIndex:1450; }","duration":"663.029103ms","start":"2026-06-25T22:25:55.266062Z","end":"2026-06-25T22:25:55.929091Z","steps":["trace[2007618265] 'read index received' (duration: 304.629522ms)","trace[2007618265] 'applied index is now lower than readState.Index' (duration: 358.398601ms)"],"step_count":2} {"level":"info","ts":"2026-06-25T22:25:55.9293Z","caller":"traceutil/trace.go:171","msg":"trace[1109497741] transaction","detail":"{read_only:false; response_revision:1393; number_of_response:1; }","duration":"741.810988ms","start":"2026-06-25T22:25:55.18747Z","end":"2026-06-25T22:25:55.929281Z","steps":["trace[1109497741] 'process raft request' (duration: 622.335411ms)","trace[1109497741] 'compare' (duration: 118.855203ms)"],"step_count":2} {"level":"warn","ts":"2026-06-25T22:25:55.929398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:25:55.187442Z","time spent":"741.90869ms","remote":"127.0.0.1:49416","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-25T22:25:55.929497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"663.420232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-25T22:25:55.929575Z","caller":"traceutil/trace.go:171","msg":"trace[1676367256] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1395; }","duration":"663.531415ms","start":"2026-06-25T22:25:55.266027Z","end":"2026-06-25T22:25:55.929558Z","steps":["trace[1676367256] 'agreement among raft nodes before linearized reading' (duration: 663.375792ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:25:55.929618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:25:55.266011Z","time spent":"663.600776ms","remote":"127.0.0.1:49176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-25T22:25:55.929765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.149841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-25T22:25:55.929818Z","caller":"traceutil/trace.go:171","msg":"trace[1758779985] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:1395; }","duration":"454.265694ms","start":"2026-06-25T22:25:55.47554Z","end":"2026-06-25T22:25:55.929806Z","steps":["trace[1758779985] 'agreement among raft nodes before linearized reading' (duration: 454.159331ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:25:55.929811Z","caller":"traceutil/trace.go:171","msg":"trace[800245554] transaction","detail":"{read_only:false; response_revision:1394; number_of_response:1; }","duration":"741.923271ms","start":"2026-06-25T22:25:55.187875Z","end":"2026-06-25T22:25:55.929799Z","steps":["trace[800245554] 'process raft request' (duration: 741.068501ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:25:55.929853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:25:55.475521Z","time spent":"454.323285ms","remote":"127.0.0.1:49440","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":28,"request content":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true "} {"level":"warn","ts":"2026-06-25T22:25:55.929909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:25:55.18786Z","time spent":"741.991943ms","remote":"127.0.0.1:49416","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-25T22:25:55.930054Z","caller":"traceutil/trace.go:171","msg":"trace[304306560] transaction","detail":"{read_only:false; response_revision:1395; number_of_response:1; }","duration":"741.572764ms","start":"2026-06-25T22:25:55.18847Z","end":"2026-06-25T22:25:55.930043Z","steps":["trace[304306560] 'process raft request' (duration: 740.55224ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:25:55.930104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:25:55.188441Z","time spent":"741.636265ms","remote":"127.0.0.1:49416","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-25T22:25:55.930122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.124572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-25T22:25:55.930168Z","caller":"traceutil/trace.go:171","msg":"trace[1527149231] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1395; }","duration":"229.201103ms","start":"2026-06-25T22:25:55.700956Z","end":"2026-06-25T22:25:55.930157Z","steps":["trace[1527149231] 'agreement among raft nodes before linearized reading' (duration: 229.124922ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:25:55.930406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.539881ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.81\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-06-25T22:25:55.930441Z","caller":"traceutil/trace.go:171","msg":"trace[67380160] range","detail":"{range_begin:/registry/masterleases/199.19.213.81; range_end:; response_count:1; response_revision:1395; }","duration":"413.613713ms","start":"2026-06-25T22:25:55.516818Z","end":"2026-06-25T22:25:55.930432Z","steps":["trace[67380160] 'agreement among raft nodes before linearized reading' (duration: 413.49056ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:25:55.930468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:25:55.516796Z","time spent":"413.665483ms","remote":"127.0.0.1:49180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.19.213.81\" "} {"level":"info","ts":"2026-06-25T22:25:57.580654Z","caller":"traceutil/trace.go:171","msg":"trace[1048620501] linearizableReadLoop","detail":"{readStateIndex:1458; appliedIndex:1457; }","duration":"313.677978ms","start":"2026-06-25T22:25:57.266925Z","end":"2026-06-25T22:25:57.580603Z","steps":["trace[1048620501] 'read index received' (duration: 313.603757ms)","trace[1048620501] 'applied index is now lower than readState.Index' (duration: 73.681µs)"],"step_count":2} {"level":"info","ts":"2026-06-25T22:25:57.581102Z","caller":"traceutil/trace.go:171","msg":"trace[1206257199] transaction","detail":"{read_only:false; response_revision:1398; number_of_response:1; }","duration":"389.594498ms","start":"2026-06-25T22:25:57.191496Z","end":"2026-06-25T22:25:57.58109Z","steps":["trace[1206257199] 'process raft request' (duration: 388.958844ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:25:57.581202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:25:57.191474Z","time spent":"389.660339ms","remote":"127.0.0.1:49416","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-25T22:25:57.581524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.616239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-25T22:25:57.581561Z","caller":"traceutil/trace.go:171","msg":"trace[1507138163] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1398; }","duration":"314.6895ms","start":"2026-06-25T22:25:57.266862Z","end":"2026-06-25T22:25:57.581552Z","steps":["trace[1507138163] 'agreement among raft nodes before linearized reading' (duration: 314.630919ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:25:57.581584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:25:57.266818Z","time spent":"314.761902ms","remote":"127.0.0.1:49176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-25T22:25:57.581629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.998538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-25T22:25:57.581769Z","caller":"traceutil/trace.go:171","msg":"trace[1016511507] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:1398; }","duration":"300.176602ms","start":"2026-06-25T22:25:57.281548Z","end":"2026-06-25T22:25:57.581724Z","steps":["trace[1016511507] 'agreement among raft nodes before linearized reading' (duration: 299.993138ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:25:57.58185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:25:57.28153Z","time spent":"300.282754ms","remote":"127.0.0.1:54898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":4,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true "} {"level":"warn","ts":"2026-06-25T22:25:57.719894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.46082ms","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-06-25T22:25:57.719977Z","caller":"traceutil/trace.go:171","msg":"trace[1551950519] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1398; }","duration":"120.592663ms","start":"2026-06-25T22:25:57.599366Z","end":"2026-06-25T22:25:57.719958Z","steps":["trace[1551950519] 'range keys from in-memory index tree' (duration: 120.280926ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:25:58.743724Z","caller":"traceutil/trace.go:171","msg":"trace[794655766] transaction","detail":"{read_only:false; response_revision:1411; number_of_response:1; }","duration":"157.431047ms","start":"2026-06-25T22:25:58.586271Z","end":"2026-06-25T22:25:58.743702Z","steps":["trace[794655766] 'process raft request' (duration: 157.272684ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:26:07.366724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.096487555s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-25T22:26:07.366944Z","caller":"traceutil/trace.go:171","msg":"trace[856641817] transaction","detail":"{read_only:false; response_revision:1470; number_of_response:1; }","duration":"1.317452012s","start":"2026-06-25T22:26:06.049448Z","end":"2026-06-25T22:26:07.3669Z","steps":["trace[856641817] 'process raft request' (duration: 220.708491ms)","trace[856641817] 'compare' (duration: 1.096215109s)"],"step_count":2} {"level":"warn","ts":"2026-06-25T22:26:07.367117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:26:06.04941Z","time spent":"1.317590765s","remote":"127.0.0.1:49416","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-25T22:26:07.367855Z","caller":"traceutil/trace.go:171","msg":"trace[1065077953] transaction","detail":"{read_only:false; response_revision:1471; number_of_response:1; }","duration":"1.318273731s","start":"2026-06-25T22:26:06.049563Z","end":"2026-06-25T22:26:07.367837Z","steps":["trace[1065077953] 'process raft request' (duration: 1.317271007s)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:26:07.367955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:26:06.049556Z","time spent":"1.318347073s","remote":"127.0.0.1:49416","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-25T22:26:07.368015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.240052599s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-25T22:26:07.368038Z","caller":"traceutil/trace.go:171","msg":"trace[987668132] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1471; }","duration":"1.24012206s","start":"2026-06-25T22:26:06.12791Z","end":"2026-06-25T22:26:07.368032Z","steps":["trace[987668132] 'agreement among raft nodes before linearized reading' (duration: 1.240076129s)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:26:07.368058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:26:06.127887Z","time spent":"1.240165551s","remote":"127.0.0.1:49270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":28,"request content":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true "} {"level":"info","ts":"2026-06-25T22:26:07.367964Z","caller":"traceutil/trace.go:171","msg":"trace[645541340] linearizableReadLoop","detail":"{readStateIndex:1533; appliedIndex:1531; }","duration":"1.239994807s","start":"2026-06-25T22:26:06.127957Z","end":"2026-06-25T22:26:07.367952Z","steps":["trace[645541340] 'read index received' (duration: 142.181562ms)","trace[645541340] 'applied index is now lower than readState.Index' (duration: 1.097811465s)"],"step_count":2} {"level":"warn","ts":"2026-06-25T22:26:07.368254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.100927316s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-25T22:26:07.36827Z","caller":"traceutil/trace.go:171","msg":"trace[1098520758] transaction","detail":"{read_only:false; response_revision:1472; number_of_response:1; }","duration":"1.049197454s","start":"2026-06-25T22:26:06.319053Z","end":"2026-06-25T22:26:07.36825Z","steps":["trace[1098520758] 'process raft request' (duration: 1.04903188s)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:26:07.368315Z","caller":"traceutil/trace.go:171","msg":"trace[2013454480] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1472; }","duration":"1.101048279s","start":"2026-06-25T22:26:06.267253Z","end":"2026-06-25T22:26:07.368302Z","steps":["trace[2013454480] 'agreement among raft nodes before linearized reading' (duration: 1.100937427s)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:26:07.368304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.085965047s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-25T22:26:07.368369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:26:06.319022Z","time spent":"1.049288606s","remote":"127.0.0.1:49416","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-25T22:26:07.368361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"498.835563ms","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-06-25T22:26:07.368422Z","caller":"traceutil/trace.go:171","msg":"trace[114691402] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1472; }","duration":"498.943925ms","start":"2026-06-25T22:26:06.869464Z","end":"2026-06-25T22:26:07.368408Z","steps":["trace[114691402] 'agreement among raft nodes before linearized reading' (duration: 498.772662ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:26:07.368423Z","caller":"traceutil/trace.go:171","msg":"trace[2068952812] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:1472; }","duration":"1.086124871s","start":"2026-06-25T22:26:06.282268Z","end":"2026-06-25T22:26:07.368393Z","steps":["trace[2068952812] 'agreement among raft nodes before linearized reading' (duration: 1.085976518s)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:26:07.368467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:26:06.86944Z","time spent":"499.015337ms","remote":"127.0.0.1:49416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":555,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-06-25T22:26:07.368474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:26:06.28224Z","time spent":"1.086220013s","remote":"127.0.0.1:49570","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":28,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "} {"level":"warn","ts":"2026-06-25T22:26:07.368347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:26:06.267233Z","time spent":"1.10110748s","remote":"127.0.0.1:49176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-25T22:26:07.605007Z","caller":"traceutil/trace.go:171","msg":"trace[1257754438] transaction","detail":"{read_only:false; response_revision:1473; number_of_response:1; }","duration":"230.784249ms","start":"2026-06-25T22:26:07.374205Z","end":"2026-06-25T22:26:07.604989Z","steps":["trace[1257754438] 'process raft request' (duration: 230.683266ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:26:07.605031Z","caller":"traceutil/trace.go:171","msg":"trace[612851260] linearizableReadLoop","detail":"{readStateIndex:1535; appliedIndex:1535; }","duration":"229.121991ms","start":"2026-06-25T22:26:07.37588Z","end":"2026-06-25T22:26:07.605002Z","steps":["trace[612851260] 'read index received' (duration: 229.112761ms)","trace[612851260] 'applied index is now lower than readState.Index' (duration: 7.52µs)"],"step_count":2} {"level":"warn","ts":"2026-06-25T22:26:07.605141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.250813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-25T22:26:07.605361Z","caller":"traceutil/trace.go:171","msg":"trace[1509895426] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1473; }","duration":"229.495749ms","start":"2026-06-25T22:26:07.375844Z","end":"2026-06-25T22:26:07.60534Z","steps":["trace[1509895426] 'agreement among raft nodes before linearized reading' (duration: 229.256484ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:27:33.706895Z","caller":"traceutil/trace.go:171","msg":"trace[1959090467] transaction","detail":"{read_only:false; response_revision:1866; number_of_response:1; }","duration":"161.474281ms","start":"2026-06-25T22:27:33.545397Z","end":"2026-06-25T22:27:33.706872Z","steps":["trace[1959090467] 'process raft request' (duration: 161.307928ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:27:33.851423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.45541ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-25T22:27:33.85175Z","caller":"traceutil/trace.go:171","msg":"trace[1556073944] transaction","detail":"{read_only:false; response_revision:1867; number_of_response:1; }","duration":"150.367167ms","start":"2026-06-25T22:27:33.701359Z","end":"2026-06-25T22:27:33.851726Z","steps":["trace[1556073944] 'process raft request' (duration: 46.515637ms)","trace[1556073944] 'compare' (duration: 103.298727ms)"],"step_count":2} {"level":"info","ts":"2026-06-25T22:27:33.852101Z","caller":"traceutil/trace.go:171","msg":"trace[1387929891] transaction","detail":"{read_only:false; response_revision:1868; number_of_response:1; }","duration":"124.176817ms","start":"2026-06-25T22:27:33.72791Z","end":"2026-06-25T22:27:33.852087Z","steps":["trace[1387929891] 'process raft request' (duration: 123.621815ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:28:14.452132Z","caller":"traceutil/trace.go:171","msg":"trace[1635612469] transaction","detail":"{read_only:false; response_revision:2056; number_of_response:1; }","duration":"117.029463ms","start":"2026-06-25T22:28:14.335081Z","end":"2026-06-25T22:28:14.45211Z","steps":["trace[1635612469] 'process raft request' (duration: 116.89581ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:29:12.56444Z","caller":"traceutil/trace.go:171","msg":"trace[106530644] transaction","detail":"{read_only:false; response_revision:2320; number_of_response:1; }","duration":"145.354274ms","start":"2026-06-25T22:29:12.419064Z","end":"2026-06-25T22:29:12.564418Z","steps":["trace[106530644] 'process raft request' (duration: 113.047687ms)","trace[106530644] 'compare' (duration: 32.201565ms)"],"step_count":2} {"level":"warn","ts":"2026-06-25T22:29:49.098806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.311418ms","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-06-25T22:29:49.098977Z","caller":"traceutil/trace.go:171","msg":"trace[824467268] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2509; }","duration":"149.449721ms","start":"2026-06-25T22:29:48.949439Z","end":"2026-06-25T22:29:49.098889Z","steps":["trace[824467268] 'range keys from in-memory index tree' (duration: 149.132474ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:29:49.099114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.318453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:473"} {"level":"info","ts":"2026-06-25T22:29:49.099213Z","caller":"traceutil/trace.go:171","msg":"trace[1730973112] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2509; }","duration":"113.469466ms","start":"2026-06-25T22:29:48.985724Z","end":"2026-06-25T22:29:49.099193Z","steps":["trace[1730973112] 'range keys from in-memory index tree' (duration: 113.113368ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:29:56.757834Z","caller":"traceutil/trace.go:171","msg":"trace[1465563947] transaction","detail":"{read_only:false; response_revision:2550; number_of_response:1; }","duration":"132.881652ms","start":"2026-06-25T22:29:56.624922Z","end":"2026-06-25T22:29:56.757803Z","steps":["trace[1465563947] 'process raft request' (duration: 132.721458ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:29:57.420304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.122492ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-25T22:29:57.420494Z","caller":"traceutil/trace.go:171","msg":"trace[1387787262] linearizableReadLoop","detail":"{readStateIndex:2661; appliedIndex:2660; }","duration":"285.360515ms","start":"2026-06-25T22:29:57.135013Z","end":"2026-06-25T22:29:57.420373Z","steps":["trace[1387787262] 'read index received' (duration: 28.032409ms)","trace[1387787262] 'applied index is now lower than readState.Index' (duration: 257.327096ms)"],"step_count":2} {"level":"warn","ts":"2026-06-25T22:29:57.420677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.671392ms","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:531"} {"level":"info","ts":"2026-06-25T22:29:57.420705Z","caller":"traceutil/trace.go:171","msg":"trace[1068750297] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2552; }","duration":"285.737124ms","start":"2026-06-25T22:29:57.134959Z","end":"2026-06-25T22:29:57.420696Z","steps":["trace[1068750297] 'agreement among raft nodes before linearized reading' (duration: 285.614571ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:29:57.420602Z","caller":"traceutil/trace.go:171","msg":"trace[1702303680] transaction","detail":"{read_only:false; response_revision:2552; number_of_response:1; }","duration":"459.110528ms","start":"2026-06-25T22:29:56.961472Z","end":"2026-06-25T22:29:57.420582Z","steps":["trace[1702303680] 'process raft request' (duration: 201.628168ms)","trace[1702303680] 'compare' (duration: 256.755183ms)"],"step_count":2} {"level":"warn","ts":"2026-06-25T22:29:57.420803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:29:56.961447Z","time spent":"459.296582ms","remote":"127.0.0.1:49416","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-25T22:29:57.420943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.3308ms","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-06-25T22:29:57.420971Z","caller":"traceutil/trace.go:171","msg":"trace[828340538] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2552; }","duration":"284.406212ms","start":"2026-06-25T22:29:57.136557Z","end":"2026-06-25T22:29:57.420963Z","steps":["trace[828340538] 'agreement among raft nodes before linearized reading' (duration: 284.32496ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:29:57.421084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.637096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-06-25T22:29:57.421066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.814275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-25T22:29:57.421108Z","caller":"traceutil/trace.go:171","msg":"trace[673023734] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2552; }","duration":"106.688707ms","start":"2026-06-25T22:29:57.314412Z","end":"2026-06-25T22:29:57.421101Z","steps":["trace[673023734] 'agreement among raft nodes before linearized reading' (duration: 106.618765ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:29:57.42113Z","caller":"traceutil/trace.go:171","msg":"trace[1022978552] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:2552; }","duration":"102.936878ms","start":"2026-06-25T22:29:57.318179Z","end":"2026-06-25T22:29:57.421116Z","steps":["trace[1022978552] 'agreement among raft nodes before linearized reading' (duration: 102.797405ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:29:57.421182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.797964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-25T22:29:57.421204Z","caller":"traceutil/trace.go:171","msg":"trace[981592247] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2552; }","duration":"153.863665ms","start":"2026-06-25T22:29:57.267334Z","end":"2026-06-25T22:29:57.421197Z","steps":["trace[981592247] 'agreement among raft nodes before linearized reading' (duration: 153.831465ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:29:57.421535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"574.12729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-06-25T22:29:57.42158Z","caller":"traceutil/trace.go:171","msg":"trace[1181357772] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2551; }","duration":"574.220822ms","start":"2026-06-25T22:29:56.847348Z","end":"2026-06-25T22:29:57.421569Z","steps":["trace[1181357772] 'range keys from in-memory index tree' (duration: 572.40224ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:29:57.421603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:29:56.847326Z","time spent":"574.269564ms","remote":"127.0.0.1:49416","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":"info","ts":"2026-06-25T22:30:27.758306Z","caller":"traceutil/trace.go:171","msg":"trace[432399578] transaction","detail":"{read_only:false; response_revision:2700; number_of_response:1; }","duration":"136.218701ms","start":"2026-06-25T22:30:27.622055Z","end":"2026-06-25T22:30:27.758274Z","steps":["trace[432399578] 'process raft request' (duration: 135.932974ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:30:27.758337Z","caller":"traceutil/trace.go:171","msg":"trace[955748509] transaction","detail":"{read_only:false; response_revision:2701; number_of_response:1; }","duration":"136.17546ms","start":"2026-06-25T22:30:27.622134Z","end":"2026-06-25T22:30:27.758309Z","steps":["trace[955748509] 'process raft request' (duration: 135.963585ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:30:27.75843Z","caller":"traceutil/trace.go:171","msg":"trace[372707059] linearizableReadLoop","detail":"{readStateIndex:2817; appliedIndex:2814; }","duration":"115.693899ms","start":"2026-06-25T22:30:27.642712Z","end":"2026-06-25T22:30:27.758405Z","steps":["trace[372707059] 'read index received' (duration: 28.947221ms)","trace[372707059] 'applied index is now lower than readState.Index' (duration: 86.744018ms)"],"step_count":2} {"level":"warn","ts":"2026-06-25T22:30:27.758574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.821382ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" ","response":"range_response_count:1 size:185"} {"level":"warn","ts":"2026-06-25T22:30:27.758596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.214296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-06-25T22:30:27.75865Z","caller":"traceutil/trace.go:171","msg":"trace[800921208] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:2701; }","duration":"106.284047ms","start":"2026-06-25T22:30:27.652352Z","end":"2026-06-25T22:30:27.758636Z","steps":["trace[800921208] 'agreement among raft nodes before linearized reading' (duration: 106.191555ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:30:27.758648Z","caller":"traceutil/trace.go:171","msg":"trace[1564235060] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/kube-proxy; range_end:; response_count:1; response_revision:2701; }","duration":"115.953995ms","start":"2026-06-25T22:30:27.642673Z","end":"2026-06-25T22:30:27.758627Z","steps":["trace[1564235060] 'agreement among raft nodes before linearized reading' (duration: 115.821832ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:30:28.441558Z","caller":"traceutil/trace.go:171","msg":"trace[92849206] linearizableReadLoop","detail":"{readStateIndex:2819; appliedIndex:2818; }","duration":"129.773119ms","start":"2026-06-25T22:30:28.31176Z","end":"2026-06-25T22:30:28.441533Z","steps":["trace[92849206] 'read index received' (duration: 129.595774ms)","trace[92849206] 'applied index is now lower than readState.Index' (duration: 176.205µs)"],"step_count":2} {"level":"info","ts":"2026-06-25T22:30:28.441731Z","caller":"traceutil/trace.go:171","msg":"trace[1995728332] transaction","detail":"{read_only:false; response_revision:2703; number_of_response:1; }","duration":"143.40061ms","start":"2026-06-25T22:30:28.298284Z","end":"2026-06-25T22:30:28.441685Z","steps":["trace[1995728332] 'process raft request' (duration: 142.99986ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:30:28.441846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.561822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-25T22:30:28.441934Z","caller":"traceutil/trace.go:171","msg":"trace[1853830013] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:2703; }","duration":"120.696736ms","start":"2026-06-25T22:30:28.321218Z","end":"2026-06-25T22:30:28.441914Z","steps":["trace[1853830013] 'agreement among raft nodes before linearized reading' (duration: 120.528602ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:30:28.442359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.574749ms","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:130 size:100114"} {"level":"info","ts":"2026-06-25T22:30:28.442425Z","caller":"traceutil/trace.go:171","msg":"trace[1922943211] range","detail":"{range_begin:/registry/events/kube-system/; range_end:/registry/events/kube-system0; response_count:130; response_revision:2703; }","duration":"130.686641ms","start":"2026-06-25T22:30:28.311723Z","end":"2026-06-25T22:30:28.442409Z","steps":["trace[1922943211] 'agreement among raft nodes before linearized reading' (duration: 129.938773ms)"],"step_count":1}