{"level":"warn","ts":"2026-06-10T08:30:59.395943Z","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-10T08:30:59.396048Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.68: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.68:2380","--initial-cluster=instance=https://199.19.213.68:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.68:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.68: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-10T08:30:59.396116Z","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-10T08:30:59.396124Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.68:2380"]} {"level":"info","ts":"2026-06-10T08:30:59.396145Z","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-10T08:30:59.396762Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.68:2379"]} {"level":"info","ts":"2026-06-10T08:30:59.396836Z","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.68:2380"],"listen-peer-urls":["https://199.19.213.68:2380"],"advertise-client-urls":["https://199.19.213.68:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.68:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.68: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-10T08:30:59.402872Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.766184ms"} {"level":"info","ts":"2026-06-10T08:30:59.407969Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"78a0acde880f698","cluster-id":"45d27515d88ba308"} {"level":"info","ts":"2026-06-10T08:30:59.408053Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"78a0acde880f698 switched to configuration voters=()"} {"level":"info","ts":"2026-06-10T08:30:59.408077Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"78a0acde880f698 became follower at term 0"} {"level":"info","ts":"2026-06-10T08:30:59.40809Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 78a0acde880f698 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-10T08:30:59.4081Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"78a0acde880f698 became follower at term 1"} {"level":"info","ts":"2026-06-10T08:30:59.408141Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"78a0acde880f698 switched to configuration voters=(543258584536905368)"} {"level":"warn","ts":"2026-06-10T08:30:59.412408Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-10T08:30:59.414094Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-10T08:30:59.415572Z","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-10T08:30:59.419858Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"78a0acde880f698","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-10T08:30:59.421221Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"78a0acde880f698","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-10T08:30:59.42454Z","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-10T08:30:59.424655Z","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-10T08:30:59.424674Z","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-10T08:30:59.426301Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"78a0acde880f698 switched to configuration voters=(543258584536905368)"} {"level":"info","ts":"2026-06-10T08:30:59.426901Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"45d27515d88ba308","local-member-id":"78a0acde880f698","added-peer-id":"78a0acde880f698","added-peer-peer-urls":["https://199.19.213.68:2380"]} {"level":"info","ts":"2026-06-10T08:30:59.427984Z","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-10T08:30:59.428238Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"78a0acde880f698","initial-advertise-peer-urls":["https://199.19.213.68:2380"],"listen-peer-urls":["https://199.19.213.68:2380"],"advertise-client-urls":["https://199.19.213.68:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.68:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-10T08:30:59.428264Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-10T08:30:59.428336Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.68:2380"} {"level":"info","ts":"2026-06-10T08:30:59.428345Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.68:2380"} {"level":"info","ts":"2026-06-10T08:30:59.810007Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"78a0acde880f698 is starting a new election at term 1"} {"level":"info","ts":"2026-06-10T08:30:59.810599Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"78a0acde880f698 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-10T08:30:59.810635Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"78a0acde880f698 received MsgPreVoteResp from 78a0acde880f698 at term 1"} {"level":"info","ts":"2026-06-10T08:30:59.810655Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"78a0acde880f698 became candidate at term 2"} {"level":"info","ts":"2026-06-10T08:30:59.810731Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"78a0acde880f698 received MsgVoteResp from 78a0acde880f698 at term 2"} {"level":"info","ts":"2026-06-10T08:30:59.810751Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"78a0acde880f698 became leader at term 2"} {"level":"info","ts":"2026-06-10T08:30:59.810771Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 78a0acde880f698 elected leader 78a0acde880f698 at term 2"} {"level":"info","ts":"2026-06-10T08:30:59.811605Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-10T08:30:59.812786Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-10T08:30:59.81291Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-10T08:30:59.813306Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-10T08:30:59.813349Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-10T08:30:59.812753Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"78a0acde880f698","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.68:2379]}","request-path":"/0/members/78a0acde880f698/attributes","cluster-id":"45d27515d88ba308","publish-timeout":"7s"} {"level":"info","ts":"2026-06-10T08:30:59.813107Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"45d27515d88ba308","local-member-id":"78a0acde880f698","cluster-version":"3.5"} {"level":"info","ts":"2026-06-10T08:30:59.813553Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-10T08:30:59.813595Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-10T08:30:59.816953Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-10T08:30:59.818985Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.68:2379"} {"level":"info","ts":"2026-06-10T08:31:01.726604Z","caller":"traceutil/trace.go:171","msg":"trace[2093003100] transaction","detail":"{read_only:false; response_revision:49; number_of_response:1; }","duration":"106.396425ms","start":"2026-06-10T08:31:01.62016Z","end":"2026-06-10T08:31:01.726557Z","steps":["trace[2093003100] 'process raft request' (duration: 106.303092ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:31:01.726873Z","caller":"traceutil/trace.go:171","msg":"trace[1777328395] transaction","detail":"{read_only:false; response_revision:48; number_of_response:1; }","duration":"109.661337ms","start":"2026-06-10T08:31:01.617174Z","end":"2026-06-10T08:31:01.726836Z","steps":["trace[1777328395] 'process raft request' (duration: 64.072761ms)","trace[1777328395] 'compare' (duration: 45.03161ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:31:06.14852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.79751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:5892"} {"level":"info","ts":"2026-06-10T08:31:06.148626Z","caller":"traceutil/trace.go:171","msg":"trace[1620239748] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:271; }","duration":"123.983915ms","start":"2026-06-10T08:31:06.024623Z","end":"2026-06-10T08:31:06.148606Z","steps":["trace[1620239748] 'range keys from in-memory index tree' (duration: 123.668156ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:31:06.1492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.395893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/disruption-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-06-10T08:31:06.149235Z","caller":"traceutil/trace.go:171","msg":"trace[177538761] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/disruption-controller; range_end:; response_count:1; response_revision:271; }","duration":"184.465584ms","start":"2026-06-10T08:31:05.964761Z","end":"2026-06-10T08:31:06.149226Z","steps":["trace[177538761] 'range keys from in-memory index tree' (duration: 184.282378ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:31:06.415277Z","caller":"traceutil/trace.go:171","msg":"trace[1421336550] transaction","detail":"{read_only:false; number_of_response:0; response_revision:271; }","duration":"389.502034ms","start":"2026-06-10T08:31:06.025754Z","end":"2026-06-10T08:31:06.415256Z","steps":["trace[1421336550] 'process raft request' (duration: 389.425232ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:31:06.415735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:31:06.025735Z","time spent":"389.614408ms","remote":"127.0.0.1:46664","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-10T08:31:07.299596Z","caller":"traceutil/trace.go:171","msg":"trace[421945868] linearizableReadLoop","detail":"{readStateIndex:284; appliedIndex:281; }","duration":"1.147406762s","start":"2026-06-10T08:31:06.152165Z","end":"2026-06-10T08:31:07.299572Z","steps":["trace[421945868] 'read index received' (duration: 263.032039ms)","trace[421945868] 'applied index is now lower than readState.Index' (duration: 884.373893ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:31:07.299638Z","caller":"traceutil/trace.go:171","msg":"trace[1476759334] transaction","detail":"{read_only:false; number_of_response:0; response_revision:271; }","duration":"1.273249109s","start":"2026-06-10T08:31:06.026315Z","end":"2026-06-10T08:31:07.299564Z","steps":["trace[1476759334] 'process raft request' (duration: 1.273061854s)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:31:07.299725Z","caller":"traceutil/trace.go:171","msg":"trace[975299142] transaction","detail":"{read_only:false; number_of_response:0; response_revision:271; }","duration":"1.273379153s","start":"2026-06-10T08:31:06.026336Z","end":"2026-06-10T08:31:07.299715Z","steps":["trace[975299142] 'process raft request' (duration: 1.273129526s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:31:07.299785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:31:06.026292Z","time spent":"1.273425315s","remote":"127.0.0.1:46664","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-10T08:31:07.299816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:31:06.026311Z","time spent":"1.273443315s","remote":"127.0.0.1:46664","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-10T08:31:07.300007Z","caller":"traceutil/trace.go:171","msg":"trace[1899564545] transaction","detail":"{read_only:false; response_revision:272; number_of_response:1; }","duration":"1.133951718s","start":"2026-06-10T08:31:06.166045Z","end":"2026-06-10T08:31:07.299997Z","steps":["trace[1899564545] 'process raft request' (duration: 1.133448215s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:31:07.30021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:31:06.166028Z","time spent":"1.134000011s","remote":"127.0.0.1:46664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7087,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T08:31:07.300379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"883.456906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:7102"} {"level":"info","ts":"2026-06-10T08:31:07.300423Z","caller":"traceutil/trace.go:171","msg":"trace[577213065] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:272; }","duration":"883.542069ms","start":"2026-06-10T08:31:06.416868Z","end":"2026-06-10T08:31:07.300411Z","steps":["trace[577213065] 'agreement among raft nodes before linearized reading' (duration: 883.446276ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:31:07.300456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:31:06.416847Z","time spent":"883.601661ms","remote":"127.0.0.1:46664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":7124,"request content":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" "} {"level":"warn","ts":"2026-06-10T08:31:07.300521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.148352788s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cronjob-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:31:07.300556Z","caller":"traceutil/trace.go:171","msg":"trace[142271081] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cronjob-controller; range_end:; response_count:0; response_revision:272; }","duration":"1.148420881s","start":"2026-06-10T08:31:06.152124Z","end":"2026-06-10T08:31:07.300545Z","steps":["trace[142271081] 'agreement among raft nodes before linearized reading' (duration: 1.148369439s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:31:07.300584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:31:06.152108Z","time spent":"1.148470342s","remote":"127.0.0.1:46686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":0,"response size":27,"request content":"key:\"/registry/serviceaccounts/kube-system/cronjob-controller\" "} {"level":"warn","ts":"2026-06-10T08:31:07.300611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.237596ms","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-10T08:31:07.300642Z","caller":"traceutil/trace.go:171","msg":"trace[1626474548] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:272; }","duration":"376.310469ms","start":"2026-06-10T08:31:06.924323Z","end":"2026-06-10T08:31:07.300633Z","steps":["trace[1626474548] 'agreement among raft nodes before linearized reading' (duration: 376.254198ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:31:07.300668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:31:06.924301Z","time spent":"376.36141ms","remote":"127.0.0.1:46752","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-10T08:31:07.635783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.060635ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-10T08:31:07.636046Z","caller":"traceutil/trace.go:171","msg":"trace[864886357] transaction","detail":"{read_only:false; response_revision:274; number_of_response:1; }","duration":"329.086067ms","start":"2026-06-10T08:31:07.306942Z","end":"2026-06-10T08:31:07.636028Z","steps":["trace[864886357] 'process raft request' (duration: 328.937162ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:31:07.636106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:31:07.306934Z","time spent":"329.146938ms","remote":"127.0.0.1:46686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":186,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-10T08:31:07.636176Z","caller":"traceutil/trace.go:171","msg":"trace[1720908892] transaction","detail":"{read_only:false; response_revision:273; number_of_response:1; }","duration":"330.885608ms","start":"2026-06-10T08:31:07.305258Z","end":"2026-06-10T08:31:07.636144Z","steps":["trace[1720908892] 'process raft request' (duration: 128.233846ms)","trace[1720908892] 'compare' (duration: 201.88837ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:31:07.636316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:31:07.305248Z","time spent":"330.994081ms","remote":"127.0.0.1:46752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T08:31:07.636459Z","caller":"traceutil/trace.go:171","msg":"trace[902625523] transaction","detail":"{read_only:false; response_revision:275; number_of_response:1; }","duration":"326.452932ms","start":"2026-06-10T08:31:07.309995Z","end":"2026-06-10T08:31:07.636448Z","steps":["trace[902625523] 'process raft request' (duration: 325.941827ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:31:07.636519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:31:07.309957Z","time spent":"326.528894ms","remote":"127.0.0.1:46664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4115,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T08:31:40.38275Z","caller":"traceutil/trace.go:171","msg":"trace[433390483] linearizableReadLoop","detail":"{readStateIndex:601; appliedIndex:600; }","duration":"286.820941ms","start":"2026-06-10T08:31:40.095912Z","end":"2026-06-10T08:31:40.382733Z","steps":["trace[433390483] 'read index received' (duration: 286.404819ms)","trace[433390483] 'applied index is now lower than readState.Index' (duration: 415.242µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:31:40.382869Z","caller":"traceutil/trace.go:171","msg":"trace[229727243] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"312.947892ms","start":"2026-06-10T08:31:40.069915Z","end":"2026-06-10T08:31:40.382863Z","steps":["trace[229727243] 'process raft request' (duration: 312.561331ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:31:40.382936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:31:40.069892Z","time spent":"312.997703ms","remote":"127.0.0.1:46564","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036023,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-10T08:31:40.383039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.86359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-10T08:31:40.383107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.20224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-10T08:31:40.383064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:31:40.383126Z","caller":"traceutil/trace.go:171","msg":"trace[1587106417] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:574; }","duration":"151.974143ms","start":"2026-06-10T08:31:40.231128Z","end":"2026-06-10T08:31:40.383103Z","steps":["trace[1587106417] 'agreement among raft nodes before linearized reading' (duration: 151.802039ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:31:40.383148Z","caller":"traceutil/trace.go:171","msg":"trace[898752213] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:574; }","duration":"152.285393ms","start":"2026-06-10T08:31:40.230849Z","end":"2026-06-10T08:31:40.383134Z","steps":["trace[898752213] 'agreement among raft nodes before linearized reading' (duration: 152.237522ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:31:40.383168Z","caller":"traceutil/trace.go:171","msg":"trace[562370029] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:574; }","duration":"281.668085ms","start":"2026-06-10T08:31:40.101481Z","end":"2026-06-10T08:31:40.38315Z","steps":["trace[562370029] 'agreement among raft nodes before linearized reading' (duration: 281.493249ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:31:40.383197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.690826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:31:40.383231Z","caller":"traceutil/trace.go:171","msg":"trace[1847349636] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:574; }","duration":"101.752167ms","start":"2026-06-10T08:31:40.281471Z","end":"2026-06-10T08:31:40.383223Z","steps":["trace[1847349636] 'agreement among raft nodes before linearized reading' (duration: 101.696436ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:31:40.383279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.565491ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:31:40.38331Z","caller":"traceutil/trace.go:171","msg":"trace[1361253678] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:574; }","duration":"127.659073ms","start":"2026-06-10T08:31:40.255642Z","end":"2026-06-10T08:31:40.383301Z","steps":["trace[1361253678] 'agreement among raft nodes before linearized reading' (duration: 127.608062ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:31:40.383342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.427078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:31:40.383366Z","caller":"traceutil/trace.go:171","msg":"trace[550494003] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:574; }","duration":"287.48515ms","start":"2026-06-10T08:31:40.095874Z","end":"2026-06-10T08:31:40.383359Z","steps":["trace[550494003] 'agreement among raft nodes before linearized reading' (duration: 287.449148ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:31:40.383412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.614802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:31:40.383443Z","caller":"traceutil/trace.go:171","msg":"trace[1662601471] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:574; }","duration":"152.650362ms","start":"2026-06-10T08:31:40.230783Z","end":"2026-06-10T08:31:40.383433Z","steps":["trace[1662601471] 'agreement among raft nodes before linearized reading' (duration: 152.598691ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:31:40.38346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.521532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:31:40.383479Z","caller":"traceutil/trace.go:171","msg":"trace[2139861265] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:574; }","duration":"101.580794ms","start":"2026-06-10T08:31:40.281893Z","end":"2026-06-10T08:31:40.383474Z","steps":["trace[2139861265] 'agreement among raft nodes before linearized reading' (duration: 101.550062ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:31:40.383512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.001584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-10T08:31:40.38351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.158496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-10T08:31:40.383558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.763775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-10T08:31:40.383564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.001125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:31:40.383573Z","caller":"traceutil/trace.go:171","msg":"trace[311115879] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:574; }","duration":"277.237509ms","start":"2026-06-10T08:31:40.106323Z","end":"2026-06-10T08:31:40.38356Z","steps":["trace[311115879] 'agreement among raft nodes before linearized reading' (duration: 277.144807ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:31:40.383586Z","caller":"traceutil/trace.go:171","msg":"trace[1377369523] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:574; }","duration":"102.063547ms","start":"2026-06-10T08:31:40.281518Z","end":"2026-06-10T08:31:40.383581Z","steps":["trace[1377369523] 'agreement among raft nodes before linearized reading' (duration: 102.028105ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:31:40.383591Z","caller":"traceutil/trace.go:171","msg":"trace[601547358] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:574; }","duration":"276.806877ms","start":"2026-06-10T08:31:40.106775Z","end":"2026-06-10T08:31:40.383582Z","steps":["trace[601547358] 'agreement among raft nodes before linearized reading' (duration: 276.760925ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:31:40.383607Z","caller":"traceutil/trace.go:171","msg":"trace[1853853228] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:574; }","duration":"128.028324ms","start":"2026-06-10T08:31:40.255502Z","end":"2026-06-10T08:31:40.383531Z","steps":["trace[1853853228] 'agreement among raft nodes before linearized reading' (duration: 127.991073ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:31:40.383473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.88365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:31:40.383684Z","caller":"traceutil/trace.go:171","msg":"trace[1964611965] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:574; }","duration":"128.120447ms","start":"2026-06-10T08:31:40.255558Z","end":"2026-06-10T08:31:40.383678Z","steps":["trace[1964611965] 'agreement among raft nodes before linearized reading' (duration: 127.89341ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:31:40.383039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.637701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:31:40.383772Z","caller":"traceutil/trace.go:171","msg":"trace[503495340] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:574; }","duration":"277.408704ms","start":"2026-06-10T08:31:40.106353Z","end":"2026-06-10T08:31:40.383762Z","steps":["trace[503495340] 'agreement among raft nodes before linearized reading' (duration: 276.602371ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:31:40.384002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.905762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:31:40.384023Z","caller":"traceutil/trace.go:171","msg":"trace[1011912399] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:574; }","duration":"287.939202ms","start":"2026-06-10T08:31:40.096079Z","end":"2026-06-10T08:31:40.384018Z","steps":["trace[1011912399] 'agreement among raft nodes before linearized reading' (duration: 287.904301ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:31:40.384261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.128758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:31:40.384335Z","caller":"traceutil/trace.go:171","msg":"trace[104753691] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:574; }","duration":"288.271472ms","start":"2026-06-10T08:31:40.09605Z","end":"2026-06-10T08:31:40.384322Z","steps":["trace[104753691] 'agreement among raft nodes before linearized reading' (duration: 286.858501ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:31:44.598059Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17769126811359991093,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-10T08:31:44.802865Z","caller":"traceutil/trace.go:171","msg":"trace[2009969650] linearizableReadLoop","detail":"{readStateIndex:629; appliedIndex:628; }","duration":"704.882367ms","start":"2026-06-10T08:31:44.097947Z","end":"2026-06-10T08:31:44.802829Z","steps":["trace[2009969650] 'read index received' (duration: 704.766003ms)","trace[2009969650] 'applied index is now lower than readState.Index' (duration: 115.514µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:31:44.802904Z","caller":"traceutil/trace.go:171","msg":"trace[1494117459] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"729.529605ms","start":"2026-06-10T08:31:44.073351Z","end":"2026-06-10T08:31:44.802881Z","steps":["trace[1494117459] 'process raft request' (duration: 729.306839ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:31:44.80307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:31:44.07333Z","time spent":"729.646089ms","remote":"127.0.0.1:46724","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-10T08:31:44.803116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"705.155194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-10T08:31:44.803273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"687.019659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-4mr52\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-06-10T08:31:44.803372Z","caller":"traceutil/trace.go:171","msg":"trace[1208290675] range","detail":"{range_begin:/registry/pods/kube-system/cilium-4mr52; range_end:; response_count:1; response_revision:601; }","duration":"687.160062ms","start":"2026-06-10T08:31:44.116193Z","end":"2026-06-10T08:31:44.803353Z","steps":["trace[1208290675] 'agreement among raft nodes before linearized reading' (duration: 686.810012ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:31:44.803413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:31:44.116174Z","time spent":"687.228855ms","remote":"127.0.0.1:46664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16983,"request content":"key:\"/registry/pods/kube-system/cilium-4mr52\" "} {"level":"info","ts":"2026-06-10T08:31:44.80315Z","caller":"traceutil/trace.go:171","msg":"trace[65043200] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:601; }","duration":"705.224165ms","start":"2026-06-10T08:31:44.097915Z","end":"2026-06-10T08:31:44.80314Z","steps":["trace[65043200] 'agreement among raft nodes before linearized reading' (duration: 705.03963ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:31:44.803485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:31:44.097884Z","time spent":"705.587566ms","remote":"127.0.0.1:46492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-10T08:31:59.608966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.290961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-ks27q\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-06-10T08:31:59.609104Z","caller":"traceutil/trace.go:171","msg":"trace[546888034] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-ks27q; range_end:; response_count:1; response_revision:753; }","duration":"394.488736ms","start":"2026-06-10T08:31:59.214598Z","end":"2026-06-10T08:31:59.609087Z","steps":["trace[546888034] 'range keys from in-memory index tree' (duration: 394.131626ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:31:59.609149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:31:59.214579Z","time spent":"394.560598ms","remote":"127.0.0.1:46664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3986,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-ks27q\" "} {"level":"info","ts":"2026-06-10T08:32:28.625048Z","caller":"traceutil/trace.go:171","msg":"trace[965870859] transaction","detail":"{read_only:false; response_revision:952; number_of_response:1; }","duration":"286.603253ms","start":"2026-06-10T08:32:28.338379Z","end":"2026-06-10T08:32:28.624982Z","steps":["trace[965870859] 'process raft request' (duration: 286.462919ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:32:34.715333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"616.25743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:32:34.715428Z","caller":"traceutil/trace.go:171","msg":"trace[104428679] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:970; }","duration":"616.403604ms","start":"2026-06-10T08:32:34.099008Z","end":"2026-06-10T08:32:34.715412Z","steps":["trace[104428679] 'range keys from in-memory index tree' (duration: 616.156097ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:32:34.715472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:32:34.098989Z","time spent":"616.474387ms","remote":"127.0.0.1:46476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-10T08:32:34.715535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"490.952906ms","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-10T08:32:34.715609Z","caller":"traceutil/trace.go:171","msg":"trace[1335751812] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:970; }","duration":"491.07577ms","start":"2026-06-10T08:32:34.224518Z","end":"2026-06-10T08:32:34.715594Z","steps":["trace[1335751812] 'range keys from in-memory index tree' (duration: 490.801061ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:32:34.715641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:32:34.224498Z","time spent":"491.13537ms","remote":"127.0.0.1:46752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-10T08:32:34.715687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"578.000953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-10T08:32:34.715729Z","caller":"traceutil/trace.go:171","msg":"trace[26675263] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:970; }","duration":"578.065295ms","start":"2026-06-10T08:32:34.137649Z","end":"2026-06-10T08:32:34.715714Z","steps":["trace[26675263] 'range keys from in-memory index tree' (duration: 577.8737ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:32:34.71575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:32:34.137632Z","time spent":"578.112975ms","remote":"127.0.0.1:46752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-10T08:32:34.715831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"517.433405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-06-10T08:32:34.715828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"484.108689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-10T08:32:34.715898Z","caller":"traceutil/trace.go:171","msg":"trace[1222551608] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:970; }","duration":"484.203851ms","start":"2026-06-10T08:32:34.231677Z","end":"2026-06-10T08:32:34.715881Z","steps":["trace[1222551608] 'range keys from in-memory index tree' (duration: 483.983775ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:32:34.71593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"485.743216ms","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-10T08:32:34.71594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:32:34.23167Z","time spent":"484.262824ms","remote":"127.0.0.1:46752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-10T08:32:34.715974Z","caller":"traceutil/trace.go:171","msg":"trace[377557817] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:970; }","duration":"485.826138ms","start":"2026-06-10T08:32:34.230138Z","end":"2026-06-10T08:32:34.715964Z","steps":["trace[377557817] 'range keys from in-memory index tree' (duration: 485.584211ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:32:34.715858Z","caller":"traceutil/trace.go:171","msg":"trace[1344163616] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:970; }","duration":"517.487877ms","start":"2026-06-10T08:32:34.198363Z","end":"2026-06-10T08:32:34.715851Z","steps":["trace[1344163616] 'range keys from in-memory index tree' (duration: 517.347592ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:32:34.716004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:32:34.230116Z","time spent":"485.88077ms","remote":"127.0.0.1:46752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-10T08:32:34.716013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:32:34.198348Z","time spent":"517.657032ms","remote":"127.0.0.1:46752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-10T08:32:34.809718Z","caller":"traceutil/trace.go:171","msg":"trace[1941163965] transaction","detail":"{read_only:false; response_revision:971; number_of_response:1; }","duration":"168.308489ms","start":"2026-06-10T08:32:34.641388Z","end":"2026-06-10T08:32:34.809697Z","steps":["trace[1941163965] 'process raft request' (duration: 167.878786ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:32:34.993774Z","caller":"traceutil/trace.go:171","msg":"trace[1045955186] transaction","detail":"{read_only:false; response_revision:973; number_of_response:1; }","duration":"273.578529ms","start":"2026-06-10T08:32:34.720178Z","end":"2026-06-10T08:32:34.993756Z","steps":["trace[1045955186] 'process raft request' (duration: 273.504197ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:32:34.993904Z","caller":"traceutil/trace.go:171","msg":"trace[1675129977] transaction","detail":"{read_only:false; response_revision:972; number_of_response:1; }","duration":"274.575987ms","start":"2026-06-10T08:32:34.719321Z","end":"2026-06-10T08:32:34.993897Z","steps":["trace[1675129977] 'process raft request' (duration: 274.248778ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:32:34.994105Z","caller":"traceutil/trace.go:171","msg":"trace[607321691] transaction","detail":"{read_only:false; response_revision:974; number_of_response:1; }","duration":"273.878517ms","start":"2026-06-10T08:32:34.720205Z","end":"2026-06-10T08:32:34.994084Z","steps":["trace[607321691] 'process raft request' (duration: 273.503896ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:32:34.994293Z","caller":"traceutil/trace.go:171","msg":"trace[1348332711] transaction","detail":"{read_only:false; response_revision:975; number_of_response:1; }","duration":"274.013482ms","start":"2026-06-10T08:32:34.720271Z","end":"2026-06-10T08:32:34.994284Z","steps":["trace[1348332711] 'process raft request' (duration: 273.739884ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:32:34.994449Z","caller":"traceutil/trace.go:171","msg":"trace[459280212] transaction","detail":"{read_only:false; response_revision:976; number_of_response:1; }","duration":"274.0046ms","start":"2026-06-10T08:32:34.720432Z","end":"2026-06-10T08:32:34.994436Z","steps":["trace[459280212] 'process raft request' (duration: 273.821505ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:32:57.448556Z","caller":"traceutil/trace.go:171","msg":"trace[68124686] transaction","detail":"{read_only:false; response_revision:1044; number_of_response:1; }","duration":"338.696877ms","start":"2026-06-10T08:32:57.109835Z","end":"2026-06-10T08:32:57.448532Z","steps":["trace[68124686] 'process raft request' (duration: 338.571813ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:32:57.448715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:32:57.109818Z","time spent":"338.80763ms","remote":"127.0.0.1:46752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T08:32:57.449174Z","caller":"traceutil/trace.go:171","msg":"trace[2042759530] linearizableReadLoop","detail":"{readStateIndex:1089; appliedIndex:1089; }","duration":"335.476185ms","start":"2026-06-10T08:32:57.113688Z","end":"2026-06-10T08:32:57.449165Z","steps":["trace[2042759530] 'read index received' (duration: 335.472395ms)","trace[2042759530] 'applied index is now lower than readState.Index' (duration: 3.12µs)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:32:57.449291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.604998ms","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-10T08:32:57.449321Z","caller":"traceutil/trace.go:171","msg":"trace[1679732967] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1044; }","duration":"335.6538ms","start":"2026-06-10T08:32:57.113659Z","end":"2026-06-10T08:32:57.449313Z","steps":["trace[1679732967] 'agreement among raft nodes before linearized reading' (duration: 335.552107ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:32:57.449349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:32:57.113652Z","time spent":"335.69129ms","remote":"127.0.0.1:46752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-10T08:32:57.458759Z","caller":"traceutil/trace.go:171","msg":"trace[1959539583] transaction","detail":"{read_only:false; response_revision:1045; number_of_response:1; }","duration":"225.212351ms","start":"2026-06-10T08:32:57.23352Z","end":"2026-06-10T08:32:57.458732Z","steps":["trace[1959539583] 'process raft request' (duration: 225.014095ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:32:57.458786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.363974ms","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-10T08:32:57.458846Z","caller":"traceutil/trace.go:171","msg":"trace[135829992] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1045; }","duration":"318.459447ms","start":"2026-06-10T08:32:57.140372Z","end":"2026-06-10T08:32:57.458832Z","steps":["trace[135829992] 'agreement among raft nodes before linearized reading' (duration: 318.289411ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:32:57.45889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:32:57.140357Z","time spent":"318.524488ms","remote":"127.0.0.1:46752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-10T08:32:57.458935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.948268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-10T08:32:57.459007Z","caller":"traceutil/trace.go:171","msg":"trace[1539154436] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1045; }","duration":"314.05687ms","start":"2026-06-10T08:32:57.144937Z","end":"2026-06-10T08:32:57.458994Z","steps":["trace[1539154436] 'agreement among raft nodes before linearized reading' (duration: 313.828863ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:32:57.459045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:32:57.144926Z","time spent":"314.112943ms","remote":"127.0.0.1:46752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-10T08:32:57.458947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.617104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-10T08:32:57.459101Z","caller":"traceutil/trace.go:171","msg":"trace[1359037568] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1045; }","duration":"316.785238ms","start":"2026-06-10T08:32:57.1423Z","end":"2026-06-10T08:32:57.459085Z","steps":["trace[1359037568] 'agreement among raft nodes before linearized reading' (duration: 316.496461ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:32:57.459163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:32:57.142252Z","time spent":"316.888302ms","remote":"127.0.0.1:46752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-10T08:32:57.572097Z","caller":"traceutil/trace.go:171","msg":"trace[1671760102] transaction","detail":"{read_only:false; response_revision:1046; number_of_response:1; }","duration":"119.409195ms","start":"2026-06-10T08:32:57.45266Z","end":"2026-06-10T08:32:57.57207Z","steps":["trace[1671760102] 'process raft request' (duration: 119.250881ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:32:57.590348Z","caller":"traceutil/trace.go:171","msg":"trace[1826199356] transaction","detail":"{read_only:false; response_revision:1048; number_of_response:1; }","duration":"128.077074ms","start":"2026-06-10T08:32:57.462246Z","end":"2026-06-10T08:32:57.590323Z","steps":["trace[1826199356] 'process raft request' (duration: 127.996781ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:32:57.590372Z","caller":"traceutil/trace.go:171","msg":"trace[943986394] transaction","detail":"{read_only:false; response_revision:1047; number_of_response:1; }","duration":"128.421314ms","start":"2026-06-10T08:32:57.461925Z","end":"2026-06-10T08:32:57.590347Z","steps":["trace[943986394] 'process raft request' (duration: 128.197408ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:32:57.590523Z","caller":"traceutil/trace.go:171","msg":"trace[578886319] transaction","detail":"{read_only:false; response_revision:1049; number_of_response:1; }","duration":"127.351695ms","start":"2026-06-10T08:32:57.463157Z","end":"2026-06-10T08:32:57.590509Z","steps":["trace[578886319] 'process raft request' (duration: 127.128168ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:32:59.833422Z","caller":"traceutil/trace.go:171","msg":"trace[2107001591] linearizableReadLoop","detail":"{readStateIndex:1097; appliedIndex:1096; }","duration":"256.352104ms","start":"2026-06-10T08:32:59.577048Z","end":"2026-06-10T08:32:59.8334Z","steps":["trace[2107001591] 'read index received' (duration: 256.097907ms)","trace[2107001591] 'applied index is now lower than readState.Index' (duration: 253.247µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:32:59.833545Z","caller":"traceutil/trace.go:171","msg":"trace[1747227576] transaction","detail":"{read_only:false; response_revision:1051; number_of_response:1; }","duration":"377.18287ms","start":"2026-06-10T08:32:59.456338Z","end":"2026-06-10T08:32:59.833521Z","steps":["trace[1747227576] 'process raft request' (duration: 376.858721ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:32:59.833673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.619672ms","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-10T08:32:59.833696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:32:59.456313Z","time spent":"377.281265ms","remote":"127.0.0.1:46752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T08:32:59.833746Z","caller":"traceutil/trace.go:171","msg":"trace[811541] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1051; }","duration":"256.769577ms","start":"2026-06-10T08:32:59.576962Z","end":"2026-06-10T08:32:59.833732Z","steps":["trace[811541] 'agreement among raft nodes before linearized reading' (duration: 256.583001ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:32:59.833749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.263924ms","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-10T08:32:59.833816Z","caller":"traceutil/trace.go:171","msg":"trace[875366913] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1051; }","duration":"239.378208ms","start":"2026-06-10T08:32:59.594421Z","end":"2026-06-10T08:32:59.833799Z","steps":["trace[875366913] 'agreement among raft nodes before linearized reading' (duration: 239.172702ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:32:59.833846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.035104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:32:59.833947Z","caller":"traceutil/trace.go:171","msg":"trace[166951665] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:1051; }","duration":"104.175678ms","start":"2026-06-10T08:32:59.729754Z","end":"2026-06-10T08:32:59.833929Z","steps":["trace[166951665] 'agreement among raft nodes before linearized reading' (duration: 103.999763ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:32:59.833866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.76694ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-10T08:32:59.834173Z","caller":"traceutil/trace.go:171","msg":"trace[926221748] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1051; }","duration":"239.11762ms","start":"2026-06-10T08:32:59.595037Z","end":"2026-06-10T08:32:59.834154Z","steps":["trace[926221748] 'agreement among raft nodes before linearized reading' (duration: 238.646627ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:32:59.834059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.028857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-10T08:32:59.834295Z","caller":"traceutil/trace.go:171","msg":"trace[1795850449] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1051; }","duration":"239.330765ms","start":"2026-06-10T08:32:59.594951Z","end":"2026-06-10T08:32:59.834281Z","steps":["trace[1795850449] 'agreement among raft nodes before linearized reading' (duration: 238.79818ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:33:00.099056Z","caller":"traceutil/trace.go:171","msg":"trace[703596972] transaction","detail":"{read_only:false; response_revision:1052; number_of_response:1; }","duration":"261.283026ms","start":"2026-06-10T08:32:59.837744Z","end":"2026-06-10T08:33:00.099027Z","steps":["trace[703596972] 'process raft request' (duration: 176.0242ms)","trace[703596972] 'compare' (duration: 85.146533ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:33:00.112191Z","caller":"traceutil/trace.go:171","msg":"trace[1470013542] transaction","detail":"{read_only:false; response_revision:1053; number_of_response:1; }","duration":"274.31493ms","start":"2026-06-10T08:32:59.837852Z","end":"2026-06-10T08:33:00.112167Z","steps":["trace[1470013542] 'process raft request' (duration: 274.094053ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:33:00.112474Z","caller":"traceutil/trace.go:171","msg":"trace[84623556] transaction","detail":"{read_only:false; response_revision:1054; number_of_response:1; }","duration":"274.555567ms","start":"2026-06-10T08:32:59.837892Z","end":"2026-06-10T08:33:00.112447Z","steps":["trace[84623556] 'process raft request' (duration: 274.235158ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:33:00.112567Z","caller":"traceutil/trace.go:171","msg":"trace[266977409] transaction","detail":"{read_only:false; response_revision:1055; number_of_response:1; }","duration":"273.96001ms","start":"2026-06-10T08:32:59.838553Z","end":"2026-06-10T08:33:00.112513Z","steps":["trace[266977409] 'process raft request' (duration: 273.781175ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:33:16.985092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"795.429371ms","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-10T08:33:16.985174Z","caller":"traceutil/trace.go:171","msg":"trace[890628564] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1155; }","duration":"795.559074ms","start":"2026-06-10T08:33:16.189596Z","end":"2026-06-10T08:33:16.985155Z","steps":["trace[890628564] 'range keys from in-memory index tree' (duration: 795.157622ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:33:16.985215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:33:16.189574Z","time spent":"795.631157ms","remote":"127.0.0.1:46752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-10T08:33:16.985296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"789.864561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-10T08:33:16.985368Z","caller":"traceutil/trace.go:171","msg":"trace[2144592928] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1155; }","duration":"789.956274ms","start":"2026-06-10T08:33:16.195392Z","end":"2026-06-10T08:33:16.985348Z","steps":["trace[2144592928] 'range keys from in-memory index tree' (duration: 789.736517ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:33:16.985407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:33:16.195387Z","time spent":"790.011656ms","remote":"127.0.0.1:46752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-10T08:33:16.985409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"790.466987ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-10T08:33:16.985486Z","caller":"traceutil/trace.go:171","msg":"trace[1579339829] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1155; }","duration":"790.580632ms","start":"2026-06-10T08:33:16.194883Z","end":"2026-06-10T08:33:16.985464Z","steps":["trace[1579339829] 'range keys from in-memory index tree' (duration: 790.307893ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:33:16.985541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:33:16.194867Z","time spent":"790.665324ms","remote":"127.0.0.1:46752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-10T08:33:16.985627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"819.236064ms","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-10T08:33:16.985686Z","caller":"traceutil/trace.go:171","msg":"trace[151843651] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1155; }","duration":"819.340277ms","start":"2026-06-10T08:33:16.166333Z","end":"2026-06-10T08:33:16.985673Z","steps":["trace[151843651] 'range keys from in-memory index tree' (duration: 819.110611ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:33:16.985687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"835.784529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-10T08:33:16.985722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:33:16.166309Z","time spent":"819.404998ms","remote":"127.0.0.1:46752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-10T08:33:16.985762Z","caller":"traceutil/trace.go:171","msg":"trace[2030057178] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:1155; }","duration":"835.853712ms","start":"2026-06-10T08:33:16.149864Z","end":"2026-06-10T08:33:16.985717Z","steps":["trace[2030057178] 'count revisions from in-memory index tree' (duration: 835.725937ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:33:16.985804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:33:16.149847Z","time spent":"835.946923ms","remote":"127.0.0.1:48972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-10T08:33:31.49138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.784022ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-10T08:33:31.49148Z","caller":"traceutil/trace.go:171","msg":"trace[1101909350] transaction","detail":"{read_only:false; response_revision:1207; number_of_response:1; }","duration":"234.870878ms","start":"2026-06-10T08:33:31.256592Z","end":"2026-06-10T08:33:31.491462Z","steps":["trace[1101909350] 'process raft request' (duration: 77.926512ms)","trace[1101909350] 'compare' (duration: 156.555746ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:33:32.216159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.946257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-10T08:33:32.216147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.113929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:33:32.216247Z","caller":"traceutil/trace.go:171","msg":"trace[56524776] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:1207; }","duration":"279.06027ms","start":"2026-06-10T08:33:31.93717Z","end":"2026-06-10T08:33:32.21623Z","steps":["trace[56524776] 'count revisions from in-memory index tree' (duration: 278.851133ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:33:32.216258Z","caller":"traceutil/trace.go:171","msg":"trace[911536903] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1207; }","duration":"118.231353ms","start":"2026-06-10T08:33:32.098009Z","end":"2026-06-10T08:33:32.21624Z","steps":["trace[911536903] 'range keys from in-memory index tree' (duration: 118.050848ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:33:33.351257Z","caller":"traceutil/trace.go:171","msg":"trace[1917922850] transaction","detail":"{read_only:false; response_revision:1216; number_of_response:1; }","duration":"114.125404ms","start":"2026-06-10T08:33:33.237106Z","end":"2026-06-10T08:33:33.351231Z","steps":["trace[1917922850] 'process raft request' (duration: 111.992943ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:33:33.383457Z","caller":"traceutil/trace.go:171","msg":"trace[1974723729] transaction","detail":"{read_only:false; response_revision:1217; number_of_response:1; }","duration":"113.96968ms","start":"2026-06-10T08:33:33.269461Z","end":"2026-06-10T08:33:33.383431Z","steps":["trace[1974723729] 'process raft request' (duration: 113.817437ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:33:34.100592Z","caller":"traceutil/trace.go:171","msg":"trace[1146720952] transaction","detail":"{read_only:false; response_revision:1221; number_of_response:1; }","duration":"141.815095ms","start":"2026-06-10T08:33:33.95876Z","end":"2026-06-10T08:33:34.100575Z","steps":["trace[1146720952] 'process raft request' (duration: 89.434912ms)","trace[1146720952] 'compare' (duration: 52.128756ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:33:34.100855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.970621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:33:34.10044Z","caller":"traceutil/trace.go:171","msg":"trace[477601789] linearizableReadLoop","detail":"{readStateIndex:1276; appliedIndex:1275; }","duration":"120.564639ms","start":"2026-06-10T08:33:33.979856Z","end":"2026-06-10T08:33:34.100421Z","steps":["trace[477601789] 'read index received' (duration: 68.281328ms)","trace[477601789] 'applied index is now lower than readState.Index' (duration: 52.282181ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:33:34.100959Z","caller":"traceutil/trace.go:171","msg":"trace[1335440597] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:1221; }","duration":"121.091314ms","start":"2026-06-10T08:33:33.979845Z","end":"2026-06-10T08:33:34.100936Z","steps":["trace[1335440597] 'agreement among raft nodes before linearized reading' (duration: 120.870128ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:33:35.731462Z","caller":"traceutil/trace.go:171","msg":"trace[1849629529] transaction","detail":"{read_only:false; response_revision:1227; number_of_response:1; }","duration":"376.008545ms","start":"2026-06-10T08:33:35.355432Z","end":"2026-06-10T08:33:35.73144Z","steps":["trace[1849629529] 'process raft request' (duration: 375.86585ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:33:35.73148Z","caller":"traceutil/trace.go:171","msg":"trace[878327726] linearizableReadLoop","detail":"{readStateIndex:1282; appliedIndex:1282; }","duration":"330.27495ms","start":"2026-06-10T08:33:35.401178Z","end":"2026-06-10T08:33:35.731453Z","steps":["trace[878327726] 'read index received' (duration: 330.26001ms)","trace[878327726] 'applied index is now lower than readState.Index' (duration: 13.07µs)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:33:35.731605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.398374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-10T08:33:35.731608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:33:35.355394Z","time spent":"376.136279ms","remote":"127.0.0.1:46752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T08:33:35.731636Z","caller":"traceutil/trace.go:171","msg":"trace[1089705507] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:1227; }","duration":"330.484295ms","start":"2026-06-10T08:33:35.401141Z","end":"2026-06-10T08:33:35.731625Z","steps":["trace[1089705507] 'agreement among raft nodes before linearized reading' (duration: 330.397464ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:33:35.731671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:33:35.401121Z","time spent":"330.537519ms","remote":"127.0.0.1:48850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "} {"level":"warn","ts":"2026-06-10T08:33:36.05032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.276501ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-10T08:33:36.050437Z","caller":"traceutil/trace.go:171","msg":"trace[755696457] transaction","detail":"{read_only:false; response_revision:1228; number_of_response:1; }","duration":"331.064614ms","start":"2026-06-10T08:33:35.719352Z","end":"2026-06-10T08:33:36.050417Z","steps":["trace[755696457] 'process raft request' (duration: 122.580018ms)","trace[755696457] 'compare' (duration: 208.127405ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:33:36.050519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:33:35.71933Z","time spent":"331.155855ms","remote":"127.0.0.1:46752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T08:33:36.815398Z","caller":"traceutil/trace.go:171","msg":"trace[1838073672] linearizableReadLoop","detail":"{readStateIndex:1288; appliedIndex:1287; }","duration":"257.540426ms","start":"2026-06-10T08:33:36.55783Z","end":"2026-06-10T08:33:36.815371Z","steps":["trace[1838073672] 'read index received' (duration: 237.384811ms)","trace[1838073672] 'applied index is now lower than readState.Index' (duration: 20.154085ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:33:36.815576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.722951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:33:36.815449Z","caller":"traceutil/trace.go:171","msg":"trace[273152327] transaction","detail":"{read_only:false; response_revision:1233; number_of_response:1; }","duration":"280.823441ms","start":"2026-06-10T08:33:36.534594Z","end":"2026-06-10T08:33:36.815417Z","steps":["trace[273152327] 'process raft request' (duration: 260.725747ms)","trace[273152327] 'compare' (duration: 19.653851ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:33:36.815626Z","caller":"traceutil/trace.go:171","msg":"trace[471572038] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1233; }","duration":"257.821524ms","start":"2026-06-10T08:33:36.557793Z","end":"2026-06-10T08:33:36.815615Z","steps":["trace[471572038] 'agreement among raft nodes before linearized reading' (duration: 257.678649ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:33:37.307794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.962798ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-10T08:33:37.307882Z","caller":"traceutil/trace.go:171","msg":"trace[1016884428] transaction","detail":"{read_only:false; response_revision:1235; number_of_response:1; }","duration":"466.357162ms","start":"2026-06-10T08:33:36.841511Z","end":"2026-06-10T08:33:37.307868Z","steps":["trace[1016884428] 'process raft request' (duration: 330.26056ms)","trace[1016884428] 'compare' (duration: 135.853405ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:33:37.30792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:33:36.841487Z","time spent":"466.417404ms","remote":"127.0.0.1:46546","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":773,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-10T08:33:37.485775Z","caller":"traceutil/trace.go:171","msg":"trace[396638185] linearizableReadLoop","detail":"{readStateIndex:1291; appliedIndex:1289; }","duration":"387.555134ms","start":"2026-06-10T08:33:37.098192Z","end":"2026-06-10T08:33:37.485747Z","steps":["trace[396638185] 'read index received' (duration: 73.591689ms)","trace[396638185] 'applied index is now lower than readState.Index' (duration: 313.961975ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:33:37.485812Z","caller":"traceutil/trace.go:171","msg":"trace[223194867] transaction","detail":"{read_only:false; response_revision:1236; number_of_response:1; }","duration":"642.479236ms","start":"2026-06-10T08:33:36.8433Z","end":"2026-06-10T08:33:37.485779Z","steps":["trace[223194867] 'process raft request' (duration: 599.85316ms)","trace[223194867] 'compare' (duration: 41.799482ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:33:37.485889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.680588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:33:37.485952Z","caller":"traceutil/trace.go:171","msg":"trace[1360503542] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1236; }","duration":"387.789781ms","start":"2026-06-10T08:33:37.098146Z","end":"2026-06-10T08:33:37.485936Z","steps":["trace[1360503542] 'agreement among raft nodes before linearized reading' (duration: 387.691098ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:33:37.485961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:33:36.84328Z","time spent":"642.601149ms","remote":"127.0.0.1:46752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T08:33:37.485989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:33:37.098124Z","time spent":"387.856743ms","remote":"127.0.0.1:46476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-10T08:33:37.486045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.429538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-10T08:33:37.486093Z","caller":"traceutil/trace.go:171","msg":"trace[1447138904] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1236; }","duration":"294.5149ms","start":"2026-06-10T08:33:37.191568Z","end":"2026-06-10T08:33:37.486082Z","steps":["trace[1447138904] 'agreement among raft nodes before linearized reading' (duration: 294.325785ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:33:37.486094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.049245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-10T08:33:37.486107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.325433ms","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-10T08:33:37.486148Z","caller":"traceutil/trace.go:171","msg":"trace[978300987] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:1236; }","duration":"356.139939ms","start":"2026-06-10T08:33:37.129994Z","end":"2026-06-10T08:33:37.486134Z","steps":["trace[978300987] 'agreement among raft nodes before linearized reading' (duration: 355.893522ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:33:37.486157Z","caller":"traceutil/trace.go:171","msg":"trace[1287345088] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1236; }","duration":"282.417005ms","start":"2026-06-10T08:33:37.203725Z","end":"2026-06-10T08:33:37.486142Z","steps":["trace[1287345088] 'agreement among raft nodes before linearized reading' (duration: 282.234599ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:33:37.486186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:33:37.129975Z","time spent":"356.201879ms","remote":"127.0.0.1:44114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true "} {"level":"warn","ts":"2026-06-10T08:33:37.486319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.912559ms","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-10T08:33:37.486338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.698826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-10T08:33:37.486355Z","caller":"traceutil/trace.go:171","msg":"trace[576456707] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1236; }","duration":"350.983341ms","start":"2026-06-10T08:33:37.135363Z","end":"2026-06-10T08:33:37.486346Z","steps":["trace[576456707] 'agreement among raft nodes before linearized reading' (duration: 350.892928ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:33:37.486375Z","caller":"traceutil/trace.go:171","msg":"trace[451882015] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1236; }","duration":"314.757798ms","start":"2026-06-10T08:33:37.171606Z","end":"2026-06-10T08:33:37.486364Z","steps":["trace[451882015] 'agreement among raft nodes before linearized reading' (duration: 314.617224ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:33:37.486382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:33:37.135345Z","time spent":"351.029722ms","remote":"127.0.0.1:46752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-10T08:33:37.486405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:33:37.171595Z","time spent":"314.803349ms","remote":"127.0.0.1:46752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-10T08:33:37.868539Z","caller":"traceutil/trace.go:171","msg":"trace[315292420] transaction","detail":"{read_only:false; response_revision:1241; number_of_response:1; }","duration":"132.14327ms","start":"2026-06-10T08:33:37.736369Z","end":"2026-06-10T08:33:37.868513Z","steps":["trace[315292420] 'process raft request' (duration: 132.000876ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:33:38.198295Z","caller":"traceutil/trace.go:171","msg":"trace[2087947538] transaction","detail":"{read_only:false; response_revision:1242; number_of_response:1; }","duration":"222.99042ms","start":"2026-06-10T08:33:37.975274Z","end":"2026-06-10T08:33:38.198264Z","steps":["trace[2087947538] 'process raft request' (duration: 222.773174ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:33:45.838383Z","caller":"traceutil/trace.go:171","msg":"trace[1523306182] linearizableReadLoop","detail":"{readStateIndex:1348; appliedIndex:1347; }","duration":"227.128288ms","start":"2026-06-10T08:33:45.611232Z","end":"2026-06-10T08:33:45.83836Z","steps":["trace[1523306182] 'read index received' (duration: 226.960684ms)","trace[1523306182] 'applied index is now lower than readState.Index' (duration: 166.814µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:33:45.838484Z","caller":"traceutil/trace.go:171","msg":"trace[1571626871] transaction","detail":"{read_only:false; response_revision:1291; number_of_response:1; }","duration":"265.826652ms","start":"2026-06-10T08:33:45.572617Z","end":"2026-06-10T08:33:45.838444Z","steps":["trace[1571626871] 'process raft request' (duration: 265.606186ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:33:45.838609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.358515ms","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-10T08:33:45.838648Z","caller":"traceutil/trace.go:171","msg":"trace[960730988] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1291; }","duration":"227.454838ms","start":"2026-06-10T08:33:45.611183Z","end":"2026-06-10T08:33:45.838638Z","steps":["trace[960730988] 'agreement among raft nodes before linearized reading' (duration: 227.291313ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:33:45.838659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.283524ms","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-10T08:33:45.838706Z","caller":"traceutil/trace.go:171","msg":"trace[17012773] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1291; }","duration":"226.368797ms","start":"2026-06-10T08:33:45.612324Z","end":"2026-06-10T08:33:45.838693Z","steps":["trace[17012773] 'agreement among raft nodes before linearized reading' (duration: 226.220143ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:33:45.838893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.583795ms","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-10T08:33:45.83897Z","caller":"traceutil/trace.go:171","msg":"trace[1628978026] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1291; }","duration":"225.707848ms","start":"2026-06-10T08:33:45.613249Z","end":"2026-06-10T08:33:45.838957Z","steps":["trace[1628978026] 'agreement among raft nodes before linearized reading' (duration: 225.378559ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:33:46.643492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"716.466436ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-10T08:33:46.643615Z","caller":"traceutil/trace.go:171","msg":"trace[397645696] transaction","detail":"{read_only:false; response_revision:1292; number_of_response:1; }","duration":"799.087983ms","start":"2026-06-10T08:33:45.844504Z","end":"2026-06-10T08:33:46.643592Z","steps":["trace[397645696] 'process raft request' (duration: 82.434752ms)","trace[397645696] 'compare' (duration: 715.931171ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:33:46.643691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:33:45.844482Z","time spent":"799.172075ms","remote":"127.0.0.1:46752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T08:33:46.644967Z","caller":"traceutil/trace.go:171","msg":"trace[605201075] transaction","detail":"{read_only:false; response_revision:1294; number_of_response:1; }","duration":"799.585677ms","start":"2026-06-10T08:33:45.845364Z","end":"2026-06-10T08:33:46.64495Z","steps":["trace[605201075] 'process raft request' (duration: 799.500124ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:33:46.645041Z","caller":"traceutil/trace.go:171","msg":"trace[747671149] transaction","detail":"{read_only:false; response_revision:1293; number_of_response:1; }","duration":"799.655449ms","start":"2026-06-10T08:33:45.84532Z","end":"2026-06-10T08:33:46.644976Z","steps":["trace[747671149] 'process raft request' (duration: 799.425502ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:33:46.6451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:33:45.845346Z","time spent":"799.7036ms","remote":"127.0.0.1:46752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T08:33:46.645218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:33:45.845304Z","time spent":"799.823964ms","remote":"127.0.0.1:46752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T08:33:46.645209Z","caller":"traceutil/trace.go:171","msg":"trace[1241347544] linearizableReadLoop","detail":"{readStateIndex:1351; appliedIndex:1348; }","duration":"795.057946ms","start":"2026-06-10T08:33:45.85012Z","end":"2026-06-10T08:33:46.645178Z","steps":["trace[1241347544] 'read index received' (duration: 76.847151ms)","trace[1241347544] 'applied index is now lower than readState.Index' (duration: 718.209185ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:33:46.645496Z","caller":"traceutil/trace.go:171","msg":"trace[1642409329] transaction","detail":"{read_only:false; response_revision:1295; number_of_response:1; }","duration":"750.762304ms","start":"2026-06-10T08:33:45.894717Z","end":"2026-06-10T08:33:46.645479Z","steps":["trace[1642409329] 'process raft request' (duration: 750.194558ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:33:46.645601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:33:45.894677Z","time spent":"750.871377ms","remote":"127.0.0.1:46752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T08:33:46.645627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"795.506201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-10T08:33:46.645666Z","caller":"traceutil/trace.go:171","msg":"trace[1771728308] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1295; }","duration":"795.581432ms","start":"2026-06-10T08:33:45.850073Z","end":"2026-06-10T08:33:46.645655Z","steps":["trace[1771728308] 'agreement among raft nodes before linearized reading' (duration: 795.51427ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:33:46.645701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:33:45.850059Z","time spent":"795.631624ms","remote":"127.0.0.1:46680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":5,"response size":29,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true "} {"level":"warn","ts":"2026-06-10T08:33:46.646899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"547.867877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:33:46.646952Z","caller":"traceutil/trace.go:171","msg":"trace[49463470] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1296; }","duration":"547.967919ms","start":"2026-06-10T08:33:46.098972Z","end":"2026-06-10T08:33:46.64694Z","steps":["trace[49463470] 'agreement among raft nodes before linearized reading' (duration: 547.851876ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:33:46.646986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:33:46.098948Z","time spent":"548.027792ms","remote":"127.0.0.1:46476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-10T08:33:46.647403Z","caller":"traceutil/trace.go:171","msg":"trace[212840998] transaction","detail":"{read_only:false; response_revision:1296; number_of_response:1; }","duration":"275.103437ms","start":"2026-06-10T08:33:46.372264Z","end":"2026-06-10T08:33:46.647367Z","steps":["trace[212840998] 'process raft request' (duration: 274.237892ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:33:46.647467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.876199ms","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-10T08:33:46.647532Z","caller":"traceutil/trace.go:171","msg":"trace[1282723959] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1296; }","duration":"166.975683ms","start":"2026-06-10T08:33:46.480541Z","end":"2026-06-10T08:33:46.647517Z","steps":["trace[1282723959] 'agreement among raft nodes before linearized reading' (duration: 166.777208ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:37:34.29941Z","caller":"traceutil/trace.go:171","msg":"trace[127685042] transaction","detail":"{read_only:false; response_revision:2386; number_of_response:1; }","duration":"158.316463ms","start":"2026-06-10T08:37:34.141065Z","end":"2026-06-10T08:37:34.299381Z","steps":["trace[127685042] 'process raft request' (duration: 158.181648ms)"],"step_count":1}