{"level":"warn","ts":"2026-02-24T04:30:40.784657Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-24T04:30:40.784757Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.131: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.131:2380","--initial-cluster=instance=https://199.204.45.131:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.131:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.131: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-02-24T04:30:40.784895Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-24T04:30:40.784912Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.131:2380"]} {"level":"info","ts":"2026-02-24T04:30:40.784949Z","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-02-24T04:30:40.785768Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.131:2379"]} {"level":"info","ts":"2026-02-24T04:30:40.785916Z","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.131:2380"],"listen-peer-urls":["https://199.204.45.131:2380"],"advertise-client-urls":["https://199.204.45.131:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.131:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.131: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-02-24T04:30:40.79011Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.878279ms"} {"level":"info","ts":"2026-02-24T04:30:40.796419Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"2fdf33955ed9ec6c","cluster-id":"e3dd6b4ed8cb907a"} {"level":"info","ts":"2026-02-24T04:30:40.796502Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2fdf33955ed9ec6c switched to configuration voters=()"} {"level":"info","ts":"2026-02-24T04:30:40.796531Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2fdf33955ed9ec6c became follower at term 0"} {"level":"info","ts":"2026-02-24T04:30:40.796545Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 2fdf33955ed9ec6c [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-24T04:30:40.796554Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2fdf33955ed9ec6c became follower at term 1"} {"level":"info","ts":"2026-02-24T04:30:40.796631Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2fdf33955ed9ec6c switched to configuration voters=(3449532556223573100)"} {"level":"warn","ts":"2026-02-24T04:30:40.803674Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-24T04:30:40.805746Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-24T04:30:40.807066Z","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-02-24T04:30:40.809481Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"2fdf33955ed9ec6c","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-24T04:30:40.809713Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"2fdf33955ed9ec6c","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-24T04:30:40.809774Z","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-02-24T04:30:40.810044Z","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-02-24T04:30:40.810074Z","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-02-24T04:30:40.811501Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2fdf33955ed9ec6c switched to configuration voters=(3449532556223573100)"} {"level":"info","ts":"2026-02-24T04:30:40.811672Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e3dd6b4ed8cb907a","local-member-id":"2fdf33955ed9ec6c","added-peer-id":"2fdf33955ed9ec6c","added-peer-peer-urls":["https://199.204.45.131:2380"]} {"level":"info","ts":"2026-02-24T04:30:40.81414Z","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-02-24T04:30:40.814381Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"2fdf33955ed9ec6c","initial-advertise-peer-urls":["https://199.204.45.131:2380"],"listen-peer-urls":["https://199.204.45.131:2380"],"advertise-client-urls":["https://199.204.45.131:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.131:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-24T04:30:40.81442Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-24T04:30:40.814468Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.131:2380"} {"level":"info","ts":"2026-02-24T04:30:40.81579Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.131:2380"} {"level":"info","ts":"2026-02-24T04:30:41.097528Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2fdf33955ed9ec6c is starting a new election at term 1"} {"level":"info","ts":"2026-02-24T04:30:41.09759Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2fdf33955ed9ec6c became pre-candidate at term 1"} {"level":"info","ts":"2026-02-24T04:30:41.097625Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2fdf33955ed9ec6c received MsgPreVoteResp from 2fdf33955ed9ec6c at term 1"} {"level":"info","ts":"2026-02-24T04:30:41.097647Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2fdf33955ed9ec6c became candidate at term 2"} {"level":"info","ts":"2026-02-24T04:30:41.097664Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2fdf33955ed9ec6c received MsgVoteResp from 2fdf33955ed9ec6c at term 2"} {"level":"info","ts":"2026-02-24T04:30:41.097722Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2fdf33955ed9ec6c became leader at term 2"} {"level":"info","ts":"2026-02-24T04:30:41.097743Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 2fdf33955ed9ec6c elected leader 2fdf33955ed9ec6c at term 2"} {"level":"info","ts":"2026-02-24T04:30:41.098763Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"2fdf33955ed9ec6c","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.131:2379]}","request-path":"/0/members/2fdf33955ed9ec6c/attributes","cluster-id":"e3dd6b4ed8cb907a","publish-timeout":"7s"} {"level":"info","ts":"2026-02-24T04:30:41.098778Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-24T04:30:41.0988Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-24T04:30:41.099156Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-24T04:30:41.099189Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-24T04:30:41.10126Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-24T04:30:41.102027Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.131:2379"} {"level":"info","ts":"2026-02-24T04:30:41.102211Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-24T04:30:41.112933Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e3dd6b4ed8cb907a","local-member-id":"2fdf33955ed9ec6c","cluster-version":"3.5"} {"level":"info","ts":"2026-02-24T04:30:41.113008Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-24T04:30:41.113068Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-02-24T04:30:51.314215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.165546ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-24T04:30:51.314403Z","caller":"traceutil/trace.go:171","msg":"trace[2097287118] transaction","detail":"{read_only:false; response_revision:351; number_of_response:1; }","duration":"161.891168ms","start":"2026-02-24T04:30:51.152484Z","end":"2026-02-24T04:30:51.314375Z","steps":["trace[2097287118] 'process raft request' (duration: 44.769059ms)","trace[2097287118] 'compare' (duration: 115.964775ms)"],"step_count":2} {"level":"info","ts":"2026-02-24T04:30:51.458638Z","caller":"traceutil/trace.go:171","msg":"trace[1310200202] linearizableReadLoop","detail":"{readStateIndex:361; appliedIndex:359; }","duration":"284.657995ms","start":"2026-02-24T04:30:51.173946Z","end":"2026-02-24T04:30:51.458604Z","steps":["trace[1310200202] 'read index received' (duration: 23.318904ms)","trace[1310200202] 'applied index is now lower than readState.Index' (duration: 261.337531ms)"],"step_count":2} {"level":"info","ts":"2026-02-24T04:30:51.45904Z","caller":"traceutil/trace.go:171","msg":"trace[1320518798] transaction","detail":"{read_only:false; response_revision:352; number_of_response:1; }","duration":"305.175616ms","start":"2026-02-24T04:30:51.153847Z","end":"2026-02-24T04:30:51.459022Z","steps":["trace[1320518798] 'process raft request' (duration: 259.935626ms)","trace[1320518798] 'compare' (duration: 44.482027ms)"],"step_count":2} {"level":"warn","ts":"2026-02-24T04:30:51.459568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T04:30:51.15383Z","time spent":"305.257627ms","remote":"127.0.0.1:48204","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1251,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-24T04:30:51.459601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.508009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"info","ts":"2026-02-24T04:30:51.45972Z","caller":"traceutil/trace.go:171","msg":"trace[195205367] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:352; }","duration":"285.75199ms","start":"2026-02-24T04:30:51.173943Z","end":"2026-02-24T04:30:51.459695Z","steps":["trace[195205367] 'agreement among raft nodes before linearized reading' (duration: 285.398349ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T04:30:51.518698Z","caller":"traceutil/trace.go:171","msg":"trace[1034882557] transaction","detail":"{read_only:false; response_revision:353; number_of_response:1; }","duration":"199.206805ms","start":"2026-02-24T04:30:51.319469Z","end":"2026-02-24T04:30:51.518676Z","steps":["trace[1034882557] 'process raft request' (duration: 198.963664ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T04:30:51.519025Z","caller":"traceutil/trace.go:171","msg":"trace[1432715105] transaction","detail":"{read_only:false; response_revision:354; number_of_response:1; }","duration":"199.377816ms","start":"2026-02-24T04:30:51.319609Z","end":"2026-02-24T04:30:51.518987Z","steps":["trace[1432715105] 'process raft request' (duration: 199.015094ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T04:30:51.519431Z","caller":"traceutil/trace.go:171","msg":"trace[1053554601] transaction","detail":"{read_only:false; response_revision:355; number_of_response:1; }","duration":"198.376582ms","start":"2026-02-24T04:30:51.321016Z","end":"2026-02-24T04:30:51.519392Z","steps":["trace[1053554601] 'process raft request' (duration: 197.870609ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T04:30:51.520064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.135789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-02-24T04:30:51.520201Z","caller":"traceutil/trace.go:171","msg":"trace[638601033] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:355; }","duration":"146.310741ms","start":"2026-02-24T04:30:51.373869Z","end":"2026-02-24T04:30:51.520179Z","steps":["trace[638601033] 'agreement among raft nodes before linearized reading' (duration: 146.12707ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T04:30:51.520418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.523268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-02-24T04:30:51.520479Z","caller":"traceutil/trace.go:171","msg":"trace[1025901563] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:355; }","duration":"296.631299ms","start":"2026-02-24T04:30:51.223828Z","end":"2026-02-24T04:30:51.520459Z","steps":["trace[1025901563] 'agreement among raft nodes before linearized reading' (duration: 296.481828ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T04:30:51.520566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.388589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-02-24T04:30:51.520713Z","caller":"traceutil/trace.go:171","msg":"trace[898642492] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:355; }","duration":"247.57211ms","start":"2026-02-24T04:30:51.273096Z","end":"2026-02-24T04:30:51.520668Z","steps":["trace[898642492] 'agreement among raft nodes before linearized reading' (duration: 247.348039ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T04:30:51.519445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.714035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-02-24T04:30:51.521236Z","caller":"traceutil/trace.go:171","msg":"trace[748166154] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:355; }","duration":"198.543723ms","start":"2026-02-24T04:30:51.322673Z","end":"2026-02-24T04:30:51.521217Z","steps":["trace[748166154] 'agreement among raft nodes before linearized reading' (duration: 196.704395ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T04:30:51.72297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.681134ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-24T04:30:51.723395Z","caller":"traceutil/trace.go:171","msg":"trace[484666715] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"197.280746ms","start":"2026-02-24T04:30:51.526063Z","end":"2026-02-24T04:30:51.723343Z","steps":["trace[484666715] 'process raft request' (duration: 81.12826ms)","trace[484666715] 'compare' (duration: 115.442203ms)"],"step_count":2} {"level":"info","ts":"2026-02-24T04:30:51.723562Z","caller":"traceutil/trace.go:171","msg":"trace[955634684] transaction","detail":"{read_only:false; response_revision:359; number_of_response:1; }","duration":"194.285074ms","start":"2026-02-24T04:30:51.529238Z","end":"2026-02-24T04:30:51.723523Z","steps":["trace[955634684] 'process raft request' (duration: 193.904042ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T04:30:51.723811Z","caller":"traceutil/trace.go:171","msg":"trace[1268876855] transaction","detail":"{read_only:false; response_revision:360; number_of_response:1; }","duration":"193.4555ms","start":"2026-02-24T04:30:51.530342Z","end":"2026-02-24T04:30:51.723798Z","steps":["trace[1268876855] 'process raft request' (duration: 193.102937ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T04:30:51.723801Z","caller":"traceutil/trace.go:171","msg":"trace[956421259] transaction","detail":"{read_only:false; response_revision:361; number_of_response:1; }","duration":"193.390309ms","start":"2026-02-24T04:30:51.530362Z","end":"2026-02-24T04:30:51.723752Z","steps":["trace[956421259] 'process raft request' (duration: 193.130687ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T04:30:51.723906Z","caller":"traceutil/trace.go:171","msg":"trace[928175206] linearizableReadLoop","detail":"{readStateIndex:372; appliedIndex:366; }","duration":"174.621546ms","start":"2026-02-24T04:30:51.549262Z","end":"2026-02-24T04:30:51.723883Z","steps":["trace[928175206] 'read index received' (duration: 58.021028ms)","trace[928175206] 'applied index is now lower than readState.Index' (duration: 116.599498ms)"],"step_count":2} {"level":"info","ts":"2026-02-24T04:30:51.724019Z","caller":"traceutil/trace.go:171","msg":"trace[1369574521] transaction","detail":"{read_only:false; response_revision:362; number_of_response:1; }","duration":"193.50508ms","start":"2026-02-24T04:30:51.530503Z","end":"2026-02-24T04:30:51.724008Z","steps":["trace[1369574521] 'process raft request' (duration: 193.032367ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T04:30:51.724022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.939599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-proxy-shqms\" ","response":"range_response_count:1 size:3416"} {"level":"info","ts":"2026-02-24T04:30:51.724055Z","caller":"traceutil/trace.go:171","msg":"trace[1942184049] range","detail":"{range_begin:/registry/pods/kube-system/kube-proxy-shqms; range_end:; response_count:1; response_revision:363; }","duration":"198.024881ms","start":"2026-02-24T04:30:51.52602Z","end":"2026-02-24T04:30:51.724045Z","steps":["trace[1942184049] 'agreement among raft nodes before linearized reading' (duration: 197.94127ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T04:30:51.724076Z","caller":"traceutil/trace.go:171","msg":"trace[474539656] transaction","detail":"{read_only:false; response_revision:363; number_of_response:1; }","duration":"192.837088ms","start":"2026-02-24T04:30:51.531214Z","end":"2026-02-24T04:30:51.724051Z","steps":["trace[474539656] 'process raft request' (duration: 192.591447ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T04:30:51.724502Z","caller":"traceutil/trace.go:171","msg":"trace[1638656151] transaction","detail":"{read_only:false; response_revision:366; number_of_response:1; }","duration":"165.440975ms","start":"2026-02-24T04:30:51.559049Z","end":"2026-02-24T04:30:51.72449Z","steps":["trace[1638656151] 'process raft request' (duration: 165.401305ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T04:30:51.724638Z","caller":"traceutil/trace.go:171","msg":"trace[1925506467] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"171.290721ms","start":"2026-02-24T04:30:51.553341Z","end":"2026-02-24T04:30:51.724631Z","steps":["trace[1925506467] 'process raft request' (duration: 171.02506ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T04:30:51.724722Z","caller":"traceutil/trace.go:171","msg":"trace[1827783846] transaction","detail":"{read_only:false; response_revision:365; number_of_response:1; }","duration":"169.349753ms","start":"2026-02-24T04:30:51.555367Z","end":"2026-02-24T04:30:51.724716Z","steps":["trace[1827783846] 'process raft request' (duration: 169.042602ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T04:30:51.92496Z","caller":"traceutil/trace.go:171","msg":"trace[1221133455] transaction","detail":"{read_only:false; response_revision:368; number_of_response:1; }","duration":"195.277248ms","start":"2026-02-24T04:30:51.729636Z","end":"2026-02-24T04:30:51.924913Z","steps":["trace[1221133455] 'process raft request' (duration: 97.468272ms)","trace[1221133455] 'compare' (duration: 96.940652ms)"],"step_count":2} {"level":"info","ts":"2026-02-24T04:30:51.925276Z","caller":"traceutil/trace.go:171","msg":"trace[125592203] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"193.837021ms","start":"2026-02-24T04:30:51.731389Z","end":"2026-02-24T04:30:51.925226Z","steps":["trace[125592203] 'process raft request' (duration: 193.52002ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T04:30:51.925419Z","caller":"traceutil/trace.go:171","msg":"trace[1557971032] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"192.895418ms","start":"2026-02-24T04:30:51.732511Z","end":"2026-02-24T04:30:51.925406Z","steps":["trace[1557971032] 'process raft request' (duration: 192.469405ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T04:30:51.925504Z","caller":"traceutil/trace.go:171","msg":"trace[134796259] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"192.306415ms","start":"2026-02-24T04:30:51.733116Z","end":"2026-02-24T04:30:51.925422Z","steps":["trace[134796259] 'process raft request' (duration: 191.966252ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T04:30:51.925494Z","caller":"traceutil/trace.go:171","msg":"trace[1546447254] transaction","detail":"{read_only:false; response_revision:369; number_of_response:1; }","duration":"194.505485ms","start":"2026-02-24T04:30:51.730842Z","end":"2026-02-24T04:30:51.925348Z","steps":["trace[1546447254] 'process raft request' (duration: 193.927402ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T04:30:51.925598Z","caller":"traceutil/trace.go:171","msg":"trace[202754558] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"188.061826ms","start":"2026-02-24T04:30:51.737475Z","end":"2026-02-24T04:30:51.925537Z","steps":["trace[202754558] 'process raft request' (duration: 187.689614ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T04:30:51.926176Z","caller":"traceutil/trace.go:171","msg":"trace[212614602] linearizableReadLoop","detail":"{readStateIndex:383; appliedIndex:375; }","duration":"183.168465ms","start":"2026-02-24T04:30:51.742993Z","end":"2026-02-24T04:30:51.926162Z","steps":["trace[212614602] 'read index received' (duration: 53.209487ms)","trace[212614602] 'applied index is now lower than readState.Index' (duration: 129.958178ms)"],"step_count":2} {"level":"info","ts":"2026-02-24T04:30:51.926172Z","caller":"traceutil/trace.go:171","msg":"trace[241730467] transaction","detail":"{read_only:false; response_revision:375; number_of_response:1; }","duration":"125.227477ms","start":"2026-02-24T04:30:51.800923Z","end":"2026-02-24T04:30:51.926151Z","steps":["trace[241730467] 'process raft request' (duration: 125.128216ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T04:30:51.926325Z","caller":"traceutil/trace.go:171","msg":"trace[570767582] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"186.446709ms","start":"2026-02-24T04:30:51.73987Z","end":"2026-02-24T04:30:51.926316Z","steps":["trace[570767582] 'process raft request' (duration: 185.398344ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T04:30:51.926534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.524416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" ","response":"range_response_count:1 size:185"} {"level":"info","ts":"2026-02-24T04:30:51.926597Z","caller":"traceutil/trace.go:171","msg":"trace[698198686] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/kube-proxy; range_end:; response_count:1; response_revision:375; }","duration":"183.600366ms","start":"2026-02-24T04:30:51.742987Z","end":"2026-02-24T04:30:51.926588Z","steps":["trace[698198686] 'agreement among raft nodes before linearized reading' (duration: 183.462156ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T04:30:52.063902Z","caller":"traceutil/trace.go:171","msg":"trace[1564937607] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"131.355603ms","start":"2026-02-24T04:30:51.932507Z","end":"2026-02-24T04:30:52.063863Z","steps":["trace[1564937607] 'process raft request' (duration: 98.721528ms)","trace[1564937607] 'compare' (duration: 32.402234ms)"],"step_count":2} {"level":"info","ts":"2026-02-24T04:30:52.064916Z","caller":"traceutil/trace.go:171","msg":"trace[962214642] transaction","detail":"{read_only:false; response_revision:380; number_of_response:1; }","duration":"129.128632ms","start":"2026-02-24T04:30:51.935753Z","end":"2026-02-24T04:30:52.064881Z","steps":["trace[962214642] 'process raft request' (duration: 129.036851ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T04:30:52.065172Z","caller":"traceutil/trace.go:171","msg":"trace[257332386] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"132.186316ms","start":"2026-02-24T04:30:51.932931Z","end":"2026-02-24T04:30:52.065117Z","steps":["trace[257332386] 'process raft request' (duration: 131.545643ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T04:30:52.065443Z","caller":"traceutil/trace.go:171","msg":"trace[724561595] transaction","detail":"{read_only:false; response_revision:381; number_of_response:1; }","duration":"124.732173ms","start":"2026-02-24T04:30:51.940689Z","end":"2026-02-24T04:30:52.065422Z","steps":["trace[724561595] 'process raft request' (duration: 124.15035ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T04:30:52.065538Z","caller":"traceutil/trace.go:171","msg":"trace[2009734139] transaction","detail":"{read_only:false; response_revision:378; number_of_response:1; }","duration":"131.193051ms","start":"2026-02-24T04:30:51.934325Z","end":"2026-02-24T04:30:52.065518Z","steps":["trace[2009734139] 'process raft request' (duration: 130.335507ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T04:30:52.065555Z","caller":"traceutil/trace.go:171","msg":"trace[1162412503] transaction","detail":"{read_only:false; response_revision:379; number_of_response:1; }","duration":"131.060861ms","start":"2026-02-24T04:30:51.934452Z","end":"2026-02-24T04:30:52.065513Z","steps":["trace[1162412503] 'process raft request' (duration: 130.287717ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T04:30:53.004245Z","caller":"traceutil/trace.go:171","msg":"trace[578530749] transaction","detail":"{read_only:false; response_revision:388; number_of_response:1; }","duration":"160.94637ms","start":"2026-02-24T04:30:52.843269Z","end":"2026-02-24T04:30:53.004215Z","steps":["trace[578530749] 'process raft request' (duration: 151.185907ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T04:30:53.217646Z","caller":"traceutil/trace.go:171","msg":"trace[315323675] transaction","detail":"{read_only:false; response_revision:389; number_of_response:1; }","duration":"208.493245ms","start":"2026-02-24T04:30:53.009128Z","end":"2026-02-24T04:30:53.217621Z","steps":["trace[315323675] 'process raft request' (duration: 164.487922ms)","trace[315323675] 'compare' (duration: 43.882853ms)"],"step_count":2} {"level":"info","ts":"2026-02-24T04:30:57.487036Z","caller":"traceutil/trace.go:171","msg":"trace[1563562106] transaction","detail":"{read_only:false; response_revision:410; number_of_response:1; }","duration":"187.123062ms","start":"2026-02-24T04:30:57.299881Z","end":"2026-02-24T04:30:57.487004Z","steps":["trace[1563562106] 'process raft request' (duration: 186.835631ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T04:31:02.983127Z","caller":"traceutil/trace.go:171","msg":"trace[739167723] transaction","detail":"{read_only:false; response_revision:456; number_of_response:1; }","duration":"134.107239ms","start":"2026-02-24T04:31:02.848985Z","end":"2026-02-24T04:31:02.983092Z","steps":["trace[739167723] 'process raft request' (duration: 133.903929ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T04:31:07.996661Z","caller":"traceutil/trace.go:171","msg":"trace[2048429580] transaction","detail":"{read_only:false; response_revision:468; number_of_response:1; }","duration":"401.944598ms","start":"2026-02-24T04:31:07.594681Z","end":"2026-02-24T04:31:07.996625Z","steps":["trace[2048429580] 'process raft request' (duration: 401.761447ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T04:31:07.996943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T04:31:07.594648Z","time spent":"402.126699ms","remote":"127.0.0.1:48214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-24T04:31:12.183338Z","caller":"traceutil/trace.go:171","msg":"trace[1990167573] linearizableReadLoop","detail":"{readStateIndex:492; appliedIndex:491; }","duration":"351.874787ms","start":"2026-02-24T04:31:11.831436Z","end":"2026-02-24T04:31:12.183311Z","steps":["trace[1990167573] 'read index received' (duration: 351.174665ms)","trace[1990167573] 'applied index is now lower than readState.Index' (duration: 699.192µs)"],"step_count":2} {"level":"warn","ts":"2026-02-24T04:31:12.183509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.058058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-24T04:31:12.183562Z","caller":"traceutil/trace.go:171","msg":"trace[1951358400] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:476; }","duration":"352.159578ms","start":"2026-02-24T04:31:11.831392Z","end":"2026-02-24T04:31:12.183552Z","steps":["trace[1951358400] 'agreement among raft nodes before linearized reading' (duration: 352.041778ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T04:31:12.183591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T04:31:11.831366Z","time spent":"352.219368ms","remote":"127.0.0.1:47924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-24T04:31:12.183401Z","caller":"traceutil/trace.go:171","msg":"trace[1319911422] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"498.407724ms","start":"2026-02-24T04:31:11.684968Z","end":"2026-02-24T04:31:12.183376Z","steps":["trace[1319911422] 'process raft request' (duration: 497.990273ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T04:31:12.183968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T04:31:11.684937Z","time spent":"498.970116ms","remote":"127.0.0.1:48016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":317276,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-24T04:31:12.184494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.358967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-02-24T04:31:12.18459Z","caller":"traceutil/trace.go:171","msg":"trace[1931908885] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:476; }","duration":"127.547639ms","start":"2026-02-24T04:31:12.057023Z","end":"2026-02-24T04:31:12.18457Z","steps":["trace[1931908885] 'agreement among raft nodes before linearized reading' (duration: 126.715635ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T04:31:14.556968Z","caller":"traceutil/trace.go:171","msg":"trace[271165634] linearizableReadLoop","detail":"{readStateIndex:532; appliedIndex:531; }","duration":"336.312002ms","start":"2026-02-24T04:31:14.22064Z","end":"2026-02-24T04:31:14.556952Z","steps":["trace[271165634] 'read index received' (duration: 336.179122ms)","trace[271165634] 'applied index is now lower than readState.Index' (duration: 132.19µs)"],"step_count":2} {"level":"warn","ts":"2026-02-24T04:31:14.557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T04:31:14.19754Z","time spent":"359.454244ms","remote":"127.0.0.1:47952","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-02-24T04:31:14.557145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.490643ms","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-02-24T04:31:14.55717Z","caller":"traceutil/trace.go:171","msg":"trace[1651320053] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:515; }","duration":"336.556343ms","start":"2026-02-24T04:31:14.220607Z","end":"2026-02-24T04:31:14.557163Z","steps":["trace[1651320053] 'agreement among raft nodes before linearized reading' (duration: 336.424053ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T04:31:14.557186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T04:31:14.22059Z","time spent":"336.592523ms","remote":"127.0.0.1:48214","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-02-24T04:31:14.557303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.221617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-24T04:31:14.557345Z","caller":"traceutil/trace.go:171","msg":"trace[2146334140] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:515; }","duration":"322.315148ms","start":"2026-02-24T04:31:14.235024Z","end":"2026-02-24T04:31:14.557339Z","steps":["trace[2146334140] 'agreement among raft nodes before linearized reading' (duration: 322.245128ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T04:31:14.557359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T04:31:14.234999Z","time spent":"322.356118ms","remote":"127.0.0.1:48214","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-02-24T04:31:14.557723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.726658ms","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-02-24T04:31:14.557962Z","caller":"traceutil/trace.go:171","msg":"trace[1346479668] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:515; }","duration":"173.995989ms","start":"2026-02-24T04:31:14.383928Z","end":"2026-02-24T04:31:14.557924Z","steps":["trace[1346479668] 'agreement among raft nodes before linearized reading' (duration: 173.390787ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T04:31:15.562298Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17036163623763877983,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-24T04:31:16.063338Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17036163623763877983,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-24T04:31:16.187713Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.012005786s","expected-duration":"1s"} {"level":"info","ts":"2026-02-24T04:31:16.231875Z","caller":"traceutil/trace.go:171","msg":"trace[252705254] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"1.671464107s","start":"2026-02-24T04:31:14.560376Z","end":"2026-02-24T04:31:16.23184Z","steps":["trace[252705254] 'process raft request' (duration: 1.627541532s)","trace[252705254] 'compare' (duration: 43.665397ms)"],"step_count":2} {"level":"warn","ts":"2026-02-24T04:31:16.232041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T04:31:14.560362Z","time spent":"1.67158685s","remote":"127.0.0.1:47952","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-24T04:31:16.252368Z","caller":"traceutil/trace.go:171","msg":"trace[653065168] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"1.690236934s","start":"2026-02-24T04:31:14.562112Z","end":"2026-02-24T04:31:16.252349Z","steps":["trace[653065168] 'process raft request' (duration: 1.690193102s)"],"step_count":1} {"level":"info","ts":"2026-02-24T04:31:16.25241Z","caller":"traceutil/trace.go:171","msg":"trace[1126397353] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"1.690904347s","start":"2026-02-24T04:31:14.561484Z","end":"2026-02-24T04:31:16.252389Z","steps":["trace[1126397353] 'process raft request' (duration: 1.690719111s)"],"step_count":1} {"level":"warn","ts":"2026-02-24T04:31:16.252472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T04:31:14.562105Z","time spent":"1.690312426s","remote":"127.0.0.1:48214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-24T04:31:16.252526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T04:31:14.561456Z","time spent":"1.691010369s","remote":"127.0.0.1:48214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-24T04:31:16.252559Z","caller":"traceutil/trace.go:171","msg":"trace[2547227] linearizableReadLoop","detail":"{readStateIndex:536; appliedIndex:532; }","duration":"1.190715759s","start":"2026-02-24T04:31:15.061824Z","end":"2026-02-24T04:31:16.25254Z","steps":["trace[2547227] 'read index received' (duration: 1.126068314s)","trace[2547227] 'applied index is now lower than readState.Index' (duration: 64.646164ms)"],"step_count":2} {"level":"info","ts":"2026-02-24T04:31:16.252632Z","caller":"traceutil/trace.go:171","msg":"trace[1091896945] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"1.690101151s","start":"2026-02-24T04:31:14.562507Z","end":"2026-02-24T04:31:16.252608Z","steps":["trace[1091896945] 'process raft request' (duration: 1.689821372s)"],"step_count":1} {"level":"warn","ts":"2026-02-24T04:31:16.252666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.058206356s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4021"} {"level":"info","ts":"2026-02-24T04:31:16.252696Z","caller":"traceutil/trace.go:171","msg":"trace[384317306] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:519; }","duration":"1.058286769s","start":"2026-02-24T04:31:15.194402Z","end":"2026-02-24T04:31:16.252689Z","steps":["trace[384317306] 'agreement among raft nodes before linearized reading' (duration: 1.058241188s)"],"step_count":1} {"level":"warn","ts":"2026-02-24T04:31:16.252704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.441377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-24T04:31:16.252721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T04:31:15.194372Z","time spent":"1.058344281s","remote":"127.0.0.1:48108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4044,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-02-24T04:31:16.25275Z","caller":"traceutil/trace.go:171","msg":"trace[1779976308] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:519; }","duration":"420.51764ms","start":"2026-02-24T04:31:15.832216Z","end":"2026-02-24T04:31:16.252734Z","steps":["trace[1779976308] 'agreement among raft nodes before linearized reading' (duration: 420.451368ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T04:31:16.252758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T04:31:14.562494Z","time spent":"1.690201353s","remote":"127.0.0.1:48214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-24T04:31:16.25279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T04:31:15.832197Z","time spent":"420.582542ms","remote":"127.0.0.1:47924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-24T04:31:16.252878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.19105851s","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-02-24T04:31:16.252914Z","caller":"traceutil/trace.go:171","msg":"trace[683772681] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:519; }","duration":"1.191131822s","start":"2026-02-24T04:31:15.061772Z","end":"2026-02-24T04:31:16.252903Z","steps":["trace[683772681] 'agreement among raft nodes before linearized reading' (duration: 1.1910732s)"],"step_count":1} {"level":"warn","ts":"2026-02-24T04:31:16.252944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T04:31:15.061752Z","time spent":"1.191184654s","remote":"127.0.0.1:48214","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-24T04:31:22.784Z","caller":"traceutil/trace.go:171","msg":"trace[1095955425] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"431.490035ms","start":"2026-02-24T04:31:22.352486Z","end":"2026-02-24T04:31:22.783976Z","steps":["trace[1095955425] 'process raft request' (duration: 431.32476ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T04:31:22.784146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T04:31:22.352448Z","time spent":"431.633559ms","remote":"127.0.0.1:48118","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16803,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-24T04:31:24.71185Z","caller":"traceutil/trace.go:171","msg":"trace[296776794] linearizableReadLoop","detail":"{readStateIndex:580; appliedIndex:579; }","duration":"416.239629ms","start":"2026-02-24T04:31:24.295578Z","end":"2026-02-24T04:31:24.711817Z","steps":["trace[296776794] 'read index received' (duration: 415.860208ms)","trace[296776794] 'applied index is now lower than readState.Index' (duration: 377.491µs)"],"step_count":2} {"level":"warn","ts":"2026-02-24T04:31:24.711906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T04:31:24.197592Z","time spent":"514.302764ms","remote":"127.0.0.1:47952","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-02-24T04:31:24.712246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.274127ms","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-02-24T04:31:24.712297Z","caller":"traceutil/trace.go:171","msg":"trace[390518669] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:561; }","duration":"402.397451ms","start":"2026-02-24T04:31:24.309889Z","end":"2026-02-24T04:31:24.712286Z","steps":["trace[390518669] 'agreement among raft nodes before linearized reading' (duration: 402.241086ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T04:31:24.71227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.656441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-02-24T04:31:24.712332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T04:31:24.309866Z","time spent":"402.458863ms","remote":"127.0.0.1:48214","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-24T04:31:24.712383Z","caller":"traceutil/trace.go:171","msg":"trace[2000696537] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:561; }","duration":"416.854247ms","start":"2026-02-24T04:31:24.295498Z","end":"2026-02-24T04:31:24.712352Z","steps":["trace[2000696537] 'agreement among raft nodes before linearized reading' (duration: 416.499686ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T04:31:24.712246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.283275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-02-24T04:31:24.712461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T04:31:24.295464Z","time spent":"416.981841ms","remote":"127.0.0.1:48214","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-24T04:31:24.712514Z","caller":"traceutil/trace.go:171","msg":"trace[251198409] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:561; }","duration":"404.618505ms","start":"2026-02-24T04:31:24.307871Z","end":"2026-02-24T04:31:24.712489Z","steps":["trace[251198409] 'agreement among raft nodes before linearized reading' (duration: 404.13294ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T04:31:24.712598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T04:31:24.30784Z","time spent":"404.718688ms","remote":"127.0.0.1:48214","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-24T04:31:24.712812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.550867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-24T04:31:24.712849Z","caller":"traceutil/trace.go:171","msg":"trace[30908017] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:561; }","duration":"392.600048ms","start":"2026-02-24T04:31:24.320239Z","end":"2026-02-24T04:31:24.712839Z","steps":["trace[30908017] 'agreement among raft nodes before linearized reading' (duration: 392.514636ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T04:31:24.712888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T04:31:24.320232Z","time spent":"392.64619ms","remote":"127.0.0.1:48214","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-24T04:31:25.243453Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17036163623763878081,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-24T04:31:25.744797Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17036163623763878081,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-24T04:31:26.005279Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.265558568s","expected-duration":"1s"} {"level":"info","ts":"2026-02-24T04:31:26.00594Z","caller":"traceutil/trace.go:171","msg":"trace[1133198209] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"1.288476187s","start":"2026-02-24T04:31:24.717424Z","end":"2026-02-24T04:31:26.0059Z","steps":["trace[1133198209] 'process raft request' (duration: 1.288176558s)"],"step_count":1} {"level":"info","ts":"2026-02-24T04:31:26.005987Z","caller":"traceutil/trace.go:171","msg":"trace[1588535978] linearizableReadLoop","detail":"{readStateIndex:585; appliedIndex:581; }","duration":"1.263348943s","start":"2026-02-24T04:31:24.742602Z","end":"2026-02-24T04:31:26.005951Z","steps":["trace[1588535978] 'read index received' (duration: 1.262910871s)","trace[1588535978] 'applied index is now lower than readState.Index' (duration: 436.842µs)"],"step_count":2} {"level":"info","ts":"2026-02-24T04:31:26.006101Z","caller":"traceutil/trace.go:171","msg":"trace[2128897819] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"1.287349914s","start":"2026-02-24T04:31:24.718737Z","end":"2026-02-24T04:31:26.006087Z","steps":["trace[2128897819] 'process raft request' (duration: 1.287169919s)"],"step_count":1} {"level":"warn","ts":"2026-02-24T04:31:26.006273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T04:31:24.718729Z","time spent":"1.287415546s","remote":"127.0.0.1:48214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-24T04:31:26.006271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T04:31:24.717405Z","time spent":"1.288628261s","remote":"127.0.0.1:48214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-24T04:31:26.006318Z","caller":"traceutil/trace.go:171","msg":"trace[1664214697] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"1.288796876s","start":"2026-02-24T04:31:24.717479Z","end":"2026-02-24T04:31:26.006276Z","steps":["trace[1664214697] 'process raft request' (duration: 1.288330543s)"],"step_count":1} {"level":"warn","ts":"2026-02-24T04:31:26.006521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T04:31:24.717447Z","time spent":"1.288963451s","remote":"127.0.0.1:48214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-24T04:31:26.006532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.26390793s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"info","ts":"2026-02-24T04:31:26.006626Z","caller":"traceutil/trace.go:171","msg":"trace[1337520141] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:566; }","duration":"1.264024163s","start":"2026-02-24T04:31:24.742579Z","end":"2026-02-24T04:31:26.006604Z","steps":["trace[1337520141] 'agreement among raft nodes before linearized reading' (duration: 1.263634512s)"],"step_count":1} {"level":"warn","ts":"2026-02-24T04:31:26.006676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T04:31:24.742491Z","time spent":"1.264174608s","remote":"127.0.0.1:48094","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":445,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "} {"level":"warn","ts":"2026-02-24T04:31:26.006661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.764437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-24T04:31:26.006944Z","caller":"traceutil/trace.go:171","msg":"trace[773607911] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:566; }","duration":"186.146947ms","start":"2026-02-24T04:31:25.820781Z","end":"2026-02-24T04:31:26.006928Z","steps":["trace[773607911] 'agreement among raft nodes before linearized reading' (duration: 185.426136ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T04:31:26.006078Z","caller":"traceutil/trace.go:171","msg":"trace[642190902] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"1.288390594s","start":"2026-02-24T04:31:24.717633Z","end":"2026-02-24T04:31:26.006024Z","steps":["trace[642190902] 'process raft request' (duration: 1.28822921s)"],"step_count":1} {"level":"warn","ts":"2026-02-24T04:31:26.007481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T04:31:24.717624Z","time spent":"1.289807405s","remote":"127.0.0.1:48214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-24T04:31:27.939463Z","caller":"traceutil/trace.go:171","msg":"trace[656719298] linearizableReadLoop","detail":"{readStateIndex:596; appliedIndex:595; }","duration":"121.562778ms","start":"2026-02-24T04:31:27.817874Z","end":"2026-02-24T04:31:27.939437Z","steps":["trace[656719298] 'read index received' (duration: 121.391633ms)","trace[656719298] 'applied index is now lower than readState.Index' (duration: 170.014µs)"],"step_count":2} {"level":"info","ts":"2026-02-24T04:31:27.939535Z","caller":"traceutil/trace.go:171","msg":"trace[785807861] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"214.035198ms","start":"2026-02-24T04:31:27.725458Z","end":"2026-02-24T04:31:27.939493Z","steps":["trace[785807861] 'process raft request' (duration: 213.835971ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T04:31:27.939646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.742863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-24T04:31:27.939688Z","caller":"traceutil/trace.go:171","msg":"trace[1360995513] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:577; }","duration":"121.839556ms","start":"2026-02-24T04:31:27.817836Z","end":"2026-02-24T04:31:27.939675Z","steps":["trace[1360995513] 'agreement among raft nodes before linearized reading' (duration: 121.715883ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T04:31:29.789862Z","caller":"traceutil/trace.go:171","msg":"trace[252806474] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"173.557129ms","start":"2026-02-24T04:31:29.616269Z","end":"2026-02-24T04:31:29.789826Z","steps":["trace[252806474] 'process raft request' (duration: 173.320913ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T04:31:29.792411Z","caller":"traceutil/trace.go:171","msg":"trace[476794967] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"133.240745ms","start":"2026-02-24T04:31:29.659139Z","end":"2026-02-24T04:31:29.79238Z","steps":["trace[476794967] 'process raft request' (duration: 133.082531ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T04:31:30.857339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.895506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:1 size:9320"} {"level":"info","ts":"2026-02-24T04:31:30.85748Z","caller":"traceutil/trace.go:171","msg":"trace[375896064] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:1; response_revision:634; }","duration":"245.102091ms","start":"2026-02-24T04:31:30.612348Z","end":"2026-02-24T04:31:30.85745Z","steps":["trace[375896064] 'range keys from in-memory index tree' (duration: 244.572757ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T04:31:36.876366Z","caller":"traceutil/trace.go:171","msg":"trace[460927925] transaction","detail":"{read_only:false; response_revision:691; number_of_response:1; }","duration":"150.182495ms","start":"2026-02-24T04:31:36.726154Z","end":"2026-02-24T04:31:36.876336Z","steps":["trace[460927925] 'process raft request' (duration: 149.397745ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T04:31:36.900199Z","caller":"traceutil/trace.go:171","msg":"trace[750007015] transaction","detail":"{read_only:false; response_revision:692; number_of_response:1; }","duration":"167.825045ms","start":"2026-02-24T04:31:36.73235Z","end":"2026-02-24T04:31:36.900175Z","steps":["trace[750007015] 'process raft request' (duration: 167.711763ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T04:31:38.556049Z","caller":"traceutil/trace.go:171","msg":"trace[164687518] transaction","detail":"{read_only:false; response_revision:712; number_of_response:1; }","duration":"115.915221ms","start":"2026-02-24T04:31:38.440114Z","end":"2026-02-24T04:31:38.556029Z","steps":["trace[164687518] 'process raft request' (duration: 115.790578ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T04:31:38.838125Z","caller":"traceutil/trace.go:171","msg":"trace[1596010838] transaction","detail":"{read_only:false; response_revision:723; number_of_response:1; }","duration":"138.316018ms","start":"2026-02-24T04:31:38.699779Z","end":"2026-02-24T04:31:38.838095Z","steps":["trace[1596010838] 'process raft request' (duration: 93.061243ms)","trace[1596010838] 'compare' (duration: 45.108782ms)"],"step_count":2} {"level":"info","ts":"2026-02-24T04:31:38.845214Z","caller":"traceutil/trace.go:171","msg":"trace[885579385] transaction","detail":"{read_only:false; response_revision:726; number_of_response:1; }","duration":"142.176882ms","start":"2026-02-24T04:31:38.703014Z","end":"2026-02-24T04:31:38.845191Z","steps":["trace[885579385] 'process raft request' (duration: 141.944427ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T04:31:38.845296Z","caller":"traceutil/trace.go:171","msg":"trace[2082863881] transaction","detail":"{read_only:false; response_revision:725; number_of_response:1; }","duration":"143.125347ms","start":"2026-02-24T04:31:38.702147Z","end":"2026-02-24T04:31:38.845272Z","steps":["trace[2082863881] 'process raft request' (duration: 142.777068ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T04:31:38.845378Z","caller":"traceutil/trace.go:171","msg":"trace[1977375212] transaction","detail":"{read_only:false; response_revision:724; number_of_response:1; }","duration":"145.180817ms","start":"2026-02-24T04:31:38.700138Z","end":"2026-02-24T04:31:38.845319Z","steps":["trace[1977375212] 'process raft request' (duration: 144.679064ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T04:31:42.837531Z","caller":"traceutil/trace.go:171","msg":"trace[302075089] transaction","detail":"{read_only:false; response_revision:755; number_of_response:1; }","duration":"127.692182ms","start":"2026-02-24T04:31:42.709809Z","end":"2026-02-24T04:31:42.837502Z","steps":["trace[302075089] 'process raft request' (duration: 127.456206ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T04:32:52.997206Z","caller":"traceutil/trace.go:171","msg":"trace[24062809] linearizableReadLoop","detail":"{readStateIndex:1034; appliedIndex:1032; }","duration":"178.886188ms","start":"2026-02-24T04:32:52.818284Z","end":"2026-02-24T04:32:52.99717Z","steps":["trace[24062809] 'read index received' (duration: 113.784811ms)","trace[24062809] 'applied index is now lower than readState.Index' (duration: 65.100217ms)"],"step_count":2} {"level":"info","ts":"2026-02-24T04:32:52.997257Z","caller":"traceutil/trace.go:171","msg":"trace[270958144] transaction","detail":"{read_only:false; response_revision:994; number_of_response:1; }","duration":"375.297779ms","start":"2026-02-24T04:32:52.621918Z","end":"2026-02-24T04:32:52.997216Z","steps":["trace[270958144] 'process raft request' (duration: 310.224482ms)","trace[270958144] 'compare' (duration: 64.414018ms)"],"step_count":2} {"level":"warn","ts":"2026-02-24T04:32:52.9974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.09797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-24T04:32:52.997459Z","caller":"traceutil/trace.go:171","msg":"trace[1142476145] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:995; }","duration":"179.195072ms","start":"2026-02-24T04:32:52.818234Z","end":"2026-02-24T04:32:52.997429Z","steps":["trace[1142476145] 'agreement among raft nodes before linearized reading' (duration: 179.07037ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T04:32:52.997496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T04:32:52.621892Z","time spent":"375.492091ms","remote":"127.0.0.1:48214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-24T04:32:52.997257Z","caller":"traceutil/trace.go:171","msg":"trace[1758191018] transaction","detail":"{read_only:false; response_revision:995; number_of_response:1; }","duration":"372.839811ms","start":"2026-02-24T04:32:52.624396Z","end":"2026-02-24T04:32:52.997236Z","steps":["trace[1758191018] 'process raft request' (duration: 372.611047ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T04:32:52.997697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T04:32:52.624377Z","time spent":"373.260235ms","remote":"127.0.0.1:48214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-24T04:33:01.255211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"660.815168ms","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":"warn","ts":"2026-02-24T04:33:01.255293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.511686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-24T04:33:01.255335Z","caller":"traceutil/trace.go:171","msg":"trace[1304985408] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1019; }","duration":"661.020701ms","start":"2026-02-24T04:33:00.594294Z","end":"2026-02-24T04:33:01.255315Z","steps":["trace[1304985408] 'range keys from in-memory index tree' (duration: 660.394493ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T04:33:01.255413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T04:33:00.594264Z","time spent":"661.124182ms","remote":"127.0.0.1:48214","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-24T04:33:01.25551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"657.787023ms","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-02-24T04:33:01.255623Z","caller":"traceutil/trace.go:171","msg":"trace[1189165064] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1019; }","duration":"657.973395ms","start":"2026-02-24T04:33:00.597623Z","end":"2026-02-24T04:33:01.255597Z","steps":["trace[1189165064] 'range keys from in-memory index tree' (duration: 657.474199ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T04:33:01.255693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T04:33:00.597612Z","time spent":"658.065986ms","remote":"127.0.0.1:48214","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-02-24T04:33:01.255693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.934307ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-24T04:33:01.255871Z","caller":"traceutil/trace.go:171","msg":"trace[1444845897] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1019; }","duration":"205.145549ms","start":"2026-02-24T04:33:01.050709Z","end":"2026-02-24T04:33:01.255854Z","steps":["trace[1444845897] 'range keys from in-memory index tree' (duration: 204.873156ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T04:33:01.255952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"658.074577ms","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-02-24T04:33:01.256014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.045543ms","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-02-24T04:33:01.256028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.838987ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-24T04:33:01.256072Z","caller":"traceutil/trace.go:171","msg":"trace[420732896] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1019; }","duration":"658.272959ms","start":"2026-02-24T04:33:00.597772Z","end":"2026-02-24T04:33:01.256045Z","steps":["trace[420732896] 'range keys from in-memory index tree' (duration: 657.800524ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T04:33:01.256082Z","caller":"traceutil/trace.go:171","msg":"trace[1924255915] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1019; }","duration":"215.151854ms","start":"2026-02-24T04:33:01.040898Z","end":"2026-02-24T04:33:01.256049Z","steps":["trace[1924255915] 'range keys from in-memory index tree' (duration: 214.821751ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T04:33:01.256083Z","caller":"traceutil/trace.go:171","msg":"trace[578347877] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:1019; }","duration":"271.926077ms","start":"2026-02-24T04:33:00.984141Z","end":"2026-02-24T04:33:01.256067Z","steps":["trace[578347877] 'count revisions from in-memory index tree' (duration: 271.780636ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T04:33:01.256128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T04:33:00.597728Z","time spent":"658.38859ms","remote":"127.0.0.1:48214","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-24T04:33:01.256277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.136482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-24T04:33:01.256313Z","caller":"traceutil/trace.go:171","msg":"trace[1543270069] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1019; }","duration":"438.226923ms","start":"2026-02-24T04:33:00.818077Z","end":"2026-02-24T04:33:01.256304Z","steps":["trace[1543270069] 'range keys from in-memory index tree' (duration: 438.033401ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T04:33:01.256341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T04:33:00.818024Z","time spent":"438.309393ms","remote":"127.0.0.1:47924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-24T04:33:01.255447Z","caller":"traceutil/trace.go:171","msg":"trace[1074016487] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:1019; }","duration":"214.668628ms","start":"2026-02-24T04:33:01.040697Z","end":"2026-02-24T04:33:01.255365Z","steps":["trace[1074016487] 'range keys from in-memory index tree' (duration: 214.363664ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T04:33:01.257154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.186894ms","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-02-24T04:33:01.257216Z","caller":"traceutil/trace.go:171","msg":"trace[1686209534] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1019; }","duration":"215.839482ms","start":"2026-02-24T04:33:01.041357Z","end":"2026-02-24T04:33:01.257197Z","steps":["trace[1686209534] 'range keys from in-memory index tree' (duration: 214.678499ms)"],"step_count":1}