{"level":"warn","ts":"2026-06-13T06:07:55.414518Z","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-13T06:07:55.41479Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.223:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.223:2380","--initial-cluster=instance=https://199.204.45.223:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.223:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.223: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-13T06:07:55.415038Z","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-13T06:07:55.415112Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.223:2380"]} {"level":"info","ts":"2026-06-13T06:07:55.415598Z","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-13T06:07:55.416537Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.223:2379"]} {"level":"info","ts":"2026-06-13T06:07:55.416691Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.223:2380"],"listen-peer-urls":["https://199.204.45.223:2380"],"advertise-client-urls":["https://199.204.45.223:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.223:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.223: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-13T06:07:55.424775Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"7.793143ms"} {"level":"info","ts":"2026-06-13T06:07:55.434787Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"11f26225a5bb9fe3","cluster-id":"75c25101f01fd4c6"} {"level":"info","ts":"2026-06-13T06:07:55.434961Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 switched to configuration voters=()"} {"level":"info","ts":"2026-06-13T06:07:55.43507Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became follower at term 0"} {"level":"info","ts":"2026-06-13T06:07:55.435141Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 11f26225a5bb9fe3 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-13T06:07:55.435179Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became follower at term 1"} {"level":"info","ts":"2026-06-13T06:07:55.435281Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 switched to configuration voters=(1293203956842602467)"} {"level":"warn","ts":"2026-06-13T06:07:55.443658Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-13T06:07:55.446663Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-13T06:07:55.447863Z","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-13T06:07:55.452876Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"11f26225a5bb9fe3","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-13T06:07:55.453091Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"11f26225a5bb9fe3","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-13T06:07:55.453477Z","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-13T06:07:55.453583Z","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-13T06:07:55.453598Z","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-13T06:07:55.458Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 switched to configuration voters=(1293203956842602467)"} {"level":"info","ts":"2026-06-13T06:07:55.458627Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"75c25101f01fd4c6","local-member-id":"11f26225a5bb9fe3","added-peer-id":"11f26225a5bb9fe3","added-peer-peer-urls":["https://199.204.45.223:2380"]} {"level":"info","ts":"2026-06-13T06:07:55.459123Z","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-13T06:07:55.459199Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.223:2380"} {"level":"info","ts":"2026-06-13T06:07:55.459232Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.223:2380"} {"level":"info","ts":"2026-06-13T06:07:55.459452Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"11f26225a5bb9fe3","initial-advertise-peer-urls":["https://199.204.45.223:2380"],"listen-peer-urls":["https://199.204.45.223:2380"],"advertise-client-urls":["https://199.204.45.223:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.223:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-13T06:07:55.459515Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-13T06:07:56.136135Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 is starting a new election at term 1"} {"level":"info","ts":"2026-06-13T06:07:56.136289Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-13T06:07:56.136388Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 received MsgPreVoteResp from 11f26225a5bb9fe3 at term 1"} {"level":"info","ts":"2026-06-13T06:07:56.136449Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became candidate at term 2"} {"level":"info","ts":"2026-06-13T06:07:56.136487Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 received MsgVoteResp from 11f26225a5bb9fe3 at term 2"} {"level":"info","ts":"2026-06-13T06:07:56.136533Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became leader at term 2"} {"level":"info","ts":"2026-06-13T06:07:56.13658Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 11f26225a5bb9fe3 elected leader 11f26225a5bb9fe3 at term 2"} {"level":"info","ts":"2026-06-13T06:07:56.137855Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-13T06:07:56.138548Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-13T06:07:56.138546Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"11f26225a5bb9fe3","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.223:2379]}","request-path":"/0/members/11f26225a5bb9fe3/attributes","cluster-id":"75c25101f01fd4c6","publish-timeout":"7s"} {"level":"info","ts":"2026-06-13T06:07:56.138596Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-13T06:07:56.139017Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"75c25101f01fd4c6","local-member-id":"11f26225a5bb9fe3","cluster-version":"3.5"} {"level":"info","ts":"2026-06-13T06:07:56.139019Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-13T06:07:56.139197Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-13T06:07:56.139243Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-13T06:07:56.139308Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-13T06:07:56.14094Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-13T06:07:56.141453Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.223:2379"} {"level":"warn","ts":"2026-06-13T06:07:57.996349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.719316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-13T06:07:57.996467Z","caller":"traceutil/trace.go:171","msg":"trace[397454432] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:86; }","duration":"225.903487ms","start":"2026-06-13T06:07:57.770541Z","end":"2026-06-13T06:07:57.996445Z","steps":["trace[397454432] 'range keys from in-memory index tree' (duration: 225.595625ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:07:57.996478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.909132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/default/instance.18b88efdc7032e49\" ","response":"range_response_count:1 size:650"} {"level":"info","ts":"2026-06-13T06:07:57.996704Z","caller":"traceutil/trace.go:171","msg":"trace[1788363174] range","detail":"{range_begin:/registry/events/default/instance.18b88efdc7032e49; range_end:; response_count:1; response_revision:86; }","duration":"300.115633ms","start":"2026-06-13T06:07:57.696478Z","end":"2026-06-13T06:07:57.996594Z","steps":["trace[1788363174] 'range keys from in-memory index tree' (duration: 299.7517ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:07:57.996865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:07:57.696469Z","time spent":"300.356894ms","remote":"127.0.0.1:59308","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":672,"request content":"key:\"/registry/events/default/instance.18b88efdc7032e49\" "} {"level":"warn","ts":"2026-06-13T06:08:02.53445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.595397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T06:08:02.534539Z","caller":"traceutil/trace.go:171","msg":"trace[202436285] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:0; response_revision:323; }","duration":"192.754348ms","start":"2026-06-13T06:08:02.341765Z","end":"2026-06-13T06:08:02.53452Z","steps":["trace[202436285] 'range keys from in-memory index tree' (duration: 192.499196ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:08:09.167074Z","caller":"traceutil/trace.go:171","msg":"trace[1499912610] transaction","detail":"{read_only:false; response_revision:400; number_of_response:1; }","duration":"166.691322ms","start":"2026-06-13T06:08:09.000342Z","end":"2026-06-13T06:08:09.167033Z","steps":["trace[1499912610] 'process raft request' (duration: 166.502111ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:08:09.696107Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11521226817471262343,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-13T06:08:10.285874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.943783ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:39"} {"level":"info","ts":"2026-06-13T06:08:10.285977Z","caller":"traceutil/trace.go:171","msg":"trace[1579470221] linearizableReadLoop","detail":"{readStateIndex:417; appliedIndex:416; }","duration":"1.089941911s","start":"2026-06-13T06:08:09.196019Z","end":"2026-06-13T06:08:10.28596Z","steps":["trace[1579470221] 'read index received' (duration: 612.641235ms)","trace[1579470221] 'applied index is now lower than readState.Index' (duration: 477.299496ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T06:08:10.286004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:08:09.168092Z","time spent":"1.117904882s","remote":"127.0.0.1:59252","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-06-13T06:08:10.286096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.090075812s","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-13T06:08:10.286135Z","caller":"traceutil/trace.go:171","msg":"trace[1112926291] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:400; }","duration":"1.090147402s","start":"2026-06-13T06:08:09.195972Z","end":"2026-06-13T06:08:10.28612Z","steps":["trace[1112926291] 'agreement among raft nodes before linearized reading' (duration: 1.090069721s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:08:10.286185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:08:09.195953Z","time spent":"1.090225282s","remote":"127.0.0.1:59502","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-13T06:08:10.286303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"521.250775ms","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-13T06:08:10.286416Z","caller":"traceutil/trace.go:171","msg":"trace[1360348634] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:400; }","duration":"521.391395ms","start":"2026-06-13T06:08:09.764985Z","end":"2026-06-13T06:08:10.286377Z","steps":["trace[1360348634] 'agreement among raft nodes before linearized reading' (duration: 521.193754ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:08:10.28648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:08:09.764963Z","time spent":"521.507447ms","remote":"127.0.0.1:59502","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-13T06:08:10.286453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"790.809687ms","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-13T06:08:10.287041Z","caller":"traceutil/trace.go:171","msg":"trace[1651520014] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:400; }","duration":"791.517731ms","start":"2026-06-13T06:08:09.495503Z","end":"2026-06-13T06:08:10.287021Z","steps":["trace[1651520014] 'agreement among raft nodes before linearized reading' (duration: 790.661806ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:08:10.287356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:08:09.495481Z","time spent":"791.854873ms","remote":"127.0.0.1:59502","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-13T06:08:11.175847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.634899ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-13T06:08:11.175974Z","caller":"traceutil/trace.go:171","msg":"trace[1141172766] transaction","detail":"{read_only:false; response_revision:401; number_of_response:1; }","duration":"888.505367ms","start":"2026-06-13T06:08:10.287451Z","end":"2026-06-13T06:08:11.175956Z","steps":["trace[1141172766] 'process raft request' (duration: 588.303994ms)","trace[1141172766] 'compare' (duration: 299.476388ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T06:08:11.176061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:08:10.287433Z","time spent":"888.596887ms","remote":"127.0.0.1:59252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T06:08:11.195354Z","caller":"traceutil/trace.go:171","msg":"trace[171093792] transaction","detail":"{read_only:false; response_revision:402; number_of_response:1; }","duration":"905.215118ms","start":"2026-06-13T06:08:10.290117Z","end":"2026-06-13T06:08:11.195332Z","steps":["trace[171093792] 'process raft request' (duration: 905.080207ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:08:11.195446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:08:10.290095Z","time spent":"905.303938ms","remote":"127.0.0.1:59502","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-13T06:08:11.195635Z","caller":"traceutil/trace.go:171","msg":"trace[14166798] transaction","detail":"{read_only:false; response_revision:403; number_of_response:1; }","duration":"904.728045ms","start":"2026-06-13T06:08:10.290894Z","end":"2026-06-13T06:08:11.195622Z","steps":["trace[14166798] 'process raft request' (duration: 904.404533ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:08:11.195695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:08:10.290881Z","time spent":"904.786345ms","remote":"127.0.0.1:59502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T06:08:11.195734Z","caller":"traceutil/trace.go:171","msg":"trace[1602515981] linearizableReadLoop","detail":"{readStateIndex:421; appliedIndex:418; }","duration":"178.448331ms","start":"2026-06-13T06:08:11.017214Z","end":"2026-06-13T06:08:11.195662Z","steps":["trace[1602515981] 'read index received' (duration: 178.007508ms)","trace[1602515981] 'applied index is now lower than readState.Index' (duration: 439.743µs)"],"step_count":2} {"level":"info","ts":"2026-06-13T06:08:11.195744Z","caller":"traceutil/trace.go:171","msg":"trace[1440061526] transaction","detail":"{read_only:false; response_revision:404; number_of_response:1; }","duration":"901.618646ms","start":"2026-06-13T06:08:10.294088Z","end":"2026-06-13T06:08:11.195706Z","steps":["trace[1440061526] 'process raft request' (duration: 901.468545ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:08:11.195926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.695042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:4796"} {"level":"info","ts":"2026-06-13T06:08:11.19601Z","caller":"traceutil/trace.go:171","msg":"trace[494678380] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:404; }","duration":"178.817933ms","start":"2026-06-13T06:08:11.017175Z","end":"2026-06-13T06:08:11.195993Z","steps":["trace[494678380] 'agreement among raft nodes before linearized reading' (duration: 178.676612ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:08:11.19601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:08:10.294081Z","time spent":"901.860688ms","remote":"127.0.0.1:59502","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-13T06:08:35.819917Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11521226817471262604,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-13T06:08:35.847088Z","caller":"traceutil/trace.go:171","msg":"trace[797413977] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"837.552402ms","start":"2026-06-13T06:08:35.009511Z","end":"2026-06-13T06:08:35.847063Z","steps":["trace[797413977] 'process raft request' (duration: 837.397025ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:08:35.847218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:08:35.00949Z","time spent":"837.670388ms","remote":"127.0.0.1:59276","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-13T06:08:35.862296Z","caller":"traceutil/trace.go:171","msg":"trace[714155745] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"847.003148ms","start":"2026-06-13T06:08:35.015284Z","end":"2026-06-13T06:08:35.862287Z","steps":["trace[714155745] 'process raft request' (duration: 846.803089ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:08:35.862382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:08:35.015273Z","time spent":"847.067622ms","remote":"127.0.0.1:59276","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-13T06:08:35.862344Z","caller":"traceutil/trace.go:171","msg":"trace[762397024] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"832.327867ms","start":"2026-06-13T06:08:35.029987Z","end":"2026-06-13T06:08:35.862315Z","steps":["trace[762397024] 'process raft request' (duration: 832.206172ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:08:35.862443Z","caller":"traceutil/trace.go:171","msg":"trace[987233057] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"832.346338ms","start":"2026-06-13T06:08:35.030074Z","end":"2026-06-13T06:08:35.86242Z","steps":["trace[987233057] 'process raft request' (duration: 832.15827ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:08:35.862248Z","caller":"traceutil/trace.go:171","msg":"trace[1481811653] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"850.219513ms","start":"2026-06-13T06:08:35.012009Z","end":"2026-06-13T06:08:35.862228Z","steps":["trace[1481811653] 'process raft request' (duration: 849.971552ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:08:35.862553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:08:35.030067Z","time spent":"832.421311ms","remote":"127.0.0.1:59276","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-13T06:08:35.86256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:08:35.011989Z","time spent":"850.549418ms","remote":"127.0.0.1:59276","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-13T06:08:35.862791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:08:35.029967Z","time spent":"832.487515ms","remote":"127.0.0.1:59276","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-13T06:08:35.862998Z","caller":"traceutil/trace.go:171","msg":"trace[1817810408] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"832.878362ms","start":"2026-06-13T06:08:35.030074Z","end":"2026-06-13T06:08:35.862952Z","steps":["trace[1817810408] 'process raft request' (duration: 832.526526ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:08:35.863175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:08:35.030064Z","time spent":"833.05302ms","remote":"127.0.0.1:59276","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-13T06:08:35.86321Z","caller":"traceutil/trace.go:171","msg":"trace[575499896] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"833.031608ms","start":"2026-06-13T06:08:35.030129Z","end":"2026-06-13T06:08:35.863161Z","steps":["trace[575499896] 'process raft request' (duration: 832.85402ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:08:35.863369Z","caller":"traceutil/trace.go:171","msg":"trace[984665105] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"830.044994ms","start":"2026-06-13T06:08:35.033305Z","end":"2026-06-13T06:08:35.86335Z","steps":["trace[984665105] 'process raft request' (duration: 829.795113ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:08:35.86334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:08:35.030124Z","time spent":"833.193556ms","remote":"127.0.0.1:59276","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-13T06:08:35.863514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:08:35.033279Z","time spent":"830.143908ms","remote":"127.0.0.1:59276","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-13T06:08:35.863531Z","caller":"traceutil/trace.go:171","msg":"trace[814628031] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"829.459438ms","start":"2026-06-13T06:08:35.034057Z","end":"2026-06-13T06:08:35.863517Z","steps":["trace[814628031] 'process raft request' (duration: 829.155014ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:08:35.863593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:08:35.03405Z","time spent":"829.514841ms","remote":"127.0.0.1:59276","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-13T06:08:35.863654Z","caller":"traceutil/trace.go:171","msg":"trace[546817273] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"812.190549ms","start":"2026-06-13T06:08:35.051453Z","end":"2026-06-13T06:08:35.863643Z","steps":["trace[546817273] 'process raft request' (duration: 812.014631ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:08:35.863759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:08:35.051433Z","time spent":"812.298994ms","remote":"127.0.0.1:59276","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-13T06:08:35.864253Z","caller":"traceutil/trace.go:171","msg":"trace[1519851460] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"783.816672ms","start":"2026-06-13T06:08:35.080418Z","end":"2026-06-13T06:08:35.864234Z","steps":["trace[1519851460] 'process raft request' (duration: 783.258537ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:08:35.866876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:08:35.080388Z","time spent":"786.396588ms","remote":"127.0.0.1:59276","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-13T06:08:35.874327Z","caller":"traceutil/trace.go:171","msg":"trace[1050694976] linearizableReadLoop","detail":"{readStateIndex:562; appliedIndex:550; }","duration":"554.414966ms","start":"2026-06-13T06:08:35.319883Z","end":"2026-06-13T06:08:35.874298Z","steps":["trace[1050694976] 'read index received' (duration: 527.067674ms)","trace[1050694976] 'applied index is now lower than readState.Index' (duration: 27.346782ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T06:08:35.874399Z","caller":"traceutil/trace.go:171","msg":"trace[1376639104] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"705.562456ms","start":"2026-06-13T06:08:35.168828Z","end":"2026-06-13T06:08:35.87439Z","steps":["trace[1376639104] 'process raft request' (duration: 696.109351ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:08:35.874538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:08:35.168777Z","time spent":"705.741554ms","remote":"127.0.0.1:59276","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-13T06:08:35.876152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"556.124944ms","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-13T06:08:35.876195Z","caller":"traceutil/trace.go:171","msg":"trace[2007248635] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:538; }","duration":"556.347263ms","start":"2026-06-13T06:08:35.319841Z","end":"2026-06-13T06:08:35.876188Z","steps":["trace[2007248635] 'agreement among raft nodes before linearized reading' (duration: 554.644557ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:08:35.876213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:08:35.319827Z","time spent":"556.381465ms","remote":"127.0.0.1:59502","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-13T06:08:35.88275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"558.649697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-13T06:08:35.882777Z","caller":"traceutil/trace.go:171","msg":"trace[935364559] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:543; }","duration":"558.70962ms","start":"2026-06-13T06:08:35.324061Z","end":"2026-06-13T06:08:35.882771Z","steps":["trace[935364559] 'agreement among raft nodes before linearized reading' (duration: 558.632907ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:08:35.882833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:08:35.324051Z","time spent":"558.778114ms","remote":"127.0.0.1:59502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-13T06:08:35.882965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.3153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T06:08:35.88302Z","caller":"traceutil/trace.go:171","msg":"trace[1707328447] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:543; }","duration":"132.407044ms","start":"2026-06-13T06:08:35.750599Z","end":"2026-06-13T06:08:35.883006Z","steps":["trace[1707328447] 'agreement among raft nodes before linearized reading' (duration: 132.32325ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:08:35.883101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"558.974392ms","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-13T06:08:35.883178Z","caller":"traceutil/trace.go:171","msg":"trace[44548583] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:543; }","duration":"559.099258ms","start":"2026-06-13T06:08:35.324073Z","end":"2026-06-13T06:08:35.883172Z","steps":["trace[44548583] 'agreement among raft nodes before linearized reading' (duration: 559.008324ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:08:35.88321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:08:35.324061Z","time spent":"559.14449ms","remote":"127.0.0.1:59502","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-13T06:08:35.883553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"559.37399ms","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-13T06:08:35.883574Z","caller":"traceutil/trace.go:171","msg":"trace[853142932] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:543; }","duration":"559.428603ms","start":"2026-06-13T06:08:35.32414Z","end":"2026-06-13T06:08:35.883568Z","steps":["trace[853142932] 'agreement among raft nodes before linearized reading' (duration: 558.789514ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:08:35.883682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:08:35.324117Z","time spent":"559.467785ms","remote":"127.0.0.1:59502","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-13T06:08:42.111231Z","caller":"traceutil/trace.go:171","msg":"trace[1235052944] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"182.895149ms","start":"2026-06-13T06:08:41.928312Z","end":"2026-06-13T06:08:42.111208Z","steps":["trace[1235052944] 'process raft request' (duration: 182.716842ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:08:42.431468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.341878ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-13T06:08:42.431827Z","caller":"traceutil/trace.go:171","msg":"trace[950948546] linearizableReadLoop","detail":"{readStateIndex:663; appliedIndex:661; }","duration":"493.728601ms","start":"2026-06-13T06:08:41.938083Z","end":"2026-06-13T06:08:42.431811Z","steps":["trace[950948546] 'read index received' (duration: 172.974914ms)","trace[950948546] 'applied index is now lower than readState.Index' (duration: 320.751897ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T06:08:42.431902Z","caller":"traceutil/trace.go:171","msg":"trace[90010794] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"502.211346ms","start":"2026-06-13T06:08:41.929682Z","end":"2026-06-13T06:08:42.431894Z","steps":["trace[90010794] 'process raft request' (duration: 219.17856ms)","trace[90010794] 'compare' (duration: 281.990663ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T06:08:42.431949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:08:41.929664Z","time spent":"502.255967ms","remote":"127.0.0.1:59502","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-13T06:08:42.431802Z","caller":"traceutil/trace.go:171","msg":"trace[2081052545] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"299.07705ms","start":"2026-06-13T06:08:42.132707Z","end":"2026-06-13T06:08:42.431784Z","steps":["trace[2081052545] 'process raft request' (duration: 298.918133ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:08:42.432094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.95097ms","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-13T06:08:42.43224Z","caller":"traceutil/trace.go:171","msg":"trace[1941922489] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:637; }","duration":"494.115627ms","start":"2026-06-13T06:08:41.938079Z","end":"2026-06-13T06:08:42.432194Z","steps":["trace[1941922489] 'agreement among raft nodes before linearized reading' (duration: 493.841175ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:08:42.432293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:08:41.938056Z","time spent":"494.224451ms","remote":"127.0.0.1:59502","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-13T06:08:42.457085Z","caller":"traceutil/trace.go:171","msg":"trace[2012953353] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"285.114212ms","start":"2026-06-13T06:08:42.171928Z","end":"2026-06-13T06:08:42.457043Z","steps":["trace[2012953353] 'process raft request' (duration: 284.450344ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:08:42.457165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"517.744035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-13T06:08:42.457374Z","caller":"traceutil/trace.go:171","msg":"trace[540937866] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:638; }","duration":"517.956214ms","start":"2026-06-13T06:08:41.939332Z","end":"2026-06-13T06:08:42.457288Z","steps":["trace[540937866] 'agreement among raft nodes before linearized reading' (duration: 517.63319ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:08:42.45741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.92766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-xnkhr\" ","response":"range_response_count:1 size:16965"} {"level":"warn","ts":"2026-06-13T06:08:42.457481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:08:41.939322Z","time spent":"518.139621ms","remote":"127.0.0.1:59502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-13T06:08:42.457502Z","caller":"traceutil/trace.go:171","msg":"trace[1676346626] range","detail":"{range_begin:/registry/pods/kube-system/cilium-xnkhr; range_end:; response_count:1; response_revision:638; }","duration":"332.050955ms","start":"2026-06-13T06:08:42.125427Z","end":"2026-06-13T06:08:42.457478Z","steps":["trace[1676346626] 'agreement among raft nodes before linearized reading' (duration: 331.759043ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:08:42.457679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:08:42.125415Z","time spent":"332.253493ms","remote":"127.0.0.1:59422","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-xnkhr\" "} {"level":"warn","ts":"2026-06-13T06:08:43.250687Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11521226817471262787,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-13T06:08:43.400864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.864362ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-13T06:08:43.40117Z","caller":"traceutil/trace.go:171","msg":"trace[711960798] linearizableReadLoop","detail":"{readStateIndex:669; appliedIndex:666; }","duration":"650.978252ms","start":"2026-06-13T06:08:42.750173Z","end":"2026-06-13T06:08:43.401152Z","steps":["trace[711960798] 'read index received' (duration: 520.39524ms)","trace[711960798] 'applied index is now lower than readState.Index' (duration: 130.580121ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T06:08:43.401222Z","caller":"traceutil/trace.go:171","msg":"trace[37767922] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"926.666923ms","start":"2026-06-13T06:08:42.474531Z","end":"2026-06-13T06:08:43.401198Z","steps":["trace[37767922] 'process raft request' (duration: 926.464995ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:08:43.401298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"651.127617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T06:08:43.401329Z","caller":"traceutil/trace.go:171","msg":"trace[2093668774] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:642; }","duration":"651.19384ms","start":"2026-06-13T06:08:42.750125Z","end":"2026-06-13T06:08:43.401319Z","steps":["trace[2093668774] 'agreement among raft nodes before linearized reading' (duration: 651.082996ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:08:43.401362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:08:42.750104Z","time spent":"651.251443ms","remote":"127.0.0.1:59224","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-13T06:08:43.401393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:08:42.474486Z","time spent":"926.802148ms","remote":"127.0.0.1:59422","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-13T06:08:43.401414Z","caller":"traceutil/trace.go:171","msg":"trace[1964961123] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"890.749476ms","start":"2026-06-13T06:08:42.510639Z","end":"2026-06-13T06:08:43.401388Z","steps":["trace[1964961123] 'process raft request' (duration: 890.440694ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:08:43.401664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:08:42.510619Z","time spent":"890.942744ms","remote":"127.0.0.1:59468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-13T06:08:43.401178Z","caller":"traceutil/trace.go:171","msg":"trace[676689655] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"939.500384ms","start":"2026-06-13T06:08:42.461644Z","end":"2026-06-13T06:08:43.401144Z","steps":["trace[676689655] 'process raft request' (duration: 808.85607ms)","trace[676689655] 'compare' (duration: 129.742897ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T06:08:43.402241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:08:42.461596Z","time spent":"940.593589ms","remote":"127.0.0.1:59502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T06:08:44.935697Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11521226817471262801,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-13T06:08:45.194655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.44473912s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T06:08:45.194751Z","caller":"traceutil/trace.go:171","msg":"trace[2031817416] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:647; }","duration":"1.444856955s","start":"2026-06-13T06:08:43.749857Z","end":"2026-06-13T06:08:45.194713Z","steps":["trace[2031817416] 'range keys from in-memory index tree' (duration: 1.444626326s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:08:45.194791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:08:43.749836Z","time spent":"1.444945659s","remote":"127.0.0.1:59214","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-13T06:08:45.194811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.078768875s","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-13T06:08:45.194879Z","caller":"traceutil/trace.go:171","msg":"trace[1569184722] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:647; }","duration":"1.078850608s","start":"2026-06-13T06:08:44.11601Z","end":"2026-06-13T06:08:45.194861Z","steps":["trace[1569184722] 'range keys from in-memory index tree' (duration: 1.078517004s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:08:45.194919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:08:44.115949Z","time spent":"1.078961793s","remote":"127.0.0.1:59502","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-13T06:08:45.436215Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11521226817471262801,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-13T06:08:45.936452Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11521226817471262801,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-13T06:08:46.436791Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11521226817471262801,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-13T06:08:46.734972Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.399712154s","expected-duration":"1s"} {"level":"warn","ts":"2026-06-13T06:08:47.196162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999900592s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-06-13T06:08:47.196239Z","caller":"traceutil/trace.go:171","msg":"trace[903188954] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000042267s","start":"2026-06-13T06:08:45.196178Z","end":"2026-06-13T06:08:47.19622Z","steps":["trace[903188954] 'agreement among raft nodes before linearized reading' (duration: 1.999933133s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:08:47.196282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:08:45.196141Z","time spent":"2.000129711s","remote":"127.0.0.1:59224","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/06/13 06:08:47 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-06-13T06:08:47.215482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"480.318275ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-06-13T06:08:47.216245Z","caller":"traceutil/trace.go:171","msg":"trace[1957276962] linearizableReadLoop","detail":"{readStateIndex:676; appliedIndex:674; }","duration":"2.780585718s","start":"2026-06-13T06:08:44.43564Z","end":"2026-06-13T06:08:47.216226Z","steps":["trace[1957276962] 'read index received' (duration: 2.29966315s)","trace[1957276962] 'applied index is now lower than readState.Index' (duration: 480.921408ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T06:08:47.216316Z","caller":"traceutil/trace.go:171","msg":"trace[1253791527] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"2.017087309s","start":"2026-06-13T06:08:45.199208Z","end":"2026-06-13T06:08:47.216295Z","steps":["trace[1253791527] 'process raft request' (duration: 2.01685396s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:08:47.216662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.781029617s","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-13T06:08:47.21671Z","caller":"traceutil/trace.go:171","msg":"trace[2066043993] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:648; }","duration":"2.78113137s","start":"2026-06-13T06:08:44.435568Z","end":"2026-06-13T06:08:47.2167Z","steps":["trace[2066043993] 'agreement among raft nodes before linearized reading' (duration: 2.780746375s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:08:47.216747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:08:44.43554Z","time spent":"2.781199643s","remote":"127.0.0.1:59502","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-13T06:08:47.216988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.721626524s","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-13T06:08:47.21704Z","caller":"traceutil/trace.go:171","msg":"trace[950674362] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:649; }","duration":"2.721734849s","start":"2026-06-13T06:08:44.495292Z","end":"2026-06-13T06:08:47.217027Z","steps":["trace[950674362] 'agreement among raft nodes before linearized reading' (duration: 2.721468918s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:08:47.217073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:08:44.495272Z","time spent":"2.721793571s","remote":"127.0.0.1:59502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-13T06:08:47.217086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.809786788s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-13T06:08:47.217166Z","caller":"traceutil/trace.go:171","msg":"trace[1493706554] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:649; }","duration":"1.809910994s","start":"2026-06-13T06:08:45.407239Z","end":"2026-06-13T06:08:47.21715Z","steps":["trace[1493706554] 'agreement among raft nodes before linearized reading' (duration: 1.809754817s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:08:47.217205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:08:45.407221Z","time spent":"1.809974265s","remote":"127.0.0.1:59502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-13T06:08:47.217253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:08:45.199173Z","time spent":"2.017995115s","remote":"127.0.0.1:59502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T06:09:03.787302Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11521226817471263110,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-13T06:09:04.083562Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.296411926s","expected-duration":"1s"} {"level":"info","ts":"2026-06-13T06:09:04.084027Z","caller":"traceutil/trace.go:171","msg":"trace[78558279] transaction","detail":"{read_only:false; response_revision:806; number_of_response:1; }","duration":"1.296918682s","start":"2026-06-13T06:09:02.787085Z","end":"2026-06-13T06:09:04.084004Z","steps":["trace[78558279] 'process raft request' (duration: 1.296754907s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:09:04.084213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:09:02.787074Z","time spent":"1.297028106s","remote":"127.0.0.1:59502","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-13T06:09:04.48945Z","caller":"traceutil/trace.go:171","msg":"trace[378638618] transaction","detail":"{read_only:false; response_revision:807; number_of_response:1; }","duration":"1.699237886s","start":"2026-06-13T06:09:02.790199Z","end":"2026-06-13T06:09:04.489437Z","steps":["trace[378638618] 'process raft request' (duration: 1.699096671s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:09:04.489608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:09:02.790176Z","time spent":"1.699324629s","remote":"127.0.0.1:59408","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4905,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T06:09:04.489862Z","caller":"traceutil/trace.go:171","msg":"trace[1876166344] transaction","detail":"{read_only:false; response_revision:808; number_of_response:1; }","duration":"1.600570818s","start":"2026-06-13T06:09:02.889269Z","end":"2026-06-13T06:09:04.489839Z","steps":["trace[1876166344] 'process raft request' (duration: 1.600135474s)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:09:04.489997Z","caller":"traceutil/trace.go:171","msg":"trace[2133266510] linearizableReadLoop","detail":"{readStateIndex:842; appliedIndex:838; }","duration":"1.202770545s","start":"2026-06-13T06:09:03.287206Z","end":"2026-06-13T06:09:04.489977Z","steps":["trace[2133266510] 'read index received' (duration: 796.546674ms)","trace[2133266510] 'applied index is now lower than readState.Index' (duration: 406.221881ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T06:09:04.490009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:09:02.889254Z","time spent":"1.600677281s","remote":"127.0.0.1:59502","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-13T06:09:04.490539Z","caller":"traceutil/trace.go:171","msg":"trace[432228477] transaction","detail":"{read_only:false; response_revision:809; number_of_response:1; }","duration":"1.250176009s","start":"2026-06-13T06:09:03.240353Z","end":"2026-06-13T06:09:04.490529Z","steps":["trace[432228477] 'process raft request' (duration: 1.249299091s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:09:04.490674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.203457267s","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-13T06:09:04.490724Z","caller":"traceutil/trace.go:171","msg":"trace[553215026] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:809; }","duration":"1.20353841s","start":"2026-06-13T06:09:03.287173Z","end":"2026-06-13T06:09:04.490711Z","steps":["trace[553215026] 'agreement among raft nodes before linearized reading' (duration: 1.202982632s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:09:04.490757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:09:03.287161Z","time spent":"1.203589142s","remote":"127.0.0.1:59502","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-13T06:09:04.490924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:09:03.240329Z","time spent":"1.250241011s","remote":"127.0.0.1:59468","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-13T06:09:04.503862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.1861755s","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-13T06:09:04.503961Z","caller":"traceutil/trace.go:171","msg":"trace[1212949960] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:809; }","duration":"1.186308785s","start":"2026-06-13T06:09:03.317638Z","end":"2026-06-13T06:09:04.503947Z","steps":["trace[1212949960] 'agreement among raft nodes before linearized reading' (duration: 1.186088948s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:09:04.503993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:09:03.317624Z","time spent":"1.186362976s","remote":"127.0.0.1:59502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-13T06:09:04.504175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.458965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T06:09:04.504203Z","caller":"traceutil/trace.go:171","msg":"trace[694982036] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:809; }","duration":"182.503747ms","start":"2026-06-13T06:09:04.321689Z","end":"2026-06-13T06:09:04.504193Z","steps":["trace[694982036] 'agreement among raft nodes before linearized reading' (duration: 182.462165ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:09:04.504308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.115666ms","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":"info","ts":"2026-06-13T06:09:04.504331Z","caller":"traceutil/trace.go:171","msg":"trace[1569354687] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:809; }","duration":"183.184438ms","start":"2026-06-13T06:09:04.321141Z","end":"2026-06-13T06:09:04.504326Z","steps":["trace[1569354687] 'agreement among raft nodes before linearized reading' (duration: 183.150587ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:09:04.504412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.481327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T06:09:04.504432Z","caller":"traceutil/trace.go:171","msg":"trace[199892779] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:809; }","duration":"183.503908ms","start":"2026-06-13T06:09:04.320924Z","end":"2026-06-13T06:09:04.504428Z","steps":["trace[199892779] 'agreement among raft nodes before linearized reading' (duration: 183.472207ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:09:04.504478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"494.39396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T06:09:04.504514Z","caller":"traceutil/trace.go:171","msg":"trace[885276418] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:809; }","duration":"494.464083ms","start":"2026-06-13T06:09:04.010042Z","end":"2026-06-13T06:09:04.504506Z","steps":["trace[885276418] 'agreement among raft nodes before linearized reading' (duration: 494.414791ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:09:04.504543Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:09:04.010017Z","time spent":"494.520075ms","remote":"127.0.0.1:59566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":27,"request content":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true "} {"level":"warn","ts":"2026-06-13T06:09:04.50457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.139959245s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-13T06:09:04.504595Z","caller":"traceutil/trace.go:171","msg":"trace[111892369] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:809; }","duration":"1.140003696s","start":"2026-06-13T06:09:03.364585Z","end":"2026-06-13T06:09:04.504589Z","steps":["trace[111892369] 'agreement among raft nodes before linearized reading' (duration: 1.139963235s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:09:04.504616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:09:03.364574Z","time spent":"1.140038148s","remote":"127.0.0.1:59394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":2,"response size":29,"request content":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true "} {"level":"warn","ts":"2026-06-13T06:09:04.504643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.317508ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T06:09:04.504671Z","caller":"traceutil/trace.go:171","msg":"trace[1999278970] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:809; }","duration":"249.355139ms","start":"2026-06-13T06:09:04.255305Z","end":"2026-06-13T06:09:04.50466Z","steps":["trace[1999278970] 'agreement among raft nodes before linearized reading' (duration: 249.322028ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:09:04.504734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.182788719s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-13T06:09:04.504756Z","caller":"traceutil/trace.go:171","msg":"trace[363762579] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:809; }","duration":"1.18282429s","start":"2026-06-13T06:09:03.321926Z","end":"2026-06-13T06:09:04.50475Z","steps":["trace[363762579] 'agreement among raft nodes before linearized reading' (duration: 1.182763419s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:09:04.504771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:09:03.321919Z","time spent":"1.182848781s","remote":"127.0.0.1:59502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-13T06:09:04.504777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.978349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T06:09:04.504797Z","caller":"traceutil/trace.go:171","msg":"trace[1284783450] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:809; }","duration":"250.00092ms","start":"2026-06-13T06:09:04.254791Z","end":"2026-06-13T06:09:04.504792Z","steps":["trace[1284783450] 'agreement among raft nodes before linearized reading' (duration: 249.967839ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:09:04.504871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.183621576s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-13T06:09:04.504869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.072838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T06:09:04.504943Z","caller":"traceutil/trace.go:171","msg":"trace[357863275] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:809; }","duration":"289.212823ms","start":"2026-06-13T06:09:04.215714Z","end":"2026-06-13T06:09:04.504927Z","steps":["trace[357863275] 'agreement among raft nodes before linearized reading' (duration: 289.065558ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:09:04.504976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.259598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T06:09:04.50503Z","caller":"traceutil/trace.go:171","msg":"trace[1614331884] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:809; }","duration":"123.33122ms","start":"2026-06-13T06:09:04.381686Z","end":"2026-06-13T06:09:04.505017Z","steps":["trace[1614331884] 'agreement among raft nodes before linearized reading' (duration: 123.218786ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:09:04.50506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.244693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T06:09:04.505089Z","caller":"traceutil/trace.go:171","msg":"trace[697515156] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:809; }","duration":"289.301535ms","start":"2026-06-13T06:09:04.215782Z","end":"2026-06-13T06:09:04.505083Z","steps":["trace[697515156] 'agreement among raft nodes before linearized reading' (duration: 289.258074ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:09:04.504893Z","caller":"traceutil/trace.go:171","msg":"trace[706537967] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:809; }","duration":"1.183675548s","start":"2026-06-13T06:09:03.321211Z","end":"2026-06-13T06:09:04.504886Z","steps":["trace[706537967] 'agreement among raft nodes before linearized reading' (duration: 1.183624526s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:09:04.505176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:09:03.32119Z","time spent":"1.183974808s","remote":"127.0.0.1:59502","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-13T06:09:04.505199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.408423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T06:09:04.505217Z","caller":"traceutil/trace.go:171","msg":"trace[954048033] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:809; }","duration":"250.462254ms","start":"2026-06-13T06:09:04.25475Z","end":"2026-06-13T06:09:04.505212Z","steps":["trace[954048033] 'agreement among raft nodes before linearized reading' (duration: 250.432843ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:09:04.505252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.799729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T06:09:04.505274Z","caller":"traceutil/trace.go:171","msg":"trace[1326163332] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:809; }","duration":"125.835451ms","start":"2026-06-13T06:09:04.379434Z","end":"2026-06-13T06:09:04.505269Z","steps":["trace[1326163332] 'agreement among raft nodes before linearized reading' (duration: 125.79975ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:09:04.50543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.539464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T06:09:04.505485Z","caller":"traceutil/trace.go:171","msg":"trace[467396840] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:809; }","duration":"126.618626ms","start":"2026-06-13T06:09:04.378854Z","end":"2026-06-13T06:09:04.505473Z","steps":["trace[467396840] 'agreement among raft nodes before linearized reading' (duration: 126.531643ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:09:10.082732Z","caller":"traceutil/trace.go:171","msg":"trace[1183120076] transaction","detail":"{read_only:false; response_revision:864; number_of_response:1; }","duration":"157.087558ms","start":"2026-06-13T06:09:09.925626Z","end":"2026-06-13T06:09:10.082713Z","steps":["trace[1183120076] 'process raft request' (duration: 156.955694ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:09:10.082711Z","caller":"traceutil/trace.go:171","msg":"trace[2089892000] linearizableReadLoop","detail":"{readStateIndex:899; appliedIndex:898; }","duration":"140.07768ms","start":"2026-06-13T06:09:09.942612Z","end":"2026-06-13T06:09:10.08269Z","steps":["trace[2089892000] 'read index received' (duration: 139.905964ms)","trace[2089892000] 'applied index is now lower than readState.Index' (duration: 171.086µs)"],"step_count":2} {"level":"warn","ts":"2026-06-13T06:09:10.082888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.259915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/envoy-oidc-hmac\" ","response":"range_response_count:1 size:452"} {"level":"info","ts":"2026-06-13T06:09:10.082918Z","caller":"traceutil/trace.go:171","msg":"trace[742445615] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/envoy-oidc-hmac; range_end:; response_count:1; response_revision:864; }","duration":"140.331507ms","start":"2026-06-13T06:09:09.94258Z","end":"2026-06-13T06:09:10.082912Z","steps":["trace[742445615] 'agreement among raft nodes before linearized reading' (duration: 140.177543ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:09:10.290588Z","caller":"traceutil/trace.go:171","msg":"trace[1708992811] linearizableReadLoop","detail":"{readStateIndex:900; appliedIndex:899; }","duration":"182.528843ms","start":"2026-06-13T06:09:10.108025Z","end":"2026-06-13T06:09:10.290554Z","steps":["trace[1708992811] 'read index received' (duration: 180.7837ms)","trace[1708992811] 'applied index is now lower than readState.Index' (duration: 1.743773ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T06:09:10.290632Z","caller":"traceutil/trace.go:171","msg":"trace[1315255744] transaction","detail":"{read_only:false; response_revision:865; number_of_response:1; }","duration":"202.63554ms","start":"2026-06-13T06:09:10.087942Z","end":"2026-06-13T06:09:10.290578Z","steps":["trace[1315255744] 'process raft request' (duration: 200.9549ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:09:10.290971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.920194ms","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-13T06:09:10.291085Z","caller":"traceutil/trace.go:171","msg":"trace[1314990450] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:865; }","duration":"183.074589ms","start":"2026-06-13T06:09:10.107992Z","end":"2026-06-13T06:09:10.291067Z","steps":["trace[1314990450] 'agreement among raft nodes before linearized reading' (duration: 182.76638ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:09:10.292267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.65667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/eg\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T06:09:10.29233Z","caller":"traceutil/trace.go:171","msg":"trace[666275484] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/eg; range_end:; response_count:0; response_revision:865; }","duration":"146.745222ms","start":"2026-06-13T06:09:10.145569Z","end":"2026-06-13T06:09:10.292314Z","steps":["trace[666275484] 'agreement among raft nodes before linearized reading' (duration: 145.178414ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:09:12.215469Z","caller":"traceutil/trace.go:171","msg":"trace[178495001] transaction","detail":"{read_only:false; response_revision:878; number_of_response:1; }","duration":"161.901269ms","start":"2026-06-13T06:09:12.053539Z","end":"2026-06-13T06:09:12.21544Z","steps":["trace[178495001] 'process raft request' (duration: 161.741264ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:09:12.339296Z","caller":"traceutil/trace.go:171","msg":"trace[1182815377] transaction","detail":"{read_only:false; response_revision:879; number_of_response:1; }","duration":"115.727043ms","start":"2026-06-13T06:09:12.223539Z","end":"2026-06-13T06:09:12.339266Z","steps":["trace[1182815377] 'process raft request' (duration: 115.576618ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:09:12.579124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.052999ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-13T06:09:12.579309Z","caller":"traceutil/trace.go:171","msg":"trace[775999393] linearizableReadLoop","detail":"{readStateIndex:916; appliedIndex:914; }","duration":"235.678821ms","start":"2026-06-13T06:09:12.343613Z","end":"2026-06-13T06:09:12.579292Z","steps":["trace[775999393] 'read index received' (duration: 135.479927ms)","trace[775999393] 'applied index is now lower than readState.Index' (duration: 100.197764ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T06:09:12.579418Z","caller":"traceutil/trace.go:171","msg":"trace[1592177824] transaction","detail":"{read_only:false; response_revision:881; number_of_response:1; }","duration":"352.026731ms","start":"2026-06-13T06:09:12.227382Z","end":"2026-06-13T06:09:12.579409Z","steps":["trace[1592177824] 'process raft request' (duration: 351.835536ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:09:12.579439Z","caller":"traceutil/trace.go:171","msg":"trace[365430988] transaction","detail":"{read_only:false; response_revision:880; number_of_response:1; }","duration":"355.781583ms","start":"2026-06-13T06:09:12.223645Z","end":"2026-06-13T06:09:12.579427Z","steps":["trace[365430988] 'process raft request' (duration: 255.344392ms)","trace[365430988] 'compare' (duration: 99.924006ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T06:09:12.579476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:09:12.22737Z","time spent":"352.073603ms","remote":"127.0.0.1:46508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2317,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T06:09:12.579496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:09:12.22361Z","time spent":"355.854085ms","remote":"127.0.0.1:59422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3856,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T06:09:12.579658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.037791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-67659f764b-z9zs7\" ","response":"range_response_count:1 size:3871"} {"level":"info","ts":"2026-06-13T06:09:12.579705Z","caller":"traceutil/trace.go:171","msg":"trace[487413740] range","detail":"{range_begin:/registry/pods/kube-system/coredns-67659f764b-z9zs7; range_end:; response_count:1; response_revision:881; }","duration":"236.121264ms","start":"2026-06-13T06:09:12.343572Z","end":"2026-06-13T06:09:12.579693Z","steps":["trace[487413740] 'agreement among raft nodes before linearized reading' (duration: 235.98496ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:09:12.706359Z","caller":"traceutil/trace.go:171","msg":"trace[1717569236] linearizableReadLoop","detail":"{readStateIndex:918; appliedIndex:916; }","duration":"126.980536ms","start":"2026-06-13T06:09:12.579363Z","end":"2026-06-13T06:09:12.706343Z","steps":["trace[1717569236] 'read index received' (duration: 119.478034ms)","trace[1717569236] 'applied index is now lower than readState.Index' (duration: 7.501862ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T06:09:12.70643Z","caller":"traceutil/trace.go:171","msg":"trace[1595714039] transaction","detail":"{read_only:false; response_revision:883; number_of_response:1; }","duration":"350.464455ms","start":"2026-06-13T06:09:12.35596Z","end":"2026-06-13T06:09:12.706424Z","steps":["trace[1595714039] 'process raft request' (duration: 350.337001ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:09:12.706531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:09:12.355935Z","time spent":"350.511997ms","remote":"127.0.0.1:59502","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-13T06:09:12.706502Z","caller":"traceutil/trace.go:171","msg":"trace[1013403083] transaction","detail":"{read_only:false; response_revision:882; number_of_response:1; }","duration":"361.646347ms","start":"2026-06-13T06:09:12.344823Z","end":"2026-06-13T06:09:12.706469Z","steps":["trace[1013403083] 'process raft request' (duration: 353.960239ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:09:12.706652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:09:12.344807Z","time spent":"361.76978ms","remote":"127.0.0.1:59308","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":719,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-13T06:09:12.706689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.763674ms","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-13T06:09:12.706796Z","caller":"traceutil/trace.go:171","msg":"trace[1969013014] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:883; }","duration":"352.893657ms","start":"2026-06-13T06:09:12.353861Z","end":"2026-06-13T06:09:12.706754Z","steps":["trace[1969013014] 'agreement among raft nodes before linearized reading' (duration: 352.640459ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:09:12.706856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:09:12.353854Z","time spent":"352.989501ms","remote":"127.0.0.1:59502","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-13T06:09:12.799935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.417235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-13T06:09:12.799941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.967481ms","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-13T06:09:12.799977Z","caller":"traceutil/trace.go:171","msg":"trace[1540808822] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:884; }","duration":"112.490347ms","start":"2026-06-13T06:09:12.687474Z","end":"2026-06-13T06:09:12.799965Z","steps":["trace[1540808822] 'agreement among raft nodes before linearized reading' (duration: 112.392614ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:09:12.79998Z","caller":"traceutil/trace.go:171","msg":"trace[569435631] transaction","detail":"{read_only:false; response_revision:884; number_of_response:1; }","duration":"212.133574ms","start":"2026-06-13T06:09:12.587826Z","end":"2026-06-13T06:09:12.79996Z","steps":["trace[569435631] 'process raft request' (duration: 211.802275ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:09:12.799998Z","caller":"traceutil/trace.go:171","msg":"trace[11554204] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:884; }","duration":"184.052973ms","start":"2026-06-13T06:09:12.615935Z","end":"2026-06-13T06:09:12.799988Z","steps":["trace[11554204] 'agreement among raft nodes before linearized reading' (duration: 183.885488ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:09:12.799996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.973588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/coredns\" ","response":"range_response_count:1 size:179"} {"level":"info","ts":"2026-06-13T06:09:12.80004Z","caller":"traceutil/trace.go:171","msg":"trace[310005041] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/coredns; range_end:; response_count:1; response_revision:884; }","duration":"216.047939ms","start":"2026-06-13T06:09:12.583981Z","end":"2026-06-13T06:09:12.800029Z","steps":["trace[310005041] 'agreement among raft nodes before linearized reading' (duration: 215.933106ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:09:12.800051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.226309ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-13T06:09:12.800091Z","caller":"traceutil/trace.go:171","msg":"trace[826494975] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:884; }","duration":"184.27798ms","start":"2026-06-13T06:09:12.615798Z","end":"2026-06-13T06:09:12.800076Z","steps":["trace[826494975] 'agreement among raft nodes before linearized reading' (duration: 184.213918ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:09:12.800093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.092885ms","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-13T06:09:12.80012Z","caller":"traceutil/trace.go:171","msg":"trace[1137082970] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:884; }","duration":"184.141236ms","start":"2026-06-13T06:09:12.615972Z","end":"2026-06-13T06:09:12.800113Z","steps":["trace[1137082970] 'agreement among raft nodes before linearized reading' (duration: 184.073364ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:09:12.799958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.550919ms","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-13T06:09:12.800181Z","caller":"traceutil/trace.go:171","msg":"trace[333545981] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:884; }","duration":"184.793515ms","start":"2026-06-13T06:09:12.61536Z","end":"2026-06-13T06:09:12.800154Z","steps":["trace[333545981] 'agreement among raft nodes before linearized reading' (duration: 184.479456ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:09:12.972641Z","caller":"traceutil/trace.go:171","msg":"trace[2002191105] linearizableReadLoop","detail":"{readStateIndex:921; appliedIndex:919; }","duration":"172.860723ms","start":"2026-06-13T06:09:12.799756Z","end":"2026-06-13T06:09:12.972617Z","steps":["trace[2002191105] 'read index received' (duration: 89.302102ms)","trace[2002191105] 'applied index is now lower than readState.Index' (duration: 83.557701ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T06:09:12.972667Z","caller":"traceutil/trace.go:171","msg":"trace[1741178691] transaction","detail":"{read_only:false; response_revision:885; number_of_response:1; }","duration":"262.00972ms","start":"2026-06-13T06:09:12.710625Z","end":"2026-06-13T06:09:12.972635Z","steps":["trace[1741178691] 'process raft request' (duration: 178.415567ms)","trace[1741178691] 'compare' (duration: 83.401577ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T06:09:12.972958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.160766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/coredns\" ","response":"range_response_count:1 size:179"} {"level":"warn","ts":"2026-06-13T06:09:12.973003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.877062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T06:09:12.973032Z","caller":"traceutil/trace.go:171","msg":"trace[968449472] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/coredns; range_end:; response_count:1; response_revision:886; }","duration":"186.29704ms","start":"2026-06-13T06:09:12.786717Z","end":"2026-06-13T06:09:12.973014Z","steps":["trace[968449472] 'agreement among raft nodes before linearized reading' (duration: 185.987301ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:09:12.972736Z","caller":"traceutil/trace.go:171","msg":"trace[644230732] transaction","detail":"{read_only:false; response_revision:886; number_of_response:1; }","duration":"261.775562ms","start":"2026-06-13T06:09:12.710913Z","end":"2026-06-13T06:09:12.972689Z","steps":["trace[644230732] 'process raft request' (duration: 261.649788ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:09:12.973197Z","caller":"traceutil/trace.go:171","msg":"trace[1336875686] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:886; }","duration":"223.980715ms","start":"2026-06-13T06:09:12.749059Z","end":"2026-06-13T06:09:12.973039Z","steps":["trace[1336875686] 'agreement among raft nodes before linearized reading' (duration: 223.665635ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:09:13.070015Z","caller":"traceutil/trace.go:171","msg":"trace[1053030800] transaction","detail":"{read_only:false; response_revision:887; number_of_response:1; }","duration":"265.470481ms","start":"2026-06-13T06:09:12.804512Z","end":"2026-06-13T06:09:13.069983Z","steps":["trace[1053030800] 'process raft request' (duration: 265.175522ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:09:13.070253Z","caller":"traceutil/trace.go:171","msg":"trace[712145279] transaction","detail":"{read_only:false; response_revision:888; number_of_response:1; }","duration":"265.566643ms","start":"2026-06-13T06:09:12.804634Z","end":"2026-06-13T06:09:13.0702Z","steps":["trace[712145279] 'process raft request' (duration: 265.240493ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:09:13.070404Z","caller":"traceutil/trace.go:171","msg":"trace[148230701] transaction","detail":"{read_only:false; response_revision:890; number_of_response:1; }","duration":"265.040318ms","start":"2026-06-13T06:09:12.805351Z","end":"2026-06-13T06:09:13.070392Z","steps":["trace[148230701] 'process raft request' (duration: 264.933594ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:09:13.070428Z","caller":"traceutil/trace.go:171","msg":"trace[991237149] transaction","detail":"{read_only:false; response_revision:889; number_of_response:1; }","duration":"265.632235ms","start":"2026-06-13T06:09:12.804769Z","end":"2026-06-13T06:09:13.070402Z","steps":["trace[991237149] 'process raft request' (duration: 265.45558ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:09:13.070691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.14032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-67659f764b-m76sq\" ","response":"range_response_count:1 size:3871"} {"level":"info","ts":"2026-06-13T06:09:13.070733Z","caller":"traceutil/trace.go:171","msg":"trace[1422908137] range","detail":"{range_begin:/registry/pods/kube-system/coredns-67659f764b-m76sq; range_end:; response_count:1; response_revision:890; }","duration":"267.227702ms","start":"2026-06-13T06:09:12.803494Z","end":"2026-06-13T06:09:13.070722Z","steps":["trace[1422908137] 'agreement among raft nodes before linearized reading' (duration: 267.080658ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:09:13.070916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.439087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-67659f764b-z9zs7\" ","response":"range_response_count:1 size:4777"} {"level":"info","ts":"2026-06-13T06:09:13.071028Z","caller":"traceutil/trace.go:171","msg":"trace[1976718496] range","detail":"{range_begin:/registry/pods/kube-system/coredns-67659f764b-z9zs7; range_end:; response_count:1; response_revision:890; }","duration":"269.572062ms","start":"2026-06-13T06:09:12.801442Z","end":"2026-06-13T06:09:13.071014Z","steps":["trace[1976718496] 'agreement among raft nodes before linearized reading' (duration: 269.235802ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:09:13.415951Z","caller":"traceutil/trace.go:171","msg":"trace[778626715] transaction","detail":"{read_only:false; response_revision:891; number_of_response:1; }","duration":"338.646062ms","start":"2026-06-13T06:09:13.077278Z","end":"2026-06-13T06:09:13.415924Z","steps":["trace[778626715] 'process raft request' (duration: 338.452397ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:09:13.416135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:09:13.077258Z","time spent":"338.766215ms","remote":"127.0.0.1:59422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4762,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T06:09:14.539647Z","caller":"traceutil/trace.go:171","msg":"trace[581424985] transaction","detail":"{read_only:false; response_revision:906; number_of_response:1; }","duration":"178.852331ms","start":"2026-06-13T06:09:14.360767Z","end":"2026-06-13T06:09:14.539619Z","steps":["trace[581424985] 'process raft request' (duration: 166.109172ms)","trace[581424985] 'compare' (duration: 12.591495ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T06:09:14.561473Z","caller":"traceutil/trace.go:171","msg":"trace[279104614] transaction","detail":"{read_only:false; response_revision:907; number_of_response:1; }","duration":"132.090957ms","start":"2026-06-13T06:09:14.429366Z","end":"2026-06-13T06:09:14.561457Z","steps":["trace[279104614] 'process raft request' (duration: 131.988284ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:09:14.885972Z","caller":"traceutil/trace.go:171","msg":"trace[2011253835] linearizableReadLoop","detail":"{readStateIndex:955; appliedIndex:952; }","duration":"137.74019ms","start":"2026-06-13T06:09:14.748215Z","end":"2026-06-13T06:09:14.885955Z","steps":["trace[2011253835] 'read index received' (duration: 623.748µs)","trace[2011253835] 'applied index is now lower than readState.Index' (duration: 137.115732ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T06:09:14.886075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.844623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T06:09:14.886081Z","caller":"traceutil/trace.go:171","msg":"trace[1869395282] transaction","detail":"{read_only:false; response_revision:919; number_of_response:1; }","duration":"173.98948ms","start":"2026-06-13T06:09:14.712072Z","end":"2026-06-13T06:09:14.886061Z","steps":["trace[1869395282] 'process raft request' (duration: 173.739813ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:09:14.886111Z","caller":"traceutil/trace.go:171","msg":"trace[1353885006] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:919; }","duration":"137.913105ms","start":"2026-06-13T06:09:14.748187Z","end":"2026-06-13T06:09:14.8861Z","steps":["trace[1353885006] 'agreement among raft nodes before linearized reading' (duration: 137.832953ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:09:14.992113Z","caller":"traceutil/trace.go:171","msg":"trace[1902686779] transaction","detail":"{read_only:false; response_revision:920; number_of_response:1; }","duration":"237.115999ms","start":"2026-06-13T06:09:14.754982Z","end":"2026-06-13T06:09:14.992098Z","steps":["trace[1902686779] 'process raft request' (duration: 236.727848ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:09:23.497485Z","caller":"traceutil/trace.go:171","msg":"trace[500326714] transaction","detail":"{read_only:false; response_revision:1002; number_of_response:1; }","duration":"176.510022ms","start":"2026-06-13T06:09:23.320949Z","end":"2026-06-13T06:09:23.497459Z","steps":["trace[500326714] 'process raft request' (duration: 176.337507ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:09:29.560846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.121047ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-13T06:09:29.560933Z","caller":"traceutil/trace.go:171","msg":"trace[538625218] linearizableReadLoop","detail":"{readStateIndex:1059; appliedIndex:1057; }","duration":"444.683667ms","start":"2026-06-13T06:09:29.116235Z","end":"2026-06-13T06:09:29.560919Z","steps":["trace[538625218] 'read index received' (duration: 110.703405ms)","trace[538625218] 'applied index is now lower than readState.Index' (duration: 333.978922ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T06:09:29.560993Z","caller":"traceutil/trace.go:171","msg":"trace[2079363489] transaction","detail":"{read_only:false; response_revision:1019; number_of_response:1; }","duration":"451.529459ms","start":"2026-06-13T06:09:29.109454Z","end":"2026-06-13T06:09:29.560983Z","steps":["trace[2079363489] 'process raft request' (duration: 201.197956ms)","trace[2079363489] 'compare' (duration: 249.990764ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T06:09:29.561049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:09:29.109416Z","time spent":"451.606121ms","remote":"127.0.0.1:59502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T06:09:29.561218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.978305ms","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-13T06:09:29.56124Z","caller":"traceutil/trace.go:171","msg":"trace[781927333] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1019; }","duration":"445.014916ms","start":"2026-06-13T06:09:29.116218Z","end":"2026-06-13T06:09:29.561233Z","steps":["trace[781927333] 'agreement among raft nodes before linearized reading' (duration: 444.923924ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:09:29.56126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:09:29.116209Z","time spent":"445.046167ms","remote":"127.0.0.1:59502","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-13T06:09:29.58715Z","caller":"traceutil/trace.go:171","msg":"trace[769806622] transaction","detail":"{read_only:false; response_revision:1020; number_of_response:1; }","duration":"358.914645ms","start":"2026-06-13T06:09:29.22822Z","end":"2026-06-13T06:09:29.587134Z","steps":["trace[769806622] 'process raft request' (duration: 358.824353ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:09:29.587247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:09:29.228195Z","time spent":"359.006057ms","remote":"127.0.0.1:59252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T06:09:29.587538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.670383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-13T06:09:29.587634Z","caller":"traceutil/trace.go:171","msg":"trace[671879991] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1020; }","duration":"429.775105ms","start":"2026-06-13T06:09:29.157812Z","end":"2026-06-13T06:09:29.587587Z","steps":["trace[671879991] 'agreement among raft nodes before linearized reading' (duration: 429.522219ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:09:29.587631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.439529ms","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-13T06:09:29.587642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.909176ms","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-13T06:09:29.587694Z","caller":"traceutil/trace.go:171","msg":"trace[155761865] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1020; }","duration":"311.524232ms","start":"2026-06-13T06:09:29.276146Z","end":"2026-06-13T06:09:29.58767Z","steps":["trace[155761865] 'agreement among raft nodes before linearized reading' (duration: 311.381948ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:09:29.587678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:09:29.15779Z","time spent":"429.877257ms","remote":"127.0.0.1:59502","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":"info","ts":"2026-06-13T06:09:29.587719Z","caller":"traceutil/trace.go:171","msg":"trace[677873711] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1020; }","duration":"305.018068ms","start":"2026-06-13T06:09:29.282672Z","end":"2026-06-13T06:09:29.58769Z","steps":["trace[677873711] 'agreement among raft nodes before linearized reading' (duration: 304.882375ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:09:29.587747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:09:29.276133Z","time spent":"311.600893ms","remote":"127.0.0.1:59502","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-13T06:09:29.587759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:09:29.282648Z","time spent":"305.100031ms","remote":"127.0.0.1:59502","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-13T06:09:29.58787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.795958ms","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-13T06:09:29.588039Z","caller":"traceutil/trace.go:171","msg":"trace[1355912078] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1020; }","duration":"306.29797ms","start":"2026-06-13T06:09:29.281726Z","end":"2026-06-13T06:09:29.588023Z","steps":["trace[1355912078] 'agreement among raft nodes before linearized reading' (duration: 305.732796ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:09:29.588159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:09:29.281712Z","time spent":"306.437854ms","remote":"127.0.0.1:59502","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-13T06:09:36.067732Z","caller":"traceutil/trace.go:171","msg":"trace[323573484] linearizableReadLoop","detail":"{readStateIndex:1084; appliedIndex:1082; }","duration":"386.13484ms","start":"2026-06-13T06:09:35.681574Z","end":"2026-06-13T06:09:36.067709Z","steps":["trace[323573484] 'read index received' (duration: 386.012227ms)","trace[323573484] 'applied index is now lower than readState.Index' (duration: 121.693µs)"],"step_count":2} {"level":"info","ts":"2026-06-13T06:09:36.067782Z","caller":"traceutil/trace.go:171","msg":"trace[939558448] transaction","detail":"{read_only:false; response_revision:1042; number_of_response:1; }","duration":"422.604302ms","start":"2026-06-13T06:09:35.645138Z","end":"2026-06-13T06:09:36.067742Z","steps":["trace[939558448] 'process raft request' (duration: 422.381766ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:09:36.067849Z","caller":"traceutil/trace.go:171","msg":"trace[1698866464] transaction","detail":"{read_only:false; response_revision:1043; number_of_response:1; }","duration":"421.408854ms","start":"2026-06-13T06:09:35.646427Z","end":"2026-06-13T06:09:36.067836Z","steps":["trace[1698866464] 'process raft request' (duration: 421.24133ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:09:36.067974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:09:35.645126Z","time spent":"422.745176ms","remote":"127.0.0.1:59502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T06:09:36.068254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:09:35.646414Z","time spent":"421.765122ms","remote":"127.0.0.1:59502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T06:09:36.068497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.130531ms","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-13T06:09:36.068588Z","caller":"traceutil/trace.go:171","msg":"trace[198964747] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1043; }","duration":"425.259495ms","start":"2026-06-13T06:09:35.643306Z","end":"2026-06-13T06:09:36.068566Z","steps":["trace[198964747] 'agreement among raft nodes before linearized reading' (duration: 424.920957ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:09:36.06865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:09:35.6433Z","time spent":"425.341257ms","remote":"127.0.0.1:59502","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-13T06:09:36.109533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.180848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T06:09:36.109555Z","caller":"traceutil/trace.go:171","msg":"trace[545587153] transaction","detail":"{read_only:false; response_revision:1044; number_of_response:1; }","duration":"424.333374ms","start":"2026-06-13T06:09:35.685202Z","end":"2026-06-13T06:09:36.109535Z","steps":["trace[545587153] 'process raft request' (duration: 424.17087ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:09:36.109591Z","caller":"traceutil/trace.go:171","msg":"trace[932241891] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1044; }","duration":"360.28924ms","start":"2026-06-13T06:09:35.749287Z","end":"2026-06-13T06:09:36.109576Z","steps":["trace[932241891] 'agreement among raft nodes before linearized reading' (duration: 360.180628ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:09:36.109619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:09:35.749263Z","time spent":"360.351132ms","remote":"127.0.0.1:59214","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-13T06:09:36.109619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.561113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-13T06:09:36.109665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:09:35.685188Z","time spent":"424.411686ms","remote":"127.0.0.1:59502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T06:09:36.109696Z","caller":"traceutil/trace.go:171","msg":"trace[1228805747] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1044; }","duration":"282.683837ms","start":"2026-06-13T06:09:35.826993Z","end":"2026-06-13T06:09:36.109677Z","steps":["trace[1228805747] 'agreement among raft nodes before linearized reading' (duration: 282.541453ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:09:38.26302Z","caller":"traceutil/trace.go:171","msg":"trace[1754678738] linearizableReadLoop","detail":"{readStateIndex:1089; appliedIndex:1088; }","duration":"192.041427ms","start":"2026-06-13T06:09:38.07095Z","end":"2026-06-13T06:09:38.262992Z","steps":["trace[1754678738] 'read index received' (duration: 191.934725ms)","trace[1754678738] 'applied index is now lower than readState.Index' (duration: 104.752µs)"],"step_count":2} {"level":"info","ts":"2026-06-13T06:09:38.263094Z","caller":"traceutil/trace.go:171","msg":"trace[2146720751] transaction","detail":"{read_only:false; response_revision:1048; number_of_response:1; }","duration":"241.464774ms","start":"2026-06-13T06:09:38.021599Z","end":"2026-06-13T06:09:38.263064Z","steps":["trace[2146720751] 'process raft request' (duration: 241.218588ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:09:38.263472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.491268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-13T06:09:38.26354Z","caller":"traceutil/trace.go:171","msg":"trace[1006126260] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1048; }","duration":"192.597451ms","start":"2026-06-13T06:09:38.070926Z","end":"2026-06-13T06:09:38.263524Z","steps":["trace[1006126260] 'agreement among raft nodes before linearized reading' (duration: 192.294374ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:09:38.263724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.589482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-13T06:09:38.263755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.707557ms","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-13T06:09:38.263787Z","caller":"traceutil/trace.go:171","msg":"trace[915450680] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1048; }","duration":"149.684973ms","start":"2026-06-13T06:09:38.114088Z","end":"2026-06-13T06:09:38.263773Z","steps":["trace[915450680] 'agreement among raft nodes before linearized reading' (duration: 149.494289ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:09:38.263834Z","caller":"traceutil/trace.go:171","msg":"trace[2088425975] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1048; }","duration":"150.827159ms","start":"2026-06-13T06:09:38.112987Z","end":"2026-06-13T06:09:38.263814Z","steps":["trace[2088425975] 'agreement among raft nodes before linearized reading' (duration: 150.619805ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:09:38.264186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.1584ms","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-13T06:09:38.26422Z","caller":"traceutil/trace.go:171","msg":"trace[186237522] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1048; }","duration":"192.230081ms","start":"2026-06-13T06:09:38.07198Z","end":"2026-06-13T06:09:38.26421Z","steps":["trace[186237522] 'agreement among raft nodes before linearized reading' (duration: 191.434383ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:10:58.189478Z","caller":"traceutil/trace.go:171","msg":"trace[827071498] transaction","detail":"{read_only:false; response_revision:1351; number_of_response:1; }","duration":"182.162485ms","start":"2026-06-13T06:10:58.007274Z","end":"2026-06-13T06:10:58.189436Z","steps":["trace[827071498] 'process raft request' (duration: 181.930792ms)"],"step_count":1}