{"level":"warn","ts":"2026-06-09T17:12:01.363432Z","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-09T17:12:01.363904Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.221:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.221:2380","--initial-cluster=instance=https://199.19.213.221:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.221:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.221: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-09T17:12:01.364032Z","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-09T17:12:01.364043Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.221:2380"]} {"level":"info","ts":"2026-06-09T17:12:01.364068Z","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-09T17:12:01.365537Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.221:2379"]} {"level":"info","ts":"2026-06-09T17:12:01.365917Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.221:2380"],"listen-peer-urls":["https://199.19.213.221:2380"],"advertise-client-urls":["https://199.19.213.221:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.221:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.221: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-09T17:12:01.376281Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"10.072772ms"} {"level":"info","ts":"2026-06-09T17:12:01.389085Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b506daf99e68981a","cluster-id":"d2c45690f9793857"} {"level":"info","ts":"2026-06-09T17:12:01.389187Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b506daf99e68981a switched to configuration voters=()"} {"level":"info","ts":"2026-06-09T17:12:01.389222Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b506daf99e68981a became follower at term 0"} {"level":"info","ts":"2026-06-09T17:12:01.389241Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b506daf99e68981a [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-09T17:12:01.38926Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b506daf99e68981a became follower at term 1"} {"level":"info","ts":"2026-06-09T17:12:01.389361Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b506daf99e68981a switched to configuration voters=(13044354136364587034)"} {"level":"warn","ts":"2026-06-09T17:12:01.397002Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-09T17:12:01.39837Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-09T17:12:01.400069Z","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-09T17:12:01.402631Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b506daf99e68981a","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-09T17:12:01.403395Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b506daf99e68981a","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-09T17:12:01.403703Z","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-09T17:12:01.405216Z","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-09T17:12:01.405262Z","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-09T17:12:01.406226Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b506daf99e68981a switched to configuration voters=(13044354136364587034)"} {"level":"info","ts":"2026-06-09T17:12:01.407275Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"d2c45690f9793857","local-member-id":"b506daf99e68981a","added-peer-id":"b506daf99e68981a","added-peer-peer-urls":["https://199.19.213.221:2380"]} {"level":"info","ts":"2026-06-09T17:12:01.408893Z","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-09T17:12:01.408955Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.221:2380"} {"level":"info","ts":"2026-06-09T17:12:01.409042Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.221:2380"} {"level":"info","ts":"2026-06-09T17:12:01.409301Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b506daf99e68981a","initial-advertise-peer-urls":["https://199.19.213.221:2380"],"listen-peer-urls":["https://199.19.213.221:2380"],"advertise-client-urls":["https://199.19.213.221:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.221:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-09T17:12:01.409341Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-09T17:12:01.890047Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b506daf99e68981a is starting a new election at term 1"} {"level":"info","ts":"2026-06-09T17:12:01.890107Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b506daf99e68981a became pre-candidate at term 1"} {"level":"info","ts":"2026-06-09T17:12:01.890211Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b506daf99e68981a received MsgPreVoteResp from b506daf99e68981a at term 1"} {"level":"info","ts":"2026-06-09T17:12:01.89024Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b506daf99e68981a became candidate at term 2"} {"level":"info","ts":"2026-06-09T17:12:01.890252Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b506daf99e68981a received MsgVoteResp from b506daf99e68981a at term 2"} {"level":"info","ts":"2026-06-09T17:12:01.890274Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b506daf99e68981a became leader at term 2"} {"level":"info","ts":"2026-06-09T17:12:01.890294Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b506daf99e68981a elected leader b506daf99e68981a at term 2"} {"level":"info","ts":"2026-06-09T17:12:01.89463Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T17:12:01.894797Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b506daf99e68981a","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.221:2379]}","request-path":"/0/members/b506daf99e68981a/attributes","cluster-id":"d2c45690f9793857","publish-timeout":"7s"} {"level":"info","ts":"2026-06-09T17:12:01.895011Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-09T17:12:01.895057Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-09T17:12:01.895242Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-09T17:12:01.895278Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-09T17:12:01.897947Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-09T17:12:01.899772Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.221:2379"} {"level":"info","ts":"2026-06-09T17:12:01.900076Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"d2c45690f9793857","local-member-id":"b506daf99e68981a","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T17:12:01.900577Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T17:12:01.900642Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T17:12:04.346783Z","caller":"traceutil/trace.go:171","msg":"trace[2109287793] linearizableReadLoop","detail":"{readStateIndex:96; appliedIndex:95; }","duration":"102.975825ms","start":"2026-06-09T17:12:04.243781Z","end":"2026-06-09T17:12:04.346757Z","steps":["trace[2109287793] 'read index received' (duration: 70.903045ms)","trace[2109287793] 'applied index is now lower than readState.Index' (duration: 32.07175ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:12:04.346996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.204621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-edit\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-09T17:12:04.347069Z","caller":"traceutil/trace.go:171","msg":"trace[594865019] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-edit; range_end:; response_count:0; response_revision:91; }","duration":"103.339554ms","start":"2026-06-09T17:12:04.243713Z","end":"2026-06-09T17:12:04.347053Z","steps":["trace[594865019] 'agreement among raft nodes before linearized reading' (duration: 103.198181ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:12:04.34721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.74711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/default/instance.18b778e926898dac\" ","response":"range_response_count:1 size:648"} {"level":"info","ts":"2026-06-09T17:12:04.347379Z","caller":"traceutil/trace.go:171","msg":"trace[741744298] range","detail":"{range_begin:/registry/events/default/instance.18b778e926898dac; range_end:; response_count:1; response_revision:91; }","duration":"102.910865ms","start":"2026-06-09T17:12:04.24439Z","end":"2026-06-09T17:12:04.347301Z","steps":["trace[741744298] 'agreement among raft nodes before linearized reading' (duration: 102.601977ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:12:04.347453Z","caller":"traceutil/trace.go:171","msg":"trace[1674652607] transaction","detail":"{read_only:false; response_revision:91; number_of_response:1; }","duration":"117.285855ms","start":"2026-06-09T17:12:04.23013Z","end":"2026-06-09T17:12:04.347416Z","steps":["trace[1674652607] 'process raft request' (duration: 84.472388ms)","trace[1674652607] 'compare' (duration: 32.021878ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:12:04.668048Z","caller":"traceutil/trace.go:171","msg":"trace[997193879] transaction","detail":"{read_only:false; response_revision:106; number_of_response:1; }","duration":"133.372066ms","start":"2026-06-09T17:12:04.534546Z","end":"2026-06-09T17:12:04.667918Z","steps":["trace[997193879] 'process raft request' (duration: 133.324264ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:12:04.668206Z","caller":"traceutil/trace.go:171","msg":"trace[43307692] transaction","detail":"{read_only:false; response_revision:104; number_of_response:1; }","duration":"133.641502ms","start":"2026-06-09T17:12:04.534526Z","end":"2026-06-09T17:12:04.668167Z","steps":["trace[43307692] 'process raft request' (duration: 81.883129ms)","trace[43307692] 'compare' (duration: 51.238631ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:12:04.668199Z","caller":"traceutil/trace.go:171","msg":"trace[1987374818] transaction","detail":"{read_only:false; response_revision:105; number_of_response:1; }","duration":"133.619511ms","start":"2026-06-09T17:12:04.534538Z","end":"2026-06-09T17:12:04.668157Z","steps":["trace[1987374818] 'process raft request' (duration: 133.283913ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:12:04.833523Z","caller":"traceutil/trace.go:171","msg":"trace[194796697] transaction","detail":"{read_only:false; response_revision:108; number_of_response:1; }","duration":"158.67943ms","start":"2026-06-09T17:12:04.674802Z","end":"2026-06-09T17:12:04.833481Z","steps":["trace[194796697] 'process raft request' (duration: 150.89692ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:12:11.516417Z","caller":"traceutil/trace.go:171","msg":"trace[1295368536] linearizableReadLoop","detail":"{readStateIndex:360; appliedIndex:359; }","duration":"118.672087ms","start":"2026-06-09T17:12:11.397723Z","end":"2026-06-09T17:12:11.516395Z","steps":["trace[1295368536] 'read index received' (duration: 90.930958ms)","trace[1295368536] 'applied index is now lower than readState.Index' (duration: 27.740309ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:12:11.516766Z","caller":"traceutil/trace.go:171","msg":"trace[1296478599] transaction","detail":"{read_only:false; response_revision:350; number_of_response:1; }","duration":"134.634235ms","start":"2026-06-09T17:12:11.382103Z","end":"2026-06-09T17:12:11.516737Z","steps":["trace[1296478599] 'process raft request' (duration: 106.66488ms)","trace[1296478599] 'compare' (duration: 27.525345ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:12:11.51679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.054317ms","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-06-09T17:12:11.517004Z","caller":"traceutil/trace.go:171","msg":"trace[1169176787] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:350; }","duration":"119.393254ms","start":"2026-06-09T17:12:11.397598Z","end":"2026-06-09T17:12:11.516991Z","steps":["trace[1169176787] 'agreement among raft nodes before linearized reading' (duration: 119.086877ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:12:11.980756Z","caller":"traceutil/trace.go:171","msg":"trace[1776266068] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"110.239349ms","start":"2026-06-09T17:12:11.87042Z","end":"2026-06-09T17:12:11.98066Z","steps":["trace[1776266068] 'process raft request' (duration: 109.829539ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:12:12.209068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.20335ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-09T17:12:12.209328Z","caller":"traceutil/trace.go:171","msg":"trace[849422780] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"221.645099ms","start":"2026-06-09T17:12:11.987622Z","end":"2026-06-09T17:12:12.209267Z","steps":["trace[849422780] 'process raft request' (duration: 89.585738ms)","trace[849422780] 'compare' (duration: 131.006646ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:12:12.209437Z","caller":"traceutil/trace.go:171","msg":"trace[725777194] transaction","detail":"{read_only:false; response_revision:379; number_of_response:1; }","duration":"213.085754ms","start":"2026-06-09T17:12:11.996342Z","end":"2026-06-09T17:12:12.209427Z","steps":["trace[725777194] 'process raft request' (duration: 213.037073ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:12:12.209674Z","caller":"traceutil/trace.go:171","msg":"trace[16011639] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"218.067333ms","start":"2026-06-09T17:12:11.991591Z","end":"2026-06-09T17:12:12.209658Z","steps":["trace[16011639] 'process raft request' (duration: 217.701525ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:12:12.209726Z","caller":"traceutil/trace.go:171","msg":"trace[329411679] transaction","detail":"{read_only:false; response_revision:378; number_of_response:1; }","duration":"218.021893ms","start":"2026-06-09T17:12:11.991663Z","end":"2026-06-09T17:12:12.209685Z","steps":["trace[329411679] 'process raft request' (duration: 217.657714ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:12:12.209787Z","caller":"traceutil/trace.go:171","msg":"trace[407570539] transaction","detail":"{read_only:false; response_revision:375; number_of_response:1; }","duration":"222.080769ms","start":"2026-06-09T17:12:11.987673Z","end":"2026-06-09T17:12:12.209754Z","steps":["trace[407570539] 'process raft request' (duration: 221.508746ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:12:12.209611Z","caller":"traceutil/trace.go:171","msg":"trace[602671982] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"221.000814ms","start":"2026-06-09T17:12:11.988586Z","end":"2026-06-09T17:12:12.209587Z","steps":["trace[602671982] 'process raft request' (duration: 220.656026ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:12:16.466234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.04416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-06-09T17:12:16.466284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.594473ms","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-09T17:12:16.466373Z","caller":"traceutil/trace.go:171","msg":"trace[918644963] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:407; }","duration":"239.231953ms","start":"2026-06-09T17:12:16.227111Z","end":"2026-06-09T17:12:16.466343Z","steps":["trace[918644963] 'range keys from in-memory index tree' (duration: 238.948797ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:12:16.466392Z","caller":"traceutil/trace.go:171","msg":"trace[893253183] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:407; }","duration":"239.766407ms","start":"2026-06-09T17:12:16.226596Z","end":"2026-06-09T17:12:16.466363Z","steps":["trace[893253183] 'range keys from in-memory index tree' (duration: 239.46253ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:12:22.678568Z","caller":"traceutil/trace.go:171","msg":"trace[1730432482] transaction","detail":"{read_only:false; response_revision:421; number_of_response:1; }","duration":"117.423109ms","start":"2026-06-09T17:12:22.561097Z","end":"2026-06-09T17:12:22.67852Z","steps":["trace[1730432482] 'process raft request' (duration: 117.176403ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:12:45.853129Z","caller":"traceutil/trace.go:171","msg":"trace[174266868] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"240.919204ms","start":"2026-06-09T17:12:45.612184Z","end":"2026-06-09T17:12:45.853103Z","steps":["trace[174266868] 'process raft request' (duration: 240.76191ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:12:45.859747Z","caller":"traceutil/trace.go:171","msg":"trace[1711132429] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"242.211754ms","start":"2026-06-09T17:12:45.617494Z","end":"2026-06-09T17:12:45.859705Z","steps":["trace[1711132429] 'process raft request' (duration: 242.094932ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:12:45.85979Z","caller":"traceutil/trace.go:171","msg":"trace[1532570093] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"243.858274ms","start":"2026-06-09T17:12:45.615879Z","end":"2026-06-09T17:12:45.859738Z","steps":["trace[1532570093] 'process raft request' (duration: 243.580318ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:12:45.859802Z","caller":"traceutil/trace.go:171","msg":"trace[2008779569] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"210.560093ms","start":"2026-06-09T17:12:45.649199Z","end":"2026-06-09T17:12:45.859759Z","steps":["trace[2008779569] 'process raft request' (duration: 210.424969ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:12:45.859809Z","caller":"traceutil/trace.go:171","msg":"trace[794729828] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"210.369518ms","start":"2026-06-09T17:12:45.649404Z","end":"2026-06-09T17:12:45.859774Z","steps":["trace[794729828] 'process raft request' (duration: 210.252005ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:12:45.859983Z","caller":"traceutil/trace.go:171","msg":"trace[1397206632] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"206.922813ms","start":"2026-06-09T17:12:45.653039Z","end":"2026-06-09T17:12:45.859962Z","steps":["trace[1397206632] 'process raft request' (duration: 206.654607ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:12:45.861205Z","caller":"traceutil/trace.go:171","msg":"trace[1209061977] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"205.258434ms","start":"2026-06-09T17:12:45.655935Z","end":"2026-06-09T17:12:45.861194Z","steps":["trace[1209061977] 'process raft request' (duration: 205.080289ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:12:45.86122Z","caller":"traceutil/trace.go:171","msg":"trace[945262891] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"191.151704ms","start":"2026-06-09T17:12:45.670056Z","end":"2026-06-09T17:12:45.861208Z","steps":["trace[945262891] 'process raft request' (duration: 190.99596ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:12:45.861348Z","caller":"traceutil/trace.go:171","msg":"trace[1133957241] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"205.546232ms","start":"2026-06-09T17:12:45.655795Z","end":"2026-06-09T17:12:45.861341Z","steps":["trace[1133957241] 'process raft request' (duration: 203.928273ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:12:45.86144Z","caller":"traceutil/trace.go:171","msg":"trace[912190853] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"182.301771ms","start":"2026-06-09T17:12:45.679131Z","end":"2026-06-09T17:12:45.861433Z","steps":["trace[912190853] 'process raft request' (duration: 181.966423ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:12:45.861738Z","caller":"traceutil/trace.go:171","msg":"trace[455653601] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"172.139046ms","start":"2026-06-09T17:12:45.689589Z","end":"2026-06-09T17:12:45.861728Z","steps":["trace[455653601] 'process raft request' (duration: 171.552822ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:12:45.862247Z","caller":"traceutil/trace.go:171","msg":"trace[390222662] linearizableReadLoop","detail":"{readStateIndex:565; appliedIndex:559; }","duration":"206.944025ms","start":"2026-06-09T17:12:45.655291Z","end":"2026-06-09T17:12:45.862235Z","steps":["trace[390222662] 'read index received' (duration: 197.664062ms)","trace[390222662] 'applied index is now lower than readState.Index' (duration: 9.279163ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:12:45.862373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.067688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.221\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-09T17:12:45.862429Z","caller":"traceutil/trace.go:171","msg":"trace[441092114] range","detail":"{range_begin:/registry/masterleases/199.19.213.221; range_end:; response_count:1; response_revision:553; }","duration":"207.15887ms","start":"2026-06-09T17:12:45.655258Z","end":"2026-06-09T17:12:45.862417Z","steps":["trace[441092114] 'agreement among raft nodes before linearized reading' (duration: 207.048797ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:12:46.94782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.758988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T17:12:46.947941Z","caller":"traceutil/trace.go:171","msg":"trace[1429834071] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:610; }","duration":"242.932483ms","start":"2026-06-09T17:12:46.704981Z","end":"2026-06-09T17:12:46.947913Z","steps":["trace[1429834071] 'range keys from in-memory index tree' (duration: 242.630185ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:12:46.951074Z","caller":"traceutil/trace.go:171","msg":"trace[327315225] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"145.804622ms","start":"2026-06-09T17:12:46.805243Z","end":"2026-06-09T17:12:46.951047Z","steps":["trace[327315225] 'process raft request' (duration: 145.247879ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:12:46.954999Z","caller":"traceutil/trace.go:171","msg":"trace[1372796389] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"104.708921ms","start":"2026-06-09T17:12:46.850242Z","end":"2026-06-09T17:12:46.954951Z","steps":["trace[1372796389] 'process raft request' (duration: 104.534687ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:12:52.305786Z","caller":"traceutil/trace.go:171","msg":"trace[148136986] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"403.89745ms","start":"2026-06-09T17:12:51.901859Z","end":"2026-06-09T17:12:52.305756Z","steps":["trace[148136986] 'process raft request' (duration: 403.210464ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:12:52.306127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:12:51.901821Z","time spent":"404.046183ms","remote":"127.0.0.1:34750","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T17:12:52.696265Z","caller":"traceutil/trace.go:171","msg":"trace[1126573085] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"329.896757ms","start":"2026-06-09T17:12:52.366337Z","end":"2026-06-09T17:12:52.696234Z","steps":["trace[1126573085] 'process raft request' (duration: 311.528504ms)","trace[1126573085] 'compare' (duration: 18.23307ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:12:52.696416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:12:52.366315Z","time spent":"330.0345ms","remote":"127.0.0.1:35192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-09T17:12:53.647921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"663.554154ms","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-09T17:12:53.648007Z","caller":"traceutil/trace.go:171","msg":"trace[85160797] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:650; }","duration":"663.684747ms","start":"2026-06-09T17:12:52.984298Z","end":"2026-06-09T17:12:53.647983Z","steps":["trace[85160797] 'range keys from in-memory index tree' (duration: 663.301938ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:12:53.648024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"654.047935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-06-09T17:12:53.648057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:12:52.984275Z","time spent":"663.769009ms","remote":"127.0.0.1:34932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-09T17:12:53.64807Z","caller":"traceutil/trace.go:171","msg":"trace[287150863] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:650; }","duration":"654.118467ms","start":"2026-06-09T17:12:52.993939Z","end":"2026-06-09T17:12:53.648058Z","steps":["trace[287150863] 'range keys from in-memory index tree' (duration: 653.920122ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:12:53.648105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:12:52.993928Z","time spent":"654.169468ms","remote":"127.0.0.1:34932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-09T17:12:53.648321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"655.867341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-09T17:12:53.648413Z","caller":"traceutil/trace.go:171","msg":"trace[1616917116] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:650; }","duration":"656.001014ms","start":"2026-06-09T17:12:52.992386Z","end":"2026-06-09T17:12:53.648387Z","steps":["trace[1616917116] 'range keys from in-memory index tree' (duration: 655.688876ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:12:53.648464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:12:52.992365Z","time spent":"656.090086ms","remote":"127.0.0.1:34932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-09T17:12:53.650656Z","caller":"traceutil/trace.go:171","msg":"trace[729702077] linearizableReadLoop","detail":"{readStateIndex:674; appliedIndex:673; }","duration":"482.669797ms","start":"2026-06-09T17:12:53.167956Z","end":"2026-06-09T17:12:53.650626Z","steps":["trace[729702077] 'read index received' (duration: 481.704094ms)","trace[729702077] 'applied index is now lower than readState.Index' (duration: 964.753µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:12:53.650734Z","caller":"traceutil/trace.go:171","msg":"trace[1305452410] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"547.098619ms","start":"2026-06-09T17:12:53.103614Z","end":"2026-06-09T17:12:53.650713Z","steps":["trace[1305452410] 'process raft request' (duration: 546.343161ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:12:53.650854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.890952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-09T17:12:53.650895Z","caller":"traceutil/trace.go:171","msg":"trace[1126465885] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:651; }","duration":"483.011545ms","start":"2026-06-09T17:12:53.167872Z","end":"2026-06-09T17:12:53.650884Z","steps":["trace[1126465885] 'agreement among raft nodes before linearized reading' (duration: 482.859912ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:12:53.65089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:12:53.103586Z","time spent":"547.211271ms","remote":"127.0.0.1:34750","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036313,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T17:12:53.650935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:12:53.167794Z","time spent":"483.132598ms","remote":"127.0.0.1:34932","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":"info","ts":"2026-06-09T17:12:55.105976Z","caller":"traceutil/trace.go:171","msg":"trace[2123324152] transaction","detail":"{read_only:false; response_revision:688; number_of_response:1; }","duration":"109.721083ms","start":"2026-06-09T17:12:54.996237Z","end":"2026-06-09T17:12:55.105958Z","steps":["trace[2123324152] 'process raft request' (duration: 109.626081ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:12:58.150728Z","caller":"traceutil/trace.go:171","msg":"trace[1770153156] transaction","detail":"{read_only:false; response_revision:729; number_of_response:1; }","duration":"151.977441ms","start":"2026-06-09T17:12:57.998733Z","end":"2026-06-09T17:12:58.150711Z","steps":["trace[1770153156] 'process raft request' (duration: 151.884729ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:13:05.899932Z","caller":"traceutil/trace.go:171","msg":"trace[1637716515] linearizableReadLoop","detail":"{readStateIndex:826; appliedIndex:825; }","duration":"232.219534ms","start":"2026-06-09T17:13:05.667687Z","end":"2026-06-09T17:13:05.899906Z","steps":["trace[1637716515] 'read index received' (duration: 232.05685ms)","trace[1637716515] 'applied index is now lower than readState.Index' (duration: 161.314µs)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:13:05.900121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.411139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-09T17:13:05.900157Z","caller":"traceutil/trace.go:171","msg":"trace[563005229] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:797; }","duration":"232.4929ms","start":"2026-06-09T17:13:05.667653Z","end":"2026-06-09T17:13:05.900146Z","steps":["trace[563005229] 'agreement among raft nodes before linearized reading' (duration: 232.399608ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:13:05.900305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.21528ms","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-09T17:13:05.900411Z","caller":"traceutil/trace.go:171","msg":"trace[883524656] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:797; }","duration":"175.373444ms","start":"2026-06-09T17:13:05.725015Z","end":"2026-06-09T17:13:05.900389Z","steps":["trace[883524656] 'agreement among raft nodes before linearized reading' (duration: 175.103818ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:13:05.900454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.804471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-09T17:13:05.900567Z","caller":"traceutil/trace.go:171","msg":"trace[1050874401] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:797; }","duration":"174.975725ms","start":"2026-06-09T17:13:05.725567Z","end":"2026-06-09T17:13:05.900543Z","steps":["trace[1050874401] 'agreement among raft nodes before linearized reading' (duration: 174.737169ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:13:05.900597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.860077ms","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-09T17:13:05.90079Z","caller":"traceutil/trace.go:171","msg":"trace[588909687] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:797; }","duration":"169.085352ms","start":"2026-06-09T17:13:05.731678Z","end":"2026-06-09T17:13:05.900764Z","steps":["trace[588909687] 'agreement among raft nodes before linearized reading' (duration: 168.630261ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:13:05.90085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.620805ms","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-09T17:13:05.900914Z","caller":"traceutil/trace.go:171","msg":"trace[339595618] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:797; }","duration":"169.709857ms","start":"2026-06-09T17:13:05.731189Z","end":"2026-06-09T17:13:05.900899Z","steps":["trace[339595618] 'agreement among raft nodes before linearized reading' (duration: 169.005651ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:13:06.128487Z","caller":"traceutil/trace.go:171","msg":"trace[1933480332] transaction","detail":"{read_only:false; response_revision:798; number_of_response:1; }","duration":"227.186834ms","start":"2026-06-09T17:13:05.90124Z","end":"2026-06-09T17:13:06.128427Z","steps":["trace[1933480332] 'process raft request' (duration: 177.177009ms)","trace[1933480332] 'compare' (duration: 49.83236ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:13:06.201379Z","caller":"traceutil/trace.go:171","msg":"trace[703810396] transaction","detail":"{read_only:false; response_revision:799; number_of_response:1; }","duration":"296.36083ms","start":"2026-06-09T17:13:05.904986Z","end":"2026-06-09T17:13:06.201347Z","steps":["trace[703810396] 'process raft request' (duration: 296.117853ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:13:06.2014Z","caller":"traceutil/trace.go:171","msg":"trace[874009061] transaction","detail":"{read_only:false; response_revision:800; number_of_response:1; }","duration":"296.124264ms","start":"2026-06-09T17:13:05.905246Z","end":"2026-06-09T17:13:06.20137Z","steps":["trace[874009061] 'process raft request' (duration: 296.017672ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:13:06.201611Z","caller":"traceutil/trace.go:171","msg":"trace[589360075] transaction","detail":"{read_only:false; response_revision:801; number_of_response:1; }","duration":"296.014072ms","start":"2026-06-09T17:13:05.905583Z","end":"2026-06-09T17:13:06.201597Z","steps":["trace[589360075] 'process raft request' (duration: 295.738495ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:13:06.201702Z","caller":"traceutil/trace.go:171","msg":"trace[525571839] transaction","detail":"{read_only:false; response_revision:802; number_of_response:1; }","duration":"294.782562ms","start":"2026-06-09T17:13:05.906882Z","end":"2026-06-09T17:13:06.201665Z","steps":["trace[525571839] 'process raft request' (duration: 294.556297ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:13:09.34763Z","caller":"traceutil/trace.go:171","msg":"trace[1626557362] transaction","detail":"{read_only:false; response_revision:816; number_of_response:1; }","duration":"625.97527ms","start":"2026-06-09T17:13:08.721626Z","end":"2026-06-09T17:13:09.347601Z","steps":["trace[1626557362] 'process raft request' (duration: 625.809966ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:13:09.347791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:13:08.721609Z","time spent":"626.107673ms","remote":"127.0.0.1:34932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T17:13:09.499458Z","caller":"traceutil/trace.go:171","msg":"trace[984860285] linearizableReadLoop","detail":"{readStateIndex:846; appliedIndex:844; }","duration":"627.542027ms","start":"2026-06-09T17:13:08.871876Z","end":"2026-06-09T17:13:09.499418Z","steps":["trace[984860285] 'read index received' (duration: 475.626017ms)","trace[984860285] 'applied index is now lower than readState.Index' (duration: 151.91502ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:13:09.499573Z","caller":"traceutil/trace.go:171","msg":"trace[919973021] transaction","detail":"{read_only:false; response_revision:817; number_of_response:1; }","duration":"770.082011ms","start":"2026-06-09T17:13:08.729437Z","end":"2026-06-09T17:13:09.499519Z","steps":["trace[919973021] 'process raft request' (duration: 769.842666ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:13:09.499678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"627.785763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-9cq8p\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-06-09T17:13:09.499716Z","caller":"traceutil/trace.go:171","msg":"trace[404413160] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-9cq8p; range_end:; response_count:1; response_revision:817; }","duration":"627.877085ms","start":"2026-06-09T17:13:08.871828Z","end":"2026-06-09T17:13:09.499705Z","steps":["trace[404413160] 'agreement among raft nodes before linearized reading' (duration: 627.726651ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:13:09.499768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:13:08.871806Z","time spent":"627.952327ms","remote":"127.0.0.1:34850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3989,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-9cq8p\" "} {"level":"warn","ts":"2026-06-09T17:13:09.499758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:13:08.729416Z","time spent":"770.243785ms","remote":"127.0.0.1:34836","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4905,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T17:13:09.499901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"622.002244ms","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-09T17:13:09.499968Z","caller":"traceutil/trace.go:171","msg":"trace[200818540] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:817; }","duration":"622.091276ms","start":"2026-06-09T17:13:08.87786Z","end":"2026-06-09T17:13:09.499951Z","steps":["trace[200818540] 'agreement among raft nodes before linearized reading' (duration: 621.908851ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:13:09.500014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:13:08.877844Z","time spent":"622.157758ms","remote":"127.0.0.1:34932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-09T17:13:09.500324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.519518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-09T17:13:09.50111Z","caller":"traceutil/trace.go:171","msg":"trace[883853874] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:817; }","duration":"418.392309ms","start":"2026-06-09T17:13:09.082697Z","end":"2026-06-09T17:13:09.50109Z","steps":["trace[883853874] 'agreement among raft nodes before linearized reading' (duration: 417.443256ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:13:09.501226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:13:09.082675Z","time spent":"418.530373ms","remote":"127.0.0.1:34850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":12,"response size":31,"request content":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true "} {"level":"info","ts":"2026-06-09T17:13:44.609685Z","caller":"traceutil/trace.go:171","msg":"trace[1240391334] transaction","detail":"{read_only:false; response_revision:1029; number_of_response:1; }","duration":"117.0604ms","start":"2026-06-09T17:13:44.492596Z","end":"2026-06-09T17:13:44.609656Z","steps":["trace[1240391334] 'process raft request' (duration: 116.861736ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:13:45.622827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"585.32919ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T17:13:45.623026Z","caller":"traceutil/trace.go:171","msg":"trace[949088360] transaction","detail":"{read_only:false; response_revision:1031; number_of_response:1; }","duration":"911.621797ms","start":"2026-06-09T17:13:44.71139Z","end":"2026-06-09T17:13:45.623011Z","steps":["trace[949088360] 'process raft request' (duration: 911.566846ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:13:45.62302Z","caller":"traceutil/trace.go:171","msg":"trace[1082242773] transaction","detail":"{read_only:false; response_revision:1030; number_of_response:1; }","duration":"1.128641033s","start":"2026-06-09T17:13:44.494323Z","end":"2026-06-09T17:13:45.622964Z","steps":["trace[1082242773] 'process raft request' (duration: 543.099829ms)","trace[1082242773] 'compare' (duration: 585.212287ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:13:45.623029Z","caller":"traceutil/trace.go:171","msg":"trace[1368617505] linearizableReadLoop","detail":"{readStateIndex:1068; appliedIndex:1066; }","duration":"1.082736499s","start":"2026-06-09T17:13:44.540268Z","end":"2026-06-09T17:13:45.623004Z","steps":["trace[1368617505] 'read index received' (duration: 69.165189ms)","trace[1368617505] 'applied index is now lower than readState.Index' (duration: 1.01356932s)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:13:45.623088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:13:44.711369Z","time spent":"911.69432ms","remote":"127.0.0.1:34932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T17:13:45.623202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:13:44.494278Z","time spent":"1.128826019s","remote":"127.0.0.1:34932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T17:13:45.623308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.083032327s","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-09T17:13:45.623345Z","caller":"traceutil/trace.go:171","msg":"trace[1610629816] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1031; }","duration":"1.083114798s","start":"2026-06-09T17:13:44.540216Z","end":"2026-06-09T17:13:45.623331Z","steps":["trace[1610629816] 'agreement among raft nodes before linearized reading' (duration: 1.082917553s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:13:45.62337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:13:44.540197Z","time spent":"1.083168189s","remote":"127.0.0.1:34932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-09T17:13:45.623491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"540.390877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T17:13:45.623515Z","caller":"traceutil/trace.go:171","msg":"trace[729247669] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1031; }","duration":"540.448529ms","start":"2026-06-09T17:13:45.083058Z","end":"2026-06-09T17:13:45.623507Z","steps":["trace[729247669] 'agreement among raft nodes before linearized reading' (duration: 540.405018ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:13:45.623534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:13:45.083039Z","time spent":"540.49013ms","remote":"127.0.0.1:34808","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":29,"request content":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true "} {"level":"warn","ts":"2026-06-09T17:13:45.623534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.079871993s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-09T17:13:45.623563Z","caller":"traceutil/trace.go:171","msg":"trace[1759158602] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1031; }","duration":"1.079951905s","start":"2026-06-09T17:13:44.543602Z","end":"2026-06-09T17:13:45.623554Z","steps":["trace[1759158602] 'agreement among raft nodes before linearized reading' (duration: 1.079818702s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:13:45.623583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:13:44.543578Z","time spent":"1.080000675s","remote":"127.0.0.1:34932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-09T17:14:09.861685Z","caller":"traceutil/trace.go:171","msg":"trace[424645286] linearizableReadLoop","detail":"{readStateIndex:1153; appliedIndex:1152; }","duration":"117.232843ms","start":"2026-06-09T17:14:09.744431Z","end":"2026-06-09T17:14:09.861664Z","steps":["trace[424645286] 'read index received' (duration: 117.06207ms)","trace[424645286] 'applied index is now lower than readState.Index' (duration: 169.893µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:14:09.861791Z","caller":"traceutil/trace.go:171","msg":"trace[1357498918] transaction","detail":"{read_only:false; response_revision:1110; number_of_response:1; }","duration":"133.739192ms","start":"2026-06-09T17:14:09.728039Z","end":"2026-06-09T17:14:09.861779Z","steps":["trace[1357498918] 'process raft request' (duration: 133.500617ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:14:09.862074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.635403ms","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-09T17:14:09.862115Z","caller":"traceutil/trace.go:171","msg":"trace[170083220] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1110; }","duration":"117.722934ms","start":"2026-06-09T17:14:09.744381Z","end":"2026-06-09T17:14:09.862104Z","steps":["trace[170083220] 'agreement among raft nodes before linearized reading' (duration: 117.594212ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:14:09.862417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.628338ms","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-09T17:14:09.862525Z","caller":"traceutil/trace.go:171","msg":"trace[941932514] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1110; }","duration":"112.760522ms","start":"2026-06-09T17:14:09.749746Z","end":"2026-06-09T17:14:09.862507Z","steps":["trace[941932514] 'agreement among raft nodes before linearized reading' (duration: 112.559276ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:14:09.862631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.789842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-09T17:14:09.86267Z","caller":"traceutil/trace.go:171","msg":"trace[525962762] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1110; }","duration":"112.860754ms","start":"2026-06-09T17:14:09.7498Z","end":"2026-06-09T17:14:09.862661Z","steps":["trace[525962762] 'agreement among raft nodes before linearized reading' (duration: 112.70096ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:14:09.998335Z","caller":"traceutil/trace.go:171","msg":"trace[773526244] transaction","detail":"{read_only:false; response_revision:1113; number_of_response:1; }","duration":"131.600454ms","start":"2026-06-09T17:14:09.866707Z","end":"2026-06-09T17:14:09.998308Z","steps":["trace[773526244] 'process raft request' (duration: 131.490351ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:14:09.998315Z","caller":"traceutil/trace.go:171","msg":"trace[1811267433] transaction","detail":"{read_only:false; response_revision:1112; number_of_response:1; }","duration":"131.694796ms","start":"2026-06-09T17:14:09.866585Z","end":"2026-06-09T17:14:09.99828Z","steps":["trace[1811267433] 'process raft request' (duration: 131.473271ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:14:09.999097Z","caller":"traceutil/trace.go:171","msg":"trace[698141413] linearizableReadLoop","detail":"{readStateIndex:1156; appliedIndex:1153; }","duration":"112.628978ms","start":"2026-06-09T17:14:09.88645Z","end":"2026-06-09T17:14:09.999079Z","steps":["trace[698141413] 'read index received' (duration: 30.87475ms)","trace[698141413] 'applied index is now lower than readState.Index' (duration: 81.751388ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:14:09.999303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.837963ms","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-09T17:14:09.999334Z","caller":"traceutil/trace.go:171","msg":"trace[152614488] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1113; }","duration":"112.902244ms","start":"2026-06-09T17:14:09.886425Z","end":"2026-06-09T17:14:09.999327Z","steps":["trace[152614488] 'agreement among raft nodes before linearized reading' (duration: 112.7273ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:14:11.249197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"542.564957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T17:14:11.249291Z","caller":"traceutil/trace.go:171","msg":"trace[1466988546] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1115; }","duration":"542.751562ms","start":"2026-06-09T17:14:10.706521Z","end":"2026-06-09T17:14:11.249273Z","steps":["trace[1466988546] 'range keys from in-memory index tree' (duration: 542.460135ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:14:11.249332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:14:10.706492Z","time spent":"542.829543ms","remote":"127.0.0.1:34660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-09T17:14:11.249876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"527.790658ms","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-09T17:14:11.250355Z","caller":"traceutil/trace.go:171","msg":"trace[1997143089] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1115; }","duration":"528.742579ms","start":"2026-06-09T17:14:10.721581Z","end":"2026-06-09T17:14:11.250324Z","steps":["trace[1997143089] 'range keys from in-memory index tree' (duration: 527.647925ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:14:11.25047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:14:10.721571Z","time spent":"528.886152ms","remote":"127.0.0.1:34932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-09T17:14:11.350719Z","caller":"traceutil/trace.go:171","msg":"trace[1679567268] linearizableReadLoop","detail":"{readStateIndex:1159; appliedIndex:1158; }","duration":"100.264104ms","start":"2026-06-09T17:14:11.250412Z","end":"2026-06-09T17:14:11.350677Z","steps":["trace[1679567268] 'read index received' (duration: 9.435787ms)","trace[1679567268] 'applied index is now lower than readState.Index' (duration: 90.827037ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:14:11.350836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.410397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T17:14:11.350869Z","caller":"traceutil/trace.go:171","msg":"trace[398908907] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1115; }","duration":"100.496779ms","start":"2026-06-09T17:14:11.250361Z","end":"2026-06-09T17:14:11.350858Z","steps":["trace[398908907] 'agreement among raft nodes before linearized reading' (duration: 100.426468ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:14:12.420582Z","caller":"traceutil/trace.go:171","msg":"trace[1493214398] linearizableReadLoop","detail":"{readStateIndex:1162; appliedIndex:1161; }","duration":"416.761126ms","start":"2026-06-09T17:14:12.003796Z","end":"2026-06-09T17:14:12.420557Z","steps":["trace[1493214398] 'read index received' (duration: 416.542741ms)","trace[1493214398] 'applied index is now lower than readState.Index' (duration: 217.255µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:14:12.420657Z","caller":"traceutil/trace.go:171","msg":"trace[1373339724] transaction","detail":"{read_only:false; response_revision:1118; number_of_response:1; }","duration":"461.441254ms","start":"2026-06-09T17:14:11.959184Z","end":"2026-06-09T17:14:12.420626Z","steps":["trace[1373339724] 'process raft request' (duration: 461.206008ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:14:12.42082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:14:11.959168Z","time spent":"461.583146ms","remote":"127.0.0.1:34932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T17:14:12.420964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.924161ms","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-09T17:14:12.421009Z","caller":"traceutil/trace.go:171","msg":"trace[647009856] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1118; }","duration":"417.018672ms","start":"2026-06-09T17:14:12.003979Z","end":"2026-06-09T17:14:12.420997Z","steps":["trace[647009856] 'agreement among raft nodes before linearized reading' (duration: 416.749326ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:14:12.421092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:14:12.003959Z","time spent":"417.116785ms","remote":"127.0.0.1:34932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-09T17:14:12.421192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.73475ms","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-09T17:14:12.421276Z","caller":"traceutil/trace.go:171","msg":"trace[1444543324] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1118; }","duration":"377.845592ms","start":"2026-06-09T17:14:12.043415Z","end":"2026-06-09T17:14:12.42126Z","steps":["trace[1444543324] 'agreement among raft nodes before linearized reading' (duration: 377.563186ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:14:12.42134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:14:12.043401Z","time spent":"377.926463ms","remote":"127.0.0.1:34932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-09T17:14:12.421359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.452822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-09T17:14:12.421553Z","caller":"traceutil/trace.go:171","msg":"trace[431020888] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1118; }","duration":"417.719028ms","start":"2026-06-09T17:14:12.003741Z","end":"2026-06-09T17:14:12.42146Z","steps":["trace[431020888] 'agreement among raft nodes before linearized reading' (duration: 416.925521ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:14:12.421638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:14:12.003716Z","time spent":"417.907162ms","remote":"127.0.0.1:34932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-09T17:14:27.738146Z","caller":"traceutil/trace.go:171","msg":"trace[1820250957] transaction","detail":"{read_only:false; response_revision:1220; number_of_response:1; }","duration":"241.201642ms","start":"2026-06-09T17:14:27.496921Z","end":"2026-06-09T17:14:27.738122Z","steps":["trace[1820250957] 'process raft request' (duration: 240.393873ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:14:29.046961Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10960247110613890946,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-09T17:14:29.44034Z","caller":"traceutil/trace.go:171","msg":"trace[980100729] linearizableReadLoop","detail":"{readStateIndex:1271; appliedIndex:1270; }","duration":"894.152602ms","start":"2026-06-09T17:14:28.546166Z","end":"2026-06-09T17:14:29.440319Z","steps":["trace[980100729] 'read index received' (duration: 893.919337ms)","trace[980100729] 'applied index is now lower than readState.Index' (duration: 231.895µs)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:14:29.440549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"894.244924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-09T17:14:29.440577Z","caller":"traceutil/trace.go:171","msg":"trace[1687705344] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1222; }","duration":"894.303145ms","start":"2026-06-09T17:14:28.546262Z","end":"2026-06-09T17:14:29.440565Z","steps":["trace[1687705344] 'agreement among raft nodes before linearized reading' (duration: 894.184003ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:14:29.440572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"894.394128ms","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-09T17:14:29.440604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:14:28.546254Z","time spent":"894.344796ms","remote":"127.0.0.1:34932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-09T17:14:29.440631Z","caller":"traceutil/trace.go:171","msg":"trace[656839439] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1222; }","duration":"894.485519ms","start":"2026-06-09T17:14:28.546125Z","end":"2026-06-09T17:14:29.440611Z","steps":["trace[656839439] 'agreement among raft nodes before linearized reading' (duration: 894.332606ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:14:29.440667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:14:28.546103Z","time spent":"894.555612ms","remote":"127.0.0.1:34932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-09T17:14:29.440726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"592.126477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T17:14:29.440804Z","caller":"traceutil/trace.go:171","msg":"trace[414054046] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:1222; }","duration":"592.294281ms","start":"2026-06-09T17:14:28.848496Z","end":"2026-06-09T17:14:29.44079Z","steps":["trace[414054046] 'agreement among raft nodes before linearized reading' (duration: 592.101646ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:14:29.440841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:14:28.84848Z","time spent":"592.353842ms","remote":"127.0.0.1:53982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"warn","ts":"2026-06-09T17:14:29.440847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.400547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-09T17:14:29.440988Z","caller":"traceutil/trace.go:171","msg":"trace[2074744712] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:1222; }","duration":"102.628652ms","start":"2026-06-09T17:14:29.338333Z","end":"2026-06-09T17:14:29.440961Z","steps":["trace[2074744712] 'agreement among raft nodes before linearized reading' (duration: 102.225753ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:14:29.440867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"894.51733ms","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-09T17:14:29.441148Z","caller":"traceutil/trace.go:171","msg":"trace[2099532924] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1222; }","duration":"894.828007ms","start":"2026-06-09T17:14:28.546299Z","end":"2026-06-09T17:14:29.441127Z","steps":["trace[2099532924] 'agreement among raft nodes before linearized reading' (duration: 894.324946ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:14:29.441185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:14:28.546294Z","time spent":"894.88337ms","remote":"127.0.0.1:34932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-09T17:14:29.44052Z","caller":"traceutil/trace.go:171","msg":"trace[434124626] transaction","detail":"{read_only:false; response_revision:1222; number_of_response:1; }","duration":"946.050802ms","start":"2026-06-09T17:14:28.494418Z","end":"2026-06-09T17:14:29.440469Z","steps":["trace[434124626] 'process raft request' (duration: 945.705424ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:14:29.441374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:14:28.4944Z","time spent":"946.904742ms","remote":"127.0.0.1:34932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T17:14:46.574056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"506.200917ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:41"} {"level":"info","ts":"2026-06-09T17:14:46.574249Z","caller":"traceutil/trace.go:171","msg":"trace[2059327539] transaction","detail":"{read_only:false; response_revision:1298; number_of_response:1; }","duration":"506.715288ms","start":"2026-06-09T17:14:46.067519Z","end":"2026-06-09T17:14:46.574234Z","steps":["trace[2059327539] 'process raft request' (duration: 506.620046ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:14:46.574234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:14:45.666514Z","time spent":"907.713564ms","remote":"127.0.0.1:34688","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-06-09T17:14:46.574332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:14:46.067471Z","time spent":"506.80796ms","remote":"127.0.0.1:34932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T17:14:46.574802Z","caller":"traceutil/trace.go:171","msg":"trace[1696178142] linearizableReadLoop","detail":"{readStateIndex:1350; appliedIndex:1349; }","duration":"868.853613ms","start":"2026-06-09T17:14:45.705919Z","end":"2026-06-09T17:14:46.574773Z","steps":["trace[1696178142] 'read index received' (duration: 361.993451ms)","trace[1696178142] 'applied index is now lower than readState.Index' (duration: 506.856652ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:14:46.574908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"868.991766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T17:14:46.574945Z","caller":"traceutil/trace.go:171","msg":"trace[2072747950] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1298; }","duration":"869.064498ms","start":"2026-06-09T17:14:45.70587Z","end":"2026-06-09T17:14:46.574935Z","steps":["trace[2072747950] 'agreement among raft nodes before linearized reading' (duration: 869.000747ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:14:46.574973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:14:45.705849Z","time spent":"869.11921ms","remote":"127.0.0.1:34660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-09T17:14:46.575656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"751.866411ms","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-09T17:14:46.575725Z","caller":"traceutil/trace.go:171","msg":"trace[1146220194] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1298; }","duration":"752.533615ms","start":"2026-06-09T17:14:45.82317Z","end":"2026-06-09T17:14:46.575704Z","steps":["trace[1146220194] 'agreement among raft nodes before linearized reading' (duration: 751.785319ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:14:46.575765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:14:45.823151Z","time spent":"752.601718ms","remote":"127.0.0.1:34932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-09T17:14:46.837693Z","caller":"traceutil/trace.go:171","msg":"trace[2047328691] transaction","detail":"{read_only:false; response_revision:1299; number_of_response:1; }","duration":"260.597656ms","start":"2026-06-09T17:14:46.577075Z","end":"2026-06-09T17:14:46.837673Z","steps":["trace[2047328691] 'process raft request' (duration: 260.469643ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:14:46.927889Z","caller":"traceutil/trace.go:171","msg":"trace[1568040209] linearizableReadLoop","detail":"{readStateIndex:1353; appliedIndex:1352; }","duration":"302.253431ms","start":"2026-06-09T17:14:46.625613Z","end":"2026-06-09T17:14:46.927866Z","steps":["trace[1568040209] 'read index received' (duration: 212.086803ms)","trace[1568040209] 'applied index is now lower than readState.Index' (duration: 90.165818ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:14:46.928179Z","caller":"traceutil/trace.go:171","msg":"trace[1555268243] transaction","detail":"{read_only:false; response_revision:1300; number_of_response:1; }","duration":"347.10608ms","start":"2026-06-09T17:14:46.581057Z","end":"2026-06-09T17:14:46.928164Z","steps":["trace[1555268243] 'process raft request' (duration: 303.051489ms)","trace[1555268243] 'compare' (duration: 43.652461ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:14:46.928297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:14:46.581034Z","time spent":"347.186601ms","remote":"127.0.0.1:34932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T17:14:46.928491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.888926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-09T17:14:46.928516Z","caller":"traceutil/trace.go:171","msg":"trace[476633892] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1300; }","duration":"302.966057ms","start":"2026-06-09T17:14:46.625542Z","end":"2026-06-09T17:14:46.928508Z","steps":["trace[476633892] 'agreement among raft nodes before linearized reading' (duration: 302.914886ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:14:46.928536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:14:46.625516Z","time spent":"303.015268ms","remote":"127.0.0.1:34750","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":11,"response size":31,"request content":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true "} {"level":"warn","ts":"2026-06-09T17:14:46.928723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.340778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T17:14:46.928752Z","caller":"traceutil/trace.go:171","msg":"trace[1164950450] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1300; }","duration":"222.4252ms","start":"2026-06-09T17:14:46.706318Z","end":"2026-06-09T17:14:46.928743Z","steps":["trace[1164950450] 'agreement among raft nodes before linearized reading' (duration: 222.341078ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:14:47.696436Z","caller":"traceutil/trace.go:171","msg":"trace[856275578] transaction","detail":"{read_only:false; response_revision:1302; number_of_response:1; }","duration":"107.016314ms","start":"2026-06-09T17:14:47.589399Z","end":"2026-06-09T17:14:47.696415Z","steps":["trace[856275578] 'process raft request' (duration: 106.649105ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:14:48.032782Z","caller":"traceutil/trace.go:171","msg":"trace[501125079] transaction","detail":"{read_only:false; response_revision:1303; number_of_response:1; }","duration":"327.432808ms","start":"2026-06-09T17:14:47.70524Z","end":"2026-06-09T17:14:48.032673Z","steps":["trace[501125079] 'process raft request' (duration: 327.296125ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:14:48.032937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:14:47.70522Z","time spent":"327.624792ms","remote":"127.0.0.1:34932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T17:14:48.273126Z","caller":"traceutil/trace.go:171","msg":"trace[1435275511] linearizableReadLoop","detail":"{readStateIndex:1358; appliedIndex:1355; }","duration":"566.186882ms","start":"2026-06-09T17:14:47.706911Z","end":"2026-06-09T17:14:48.273098Z","steps":["trace[1435275511] 'read index received' (duration: 325.605986ms)","trace[1435275511] 'applied index is now lower than readState.Index' (duration: 240.579976ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:14:48.273218Z","caller":"traceutil/trace.go:171","msg":"trace[805754751] transaction","detail":"{read_only:false; response_revision:1304; number_of_response:1; }","duration":"567.888962ms","start":"2026-06-09T17:14:47.705294Z","end":"2026-06-09T17:14:48.273183Z","steps":["trace[805754751] 'process raft request' (duration: 474.346528ms)","trace[805754751] 'compare' (duration: 93.250498ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:14:48.273249Z","caller":"traceutil/trace.go:171","msg":"trace[1993417381] transaction","detail":"{read_only:false; response_revision:1305; number_of_response:1; }","duration":"567.907392ms","start":"2026-06-09T17:14:47.705318Z","end":"2026-06-09T17:14:48.273225Z","steps":["trace[1993417381] 'process raft request' (duration: 567.736228ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:14:48.27327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"566.317015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T17:14:48.273374Z","caller":"traceutil/trace.go:171","msg":"trace[537815692] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1305; }","duration":"566.472849ms","start":"2026-06-09T17:14:47.706891Z","end":"2026-06-09T17:14:48.273364Z","steps":["trace[537815692] 'agreement among raft nodes before linearized reading' (duration: 566.311646ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:14:48.273381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:14:47.705291Z","time spent":"568.011015ms","remote":"127.0.0.1:34932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T17:14:48.273404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:14:47.706885Z","time spent":"566.51224ms","remote":"127.0.0.1:34660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-09T17:14:48.273388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:14:47.705268Z","time spent":"568.021755ms","remote":"127.0.0.1:34932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T17:14:48.704951Z","caller":"traceutil/trace.go:171","msg":"trace[1323190374] transaction","detail":"{read_only:false; response_revision:1306; number_of_response:1; }","duration":"214.388896ms","start":"2026-06-09T17:14:48.490538Z","end":"2026-06-09T17:14:48.704927Z","steps":["trace[1323190374] 'process raft request' (duration: 214.12488ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:14:48.954027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.077401ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T17:14:48.954199Z","caller":"traceutil/trace.go:171","msg":"trace[28281377] transaction","detail":"{read_only:false; response_revision:1307; number_of_response:1; }","duration":"369.640666ms","start":"2026-06-09T17:14:48.584526Z","end":"2026-06-09T17:14:48.954167Z","steps":["trace[28281377] 'process raft request' (duration: 178.267348ms)","trace[28281377] 'compare' (duration: 190.898227ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:14:48.954367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:14:48.584494Z","time spent":"369.776839ms","remote":"127.0.0.1:34932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T17:14:49.123385Z","caller":"traceutil/trace.go:171","msg":"trace[2142804991] transaction","detail":"{read_only:false; response_revision:1308; number_of_response:1; }","duration":"160.790636ms","start":"2026-06-09T17:14:48.962567Z","end":"2026-06-09T17:14:49.123358Z","steps":["trace[2142804991] 'process raft request' (duration: 134.101515ms)","trace[2142804991] 'compare' (duration: 26.576168ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:14:59.34027Z","caller":"traceutil/trace.go:171","msg":"trace[1976669374] transaction","detail":"{read_only:false; response_revision:1384; number_of_response:1; }","duration":"346.582048ms","start":"2026-06-09T17:14:58.993645Z","end":"2026-06-09T17:14:59.340227Z","steps":["trace[1976669374] 'process raft request' (duration: 345.940442ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:14:59.34046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:14:58.993609Z","time spent":"346.752992ms","remote":"127.0.0.1:34932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T17:14:59.33984Z","caller":"traceutil/trace.go:171","msg":"trace[1932091631] linearizableReadLoop","detail":"{readStateIndex:1439; appliedIndex:1438; }","duration":"189.30714ms","start":"2026-06-09T17:14:59.150498Z","end":"2026-06-09T17:14:59.339805Z","steps":["trace[1932091631] 'read index received' (duration: 189.006103ms)","trace[1932091631] 'applied index is now lower than readState.Index' (duration: 299.827µs)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:14:59.340784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.263203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:524"} {"level":"warn","ts":"2026-06-09T17:14:59.341217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.981355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-09T17:14:59.34129Z","caller":"traceutil/trace.go:171","msg":"trace[1205606908] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1384; }","duration":"172.083006ms","start":"2026-06-09T17:14:59.169187Z","end":"2026-06-09T17:14:59.34127Z","steps":["trace[1205606908] 'agreement among raft nodes before linearized reading' (duration: 171.903312ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:14:59.341422Z","caller":"traceutil/trace.go:171","msg":"trace[1540246519] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1384; }","duration":"190.789485ms","start":"2026-06-09T17:14:59.150424Z","end":"2026-06-09T17:14:59.341214Z","steps":["trace[1540246519] 'agreement among raft nodes before linearized reading' (duration: 189.899745ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:14:59.94267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"536.635025ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T17:14:59.942875Z","caller":"traceutil/trace.go:171","msg":"trace[2033797370] transaction","detail":"{read_only:false; response_revision:1385; number_of_response:1; }","duration":"596.972619ms","start":"2026-06-09T17:14:59.345808Z","end":"2026-06-09T17:14:59.942781Z","steps":["trace[2033797370] 'process raft request' (duration: 60.121019ms)","trace[2033797370] 'compare' (duration: 536.248415ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:14:59.943424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:14:59.34578Z","time spent":"597.598794ms","remote":"127.0.0.1:34932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T17:15:00.038768Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10960247110613891293,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-09T17:15:00.130245Z","caller":"traceutil/trace.go:171","msg":"trace[759686042] linearizableReadLoop","detail":"{readStateIndex:1441; appliedIndex:1440; }","duration":"592.337032ms","start":"2026-06-09T17:14:59.537869Z","end":"2026-06-09T17:15:00.130206Z","steps":["trace[759686042] 'read index received' (duration: 559.104561ms)","trace[759686042] 'applied index is now lower than readState.Index' (duration: 33.227951ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:15:00.130281Z","caller":"traceutil/trace.go:171","msg":"trace[924771977] transaction","detail":"{read_only:false; response_revision:1386; number_of_response:1; }","duration":"783.738772ms","start":"2026-06-09T17:14:59.346502Z","end":"2026-06-09T17:15:00.13024Z","steps":["trace[924771977] 'process raft request' (duration: 750.52678ms)","trace[924771977] 'compare' (duration: 33.014076ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:15:00.13043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:14:59.346484Z","time spent":"783.854924ms","remote":"127.0.0.1:34932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T17:15:00.130476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"592.606029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"info","ts":"2026-06-09T17:15:00.130524Z","caller":"traceutil/trace.go:171","msg":"trace[2133125763] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1386; }","duration":"592.680031ms","start":"2026-06-09T17:14:59.53783Z","end":"2026-06-09T17:15:00.13051Z","steps":["trace[2133125763] 'agreement among raft nodes before linearized reading' (duration: 592.532737ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:15:00.130572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:14:59.537811Z","time spent":"592.750702ms","remote":"127.0.0.1:34932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":498,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-06-09T17:15:00.13077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.501031ms","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-09T17:15:00.130824Z","caller":"traceutil/trace.go:171","msg":"trace[359971930] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1386; }","duration":"283.553242ms","start":"2026-06-09T17:14:59.847257Z","end":"2026-06-09T17:15:00.130811Z","steps":["trace[359971930] 'agreement among raft nodes before linearized reading' (duration: 283.411639ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:17:29.258552Z","caller":"traceutil/trace.go:171","msg":"trace[1766150700] transaction","detail":"{read_only:false; response_revision:2074; number_of_response:1; }","duration":"100.605207ms","start":"2026-06-09T17:17:29.157923Z","end":"2026-06-09T17:17:29.258528Z","steps":["trace[1766150700] 'process raft request' (duration: 100.498804ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:17:42.904199Z","caller":"traceutil/trace.go:171","msg":"trace[60333472] transaction","detail":"{read_only:false; response_revision:2134; number_of_response:1; }","duration":"111.257427ms","start":"2026-06-09T17:17:42.792913Z","end":"2026-06-09T17:17:42.90417Z","steps":["trace[60333472] 'process raft request' (duration: 73.675026ms)","trace[60333472] 'compare' (duration: 37.445377ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:17:43.429406Z","caller":"traceutil/trace.go:171","msg":"trace[1074520497] transaction","detail":"{read_only:false; response_revision:2138; number_of_response:1; }","duration":"101.370705ms","start":"2026-06-09T17:17:43.328011Z","end":"2026-06-09T17:17:43.429382Z","steps":["trace[1074520497] 'process raft request' (duration: 35.751208ms)","trace[1074520497] 'compare' (duration: 65.29066ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:17:45.66652Z","caller":"traceutil/trace.go:171","msg":"trace[379878230] transaction","detail":"{read_only:false; response_revision:2149; number_of_response:1; }","duration":"111.612385ms","start":"2026-06-09T17:17:45.554877Z","end":"2026-06-09T17:17:45.66649Z","steps":["trace[379878230] 'process raft request' (duration: 76.453231ms)","trace[379878230] 'compare' (duration: 34.839326ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:17:46.525288Z","caller":"traceutil/trace.go:171","msg":"trace[1616080726] transaction","detail":"{read_only:false; response_revision:2152; number_of_response:1; }","duration":"147.515367ms","start":"2026-06-09T17:17:46.377737Z","end":"2026-06-09T17:17:46.525252Z","steps":["trace[1616080726] 'process raft request' (duration: 147.301452ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:17:47.660444Z","caller":"traceutil/trace.go:171","msg":"trace[20406591] transaction","detail":"{read_only:false; response_revision:2158; number_of_response:1; }","duration":"131.423649ms","start":"2026-06-09T17:17:47.52898Z","end":"2026-06-09T17:17:47.660404Z","steps":["trace[20406591] 'process raft request' (duration: 108.633025ms)","trace[20406591] 'compare' (duration: 22.655101ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:17:53.044914Z","caller":"traceutil/trace.go:171","msg":"trace[1693831273] transaction","detail":"{read_only:false; response_revision:2179; number_of_response:1; }","duration":"124.285272ms","start":"2026-06-09T17:17:52.9206Z","end":"2026-06-09T17:17:53.044885Z","steps":["trace[1693831273] 'process raft request' (duration: 124.026106ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:17:53.238261Z","caller":"traceutil/trace.go:171","msg":"trace[1190496816] transaction","detail":"{read_only:false; response_revision:2180; number_of_response:1; }","duration":"187.673527ms","start":"2026-06-09T17:17:53.050568Z","end":"2026-06-09T17:17:53.238242Z","steps":["trace[1190496816] 'process raft request' (duration: 187.558255ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:18:01.637308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.876494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-06-09T17:18:01.637421Z","caller":"traceutil/trace.go:171","msg":"trace[361318788] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2218; }","duration":"191.354825ms","start":"2026-06-09T17:18:01.44604Z","end":"2026-06-09T17:18:01.637395Z","steps":["trace[361318788] 'range keys from in-memory index tree' (duration: 190.690298ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:18:03.24972Z","caller":"traceutil/trace.go:171","msg":"trace[1125302853] transaction","detail":"{read_only:false; response_revision:2225; number_of_response:1; }","duration":"109.871375ms","start":"2026-06-09T17:18:03.13982Z","end":"2026-06-09T17:18:03.249691Z","steps":["trace[1125302853] 'process raft request' (duration: 109.727201ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:18:03.682251Z","caller":"traceutil/trace.go:171","msg":"trace[90414008] transaction","detail":"{read_only:false; response_revision:2227; number_of_response:1; }","duration":"317.89253ms","start":"2026-06-09T17:18:03.364336Z","end":"2026-06-09T17:18:03.682228Z","steps":["trace[90414008] 'process raft request' (duration: 317.740636ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:18:03.683696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:18:03.364318Z","time spent":"319.287191ms","remote":"127.0.0.1:34932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T17:18:03.955034Z","caller":"traceutil/trace.go:171","msg":"trace[1466277453] transaction","detail":"{read_only:false; response_revision:2230; number_of_response:1; }","duration":"127.334524ms","start":"2026-06-09T17:18:03.827659Z","end":"2026-06-09T17:18:03.954993Z","steps":["trace[1466277453] 'process raft request' (duration: 127.16091ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:18:55.871069Z","caller":"traceutil/trace.go:171","msg":"trace[1659136987] linearizableReadLoop","detail":"{readStateIndex:2595; appliedIndex:2594; }","duration":"163.595102ms","start":"2026-06-09T17:18:55.707442Z","end":"2026-06-09T17:18:55.871037Z","steps":["trace[1659136987] 'read index received' (duration: 111.44229ms)","trace[1659136987] 'applied index is now lower than readState.Index' (duration: 52.151442ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:18:55.87133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.867928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T17:18:55.87143Z","caller":"traceutil/trace.go:171","msg":"trace[865682514] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2491; }","duration":"164.005792ms","start":"2026-06-09T17:18:55.707404Z","end":"2026-06-09T17:18:55.87141Z","steps":["trace[865682514] 'agreement among raft nodes before linearized reading' (duration: 163.777146ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:18:55.871533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.778873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"info","ts":"2026-06-09T17:18:55.871133Z","caller":"traceutil/trace.go:171","msg":"trace[352859169] transaction","detail":"{read_only:false; response_revision:2491; number_of_response:1; }","duration":"176.573631ms","start":"2026-06-09T17:18:55.694519Z","end":"2026-06-09T17:18:55.871093Z","steps":["trace[352859169] 'process raft request' (duration: 124.43332ms)","trace[352859169] 'compare' (duration: 51.836495ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:18:55.871616Z","caller":"traceutil/trace.go:171","msg":"trace[424907897] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2491; }","duration":"145.945256ms","start":"2026-06-09T17:18:55.725658Z","end":"2026-06-09T17:18:55.871603Z","steps":["trace[424907897] 'agreement among raft nodes before linearized reading' (duration: 145.654468ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:18:56.060195Z","caller":"traceutil/trace.go:171","msg":"trace[1883782730] transaction","detail":"{read_only:false; response_revision:2493; number_of_response:1; }","duration":"117.167752ms","start":"2026-06-09T17:18:55.942971Z","end":"2026-06-09T17:18:56.060139Z","steps":["trace[1883782730] 'process raft request' (duration: 93.68856ms)","trace[1883782730] 'compare' (duration: 23.145605ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:18:56.191002Z","caller":"traceutil/trace.go:171","msg":"trace[186105534] transaction","detail":"{read_only:false; response_revision:2495; number_of_response:1; }","duration":"126.067247ms","start":"2026-06-09T17:18:56.064889Z","end":"2026-06-09T17:18:56.190956Z","steps":["trace[186105534] 'process raft request' (duration: 121.689836ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:19:00.338337Z","caller":"traceutil/trace.go:171","msg":"trace[999097536] transaction","detail":"{read_only:false; response_revision:2520; number_of_response:1; }","duration":"100.529588ms","start":"2026-06-09T17:19:00.237772Z","end":"2026-06-09T17:19:00.338302Z","steps":["trace[999097536] 'process raft request' (duration: 29.689265ms)","trace[999097536] 'compare' (duration: 70.508946ms)"],"step_count":2}