{"level":"warn","ts":"2026-06-22T18:46:25.809037Z","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-22T18:46:25.809118Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.74:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.74:2380","--initial-cluster=instance=https://199.204.45.74:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.74:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.74: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-22T18:46:25.809178Z","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-22T18:46:25.809196Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.74:2380"]} {"level":"info","ts":"2026-06-22T18:46:25.809214Z","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-22T18:46:25.809813Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.74:2379"]} {"level":"info","ts":"2026-06-22T18:46:25.809888Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.74:2380"],"listen-peer-urls":["https://199.204.45.74:2380"],"advertise-client-urls":["https://199.204.45.74:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.74:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.74: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-22T18:46:25.813051Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.974402ms"} {"level":"info","ts":"2026-06-22T18:46:25.816526Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"89ba38f964b95aa0","cluster-id":"54492f71bf65c400"} {"level":"info","ts":"2026-06-22T18:46:25.816585Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 switched to configuration voters=()"} {"level":"info","ts":"2026-06-22T18:46:25.816609Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became follower at term 0"} {"level":"info","ts":"2026-06-22T18:46:25.816625Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 89ba38f964b95aa0 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-22T18:46:25.816636Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became follower at term 1"} {"level":"info","ts":"2026-06-22T18:46:25.816676Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 switched to configuration voters=(9924307372652190368)"} {"level":"warn","ts":"2026-06-22T18:46:25.820824Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-22T18:46:25.821954Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-22T18:46:25.822847Z","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-22T18:46:25.824749Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"89ba38f964b95aa0","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-22T18:46:25.826263Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"89ba38f964b95aa0","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-22T18:46:25.825991Z","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-22T18:46:25.826515Z","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-22T18:46:25.826551Z","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-22T18:46:25.826677Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 switched to configuration voters=(9924307372652190368)"} {"level":"info","ts":"2026-06-22T18:46:25.826816Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"54492f71bf65c400","local-member-id":"89ba38f964b95aa0","added-peer-id":"89ba38f964b95aa0","added-peer-peer-urls":["https://199.204.45.74:2380"]} {"level":"info","ts":"2026-06-22T18:46:25.830043Z","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-22T18:46:25.830213Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"89ba38f964b95aa0","initial-advertise-peer-urls":["https://199.204.45.74:2380"],"listen-peer-urls":["https://199.204.45.74:2380"],"advertise-client-urls":["https://199.204.45.74:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.74:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-22T18:46:25.830243Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-22T18:46:25.83033Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.74:2380"} {"level":"info","ts":"2026-06-22T18:46:25.830345Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.74:2380"} {"level":"info","ts":"2026-06-22T18:46:25.917671Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 is starting a new election at term 1"} {"level":"info","ts":"2026-06-22T18:46:25.917787Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-22T18:46:25.917832Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 received MsgPreVoteResp from 89ba38f964b95aa0 at term 1"} {"level":"info","ts":"2026-06-22T18:46:25.917881Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became candidate at term 2"} {"level":"info","ts":"2026-06-22T18:46:25.917922Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 received MsgVoteResp from 89ba38f964b95aa0 at term 2"} {"level":"info","ts":"2026-06-22T18:46:25.917955Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became leader at term 2"} {"level":"info","ts":"2026-06-22T18:46:25.917993Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 89ba38f964b95aa0 elected leader 89ba38f964b95aa0 at term 2"} {"level":"info","ts":"2026-06-22T18:46:25.918821Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"89ba38f964b95aa0","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.74:2379]}","request-path":"/0/members/89ba38f964b95aa0/attributes","cluster-id":"54492f71bf65c400","publish-timeout":"7s"} {"level":"info","ts":"2026-06-22T18:46:25.919477Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-22T18:46:25.919528Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-22T18:46:25.91955Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-22T18:46:25.919774Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-22T18:46:25.919861Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-22T18:46:25.920285Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"54492f71bf65c400","local-member-id":"89ba38f964b95aa0","cluster-version":"3.5"} {"level":"info","ts":"2026-06-22T18:46:25.920391Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-22T18:46:25.920461Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-22T18:46:25.922883Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.74:2379"} {"level":"info","ts":"2026-06-22T18:46:25.924128Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-22T18:46:45.448899Z","caller":"traceutil/trace.go:171","msg":"trace[2111378503] transaction","detail":"{read_only:false; response_revision:418; number_of_response:1; }","duration":"214.859668ms","start":"2026-06-22T18:46:45.234013Z","end":"2026-06-22T18:46:45.448873Z","steps":["trace[2111378503] 'process raft request' (duration: 214.662403ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:46:48.397782Z","caller":"traceutil/trace.go:171","msg":"trace[1758778703] transaction","detail":"{read_only:false; response_revision:427; number_of_response:1; }","duration":"100.969094ms","start":"2026-06-22T18:46:48.296739Z","end":"2026-06-22T18:46:48.397708Z","steps":["trace[1758778703] 'process raft request' (duration: 86.295954ms)","trace[1758778703] 'compare' (duration: 14.524315ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T18:46:48.600147Z","caller":"traceutil/trace.go:171","msg":"trace[264236686] transaction","detail":"{read_only:false; response_revision:437; number_of_response:1; }","duration":"113.127313ms","start":"2026-06-22T18:46:48.486997Z","end":"2026-06-22T18:46:48.600124Z","steps":["trace[264236686] 'process raft request' (duration: 113.083802ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:46:48.600413Z","caller":"traceutil/trace.go:171","msg":"trace[281637676] transaction","detail":"{read_only:false; response_revision:436; number_of_response:1; }","duration":"114.579694ms","start":"2026-06-22T18:46:48.485819Z","end":"2026-06-22T18:46:48.600399Z","steps":["trace[281637676] 'process raft request' (duration: 114.225364ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:46:48.600432Z","caller":"traceutil/trace.go:171","msg":"trace[1463310446] transaction","detail":"{read_only:false; response_revision:435; number_of_response:1; }","duration":"114.617246ms","start":"2026-06-22T18:46:48.485766Z","end":"2026-06-22T18:46:48.600383Z","steps":["trace[1463310446] 'process raft request' (duration: 114.214174ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:46:48.600541Z","caller":"traceutil/trace.go:171","msg":"trace[882937278] transaction","detail":"{read_only:false; response_revision:434; number_of_response:1; }","duration":"117.191847ms","start":"2026-06-22T18:46:48.483323Z","end":"2026-06-22T18:46:48.600515Z","steps":["trace[882937278] 'process raft request' (duration: 116.541879ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:47:01.686742Z","caller":"traceutil/trace.go:171","msg":"trace[1131153532] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"286.477142ms","start":"2026-06-22T18:47:01.40024Z","end":"2026-06-22T18:47:01.686717Z","steps":["trace[1131153532] 'process raft request' (duration: 286.177263ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:47:01.687086Z","caller":"traceutil/trace.go:171","msg":"trace[1263386504] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"278.05618ms","start":"2026-06-22T18:47:01.409018Z","end":"2026-06-22T18:47:01.687074Z","steps":["trace[1263386504] 'process raft request' (duration: 277.578787ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:47:01.687065Z","caller":"traceutil/trace.go:171","msg":"trace[82672842] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"275.389616ms","start":"2026-06-22T18:47:01.411661Z","end":"2026-06-22T18:47:01.687051Z","steps":["trace[82672842] 'process raft request' (duration: 275.050417ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:47:01.687205Z","caller":"traceutil/trace.go:171","msg":"trace[1373923022] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"277.927607ms","start":"2026-06-22T18:47:01.409227Z","end":"2026-06-22T18:47:01.687155Z","steps":["trace[1373923022] 'process raft request' (duration: 277.433133ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:47:01.687259Z","caller":"traceutil/trace.go:171","msg":"trace[1729196982] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"286.956885ms","start":"2026-06-22T18:47:01.400289Z","end":"2026-06-22T18:47:01.687246Z","steps":["trace[1729196982] 'process raft request' (duration: 286.256146ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:47:01.687273Z","caller":"traceutil/trace.go:171","msg":"trace[1375588934] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"274.326107ms","start":"2026-06-22T18:47:01.412937Z","end":"2026-06-22T18:47:01.687263Z","steps":["trace[1375588934] 'process raft request' (duration: 273.847373ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:47:01.687337Z","caller":"traceutil/trace.go:171","msg":"trace[1663402106] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"268.65182ms","start":"2026-06-22T18:47:01.418677Z","end":"2026-06-22T18:47:01.687329Z","steps":["trace[1663402106] 'process raft request' (duration: 268.152477ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:47:01.687423Z","caller":"traceutil/trace.go:171","msg":"trace[1381378991] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"264.449234ms","start":"2026-06-22T18:47:01.422967Z","end":"2026-06-22T18:47:01.687416Z","steps":["trace[1381378991] 'process raft request' (duration: 263.90707ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:47:01.687627Z","caller":"traceutil/trace.go:171","msg":"trace[361707199] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"275.204221ms","start":"2026-06-22T18:47:01.412392Z","end":"2026-06-22T18:47:01.687596Z","steps":["trace[361707199] 'process raft request' (duration: 274.357527ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:47:01.686999Z","caller":"traceutil/trace.go:171","msg":"trace[1881174480] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"244.286689ms","start":"2026-06-22T18:47:01.442686Z","end":"2026-06-22T18:47:01.686973Z","steps":["trace[1881174480] 'process raft request' (duration: 244.239018ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:47:01.697163Z","caller":"traceutil/trace.go:171","msg":"trace[1734012012] linearizableReadLoop","detail":"{readStateIndex:551; appliedIndex:538; }","duration":"167.854144ms","start":"2026-06-22T18:47:01.529291Z","end":"2026-06-22T18:47:01.697145Z","steps":["trace[1734012012] 'read index received' (duration: 157.098408ms)","trace[1734012012] 'applied index is now lower than readState.Index' (duration: 10.754826ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T18:47:01.697244Z","caller":"traceutil/trace.go:171","msg":"trace[1793991206] transaction","detail":"{read_only:false; number_of_response:1; response_revision:531; }","duration":"212.031469ms","start":"2026-06-22T18:47:01.485203Z","end":"2026-06-22T18:47:01.697234Z","steps":["trace[1793991206] 'process raft request' (duration: 211.758302ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:47:01.697253Z","caller":"traceutil/trace.go:171","msg":"trace[188567957] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"212.064031ms","start":"2026-06-22T18:47:01.485171Z","end":"2026-06-22T18:47:01.697235Z","steps":["trace[188567957] 'process raft request' (duration: 211.730452ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:47:01.69746Z","caller":"traceutil/trace.go:171","msg":"trace[83435136] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"146.957247ms","start":"2026-06-22T18:47:01.550495Z","end":"2026-06-22T18:47:01.697452Z","steps":["trace[83435136] 'process raft request' (duration: 146.536277ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:47:01.697672Z","caller":"traceutil/trace.go:171","msg":"trace[1020500194] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"110.972636ms","start":"2026-06-22T18:47:01.586692Z","end":"2026-06-22T18:47:01.697664Z","steps":["trace[1020500194] 'process raft request' (duration: 110.420391ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:47:01.697939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.588393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-22T18:47:01.697989Z","caller":"traceutil/trace.go:171","msg":"trace[702935599] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:533; }","duration":"168.742407ms","start":"2026-06-22T18:47:01.529238Z","end":"2026-06-22T18:47:01.697981Z","steps":["trace[702935599] 'agreement among raft nodes before linearized reading' (duration: 168.597643ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:47:01.697465Z","caller":"traceutil/trace.go:171","msg":"trace[1920648486] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"212.497715ms","start":"2026-06-22T18:47:01.484959Z","end":"2026-06-22T18:47:01.697457Z","steps":["trace[1920648486] 'process raft request' (duration: 211.838175ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:47:06.62073Z","caller":"traceutil/trace.go:171","msg":"trace[1045758261] linearizableReadLoop","detail":"{readStateIndex:640; appliedIndex:639; }","duration":"106.106852ms","start":"2026-06-22T18:47:06.5146Z","end":"2026-06-22T18:47:06.620707Z","steps":["trace[1045758261] 'read index received' (duration: 73.789962ms)","trace[1045758261] 'applied index is now lower than readState.Index' (duration: 32.31596ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T18:47:06.62095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.336579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-22T18:47:06.62099Z","caller":"traceutil/trace.go:171","msg":"trace[1593932337] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:616; }","duration":"106.414901ms","start":"2026-06-22T18:47:06.514564Z","end":"2026-06-22T18:47:06.620979Z","steps":["trace[1593932337] 'agreement among raft nodes before linearized reading' (duration: 106.260957ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:47:06.621165Z","caller":"traceutil/trace.go:171","msg":"trace[192583346] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"216.484723ms","start":"2026-06-22T18:47:06.404657Z","end":"2026-06-22T18:47:06.621142Z","steps":["trace[192583346] 'process raft request' (duration: 183.930077ms)","trace[192583346] 'compare' (duration: 31.768955ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T18:47:07.349105Z","caller":"traceutil/trace.go:171","msg":"trace[1883818549] linearizableReadLoop","detail":"{readStateIndex:644; appliedIndex:643; }","duration":"129.011134ms","start":"2026-06-22T18:47:07.220069Z","end":"2026-06-22T18:47:07.34908Z","steps":["trace[1883818549] 'read index received' (duration: 38.610863ms)","trace[1883818549] 'applied index is now lower than readState.Index' (duration: 90.399411ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T18:47:07.349162Z","caller":"traceutil/trace.go:171","msg":"trace[1258028534] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"137.781355ms","start":"2026-06-22T18:47:07.211354Z","end":"2026-06-22T18:47:07.349135Z","steps":["trace[1258028534] 'process raft request' (duration: 47.325803ms)","trace[1258028534] 'compare' (duration: 90.208335ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T18:47:07.349709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.61645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T18:47:07.349799Z","caller":"traceutil/trace.go:171","msg":"trace[396456612] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:620; }","duration":"129.745564ms","start":"2026-06-22T18:47:07.220009Z","end":"2026-06-22T18:47:07.349754Z","steps":["trace[396456612] 'agreement among raft nodes before linearized reading' (duration: 129.194089ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:47:07.975203Z","caller":"traceutil/trace.go:171","msg":"trace[619757646] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"205.081428ms","start":"2026-06-22T18:47:07.770089Z","end":"2026-06-22T18:47:07.975171Z","steps":["trace[619757646] 'process raft request' (duration: 204.268506ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:47:07.97551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.113452ms","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-22T18:47:07.975676Z","caller":"traceutil/trace.go:171","msg":"trace[1241575976] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:624; }","duration":"204.277617ms","start":"2026-06-22T18:47:07.771331Z","end":"2026-06-22T18:47:07.975609Z","steps":["trace[1241575976] 'agreement among raft nodes before linearized reading' (duration: 203.943028ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:47:07.975211Z","caller":"traceutil/trace.go:171","msg":"trace[1084292496] linearizableReadLoop","detail":"{readStateIndex:648; appliedIndex:647; }","duration":"203.728492ms","start":"2026-06-22T18:47:07.77138Z","end":"2026-06-22T18:47:07.975109Z","steps":["trace[1084292496] 'read index received' (duration: 202.531439ms)","trace[1084292496] 'applied index is now lower than readState.Index' (duration: 1.196023ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T18:47:07.976236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.362828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-22T18:47:07.976296Z","caller":"traceutil/trace.go:171","msg":"trace[765305355] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:624; }","duration":"192.464171ms","start":"2026-06-22T18:47:07.783812Z","end":"2026-06-22T18:47:07.976276Z","steps":["trace[765305355] 'agreement among raft nodes before linearized reading' (duration: 192.257907ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:47:08.085002Z","caller":"traceutil/trace.go:171","msg":"trace[615080110] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"104.157369ms","start":"2026-06-22T18:47:07.980817Z","end":"2026-06-22T18:47:08.084974Z","steps":["trace[615080110] 'process raft request' (duration: 103.920453ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:47:08.099316Z","caller":"traceutil/trace.go:171","msg":"trace[1579800808] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"118.289599ms","start":"2026-06-22T18:47:07.981011Z","end":"2026-06-22T18:47:08.099301Z","steps":["trace[1579800808] 'process raft request' (duration: 118.077253ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:47:08.372514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.562384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T18:47:08.372581Z","caller":"traceutil/trace.go:171","msg":"trace[855028667] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:627; }","duration":"151.672028ms","start":"2026-06-22T18:47:08.220889Z","end":"2026-06-22T18:47:08.372561Z","steps":["trace[855028667] 'range keys from in-memory index tree' (duration: 151.486912ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:47:08.372715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.533173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-xlstq\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-06-22T18:47:08.372828Z","caller":"traceutil/trace.go:171","msg":"trace[1888939124] range","detail":"{range_begin:/registry/pods/kube-system/cilium-xlstq; range_end:; response_count:1; response_revision:627; }","duration":"131.630396ms","start":"2026-06-22T18:47:08.241147Z","end":"2026-06-22T18:47:08.372777Z","steps":["trace[1888939124] 'range keys from in-memory index tree' (duration: 131.327947ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:47:08.528769Z","caller":"traceutil/trace.go:171","msg":"trace[214358285] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"139.629315ms","start":"2026-06-22T18:47:08.389105Z","end":"2026-06-22T18:47:08.528735Z","steps":["trace[214358285] 'process raft request' (duration: 138.198636ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:47:09.13545Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6530394216130878844,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-22T18:47:09.367164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"791.324898ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-22T18:47:09.36757Z","caller":"traceutil/trace.go:171","msg":"trace[1321060458] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"830.98585ms","start":"2026-06-22T18:47:08.536567Z","end":"2026-06-22T18:47:09.367552Z","steps":["trace[1321060458] 'process raft request' (duration: 830.913997ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:47:09.367709Z","caller":"traceutil/trace.go:171","msg":"trace[885493365] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"850.792426ms","start":"2026-06-22T18:47:08.516886Z","end":"2026-06-22T18:47:09.367679Z","steps":["trace[885493365] 'process raft request' (duration: 58.4054ms)","trace[885493365] 'compare' (duration: 790.956417ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T18:47:09.367818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:47:08.53655Z","time spent":"831.122494ms","remote":"127.0.0.1:49176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-22T18:47:09.367895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:47:08.516611Z","time spent":"851.171606ms","remote":"127.0.0.1:49046","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036313,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-22T18:47:09.377063Z","caller":"traceutil/trace.go:171","msg":"trace[1623649639] linearizableReadLoop","detail":"{readStateIndex:655; appliedIndex:652; }","duration":"741.919517ms","start":"2026-06-22T18:47:08.635123Z","end":"2026-06-22T18:47:09.377042Z","steps":["trace[1623649639] 'read index received' (duration: 730.370239ms)","trace[1623649639] 'applied index is now lower than readState.Index' (duration: 11.548378ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T18:47:09.37719Z","caller":"traceutil/trace.go:171","msg":"trace[1008939823] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"706.86257ms","start":"2026-06-22T18:47:08.670296Z","end":"2026-06-22T18:47:09.377158Z","steps":["trace[1008939823] 'process raft request' (duration: 706.637524ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:47:09.377289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"742.148303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-22T18:47:09.377329Z","caller":"traceutil/trace.go:171","msg":"trace[369736528] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:631; }","duration":"742.237166ms","start":"2026-06-22T18:47:08.635081Z","end":"2026-06-22T18:47:09.377318Z","steps":["trace[369736528] 'agreement among raft nodes before linearized reading' (duration: 742.075991ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:47:09.377367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:47:08.635055Z","time spent":"742.304007ms","remote":"127.0.0.1:49176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-22T18:47:09.37737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:47:08.670265Z","time spent":"707.025577ms","remote":"127.0.0.1:49176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-22T18:47:09.377371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.085219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.74\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-06-22T18:47:09.377452Z","caller":"traceutil/trace.go:171","msg":"trace[230522460] range","detail":"{range_begin:/registry/masterleases/199.204.45.74; range_end:; response_count:1; response_revision:631; }","duration":"156.218503ms","start":"2026-06-22T18:47:09.221214Z","end":"2026-06-22T18:47:09.377433Z","steps":["trace[230522460] 'agreement among raft nodes before linearized reading' (duration: 156.001887ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:47:14.652302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.174961ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-22T18:47:14.655272Z","caller":"traceutil/trace.go:171","msg":"trace[1409955648] linearizableReadLoop","detail":"{readStateIndex:736; appliedIndex:735; }","duration":"127.412069ms","start":"2026-06-22T18:47:14.527843Z","end":"2026-06-22T18:47:14.655255Z","steps":["trace[1409955648] 'read index received' (duration: 127.042109ms)","trace[1409955648] 'applied index is now lower than readState.Index' (duration: 369.28µs)"],"step_count":2} {"level":"warn","ts":"2026-06-22T18:47:14.65553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.651836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:1 size:5177"} {"level":"info","ts":"2026-06-22T18:47:14.655564Z","caller":"traceutil/trace.go:171","msg":"trace[364611954] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:1; response_revision:710; }","duration":"127.753908ms","start":"2026-06-22T18:47:14.527799Z","end":"2026-06-22T18:47:14.655553Z","steps":["trace[364611954] 'agreement among raft nodes before linearized reading' (duration: 127.512922ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:47:14.655538Z","caller":"traceutil/trace.go:171","msg":"trace[284026558] transaction","detail":"{read_only:false; response_revision:710; number_of_response:1; }","duration":"177.541171ms","start":"2026-06-22T18:47:14.477902Z","end":"2026-06-22T18:47:14.655443Z","steps":["trace[284026558] 'process raft request' (duration: 177.14679ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:47:22.566908Z","caller":"traceutil/trace.go:171","msg":"trace[278684774] transaction","detail":"{read_only:false; response_revision:778; number_of_response:1; }","duration":"197.737208ms","start":"2026-06-22T18:47:22.369151Z","end":"2026-06-22T18:47:22.566888Z","steps":["trace[278684774] 'process raft request' (duration: 197.625884ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:47:25.154999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.28857ms","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-22T18:47:25.155199Z","caller":"traceutil/trace.go:171","msg":"trace[1017702022] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:792; }","duration":"272.542618ms","start":"2026-06-22T18:47:24.882632Z","end":"2026-06-22T18:47:25.155174Z","steps":["trace[1017702022] 'range keys from in-memory index tree' (duration: 272.021553ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:47:59.873181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.795352ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-22T18:47:59.87331Z","caller":"traceutil/trace.go:171","msg":"trace[1052509435] linearizableReadLoop","detail":"{readStateIndex:1041; appliedIndex:1040; }","duration":"431.64347ms","start":"2026-06-22T18:47:59.441649Z","end":"2026-06-22T18:47:59.873292Z","steps":["trace[1052509435] 'read index received' (duration: 210.620592ms)","trace[1052509435] 'applied index is now lower than readState.Index' (duration: 221.021468ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T18:47:59.873397Z","caller":"traceutil/trace.go:171","msg":"trace[1850241842] transaction","detail":"{read_only:false; response_revision:1003; number_of_response:1; }","duration":"533.154407ms","start":"2026-06-22T18:47:59.340224Z","end":"2026-06-22T18:47:59.873379Z","steps":["trace[1850241842] 'process raft request' (duration: 312.079846ms)","trace[1850241842] 'compare' (duration: 220.657129ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T18:47:59.873488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:47:59.340205Z","time spent":"533.237229ms","remote":"127.0.0.1:48994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-22T18:47:59.873619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.961239ms","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-22T18:47:59.873684Z","caller":"traceutil/trace.go:171","msg":"trace[1311637703] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1003; }","duration":"432.071072ms","start":"2026-06-22T18:47:59.441599Z","end":"2026-06-22T18:47:59.87367Z","steps":["trace[1311637703] 'agreement among raft nodes before linearized reading' (duration: 431.819314ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:47:59.873745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:47:59.441576Z","time spent":"432.160994ms","remote":"127.0.0.1:49176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-22T18:47:59.874941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.46435ms","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-22T18:47:59.875028Z","caller":"traceutil/trace.go:171","msg":"trace[1692931780] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1004; }","duration":"160.602374ms","start":"2026-06-22T18:47:59.714406Z","end":"2026-06-22T18:47:59.875008Z","steps":["trace[1692931780] 'agreement among raft nodes before linearized reading' (duration: 160.385668ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:47:59.875207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.836901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-22T18:47:59.875241Z","caller":"traceutil/trace.go:171","msg":"trace[689106339] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1004; }","duration":"119.909463ms","start":"2026-06-22T18:47:59.755322Z","end":"2026-06-22T18:47:59.875232Z","steps":["trace[689106339] 'agreement among raft nodes before linearized reading' (duration: 119.82383ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:47:59.874979Z","caller":"traceutil/trace.go:171","msg":"trace[1740946213] transaction","detail":"{read_only:false; response_revision:1004; number_of_response:1; }","duration":"309.019264ms","start":"2026-06-22T18:47:59.56595Z","end":"2026-06-22T18:47:59.874969Z","steps":["trace[1740946213] 'process raft request' (duration: 308.707385ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:47:59.87585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:47:59.56593Z","time spent":"309.857236ms","remote":"127.0.0.1:49176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-22T18:48:20.58756Z","caller":"traceutil/trace.go:171","msg":"trace[1421938864] transaction","detail":"{read_only:false; response_revision:1074; number_of_response:1; }","duration":"150.59262ms","start":"2026-06-22T18:48:20.436884Z","end":"2026-06-22T18:48:20.587477Z","steps":["trace[1421938864] 'process raft request' (duration: 150.23912ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:48:21.02792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.14739ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-22T18:48:21.028231Z","caller":"traceutil/trace.go:171","msg":"trace[1657619848] transaction","detail":"{read_only:false; response_revision:1075; number_of_response:1; }","duration":"436.945054ms","start":"2026-06-22T18:48:20.591242Z","end":"2026-06-22T18:48:21.028187Z","steps":["trace[1657619848] 'process raft request' (duration: 238.457294ms)","trace[1657619848] 'compare' (duration: 198.043738ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T18:48:21.028379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:48:20.591219Z","time spent":"437.076167ms","remote":"127.0.0.1:49176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-22T18:48:21.028479Z","caller":"traceutil/trace.go:171","msg":"trace[800381230] transaction","detail":"{read_only:false; response_revision:1076; number_of_response:1; }","duration":"436.498761ms","start":"2026-06-22T18:48:20.591944Z","end":"2026-06-22T18:48:21.028443Z","steps":["trace[800381230] 'process raft request' (duration: 436.071399ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:48:21.028654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:48:20.591911Z","time spent":"436.649065ms","remote":"127.0.0.1:49176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-22T18:48:22.173081Z","caller":"traceutil/trace.go:171","msg":"trace[584775727] linearizableReadLoop","detail":"{readStateIndex:1119; appliedIndex:1118; }","duration":"131.704073ms","start":"2026-06-22T18:48:22.041349Z","end":"2026-06-22T18:48:22.173053Z","steps":["trace[584775727] 'read index received' (duration: 131.537369ms)","trace[584775727] 'applied index is now lower than readState.Index' (duration: 165.764µs)"],"step_count":2} {"level":"info","ts":"2026-06-22T18:48:22.173219Z","caller":"traceutil/trace.go:171","msg":"trace[2140447756] transaction","detail":"{read_only:false; response_revision:1077; number_of_response:1; }","duration":"158.959528ms","start":"2026-06-22T18:48:22.014225Z","end":"2026-06-22T18:48:22.173185Z","steps":["trace[2140447756] 'process raft request' (duration: 158.66729ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:48:22.173334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.972161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-22T18:48:22.173375Z","caller":"traceutil/trace.go:171","msg":"trace[1761447156] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1077; }","duration":"132.061933ms","start":"2026-06-22T18:48:22.041299Z","end":"2026-06-22T18:48:22.173361Z","steps":["trace[1761447156] 'agreement among raft nodes before linearized reading' (duration: 131.892199ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:48:22.17349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.869489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-06-22T18:48:22.173568Z","caller":"traceutil/trace.go:171","msg":"trace[1022623130] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1077; }","duration":"100.978692ms","start":"2026-06-22T18:48:22.07257Z","end":"2026-06-22T18:48:22.173549Z","steps":["trace[1022623130] 'agreement among raft nodes before linearized reading' (duration: 100.783276ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:48:22.173655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.351455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-22T18:48:22.173798Z","caller":"traceutil/trace.go:171","msg":"trace[1966767415] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1077; }","duration":"115.524211ms","start":"2026-06-22T18:48:22.058242Z","end":"2026-06-22T18:48:22.173766Z","steps":["trace[1966767415] 'agreement among raft nodes before linearized reading' (duration: 115.083119ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:48:22.322036Z","caller":"traceutil/trace.go:171","msg":"trace[1069659597] transaction","detail":"{read_only:false; response_revision:1078; number_of_response:1; }","duration":"143.66414ms","start":"2026-06-22T18:48:22.178347Z","end":"2026-06-22T18:48:22.322011Z","steps":["trace[1069659597] 'process raft request' (duration: 110.656177ms)","trace[1069659597] 'compare' (duration: 32.89941ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T18:48:22.351171Z","caller":"traceutil/trace.go:171","msg":"trace[1251096405] transaction","detail":"{read_only:false; response_revision:1079; number_of_response:1; }","duration":"172.732686ms","start":"2026-06-22T18:48:22.17842Z","end":"2026-06-22T18:48:22.351152Z","steps":["trace[1251096405] 'process raft request' (duration: 172.585992ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:48:22.351414Z","caller":"traceutil/trace.go:171","msg":"trace[533229077] transaction","detail":"{read_only:false; response_revision:1080; number_of_response:1; }","duration":"172.122108ms","start":"2026-06-22T18:48:22.179262Z","end":"2026-06-22T18:48:22.351384Z","steps":["trace[533229077] 'process raft request' (duration: 171.838451ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:48:23.8374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.361935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-22T18:48:23.837478Z","caller":"traceutil/trace.go:171","msg":"trace[963830048] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:1083; }","duration":"142.490858ms","start":"2026-06-22T18:48:23.69497Z","end":"2026-06-22T18:48:23.837461Z","steps":["trace[963830048] 'count revisions from in-memory index tree' (duration: 142.20641ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:48:39.482899Z","caller":"traceutil/trace.go:171","msg":"trace[352160346] transaction","detail":"{read_only:false; response_revision:1186; number_of_response:1; }","duration":"254.75767ms","start":"2026-06-22T18:48:39.228112Z","end":"2026-06-22T18:48:39.48287Z","steps":["trace[352160346] 'process raft request' (duration: 254.40192ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:48:51.684706Z","caller":"traceutil/trace.go:171","msg":"trace[2013140087] transaction","detail":"{read_only:false; response_revision:1227; number_of_response:1; }","duration":"113.096674ms","start":"2026-06-22T18:48:51.571585Z","end":"2026-06-22T18:48:51.684681Z","steps":["trace[2013140087] 'process raft request' (duration: 112.95849ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:48:56.618817Z","caller":"traceutil/trace.go:171","msg":"trace[1249005955] transaction","detail":"{read_only:false; response_revision:1261; number_of_response:1; }","duration":"300.135581ms","start":"2026-06-22T18:48:56.318648Z","end":"2026-06-22T18:48:56.618784Z","steps":["trace[1249005955] 'process raft request' (duration: 299.957535ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:48:56.618908Z","caller":"traceutil/trace.go:171","msg":"trace[247297871] linearizableReadLoop","detail":"{readStateIndex:1312; appliedIndex:1312; }","duration":"102.958697ms","start":"2026-06-22T18:48:56.51589Z","end":"2026-06-22T18:48:56.618848Z","steps":["trace[247297871] 'read index received' (duration: 102.618228ms)","trace[247297871] 'applied index is now lower than readState.Index' (duration: 338.389µs)"],"step_count":2} {"level":"warn","ts":"2026-06-22T18:48:56.619037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:48:56.318626Z","time spent":"300.302525ms","remote":"127.0.0.1:49176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-22T18:48:56.619152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.251424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-22T18:48:56.619202Z","caller":"traceutil/trace.go:171","msg":"trace[1338183084] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1261; }","duration":"103.328728ms","start":"2026-06-22T18:48:56.515858Z","end":"2026-06-22T18:48:56.619187Z","steps":["trace[1338183084] 'agreement among raft nodes before linearized reading' (duration: 103.136832ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:48:57.424553Z","caller":"traceutil/trace.go:171","msg":"trace[238177761] transaction","detail":"{read_only:false; response_revision:1266; number_of_response:1; }","duration":"122.359027ms","start":"2026-06-22T18:48:57.302171Z","end":"2026-06-22T18:48:57.42453Z","steps":["trace[238177761] 'process raft request' (duration: 122.235974ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:48:57.747384Z","caller":"traceutil/trace.go:171","msg":"trace[804026105] transaction","detail":"{read_only:false; response_revision:1267; number_of_response:1; }","duration":"116.899218ms","start":"2026-06-22T18:48:57.630462Z","end":"2026-06-22T18:48:57.747361Z","steps":["trace[804026105] 'process raft request' (duration: 116.721923ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:48:57.955726Z","caller":"traceutil/trace.go:171","msg":"trace[640022482] transaction","detail":"{read_only:false; response_revision:1272; number_of_response:1; }","duration":"100.413906ms","start":"2026-06-22T18:48:57.854869Z","end":"2026-06-22T18:48:57.955283Z","steps":["trace[640022482] 'process raft request' (duration: 100.126129ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:48:58.334576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.101636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T18:48:58.334696Z","caller":"traceutil/trace.go:171","msg":"trace[1788375999] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1273; }","duration":"116.266631ms","start":"2026-06-22T18:48:58.218404Z","end":"2026-06-22T18:48:58.334671Z","steps":["trace[1788375999] 'range keys from in-memory index tree' (duration: 116.008975ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:49:10.3965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.679211ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-22T18:49:10.396644Z","caller":"traceutil/trace.go:171","msg":"trace[1354114039] transaction","detail":"{read_only:false; response_revision:1356; number_of_response:1; }","duration":"465.55566ms","start":"2026-06-22T18:49:09.931065Z","end":"2026-06-22T18:49:10.396621Z","steps":["trace[1354114039] 'process raft request' (duration: 55.649592ms)","trace[1354114039] 'compare' (duration: 409.564638ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T18:49:10.396704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:49:09.931045Z","time spent":"465.630602ms","remote":"127.0.0.1:49176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":494,"response count":0,"response size":39,"request content":"compare: success:> failure: >"}