{"level":"warn","ts":"2026-06-25T19:42:26.934411Z","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-25T19:42:26.934486Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.249: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.249:2380","--initial-cluster=instance=https://199.19.213.249:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.249:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.249: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-25T19:42:26.934546Z","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-25T19:42:26.934559Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.249:2380"]} {"level":"info","ts":"2026-06-25T19:42:26.934574Z","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-25T19:42:26.935169Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.249:2379"]} {"level":"info","ts":"2026-06-25T19:42:26.935237Z","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.249:2380"],"listen-peer-urls":["https://199.19.213.249:2380"],"advertise-client-urls":["https://199.19.213.249:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.249:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.249: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-25T19:42:26.941365Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.923074ms"} {"level":"info","ts":"2026-06-25T19:42:26.956573Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5835264b86215850","cluster-id":"4e10f3807bdbbd9b"} {"level":"info","ts":"2026-06-25T19:42:26.95664Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5835264b86215850 switched to configuration voters=()"} {"level":"info","ts":"2026-06-25T19:42:26.956658Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5835264b86215850 became follower at term 0"} {"level":"info","ts":"2026-06-25T19:42:26.956665Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5835264b86215850 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-25T19:42:26.956674Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5835264b86215850 became follower at term 1"} {"level":"info","ts":"2026-06-25T19:42:26.956702Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5835264b86215850 switched to configuration voters=(6356028554918058064)"} {"level":"warn","ts":"2026-06-25T19:42:26.976486Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-25T19:42:26.978149Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-25T19:42:26.980534Z","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-25T19:42:26.983373Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5835264b86215850","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-25T19:42:26.98454Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5835264b86215850","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-25T19:42:26.984605Z","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-25T19:42:26.984847Z","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-25T19:42:26.984871Z","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-25T19:42:26.986729Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5835264b86215850 switched to configuration voters=(6356028554918058064)"} {"level":"info","ts":"2026-06-25T19:42:26.986837Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4e10f3807bdbbd9b","local-member-id":"5835264b86215850","added-peer-id":"5835264b86215850","added-peer-peer-urls":["https://199.19.213.249:2380"]} {"level":"info","ts":"2026-06-25T19:42:26.990092Z","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-25T19:42:26.99024Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.249:2380"} {"level":"info","ts":"2026-06-25T19:42:26.990298Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.249:2380"} {"level":"info","ts":"2026-06-25T19:42:26.990314Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5835264b86215850","initial-advertise-peer-urls":["https://199.19.213.249:2380"],"listen-peer-urls":["https://199.19.213.249:2380"],"advertise-client-urls":["https://199.19.213.249:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.249:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-25T19:42:26.990341Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-25T19:42:27.057889Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5835264b86215850 is starting a new election at term 1"} {"level":"info","ts":"2026-06-25T19:42:27.057978Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5835264b86215850 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-25T19:42:27.058117Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5835264b86215850 received MsgPreVoteResp from 5835264b86215850 at term 1"} {"level":"info","ts":"2026-06-25T19:42:27.058218Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5835264b86215850 became candidate at term 2"} {"level":"info","ts":"2026-06-25T19:42:27.058241Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5835264b86215850 received MsgVoteResp from 5835264b86215850 at term 2"} {"level":"info","ts":"2026-06-25T19:42:27.058363Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5835264b86215850 became leader at term 2"} {"level":"info","ts":"2026-06-25T19:42:27.058386Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5835264b86215850 elected leader 5835264b86215850 at term 2"} {"level":"info","ts":"2026-06-25T19:42:27.059598Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-25T19:42:27.059897Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5835264b86215850","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.249:2379]}","request-path":"/0/members/5835264b86215850/attributes","cluster-id":"4e10f3807bdbbd9b","publish-timeout":"7s"} {"level":"info","ts":"2026-06-25T19:42:27.059975Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-25T19:42:27.060026Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-25T19:42:27.060585Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4e10f3807bdbbd9b","local-member-id":"5835264b86215850","cluster-version":"3.5"} {"level":"info","ts":"2026-06-25T19:42:27.060663Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-25T19:42:27.060688Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-25T19:42:27.060814Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-25T19:42:27.060951Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-25T19:42:27.063536Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.249:2379"} {"level":"info","ts":"2026-06-25T19:42:27.065548Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-25T19:42:36.311226Z","caller":"traceutil/trace.go:171","msg":"trace[1831994308] linearizableReadLoop","detail":"{readStateIndex:304; appliedIndex:303; }","duration":"133.238777ms","start":"2026-06-25T19:42:36.177963Z","end":"2026-06-25T19:42:36.311202Z","steps":["trace[1831994308] 'read index received' (duration: 120.810394ms)","trace[1831994308] 'applied index is now lower than readState.Index' (duration: 12.427653ms)"],"step_count":2} {"level":"info","ts":"2026-06-25T19:42:36.311365Z","caller":"traceutil/trace.go:171","msg":"trace[2046243689] transaction","detail":"{read_only:false; response_revision:294; number_of_response:1; }","duration":"153.291611ms","start":"2026-06-25T19:42:36.158028Z","end":"2026-06-25T19:42:36.31132Z","steps":["trace[2046243689] 'process raft request' (duration: 140.747737ms)","trace[2046243689] 'compare' (duration: 12.29008ms)"],"step_count":2} {"level":"warn","ts":"2026-06-25T19:42:36.311435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.427608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler\" ","response":"range_response_count:1 size:216"} {"level":"info","ts":"2026-06-25T19:42:36.311503Z","caller":"traceutil/trace.go:171","msg":"trace[381081261] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler; range_end:; response_count:1; response_revision:294; }","duration":"133.59409ms","start":"2026-06-25T19:42:36.177894Z","end":"2026-06-25T19:42:36.311489Z","steps":["trace[381081261] 'agreement among raft nodes before linearized reading' (duration: 133.428258ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T19:42:36.31173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.347377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-25T19:42:36.3119Z","caller":"traceutil/trace.go:171","msg":"trace[1757562996] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:294; }","duration":"119.531039ms","start":"2026-06-25T19:42:36.192311Z","end":"2026-06-25T19:42:36.311842Z","steps":["trace[1757562996] 'agreement among raft nodes before linearized reading' (duration: 119.303617ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T19:42:36.674651Z","caller":"traceutil/trace.go:171","msg":"trace[66312652] transaction","detail":"{read_only:false; response_revision:296; number_of_response:1; }","duration":"245.040051ms","start":"2026-06-25T19:42:36.429574Z","end":"2026-06-25T19:42:36.674614Z","steps":["trace[66312652] 'process raft request' (duration: 147.70009ms)","trace[66312652] 'compare' (duration: 97.011388ms)"],"step_count":2} {"level":"info","ts":"2026-06-25T19:42:37.120789Z","caller":"traceutil/trace.go:171","msg":"trace[1897585185] transaction","detail":"{read_only:false; response_revision:300; number_of_response:1; }","duration":"241.589825ms","start":"2026-06-25T19:42:36.879178Z","end":"2026-06-25T19:42:37.120767Z","steps":["trace[1897585185] 'process raft request' (duration: 241.369563ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T19:42:37.309788Z","caller":"traceutil/trace.go:171","msg":"trace[1377660887] linearizableReadLoop","detail":"{readStateIndex:311; appliedIndex:310; }","duration":"181.26741ms","start":"2026-06-25T19:42:37.128487Z","end":"2026-06-25T19:42:37.309754Z","steps":["trace[1377660887] 'read index received' (duration: 150.689743ms)","trace[1377660887] 'applied index is now lower than readState.Index' (duration: 30.575977ms)"],"step_count":2} {"level":"warn","ts":"2026-06-25T19:42:37.309975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.452002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-06-25T19:42:37.309958Z","caller":"traceutil/trace.go:171","msg":"trace[902787783] transaction","detail":"{read_only:false; response_revision:301; number_of_response:1; }","duration":"183.565394ms","start":"2026-06-25T19:42:37.126324Z","end":"2026-06-25T19:42:37.309889Z","steps":["trace[902787783] 'process raft request' (duration: 152.770434ms)","trace[902787783] 'compare' (duration: 30.500887ms)"],"step_count":2} {"level":"info","ts":"2026-06-25T19:42:37.310029Z","caller":"traceutil/trace.go:171","msg":"trace[663746497] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:301; }","duration":"181.535973ms","start":"2026-06-25T19:42:37.128477Z","end":"2026-06-25T19:42:37.310013Z","steps":["trace[663746497] 'agreement among raft nodes before linearized reading' (duration: 181.409952ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T19:42:37.363819Z","caller":"traceutil/trace.go:171","msg":"trace[207949082] transaction","detail":"{read_only:false; response_revision:302; number_of_response:1; }","duration":"235.313318ms","start":"2026-06-25T19:42:37.12848Z","end":"2026-06-25T19:42:37.363793Z","steps":["trace[207949082] 'process raft request' (duration: 235.160256ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T19:42:39.3077Z","caller":"traceutil/trace.go:171","msg":"trace[1663906551] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"197.881818ms","start":"2026-06-25T19:42:39.109792Z","end":"2026-06-25T19:42:39.307674Z","steps":["trace[1663906551] 'process raft request' (duration: 194.016246ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T19:42:42.014664Z","caller":"traceutil/trace.go:171","msg":"trace[232657743] transaction","detail":"{read_only:false; response_revision:366; number_of_response:1; }","duration":"286.245071ms","start":"2026-06-25T19:42:41.728391Z","end":"2026-06-25T19:42:42.014636Z","steps":["trace[232657743] 'process raft request' (duration: 286.067889ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T19:42:53.260469Z","caller":"traceutil/trace.go:171","msg":"trace[1043113417] linearizableReadLoop","detail":"{readStateIndex:438; appliedIndex:437; }","duration":"328.278059ms","start":"2026-06-25T19:42:52.932166Z","end":"2026-06-25T19:42:53.260444Z","steps":["trace[1043113417] 'read index received' (duration: 249.168934ms)","trace[1043113417] 'applied index is now lower than readState.Index' (duration: 79.108235ms)"],"step_count":2} {"level":"warn","ts":"2026-06-25T19:42:53.260649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.473871ms","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-25T19:42:53.260687Z","caller":"traceutil/trace.go:171","msg":"trace[41654149] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:424; }","duration":"328.564351ms","start":"2026-06-25T19:42:52.932107Z","end":"2026-06-25T19:42:53.260672Z","steps":["trace[41654149] 'agreement among raft nodes before linearized reading' (duration: 328.43666ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T19:42:53.260723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T19:42:52.932086Z","time spent":"328.624403ms","remote":"127.0.0.1:49050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-25T19:42:53.261044Z","caller":"traceutil/trace.go:171","msg":"trace[40617890] transaction","detail":"{read_only:false; response_revision:424; number_of_response:1; }","duration":"761.272288ms","start":"2026-06-25T19:42:52.499757Z","end":"2026-06-25T19:42:53.261029Z","steps":["trace[40617890] 'process raft request' (duration: 681.653108ms)","trace[40617890] 'compare' (duration: 78.947213ms)"],"step_count":2} {"level":"warn","ts":"2026-06-25T19:42:53.261543Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T19:42:52.499719Z","time spent":"761.36386ms","remote":"127.0.0.1:49050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-25T19:42:53.660447Z","caller":"traceutil/trace.go:171","msg":"trace[727055714] transaction","detail":"{read_only:false; response_revision:427; number_of_response:1; }","duration":"164.367578ms","start":"2026-06-25T19:42:53.496055Z","end":"2026-06-25T19:42:53.660423Z","steps":["trace[727055714] 'process raft request' (duration: 164.226186ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T19:43:05.834467Z","caller":"traceutil/trace.go:171","msg":"trace[2048134936] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"871.650576ms","start":"2026-06-25T19:43:04.962771Z","end":"2026-06-25T19:43:05.834422Z","steps":["trace[2048134936] 'process raft request' (duration: 871.303391ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T19:43:05.834707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T19:43:04.962745Z","time spent":"871.844767ms","remote":"127.0.0.1:48880","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-25T19:43:05.844769Z","caller":"traceutil/trace.go:171","msg":"trace[1946258160] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"880.079735ms","start":"2026-06-25T19:43:04.964655Z","end":"2026-06-25T19:43:05.844735Z","steps":["trace[1946258160] 'process raft request' (duration: 879.856222ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T19:43:05.844858Z","caller":"traceutil/trace.go:171","msg":"trace[1134075788] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"872.541235ms","start":"2026-06-25T19:43:04.972286Z","end":"2026-06-25T19:43:05.844827Z","steps":["trace[1134075788] 'process raft request' (duration: 872.396973ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T19:43:05.844937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T19:43:04.964632Z","time spent":"880.200358ms","remote":"127.0.0.1:48880","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-25T19:43:05.844935Z","caller":"traceutil/trace.go:171","msg":"trace[1419890728] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"869.34518ms","start":"2026-06-25T19:43:04.975563Z","end":"2026-06-25T19:43:05.844909Z","steps":["trace[1419890728] 'process raft request' (duration: 869.196259ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T19:43:05.844998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T19:43:04.972279Z","time spent":"872.654796ms","remote":"127.0.0.1:48880","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-25T19:43:05.84503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T19:43:04.975544Z","time spent":"869.439112ms","remote":"127.0.0.1:48880","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-25T19:43:05.845128Z","caller":"traceutil/trace.go:171","msg":"trace[480341099] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"875.253524ms","start":"2026-06-25T19:43:04.969522Z","end":"2026-06-25T19:43:05.844775Z","steps":["trace[480341099] 'process raft request' (duration: 875.118663ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T19:43:05.84519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T19:43:04.969497Z","time spent":"875.657848ms","remote":"127.0.0.1:48880","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-25T19:43:05.845205Z","caller":"traceutil/trace.go:171","msg":"trace[1363342168] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"869.257149ms","start":"2026-06-25T19:43:04.975942Z","end":"2026-06-25T19:43:05.845199Z","steps":["trace[1363342168] 'process raft request' (duration: 868.858915ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T19:43:05.845234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T19:43:04.975931Z","time spent":"869.289179ms","remote":"127.0.0.1:48880","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-25T19:43:05.845511Z","caller":"traceutil/trace.go:171","msg":"trace[1172783383] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"866.272078ms","start":"2026-06-25T19:43:04.979223Z","end":"2026-06-25T19:43:05.845495Z","steps":["trace[1172783383] 'process raft request' (duration: 865.897143ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T19:43:05.845594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T19:43:04.979214Z","time spent":"866.349359ms","remote":"127.0.0.1:48880","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-25T19:43:05.845709Z","caller":"traceutil/trace.go:171","msg":"trace[1378589416] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"852.624172ms","start":"2026-06-25T19:43:04.993063Z","end":"2026-06-25T19:43:05.845688Z","steps":["trace[1378589416] 'process raft request' (duration: 852.276589ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T19:43:05.845822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T19:43:04.993038Z","time spent":"852.709363ms","remote":"127.0.0.1:48880","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-25T19:43:05.845853Z","caller":"traceutil/trace.go:171","msg":"trace[1841292658] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"847.401086ms","start":"2026-06-25T19:43:04.99844Z","end":"2026-06-25T19:43:05.845841Z","steps":["trace[1841292658] 'process raft request' (duration: 847.058662ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T19:43:05.845896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T19:43:04.998431Z","time spent":"847.444756ms","remote":"127.0.0.1:48880","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-25T19:43:05.84602Z","caller":"traceutil/trace.go:171","msg":"trace[1623061635] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"847.542327ms","start":"2026-06-25T19:43:04.998465Z","end":"2026-06-25T19:43:05.846008Z","steps":["trace[1623061635] 'process raft request' (duration: 847.332455ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T19:43:05.84616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T19:43:04.99844Z","time spent":"847.607748ms","remote":"127.0.0.1:48880","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-25T19:43:05.846206Z","caller":"traceutil/trace.go:171","msg":"trace[1263145303] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"826.200439ms","start":"2026-06-25T19:43:05.019996Z","end":"2026-06-25T19:43:05.846197Z","steps":["trace[1263145303] 'process raft request' (duration: 825.994177ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T19:43:05.84624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T19:43:05.019978Z","time spent":"826.24733ms","remote":"127.0.0.1:48880","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-25T19:43:05.846462Z","caller":"traceutil/trace.go:171","msg":"trace[1856141063] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"705.982985ms","start":"2026-06-25T19:43:05.140469Z","end":"2026-06-25T19:43:05.846452Z","steps":["trace[1856141063] 'process raft request' (duration: 705.825733ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T19:43:05.846508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T19:43:05.140452Z","time spent":"706.036815ms","remote":"127.0.0.1:48880","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-25T19:43:05.88692Z","caller":"traceutil/trace.go:171","msg":"trace[409047013] linearizableReadLoop","detail":"{readStateIndex:513; appliedIndex:501; }","duration":"427.320316ms","start":"2026-06-25T19:43:05.459583Z","end":"2026-06-25T19:43:05.886903Z","steps":["trace[409047013] 'read index received' (duration: 374.452191ms)","trace[409047013] 'applied index is now lower than readState.Index' (duration: 52.867495ms)"],"step_count":2} {"level":"warn","ts":"2026-06-25T19:43:05.896144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.538756ms","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-25T19:43:05.896275Z","caller":"traceutil/trace.go:171","msg":"trace[621879228] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:498; }","duration":"436.737817ms","start":"2026-06-25T19:43:05.459521Z","end":"2026-06-25T19:43:05.896259Z","steps":["trace[621879228] 'agreement among raft nodes before linearized reading' (duration: 427.462748ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T19:43:05.896351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T19:43:05.459501Z","time spent":"436.839868ms","remote":"127.0.0.1:49050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-25T19:43:05.901332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.444844ms","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-25T19:43:05.901389Z","caller":"traceutil/trace.go:171","msg":"trace[623550472] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:507; }","duration":"334.547355ms","start":"2026-06-25T19:43:05.566829Z","end":"2026-06-25T19:43:05.901376Z","steps":["trace[623550472] 'agreement among raft nodes before linearized reading' (duration: 334.445703ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T19:43:05.901417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T19:43:05.566808Z","time spent":"334.603996ms","remote":"127.0.0.1:49050","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-25T19:43:05.901587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.61662ms","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-25T19:43:05.9017Z","caller":"traceutil/trace.go:171","msg":"trace[218160135] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:507; }","duration":"180.721351ms","start":"2026-06-25T19:43:05.720905Z","end":"2026-06-25T19:43:05.901626Z","steps":["trace[218160135] 'agreement among raft nodes before linearized reading' (duration: 180.63586ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T19:43:05.901972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.343178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-25T19:43:05.902007Z","caller":"traceutil/trace.go:171","msg":"trace[205341469] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:507; }","duration":"240.40935ms","start":"2026-06-25T19:43:05.661589Z","end":"2026-06-25T19:43:05.901998Z","steps":["trace[205341469] 'agreement among raft nodes before linearized reading' (duration: 240.357779ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T19:43:12.633066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"696.230838ms","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-25T19:43:12.633142Z","caller":"traceutil/trace.go:171","msg":"trace[1762872382] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:593; }","duration":"696.35192ms","start":"2026-06-25T19:43:11.936772Z","end":"2026-06-25T19:43:12.633124Z","steps":["trace[1762872382] 'range keys from in-memory index tree' (duration: 696.092427ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T19:43:12.633176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T19:43:11.936752Z","time spent":"696.416911ms","remote":"127.0.0.1:49050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-25T19:43:12.633066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"690.411296ms","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-25T19:43:12.633231Z","caller":"traceutil/trace.go:171","msg":"trace[1311642575] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:593; }","duration":"690.599268ms","start":"2026-06-25T19:43:11.942616Z","end":"2026-06-25T19:43:12.633215Z","steps":["trace[1311642575] 'range keys from in-memory index tree' (duration: 690.259424ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T19:43:12.633275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T19:43:11.942609Z","time spent":"690.65663ms","remote":"127.0.0.1:49050","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-25T19:43:12.633066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"697.486322ms","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-25T19:43:12.633397Z","caller":"traceutil/trace.go:171","msg":"trace[507242363] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:593; }","duration":"697.847006ms","start":"2026-06-25T19:43:11.935526Z","end":"2026-06-25T19:43:12.633373Z","steps":["trace[507242363] 'range keys from in-memory index tree' (duration: 697.34447ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T19:43:12.633463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T19:43:11.935512Z","time spent":"697.933467ms","remote":"127.0.0.1:49050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-25T19:43:12.768304Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6363761097133822525,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-25T19:43:13.132244Z","caller":"traceutil/trace.go:171","msg":"trace[529765818] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"1.026047562s","start":"2026-06-25T19:43:12.106172Z","end":"2026-06-25T19:43:13.13222Z","steps":["trace[529765818] 'process raft request' (duration: 1.025482736s)"],"step_count":1} {"level":"warn","ts":"2026-06-25T19:43:13.132402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T19:43:12.10614Z","time spent":"1.026172033s","remote":"127.0.0.1:48930","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-25T19:43:14.076446Z","caller":"traceutil/trace.go:171","msg":"trace[1139642874] linearizableReadLoop","detail":"{readStateIndex:618; appliedIndex:614; }","duration":"1.808949896s","start":"2026-06-25T19:43:12.267473Z","end":"2026-06-25T19:43:14.076423Z","steps":["trace[1139642874] 'read index received' (duration: 863.9798ms)","trace[1139642874] 'applied index is now lower than readState.Index' (duration: 944.968586ms)"],"step_count":2} {"level":"info","ts":"2026-06-25T19:43:14.076445Z","caller":"traceutil/trace.go:171","msg":"trace[1260144951] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"1.439265316s","start":"2026-06-25T19:43:12.637138Z","end":"2026-06-25T19:43:14.076403Z","steps":["trace[1260144951] 'process raft request' (duration: 1.424327007s)","trace[1260144951] 'compare' (duration: 13.856898ms)"],"step_count":2} {"level":"warn","ts":"2026-06-25T19:43:14.076658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T19:43:12.637117Z","time spent":"1.439424508s","remote":"127.0.0.1:49050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-25T19:43:14.076888Z","caller":"traceutil/trace.go:171","msg":"trace[803314759] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"1.43964667s","start":"2026-06-25T19:43:12.637228Z","end":"2026-06-25T19:43:14.076875Z","steps":["trace[803314759] 'process raft request' (duration: 1.439045344s)"],"step_count":1} {"level":"info","ts":"2026-06-25T19:43:14.076886Z","caller":"traceutil/trace.go:171","msg":"trace[367758217] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"1.438548459s","start":"2026-06-25T19:43:12.638301Z","end":"2026-06-25T19:43:14.076849Z","steps":["trace[367758217] 'process raft request' (duration: 1.438078214s)"],"step_count":1} {"level":"warn","ts":"2026-06-25T19:43:14.076951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T19:43:12.637206Z","time spent":"1.439710892s","remote":"127.0.0.1:49050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-25T19:43:14.077084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T19:43:12.638291Z","time spent":"1.43868317s","remote":"127.0.0.1:49050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-25T19:43:14.077254Z","caller":"traceutil/trace.go:171","msg":"trace[1414544412] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"890.538124ms","start":"2026-06-25T19:43:13.186693Z","end":"2026-06-25T19:43:14.077231Z","steps":["trace[1414544412] 'process raft request' (duration: 890.393783ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T19:43:14.077376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T19:43:13.18666Z","time spent":"890.657665ms","remote":"127.0.0.1:49020","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-25T19:43:14.077457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.809964487s","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-25T19:43:14.07752Z","caller":"traceutil/trace.go:171","msg":"trace[2032295083] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:598; }","duration":"1.810085539s","start":"2026-06-25T19:43:12.267416Z","end":"2026-06-25T19:43:14.077502Z","steps":["trace[2032295083] 'agreement among raft nodes before linearized reading' (duration: 1.809763666s)"],"step_count":1} {"level":"warn","ts":"2026-06-25T19:43:14.077556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T19:43:12.267375Z","time spent":"1.810172649s","remote":"127.0.0.1:49050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-25T19:43:14.077766Z","caller":"traceutil/trace.go:171","msg":"trace[300782527] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"515.452356ms","start":"2026-06-25T19:43:13.562298Z","end":"2026-06-25T19:43:14.077751Z","steps":["trace[300782527] 'process raft request' (duration: 514.882981ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T19:43:14.077851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.772498506s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-7l9gq\" ","response":"range_response_count:1 size:16965"} {"level":"warn","ts":"2026-06-25T19:43:14.077832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.417469823s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-25T19:43:14.077872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T19:43:13.562274Z","time spent":"515.527167ms","remote":"127.0.0.1:49050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-25T19:43:14.077886Z","caller":"traceutil/trace.go:171","msg":"trace[639329648] range","detail":"{range_begin:/registry/pods/kube-system/cilium-7l9gq; range_end:; response_count:1; response_revision:599; }","duration":"1.772562568s","start":"2026-06-25T19:43:12.305314Z","end":"2026-06-25T19:43:14.077876Z","steps":["trace[639329648] 'agreement among raft nodes before linearized reading' (duration: 1.772406716s)"],"step_count":1} {"level":"info","ts":"2026-06-25T19:43:14.077901Z","caller":"traceutil/trace.go:171","msg":"trace[1858385588] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:599; }","duration":"1.417561605s","start":"2026-06-25T19:43:12.660323Z","end":"2026-06-25T19:43:14.077884Z","steps":["trace[1858385588] 'agreement among raft nodes before linearized reading' (duration: 1.417454214s)"],"step_count":1} {"level":"warn","ts":"2026-06-25T19:43:14.077914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T19:43:12.305293Z","time spent":"1.772614758s","remote":"127.0.0.1:48994","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16987,"request content":"key:\"/registry/pods/kube-system/cilium-7l9gq\" "} {"level":"warn","ts":"2026-06-25T19:43:14.07794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T19:43:12.660311Z","time spent":"1.417622235s","remote":"127.0.0.1:48830","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-25T19:43:15.808986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.585207475s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-25T19:43:15.809107Z","caller":"traceutil/trace.go:171","msg":"trace[209242278] linearizableReadLoop","detail":"{readStateIndex:621; appliedIndex:620; }","duration":"1.722984346s","start":"2026-06-25T19:43:14.086105Z","end":"2026-06-25T19:43:15.809089Z","steps":["trace[209242278] 'read index received' (duration: 137.409018ms)","trace[209242278] 'applied index is now lower than readState.Index' (duration: 1.585573948s)"],"step_count":2} {"level":"info","ts":"2026-06-25T19:43:15.809178Z","caller":"traceutil/trace.go:171","msg":"trace[616754877] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"1.724155339s","start":"2026-06-25T19:43:14.085011Z","end":"2026-06-25T19:43:15.809166Z","steps":["trace[616754877] 'process raft request' (duration: 138.48991ms)","trace[616754877] 'compare' (duration: 1.584762609s)"],"step_count":2} {"level":"warn","ts":"2026-06-25T19:43:15.809239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T19:43:14.084991Z","time spent":"1.724217069s","remote":"127.0.0.1:49050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-25T19:43:15.809499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.7233864s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-06-25T19:43:15.809536Z","caller":"traceutil/trace.go:171","msg":"trace[2056572503] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:600; }","duration":"1.72343708s","start":"2026-06-25T19:43:14.086089Z","end":"2026-06-25T19:43:15.809526Z","steps":["trace[2056572503] 'agreement among raft nodes before linearized reading' (duration: 1.723336659s)"],"step_count":1} {"level":"warn","ts":"2026-06-25T19:43:15.809568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T19:43:14.08608Z","time spent":"1.723480601s","remote":"127.0.0.1:49000","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":215,"request content":"key:\"/registry/serviceaccounts/kube-system/job-controller\" "} {"level":"warn","ts":"2026-06-25T19:43:16.045094Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.821527019s","expected-duration":"1s"} {"level":"info","ts":"2026-06-25T19:43:16.060547Z","caller":"traceutil/trace.go:171","msg":"trace[1205043345] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"1.967873822s","start":"2026-06-25T19:43:14.092635Z","end":"2026-06-25T19:43:16.060509Z","steps":["trace[1205043345] 'process raft request' (duration: 1.952942973s)","trace[1205043345] 'compare' (duration: 14.755697ms)"],"step_count":2} {"level":"warn","ts":"2026-06-25T19:43:16.060835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T19:43:14.092605Z","time spent":"1.968038994s","remote":"127.0.0.1:48994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-25T19:43:16.084114Z","caller":"traceutil/trace.go:171","msg":"trace[1226711367] linearizableReadLoop","detail":"{readStateIndex:623; appliedIndex:621; }","duration":"274.940456ms","start":"2026-06-25T19:43:15.809132Z","end":"2026-06-25T19:43:16.084073Z","steps":["trace[1226711367] 'read index received' (duration: 236.439636ms)","trace[1226711367] 'applied index is now lower than readState.Index' (duration: 38.49917ms)"],"step_count":2} {"level":"warn","ts":"2026-06-25T19:43:16.084438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.99765836s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-25T19:43:16.084421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.155323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/envoy-gateway-system/\" range_end:\"/registry/limitranges/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-25T19:43:16.084487Z","caller":"traceutil/trace.go:171","msg":"trace[1376920878] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:601; }","duration":"1.997748981s","start":"2026-06-25T19:43:14.086725Z","end":"2026-06-25T19:43:16.084474Z","steps":["trace[1376920878] 'agreement among raft nodes before linearized reading' (duration: 1.997542888s)"],"step_count":1} {"level":"info","ts":"2026-06-25T19:43:16.084501Z","caller":"traceutil/trace.go:171","msg":"trace[525221019] range","detail":"{range_begin:/registry/limitranges/envoy-gateway-system/; range_end:/registry/limitranges/envoy-gateway-system0; response_count:0; response_revision:601; }","duration":"266.306205ms","start":"2026-06-25T19:43:15.818175Z","end":"2026-06-25T19:43:16.084482Z","steps":["trace[525221019] 'agreement among raft nodes before linearized reading' (duration: 266.174843ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T19:43:16.084523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T19:43:14.086714Z","time spent":"1.997802082s","remote":"127.0.0.1:48830","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-25T19:43:17.885188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.395148ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-25T19:43:17.885278Z","caller":"traceutil/trace.go:171","msg":"trace[1787798698] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:632; }","duration":"224.561419ms","start":"2026-06-25T19:43:17.660693Z","end":"2026-06-25T19:43:17.885255Z","steps":["trace[1787798698] 'range keys from in-memory index tree' (duration: 224.317787ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T19:43:17.885477Z","caller":"traceutil/trace.go:171","msg":"trace[27487522] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"110.795434ms","start":"2026-06-25T19:43:17.774659Z","end":"2026-06-25T19:43:17.885454Z","steps":["trace[27487522] 'process raft request' (duration: 84.287431ms)","trace[27487522] 'compare' (duration: 26.151029ms)"],"step_count":2} {"level":"warn","ts":"2026-06-25T19:43:17.885999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.203635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-25T19:43:17.886114Z","caller":"traceutil/trace.go:171","msg":"trace[453973794] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:0; response_revision:632; }","duration":"313.023273ms","start":"2026-06-25T19:43:17.57306Z","end":"2026-06-25T19:43:17.886083Z","steps":["trace[453973794] 'range keys from in-memory index tree' (duration: 312.052703ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T19:43:17.886186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T19:43:17.573001Z","time spent":"313.160945ms","remote":"127.0.0.1:48880","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":27,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" "} {"level":"info","ts":"2026-06-25T19:43:28.174534Z","caller":"traceutil/trace.go:171","msg":"trace[1607295953] transaction","detail":"{read_only:false; response_revision:744; number_of_response:1; }","duration":"224.722009ms","start":"2026-06-25T19:43:27.949222Z","end":"2026-06-25T19:43:28.173944Z","steps":["trace[1607295953] 'process raft request' (duration: 224.489057ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T19:43:31.971649Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6363761097133822852,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-25T19:43:32.348392Z","caller":"traceutil/trace.go:171","msg":"trace[2089156929] linearizableReadLoop","detail":"{readStateIndex:791; appliedIndex:790; }","duration":"877.218118ms","start":"2026-06-25T19:43:31.471151Z","end":"2026-06-25T19:43:32.348369Z","steps":["trace[2089156929] 'read index received' (duration: 876.961375ms)","trace[2089156929] 'applied index is now lower than readState.Index' (duration: 256.013µs)"],"step_count":2} {"level":"info","ts":"2026-06-25T19:43:32.348495Z","caller":"traceutil/trace.go:171","msg":"trace[1645385680] transaction","detail":"{read_only:false; response_revision:764; number_of_response:1; }","duration":"922.126357ms","start":"2026-06-25T19:43:31.42634Z","end":"2026-06-25T19:43:32.348466Z","steps":["trace[1645385680] 'process raft request' (duration: 921.864964ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T19:43:32.348589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"877.43042ms","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-25T19:43:32.348614Z","caller":"traceutil/trace.go:171","msg":"trace[955987884] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:764; }","duration":"877.510522ms","start":"2026-06-25T19:43:31.471096Z","end":"2026-06-25T19:43:32.348607Z","steps":["trace[955987884] 'agreement among raft nodes before linearized reading' (duration: 877.39796ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T19:43:32.348638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T19:43:31.471069Z","time spent":"877.563452ms","remote":"127.0.0.1:49050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-25T19:43:32.348662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T19:43:31.42632Z","time spent":"922.249859ms","remote":"127.0.0.1:49020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-25T19:43:32.348738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"687.507362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-25T19:43:32.348795Z","caller":"traceutil/trace.go:171","msg":"trace[577205589] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:764; }","duration":"687.624333ms","start":"2026-06-25T19:43:31.661155Z","end":"2026-06-25T19:43:32.34878Z","steps":["trace[577205589] 'agreement among raft nodes before linearized reading' (duration: 687.517522ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T19:43:32.348823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T19:43:31.661137Z","time spent":"687.681144ms","remote":"127.0.0.1:48830","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-25T19:43:32.349197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.087761ms","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-25T19:43:32.349273Z","caller":"traceutil/trace.go:171","msg":"trace[1322725380] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:764; }","duration":"163.180592ms","start":"2026-06-25T19:43:32.186071Z","end":"2026-06-25T19:43:32.349252Z","steps":["trace[1322725380] 'agreement among raft nodes before linearized reading' (duration: 163.01279ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T19:43:45.851735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.623376ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-06-25T19:43:45.851858Z","caller":"traceutil/trace.go:171","msg":"trace[1517957147] linearizableReadLoop","detail":"{readStateIndex:962; appliedIndex:961; }","duration":"191.387864ms","start":"2026-06-25T19:43:45.660449Z","end":"2026-06-25T19:43:45.851837Z","steps":["trace[1517957147] 'read index received' (duration: 39.841µs)","trace[1517957147] 'applied index is now lower than readState.Index' (duration: 191.346513ms)"],"step_count":2} {"level":"warn","ts":"2026-06-25T19:43:45.851942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.488605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-25T19:43:45.85198Z","caller":"traceutil/trace.go:171","msg":"trace[1214445546] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:931; }","duration":"191.568615ms","start":"2026-06-25T19:43:45.660397Z","end":"2026-06-25T19:43:45.851966Z","steps":["trace[1214445546] 'agreement among raft nodes before linearized reading' (duration: 191.496065ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T19:43:54.593897Z","caller":"traceutil/trace.go:171","msg":"trace[662332764] linearizableReadLoop","detail":"{readStateIndex:1001; appliedIndex:1000; }","duration":"115.23602ms","start":"2026-06-25T19:43:54.478628Z","end":"2026-06-25T19:43:54.593864Z","steps":["trace[662332764] 'read index received' (duration: 115.053688ms)","trace[662332764] 'applied index is now lower than readState.Index' (duration: 181.232µs)"],"step_count":2} {"level":"info","ts":"2026-06-25T19:43:54.593964Z","caller":"traceutil/trace.go:171","msg":"trace[1240560426] transaction","detail":"{read_only:false; response_revision:968; number_of_response:1; }","duration":"118.140531ms","start":"2026-06-25T19:43:54.475799Z","end":"2026-06-25T19:43:54.59394Z","steps":["trace[1240560426] 'process raft request' (duration: 117.909218ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T19:43:54.594162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.508723ms","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-25T19:43:54.594217Z","caller":"traceutil/trace.go:171","msg":"trace[464414663] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:968; }","duration":"115.598963ms","start":"2026-06-25T19:43:54.478602Z","end":"2026-06-25T19:43:54.594201Z","steps":["trace[464414663] 'agreement among raft nodes before linearized reading' (duration: 115.423832ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T19:43:54.594965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.867736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-25T19:43:54.595061Z","caller":"traceutil/trace.go:171","msg":"trace[505595902] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:969; }","duration":"114.999688ms","start":"2026-06-25T19:43:54.480044Z","end":"2026-06-25T19:43:54.595043Z","steps":["trace[505595902] 'agreement among raft nodes before linearized reading' (duration: 114.799336ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T19:43:54.59526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.747124ms","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-25T19:43:54.595324Z","caller":"traceutil/trace.go:171","msg":"trace[1958498439] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:969; }","duration":"112.817484ms","start":"2026-06-25T19:43:54.48248Z","end":"2026-06-25T19:43:54.595298Z","steps":["trace[1958498439] 'agreement among raft nodes before linearized reading' (duration: 112.674853ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T19:43:54.595349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.899475ms","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-25T19:43:54.595539Z","caller":"traceutil/trace.go:171","msg":"trace[1797603848] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:969; }","duration":"113.130728ms","start":"2026-06-25T19:43:54.482344Z","end":"2026-06-25T19:43:54.595475Z","steps":["trace[1797603848] 'agreement among raft nodes before linearized reading' (duration: 112.864855ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T19:44:00.851309Z","caller":"traceutil/trace.go:171","msg":"trace[1965417577] transaction","detail":"{read_only:false; response_revision:991; number_of_response:1; }","duration":"178.388953ms","start":"2026-06-25T19:44:00.672883Z","end":"2026-06-25T19:44:00.851272Z","steps":["trace[1965417577] 'process raft request' (duration: 177.806297ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T19:44:00.851461Z","caller":"traceutil/trace.go:171","msg":"trace[1230630140] linearizableReadLoop","detail":"{readStateIndex:1027; appliedIndex:1025; }","duration":"173.543782ms","start":"2026-06-25T19:44:00.67789Z","end":"2026-06-25T19:44:00.851434Z","steps":["trace[1230630140] 'read index received' (duration: 38.27355ms)","trace[1230630140] 'applied index is now lower than readState.Index' (duration: 135.269332ms)"],"step_count":2} {"level":"info","ts":"2026-06-25T19:44:00.851667Z","caller":"traceutil/trace.go:171","msg":"trace[86465107] transaction","detail":"{read_only:false; response_revision:992; number_of_response:1; }","duration":"178.725677ms","start":"2026-06-25T19:44:00.672931Z","end":"2026-06-25T19:44:00.851656Z","steps":["trace[86465107] 'process raft request' (duration: 178.287892ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T19:44:00.851915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.012717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-25T19:44:00.851955Z","caller":"traceutil/trace.go:171","msg":"trace[865983377] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:992; }","duration":"174.086309ms","start":"2026-06-25T19:44:00.677858Z","end":"2026-06-25T19:44:00.851945Z","steps":["trace[865983377] 'agreement among raft nodes before linearized reading' (duration: 173.934046ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T19:44:00.852245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.999075ms","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-25T19:44:00.852385Z","caller":"traceutil/trace.go:171","msg":"trace[1273296246] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:992; }","duration":"127.181858ms","start":"2026-06-25T19:44:00.725178Z","end":"2026-06-25T19:44:00.85236Z","steps":["trace[1273296246] 'agreement among raft nodes before linearized reading' (duration: 126.871145ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T19:44:25.076615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.35078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-06-25T19:44:25.076671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.989493ms","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-25T19:44:25.076779Z","caller":"traceutil/trace.go:171","msg":"trace[981763606] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1073; }","duration":"108.131124ms","start":"2026-06-25T19:44:24.968629Z","end":"2026-06-25T19:44:25.07676Z","steps":["trace[981763606] 'range keys from in-memory index tree' (duration: 107.865981ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T19:44:25.07679Z","caller":"traceutil/trace.go:171","msg":"trace[429814515] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1073; }","duration":"114.549462ms","start":"2026-06-25T19:44:24.9622Z","end":"2026-06-25T19:44:25.076749Z","steps":["trace[429814515] 'range keys from in-memory index tree' (duration: 114.186778ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T19:44:27.274831Z","caller":"traceutil/trace.go:171","msg":"trace[749750154] linearizableReadLoop","detail":"{readStateIndex:1121; appliedIndex:1120; }","duration":"132.462782ms","start":"2026-06-25T19:44:27.142346Z","end":"2026-06-25T19:44:27.274808Z","steps":["trace[749750154] 'read index received' (duration: 132.21778ms)","trace[749750154] 'applied index is now lower than readState.Index' (duration: 243.922µs)"],"step_count":2} {"level":"info","ts":"2026-06-25T19:44:27.274966Z","caller":"traceutil/trace.go:171","msg":"trace[1200229033] transaction","detail":"{read_only:false; response_revision:1080; number_of_response:1; }","duration":"338.904056ms","start":"2026-06-25T19:44:26.936026Z","end":"2026-06-25T19:44:27.27493Z","steps":["trace[1200229033] 'process raft request' (duration: 338.633083ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T19:44:27.275064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.708306ms","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-25T19:44:27.275107Z","caller":"traceutil/trace.go:171","msg":"trace[1200286988] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1080; }","duration":"132.805527ms","start":"2026-06-25T19:44:27.14229Z","end":"2026-06-25T19:44:27.275095Z","steps":["trace[1200286988] 'agreement among raft nodes before linearized reading' (duration: 132.658175ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T19:44:27.275261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.827967ms","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-25T19:44:27.275341Z","caller":"traceutil/trace.go:171","msg":"trace[705899475] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1080; }","duration":"130.948878ms","start":"2026-06-25T19:44:27.144373Z","end":"2026-06-25T19:44:27.275322Z","steps":["trace[705899475] 'agreement among raft nodes before linearized reading' (duration: 130.751326ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T19:44:27.275726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.32787ms","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-25T19:44:27.275849Z","caller":"traceutil/trace.go:171","msg":"trace[1951818554] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1080; }","duration":"130.468432ms","start":"2026-06-25T19:44:27.145351Z","end":"2026-06-25T19:44:27.275819Z","steps":["trace[1951818554] 'agreement among raft nodes before linearized reading' (duration: 130.106988ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T19:44:27.276813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T19:44:26.936001Z","time spent":"339.034609ms","remote":"127.0.0.1:49050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"}