{"level":"warn","ts":"2026-05-22T23:22:33.797762Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-22T23:22:33.797853Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.186: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://162.253.55.186:2380","--initial-cluster=instance=https://162.253.55.186:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.186:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.186: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-05-22T23:22:33.79801Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-22T23:22:33.798027Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.186:2380"]} {"level":"info","ts":"2026-05-22T23:22:33.798046Z","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-05-22T23:22:33.799161Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.186:2379"]} {"level":"info","ts":"2026-05-22T23:22:33.799283Z","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://162.253.55.186:2380"],"listen-peer-urls":["https://162.253.55.186:2380"],"advertise-client-urls":["https://162.253.55.186:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.186:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.186: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-05-22T23:22:33.803723Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.10411ms"} {"level":"info","ts":"2026-05-22T23:22:33.812587Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"612d5169b08bb96b","cluster-id":"20ec8eafba602517"} {"level":"info","ts":"2026-05-22T23:22:33.812668Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b switched to configuration voters=()"} {"level":"info","ts":"2026-05-22T23:22:33.812744Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b became follower at term 0"} {"level":"info","ts":"2026-05-22T23:22:33.812765Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 612d5169b08bb96b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-22T23:22:33.812777Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b became follower at term 1"} {"level":"info","ts":"2026-05-22T23:22:33.812854Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b switched to configuration voters=(7002342510006352235)"} {"level":"warn","ts":"2026-05-22T23:22:33.817578Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-22T23:22:33.819861Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-22T23:22:33.821552Z","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-05-22T23:22:33.823998Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"612d5169b08bb96b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-22T23:22:33.824185Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"612d5169b08bb96b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-22T23:22:33.824477Z","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-05-22T23:22:33.824527Z","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-05-22T23:22:33.824665Z","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-05-22T23:22:33.82712Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b switched to configuration voters=(7002342510006352235)"} {"level":"info","ts":"2026-05-22T23:22:33.827614Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"20ec8eafba602517","local-member-id":"612d5169b08bb96b","added-peer-id":"612d5169b08bb96b","added-peer-peer-urls":["https://162.253.55.186:2380"]} {"level":"info","ts":"2026-05-22T23:22:33.829523Z","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-05-22T23:22:33.829764Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"612d5169b08bb96b","initial-advertise-peer-urls":["https://162.253.55.186:2380"],"listen-peer-urls":["https://162.253.55.186:2380"],"advertise-client-urls":["https://162.253.55.186:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.186:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-22T23:22:33.829804Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-22T23:22:33.83012Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.186:2380"} {"level":"info","ts":"2026-05-22T23:22:33.830147Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.186:2380"} {"level":"info","ts":"2026-05-22T23:22:34.313088Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b is starting a new election at term 1"} {"level":"info","ts":"2026-05-22T23:22:34.31313Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b became pre-candidate at term 1"} {"level":"info","ts":"2026-05-22T23:22:34.313149Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b received MsgPreVoteResp from 612d5169b08bb96b at term 1"} {"level":"info","ts":"2026-05-22T23:22:34.31316Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b became candidate at term 2"} {"level":"info","ts":"2026-05-22T23:22:34.313165Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b received MsgVoteResp from 612d5169b08bb96b at term 2"} {"level":"info","ts":"2026-05-22T23:22:34.313172Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b became leader at term 2"} {"level":"info","ts":"2026-05-22T23:22:34.313179Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 612d5169b08bb96b elected leader 612d5169b08bb96b at term 2"} {"level":"info","ts":"2026-05-22T23:22:34.315312Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-22T23:22:34.31749Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"612d5169b08bb96b","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.186:2379]}","request-path":"/0/members/612d5169b08bb96b/attributes","cluster-id":"20ec8eafba602517","publish-timeout":"7s"} {"level":"info","ts":"2026-05-22T23:22:34.3176Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-22T23:22:34.317755Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-22T23:22:34.3189Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-22T23:22:34.319001Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-22T23:22:34.319684Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"20ec8eafba602517","local-member-id":"612d5169b08bb96b","cluster-version":"3.5"} {"level":"info","ts":"2026-05-22T23:22:34.319744Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-22T23:22:34.319758Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-22T23:22:34.319843Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-22T23:22:34.321513Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.186:2379"} {"level":"warn","ts":"2026-05-22T23:22:39.047828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.207806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3709"} {"level":"info","ts":"2026-05-22T23:22:39.047958Z","caller":"traceutil/trace.go:171","msg":"trace[337510129] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:257; }","duration":"109.393968ms","start":"2026-05-22T23:22:38.938542Z","end":"2026-05-22T23:22:39.047936Z","steps":["trace[337510129] 'range keys from in-memory index tree' (duration: 109.081125ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:22:39.281489Z","caller":"traceutil/trace.go:171","msg":"trace[1108387225] transaction","detail":"{read_only:false; response_revision:258; number_of_response:1; }","duration":"229.153276ms","start":"2026-05-22T23:22:39.052284Z","end":"2026-05-22T23:22:39.281437Z","steps":["trace[1108387225] 'process raft request' (duration: 229.026045ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:22:39.303564Z","caller":"traceutil/trace.go:171","msg":"trace[1084687630] transaction","detail":"{read_only:false; response_revision:259; number_of_response:1; }","duration":"248.657874ms","start":"2026-05-22T23:22:39.054891Z","end":"2026-05-22T23:22:39.303548Z","steps":["trace[1084687630] 'process raft request' (duration: 248.559803ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:22:40.846511Z","caller":"traceutil/trace.go:171","msg":"trace[1117871072] transaction","detail":"{read_only:false; response_revision:314; number_of_response:1; }","duration":"159.449005ms","start":"2026-05-22T23:22:40.687043Z","end":"2026-05-22T23:22:40.846492Z","steps":["trace[1117871072] 'process raft request' (duration: 159.318514ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:22:40.846907Z","caller":"traceutil/trace.go:171","msg":"trace[990660484] linearizableReadLoop","detail":"{readStateIndex:323; appliedIndex:323; }","duration":"122.4102ms","start":"2026-05-22T23:22:40.724488Z","end":"2026-05-22T23:22:40.846899Z","steps":["trace[990660484] 'read index received' (duration: 122.40617ms)","trace[990660484] 'applied index is now lower than readState.Index' (duration: 3.16µs)"],"step_count":2} {"level":"warn","ts":"2026-05-22T23:22:40.847116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.611902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:5513"} {"level":"info","ts":"2026-05-22T23:22:40.847168Z","caller":"traceutil/trace.go:171","msg":"trace[261663950] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:314; }","duration":"122.714072ms","start":"2026-05-22T23:22:40.724445Z","end":"2026-05-22T23:22:40.84716Z","steps":["trace[261663950] 'agreement among raft nodes before linearized reading' (duration: 122.509751ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:22:40.850993Z","caller":"traceutil/trace.go:171","msg":"trace[375909073] transaction","detail":"{read_only:false; number_of_response:0; response_revision:314; }","duration":"124.610181ms","start":"2026-05-22T23:22:40.726373Z","end":"2026-05-22T23:22:40.850983Z","steps":["trace[375909073] 'process raft request' (duration: 124.426941ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:22:40.851105Z","caller":"traceutil/trace.go:171","msg":"trace[1721889211] transaction","detail":"{read_only:false; number_of_response:0; response_revision:314; }","duration":"123.980548ms","start":"2026-05-22T23:22:40.727117Z","end":"2026-05-22T23:22:40.851097Z","steps":["trace[1721889211] 'process raft request' (duration: 123.718677ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:23:10.419412Z","caller":"traceutil/trace.go:171","msg":"trace[1055288225] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"133.398294ms","start":"2026-05-22T23:23:10.285988Z","end":"2026-05-22T23:23:10.419386Z","steps":["trace[1055288225] 'process raft request' (duration: 109.101986ms)","trace[1055288225] 'compare' (duration: 24.037844ms)"],"step_count":2} {"level":"info","ts":"2026-05-22T23:23:10.419432Z","caller":"traceutil/trace.go:171","msg":"trace[1329052640] transaction","detail":"{read_only:false; number_of_response:1; response_revision:535; }","duration":"127.368253ms","start":"2026-05-22T23:23:10.292041Z","end":"2026-05-22T23:23:10.419409Z","steps":["trace[1329052640] 'process raft request' (duration: 127.33099ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:23:10.419447Z","caller":"traceutil/trace.go:171","msg":"trace[873706289] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"128.982816ms","start":"2026-05-22T23:23:10.290437Z","end":"2026-05-22T23:23:10.419419Z","steps":["trace[873706289] 'process raft request' (duration: 128.815657ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:23:10.419528Z","caller":"traceutil/trace.go:171","msg":"trace[2127753834] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"127.597215ms","start":"2026-05-22T23:23:10.291897Z","end":"2026-05-22T23:23:10.419494Z","steps":["trace[2127753834] 'process raft request' (duration: 127.395904ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:23:10.423874Z","caller":"traceutil/trace.go:171","msg":"trace[971877286] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"120.978179ms","start":"2026-05-22T23:23:10.302856Z","end":"2026-05-22T23:23:10.423834Z","steps":["trace[971877286] 'process raft request' (duration: 120.783457ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:23:10.423971Z","caller":"traceutil/trace.go:171","msg":"trace[1055308355] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"120.891164ms","start":"2026-05-22T23:23:10.303067Z","end":"2026-05-22T23:23:10.423958Z","steps":["trace[1055308355] 'process raft request' (duration: 120.610248ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:23:10.424067Z","caller":"traceutil/trace.go:171","msg":"trace[373142148] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"121.905654ms","start":"2026-05-22T23:23:10.30215Z","end":"2026-05-22T23:23:10.424056Z","steps":["trace[373142148] 'process raft request' (duration: 121.361702ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:23:10.424133Z","caller":"traceutil/trace.go:171","msg":"trace[358814421] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"120.928207ms","start":"2026-05-22T23:23:10.30319Z","end":"2026-05-22T23:23:10.424119Z","steps":["trace[358814421] 'process raft request' (duration: 120.528673ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:23:10.424124Z","caller":"traceutil/trace.go:171","msg":"trace[1815134956] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"120.577997ms","start":"2026-05-22T23:23:10.303526Z","end":"2026-05-22T23:23:10.424104Z","steps":["trace[1815134956] 'process raft request' (duration: 120.356533ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:23:10.424158Z","caller":"traceutil/trace.go:171","msg":"trace[1986967509] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"118.227709ms","start":"2026-05-22T23:23:10.305922Z","end":"2026-05-22T23:23:10.42415Z","steps":["trace[1986967509] 'process raft request' (duration: 117.997325ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:23:10.424279Z","caller":"traceutil/trace.go:171","msg":"trace[511140088] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"117.918401ms","start":"2026-05-22T23:23:10.306349Z","end":"2026-05-22T23:23:10.424267Z","steps":["trace[511140088] 'process raft request' (duration: 117.71392ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:23:10.424379Z","caller":"traceutil/trace.go:171","msg":"trace[1382208799] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"116.715941ms","start":"2026-05-22T23:23:10.307614Z","end":"2026-05-22T23:23:10.42433Z","steps":["trace[1382208799] 'process raft request' (duration: 116.52303ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:23:10.424429Z","caller":"traceutil/trace.go:171","msg":"trace[606830600] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"120.98247ms","start":"2026-05-22T23:23:10.303436Z","end":"2026-05-22T23:23:10.424419Z","steps":["trace[606830600] 'process raft request' (duration: 120.317411ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T23:23:16.275383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.723314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-22T23:23:16.275462Z","caller":"traceutil/trace.go:171","msg":"trace[1686476384] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system; range_end:; response_count:0; response_revision:630; }","duration":"122.867891ms","start":"2026-05-22T23:23:16.152574Z","end":"2026-05-22T23:23:16.275442Z","steps":["trace[1686476384] 'range keys from in-memory index tree' (duration: 122.63416ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:23:16.442881Z","caller":"traceutil/trace.go:171","msg":"trace[763714156] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"163.306477ms","start":"2026-05-22T23:23:16.279551Z","end":"2026-05-22T23:23:16.442858Z","steps":["trace[763714156] 'process raft request' (duration: 163.159609ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:23:16.447051Z","caller":"traceutil/trace.go:171","msg":"trace[1724157437] linearizableReadLoop","detail":"{readStateIndex:653; appliedIndex:651; }","duration":"101.122063ms","start":"2026-05-22T23:23:16.345895Z","end":"2026-05-22T23:23:16.447018Z","steps":["trace[1724157437] 'read index received' (duration: 96.871972ms)","trace[1724157437] 'applied index is now lower than readState.Index' (duration: 4.247931ms)"],"step_count":2} {"level":"warn","ts":"2026-05-22T23:23:16.447347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.409248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-22T23:23:16.447392Z","caller":"traceutil/trace.go:171","msg":"trace[1586472734] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:632; }","duration":"101.537404ms","start":"2026-05-22T23:23:16.34584Z","end":"2026-05-22T23:23:16.447378Z","steps":["trace[1586472734] 'agreement among raft nodes before linearized reading' (duration: 101.303083ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:23:16.447757Z","caller":"traceutil/trace.go:171","msg":"trace[518828542] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"167.549177ms","start":"2026-05-22T23:23:16.280197Z","end":"2026-05-22T23:23:16.447746Z","steps":["trace[518828542] 'process raft request' (duration: 166.661813ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:23:16.95828Z","caller":"traceutil/trace.go:171","msg":"trace[1407455739] linearizableReadLoop","detail":"{readStateIndex:655; appliedIndex:654; }","duration":"142.357459ms","start":"2026-05-22T23:23:16.815825Z","end":"2026-05-22T23:23:16.958183Z","steps":["trace[1407455739] 'read index received' (duration: 136.054256ms)","trace[1407455739] 'applied index is now lower than readState.Index' (duration: 6.302343ms)"],"step_count":2} {"level":"info","ts":"2026-05-22T23:23:16.958293Z","caller":"traceutil/trace.go:171","msg":"trace[1773830059] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"283.065585ms","start":"2026-05-22T23:23:16.675191Z","end":"2026-05-22T23:23:16.958257Z","steps":["trace[1773830059] 'process raft request' (duration: 277.738831ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T23:23:16.958518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.670904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-sm8gr\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-05-22T23:23:16.958631Z","caller":"traceutil/trace.go:171","msg":"trace[982450339] range","detail":"{range_begin:/registry/pods/kube-system/cilium-sm8gr; range_end:; response_count:1; response_revision:634; }","duration":"142.846222ms","start":"2026-05-22T23:23:16.815762Z","end":"2026-05-22T23:23:16.958608Z","steps":["trace[982450339] 'agreement among raft nodes before linearized reading' (duration: 142.570879ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:23:17.436916Z","caller":"traceutil/trace.go:171","msg":"trace[1245888659] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"465.667389ms","start":"2026-05-22T23:23:16.971226Z","end":"2026-05-22T23:23:17.436893Z","steps":["trace[1245888659] 'process raft request' (duration: 465.526783ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T23:23:17.437963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T23:23:16.971203Z","time spent":"465.781955ms","remote":"127.0.0.1:44242","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-22T23:23:17.782547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.315794ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-22T23:23:17.782797Z","caller":"traceutil/trace.go:171","msg":"trace[607953291] linearizableReadLoop","detail":"{readStateIndex:658; appliedIndex:655; }","duration":"436.731381ms","start":"2026-05-22T23:23:17.346048Z","end":"2026-05-22T23:23:17.782779Z","steps":["trace[607953291] 'read index received' (duration: 90.814673ms)","trace[607953291] 'applied index is now lower than readState.Index' (duration: 345.915588ms)"],"step_count":2} {"level":"info","ts":"2026-05-22T23:23:17.782812Z","caller":"traceutil/trace.go:171","msg":"trace[593212255] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"766.180624ms","start":"2026-05-22T23:23:17.016594Z","end":"2026-05-22T23:23:17.782775Z","steps":["trace[593212255] 'process raft request' (duration: 566.568128ms)","trace[593212255] 'compare' (duration: 197.405459ms)"],"step_count":2} {"level":"warn","ts":"2026-05-22T23:23:17.78295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T23:23:17.016571Z","time spent":"766.315651ms","remote":"127.0.0.1:44576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-22T23:23:17.783074Z","caller":"traceutil/trace.go:171","msg":"trace[955927651] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"736.8667ms","start":"2026-05-22T23:23:17.046195Z","end":"2026-05-22T23:23:17.783062Z","steps":["trace[955927651] 'process raft request' (duration: 736.495912ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T23:23:17.783164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T23:23:17.046169Z","time spent":"736.947064ms","remote":"127.0.0.1:44328","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-22T23:23:17.783273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.510634ms","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-05-22T23:23:17.783321Z","caller":"traceutil/trace.go:171","msg":"trace[900538880] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:637; }","duration":"290.611909ms","start":"2026-05-22T23:23:17.492696Z","end":"2026-05-22T23:23:17.783308Z","steps":["trace[900538880] 'agreement among raft nodes before linearized reading' (duration: 290.520395ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T23:23:17.783406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.363002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-22T23:23:17.783437Z","caller":"traceutil/trace.go:171","msg":"trace[1635107531] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:637; }","duration":"437.426184ms","start":"2026-05-22T23:23:17.346002Z","end":"2026-05-22T23:23:17.783428Z","steps":["trace[1635107531] 'agreement among raft nodes before linearized reading' (duration: 437.383852ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T23:23:17.78346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T23:23:17.345981Z","time spent":"437.473928ms","remote":"127.0.0.1:44082","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-22T23:23:17.78359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.265149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.186\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-22T23:23:17.783625Z","caller":"traceutil/trace.go:171","msg":"trace[1412294825] range","detail":"{range_begin:/registry/masterleases/162.253.55.186; range_end:; response_count:1; response_revision:637; }","duration":"257.348453ms","start":"2026-05-22T23:23:17.526268Z","end":"2026-05-22T23:23:17.783617Z","steps":["trace[1412294825] 'agreement among raft nodes before linearized reading' (duration: 257.29142ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:24:09.36027Z","caller":"traceutil/trace.go:171","msg":"trace[71301666] linearizableReadLoop","detail":"{readStateIndex:1269; appliedIndex:1268; }","duration":"241.786464ms","start":"2026-05-22T23:24:09.118462Z","end":"2026-05-22T23:24:09.360249Z","steps":["trace[71301666] 'read index received' (duration: 241.629072ms)","trace[71301666] 'applied index is now lower than readState.Index' (duration: 156.672µs)"],"step_count":2} {"level":"info","ts":"2026-05-22T23:24:09.360393Z","caller":"traceutil/trace.go:171","msg":"trace[1313305245] transaction","detail":"{read_only:false; response_revision:1230; number_of_response:1; }","duration":"257.805433ms","start":"2026-05-22T23:24:09.102564Z","end":"2026-05-22T23:24:09.360369Z","steps":["trace[1313305245] 'process raft request' (duration: 257.556789ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T23:24:09.360512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.044919ms","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-05-22T23:24:09.360562Z","caller":"traceutil/trace.go:171","msg":"trace[695843841] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1230; }","duration":"242.190011ms","start":"2026-05-22T23:24:09.118356Z","end":"2026-05-22T23:24:09.360546Z","steps":["trace[695843841] 'agreement among raft nodes before linearized reading' (duration: 242.033599ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T23:24:56.866881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.352068ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-22T23:24:56.867127Z","caller":"traceutil/trace.go:171","msg":"trace[1125475304] transaction","detail":"{read_only:false; response_revision:1903; number_of_response:1; }","duration":"214.952833ms","start":"2026-05-22T23:24:56.652157Z","end":"2026-05-22T23:24:56.86711Z","steps":["trace[1125475304] 'process raft request' (duration: 214.870582ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:24:56.867226Z","caller":"traceutil/trace.go:171","msg":"trace[1869161116] transaction","detail":"{read_only:false; response_revision:1902; number_of_response:1; }","duration":"491.228627ms","start":"2026-05-22T23:24:56.375959Z","end":"2026-05-22T23:24:56.867187Z","steps":["trace[1869161116] 'process raft request' (duration: 78.464256ms)","trace[1869161116] 'compare' (duration: 412.039604ms)"],"step_count":2} {"level":"warn","ts":"2026-05-22T23:24:56.867441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T23:24:56.375946Z","time spent":"491.380318ms","remote":"127.0.0.1:44328","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-22T23:25:09.096485Z","caller":"traceutil/trace.go:171","msg":"trace[651947845] transaction","detail":"{read_only:false; response_revision:2005; number_of_response:1; }","duration":"186.266693ms","start":"2026-05-22T23:25:08.910192Z","end":"2026-05-22T23:25:09.096459Z","steps":["trace[651947845] 'process raft request' (duration: 186.00142ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T23:25:09.096775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.585231ms","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-05-22T23:25:09.096915Z","caller":"traceutil/trace.go:171","msg":"trace[692297613] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2005; }","duration":"181.786682ms","start":"2026-05-22T23:25:08.915108Z","end":"2026-05-22T23:25:09.096895Z","steps":["trace[692297613] 'agreement among raft nodes before linearized reading' (duration: 181.47848ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:25:09.096884Z","caller":"traceutil/trace.go:171","msg":"trace[1194550967] linearizableReadLoop","detail":"{readStateIndex:2082; appliedIndex:2081; }","duration":"181.166986ms","start":"2026-05-22T23:25:08.915172Z","end":"2026-05-22T23:25:09.096339Z","steps":["trace[1194550967] 'read index received' (duration: 180.895834ms)","trace[1194550967] 'applied index is now lower than readState.Index' (duration: 270.212µs)"],"step_count":2} {"level":"warn","ts":"2026-05-22T23:25:09.097573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.42642ms","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-05-22T23:25:09.097696Z","caller":"traceutil/trace.go:171","msg":"trace[438662417] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2005; }","duration":"114.595041ms","start":"2026-05-22T23:25:08.983086Z","end":"2026-05-22T23:25:09.097681Z","steps":["trace[438662417] 'agreement among raft nodes before linearized reading' (duration: 114.359279ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T23:25:09.097594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.432121ms","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-05-22T23:25:09.097946Z","caller":"traceutil/trace.go:171","msg":"trace[528014457] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2005; }","duration":"113.820215ms","start":"2026-05-22T23:25:08.984103Z","end":"2026-05-22T23:25:09.097923Z","steps":["trace[528014457] 'agreement among raft nodes before linearized reading' (duration: 113.399001ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:25:13.278938Z","caller":"traceutil/trace.go:171","msg":"trace[940738573] transaction","detail":"{read_only:false; response_revision:2037; number_of_response:1; }","duration":"469.142752ms","start":"2026-05-22T23:25:12.809758Z","end":"2026-05-22T23:25:13.278901Z","steps":["trace[940738573] 'process raft request' (duration: 467.198684ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:25:13.278955Z","caller":"traceutil/trace.go:171","msg":"trace[525582011] transaction","detail":"{read_only:false; response_revision:2038; number_of_response:1; }","duration":"346.810645ms","start":"2026-05-22T23:25:12.932122Z","end":"2026-05-22T23:25:13.278932Z","steps":["trace[525582011] 'process raft request' (duration: 345.345372ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T23:25:13.279127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T23:25:12.809737Z","time spent":"469.287013ms","remote":"127.0.0.1:44226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8112,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-22T23:25:13.27917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T23:25:12.932106Z","time spent":"346.989167ms","remote":"127.0.0.1:44328","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-22T23:25:13.287707Z","caller":"traceutil/trace.go:171","msg":"trace[2124301133] linearizableReadLoop","detail":"{readStateIndex:2117; appliedIndex:2113; }","duration":"168.327986ms","start":"2026-05-22T23:25:13.119359Z","end":"2026-05-22T23:25:13.287687Z","steps":["trace[2124301133] 'read index received' (duration: 157.539102ms)","trace[2124301133] 'applied index is now lower than readState.Index' (duration: 10.787814ms)"],"step_count":2} {"level":"info","ts":"2026-05-22T23:25:13.287761Z","caller":"traceutil/trace.go:171","msg":"trace[399670399] transaction","detail":"{read_only:false; response_revision:2039; number_of_response:1; }","duration":"176.509308ms","start":"2026-05-22T23:25:13.11121Z","end":"2026-05-22T23:25:13.28772Z","steps":["trace[399670399] 'process raft request' (duration: 176.352947ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T23:25:13.287871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.512648ms","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-05-22T23:25:13.287916Z","caller":"traceutil/trace.go:171","msg":"trace[351976515] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2039; }","duration":"168.58258ms","start":"2026-05-22T23:25:13.119318Z","end":"2026-05-22T23:25:13.2879Z","steps":["trace[351976515] 'agreement among raft nodes before linearized reading' (duration: 168.464199ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:25:35.514998Z","caller":"traceutil/trace.go:171","msg":"trace[1547113421] linearizableReadLoop","detail":"{readStateIndex:2244; appliedIndex:2243; }","duration":"128.931116ms","start":"2026-05-22T23:25:35.38604Z","end":"2026-05-22T23:25:35.514972Z","steps":["trace[1547113421] 'read index received' (duration: 118.666719ms)","trace[1547113421] 'applied index is now lower than readState.Index' (duration: 10.263227ms)"],"step_count":2} {"level":"info","ts":"2026-05-22T23:25:35.515067Z","caller":"traceutil/trace.go:171","msg":"trace[1778910667] transaction","detail":"{read_only:false; response_revision:2162; number_of_response:1; }","duration":"129.660196ms","start":"2026-05-22T23:25:35.385369Z","end":"2026-05-22T23:25:35.515029Z","steps":["trace[1778910667] 'process raft request' (duration: 119.344697ms)","trace[1778910667] 'compare' (duration: 10.149003ms)"],"step_count":2} {"level":"warn","ts":"2026-05-22T23:25:35.515354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.284731ms","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-05-22T23:25:35.515522Z","caller":"traceutil/trace.go:171","msg":"trace[495055863] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2162; }","duration":"129.484559ms","start":"2026-05-22T23:25:35.386024Z","end":"2026-05-22T23:25:35.515508Z","steps":["trace[495055863] 'agreement among raft nodes before linearized reading' (duration: 129.118904ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:25:35.522418Z","caller":"traceutil/trace.go:171","msg":"trace[1750816389] transaction","detail":"{read_only:false; response_revision:2163; number_of_response:1; }","duration":"103.226333ms","start":"2026-05-22T23:25:35.419153Z","end":"2026-05-22T23:25:35.52238Z","steps":["trace[1750816389] 'process raft request' (duration: 103.120358ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T23:25:35.522653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.677736ms","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-05-22T23:25:35.522704Z","caller":"traceutil/trace.go:171","msg":"trace[532589166] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2164; }","duration":"129.740169ms","start":"2026-05-22T23:25:35.392953Z","end":"2026-05-22T23:25:35.522693Z","steps":["trace[532589166] 'agreement among raft nodes before linearized reading' (duration: 129.594153ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T23:25:35.52294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.566892ms","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-05-22T23:25:35.523718Z","caller":"traceutil/trace.go:171","msg":"trace[2132564252] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2164; }","duration":"130.379405ms","start":"2026-05-22T23:25:35.393325Z","end":"2026-05-22T23:25:35.523705Z","steps":["trace[2132564252] 'agreement among raft nodes before linearized reading' (duration: 129.339244ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T23:25:36.200689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.4855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"} {"level":"info","ts":"2026-05-22T23:25:36.200774Z","caller":"traceutil/trace.go:171","msg":"trace[191500176] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:2169; }","duration":"275.631767ms","start":"2026-05-22T23:25:35.925121Z","end":"2026-05-22T23:25:36.200753Z","steps":["trace[191500176] 'range keys from in-memory index tree' (duration: 275.365766ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T23:25:36.200702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.713952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"warn","ts":"2026-05-22T23:25:36.200808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.197895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:122419"} {"level":"info","ts":"2026-05-22T23:25:36.200932Z","caller":"traceutil/trace.go:171","msg":"trace[387927858] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:2169; }","duration":"268.368553ms","start":"2026-05-22T23:25:35.932539Z","end":"2026-05-22T23:25:36.200907Z","steps":["trace[387927858] 'range keys from in-memory index tree' (duration: 267.969225ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:25:36.200935Z","caller":"traceutil/trace.go:171","msg":"trace[525799330] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:2169; }","duration":"310.942851ms","start":"2026-05-22T23:25:35.889938Z","end":"2026-05-22T23:25:36.200881Z","steps":["trace[525799330] 'range keys from in-memory index tree' (duration: 310.476902ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T23:25:36.201034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T23:25:35.889923Z","time spent":"311.075717ms","remote":"127.0.0.1:44328","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":581,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"info","ts":"2026-05-22T23:25:37.678473Z","caller":"traceutil/trace.go:171","msg":"trace[1724353392] transaction","detail":"{read_only:false; response_revision:2172; number_of_response:1; }","duration":"155.592353ms","start":"2026-05-22T23:25:37.522853Z","end":"2026-05-22T23:25:37.678445Z","steps":["trace[1724353392] 'process raft request' (duration: 155.372134ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:25:37.759364Z","caller":"traceutil/trace.go:171","msg":"trace[1487185702] linearizableReadLoop","detail":"{readStateIndex:2256; appliedIndex:2253; }","duration":"223.774643ms","start":"2026-05-22T23:25:37.535567Z","end":"2026-05-22T23:25:37.759342Z","steps":["trace[1487185702] 'read index received' (duration: 142.627298ms)","trace[1487185702] 'applied index is now lower than readState.Index' (duration: 81.146275ms)"],"step_count":2} {"level":"info","ts":"2026-05-22T23:25:37.759427Z","caller":"traceutil/trace.go:171","msg":"trace[1736086871] transaction","detail":"{read_only:false; response_revision:2173; number_of_response:1; }","duration":"232.054022ms","start":"2026-05-22T23:25:37.527338Z","end":"2026-05-22T23:25:37.759392Z","steps":["trace[1736086871] 'process raft request' (duration: 230.372194ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:25:37.759512Z","caller":"traceutil/trace.go:171","msg":"trace[257039035] transaction","detail":"{read_only:false; response_revision:2174; number_of_response:1; }","duration":"231.658055ms","start":"2026-05-22T23:25:37.527751Z","end":"2026-05-22T23:25:37.759409Z","steps":["trace[257039035] 'process raft request' (duration: 231.52454ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T23:25:37.759722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.142877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.186\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-05-22T23:25:37.759888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.053332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-05-22T23:25:37.759899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.918628ms","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-05-22T23:25:37.759993Z","caller":"traceutil/trace.go:171","msg":"trace[1725653899] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2174; }","duration":"224.035903ms","start":"2026-05-22T23:25:37.535934Z","end":"2026-05-22T23:25:37.759969Z","steps":["trace[1725653899] 'agreement among raft nodes before linearized reading' (duration: 223.783982ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:25:37.759769Z","caller":"traceutil/trace.go:171","msg":"trace[2021329253] range","detail":"{range_begin:/registry/masterleases/162.253.55.186; range_end:; response_count:1; response_revision:2174; }","duration":"224.239381ms","start":"2026-05-22T23:25:37.535518Z","end":"2026-05-22T23:25:37.759758Z","steps":["trace[2021329253] 'agreement among raft nodes before linearized reading' (duration: 223.993501ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:25:37.759939Z","caller":"traceutil/trace.go:171","msg":"trace[101962411] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2174; }","duration":"194.138085ms","start":"2026-05-22T23:25:37.565788Z","end":"2026-05-22T23:25:37.759926Z","steps":["trace[101962411] 'agreement among raft nodes before linearized reading' (duration: 193.951377ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T23:25:37.760382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.620394ms","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-05-22T23:25:37.760503Z","caller":"traceutil/trace.go:171","msg":"trace[1551970282] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2174; }","duration":"194.721778ms","start":"2026-05-22T23:25:37.56572Z","end":"2026-05-22T23:25:37.760441Z","steps":["trace[1551970282] 'agreement among raft nodes before linearized reading' (duration: 194.393895ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:26:33.755731Z","caller":"traceutil/trace.go:171","msg":"trace[1853644181] transaction","detail":"{read_only:false; response_revision:2579; number_of_response:1; }","duration":"120.460225ms","start":"2026-05-22T23:26:33.635246Z","end":"2026-05-22T23:26:33.755707Z","steps":["trace[1853644181] 'process raft request' (duration: 120.290471ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:26:34.071165Z","caller":"traceutil/trace.go:171","msg":"trace[1430255774] transaction","detail":"{read_only:false; response_revision:2580; number_of_response:1; }","duration":"131.321571ms","start":"2026-05-22T23:26:33.939798Z","end":"2026-05-22T23:26:34.07112Z","steps":["trace[1430255774] 'process raft request' (duration: 131.154848ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:26:34.072563Z","caller":"traceutil/trace.go:171","msg":"trace[224856282] linearizableReadLoop","detail":"{readStateIndex:2677; appliedIndex:2675; }","duration":"122.641015ms","start":"2026-05-22T23:26:33.949888Z","end":"2026-05-22T23:26:34.072529Z","steps":["trace[224856282] 'read index received' (duration: 121.030427ms)","trace[224856282] 'applied index is now lower than readState.Index' (duration: 1.609728ms)"],"step_count":2} {"level":"info","ts":"2026-05-22T23:26:34.072782Z","caller":"traceutil/trace.go:171","msg":"trace[1181376361] transaction","detail":"{read_only:false; response_revision:2581; number_of_response:1; }","duration":"132.203622ms","start":"2026-05-22T23:26:33.940556Z","end":"2026-05-22T23:26:34.07276Z","steps":["trace[1181376361] 'process raft request' (duration: 131.829513ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T23:26:34.072924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.009564ms","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-05-22T23:26:34.073017Z","caller":"traceutil/trace.go:171","msg":"trace[1434547825] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2582; }","duration":"123.131697ms","start":"2026-05-22T23:26:33.949862Z","end":"2026-05-22T23:26:34.072994Z","steps":["trace[1434547825] 'agreement among raft nodes before linearized reading' (duration: 122.85184ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:27:08.058904Z","caller":"traceutil/trace.go:171","msg":"trace[393532004] linearizableReadLoop","detail":"{readStateIndex:2873; appliedIndex:2871; }","duration":"132.235638ms","start":"2026-05-22T23:27:07.926648Z","end":"2026-05-22T23:27:08.058883Z","steps":["trace[393532004] 'read index received' (duration: 79.239726ms)","trace[393532004] 'applied index is now lower than readState.Index' (duration: 52.995222ms)"],"step_count":2} {"level":"info","ts":"2026-05-22T23:27:08.059025Z","caller":"traceutil/trace.go:171","msg":"trace[342438369] transaction","detail":"{read_only:false; response_revision:2768; number_of_response:1; }","duration":"240.036576ms","start":"2026-05-22T23:27:07.818974Z","end":"2026-05-22T23:27:08.05901Z","steps":["trace[342438369] 'process raft request' (duration: 187.003553ms)","trace[342438369] 'compare' (duration: 52.752017ms)"],"step_count":2} {"level":"info","ts":"2026-05-22T23:27:08.059328Z","caller":"traceutil/trace.go:171","msg":"trace[1145189165] transaction","detail":"{read_only:false; response_revision:2769; number_of_response:1; }","duration":"163.269517ms","start":"2026-05-22T23:27:07.896013Z","end":"2026-05-22T23:27:08.059282Z","steps":["trace[1145189165] 'process raft request' (duration: 162.821869ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T23:27:08.059516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.852998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-05-22T23:27:08.059579Z","caller":"traceutil/trace.go:171","msg":"trace[1752071443] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:2769; }","duration":"132.953181ms","start":"2026-05-22T23:27:07.926613Z","end":"2026-05-22T23:27:08.059566Z","steps":["trace[1752071443] 'agreement among raft nodes before linearized reading' (duration: 132.527283ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:30:44.99699Z","caller":"traceutil/trace.go:171","msg":"trace[244534720] linearizableReadLoop","detail":"{readStateIndex:4763; appliedIndex:4762; }","duration":"103.157377ms","start":"2026-05-22T23:30:44.893814Z","end":"2026-05-22T23:30:44.996971Z","steps":["trace[244534720] 'read index received' (duration: 103.041644ms)","trace[244534720] 'applied index is now lower than readState.Index' (duration: 115.023µs)"],"step_count":2} {"level":"info","ts":"2026-05-22T23:30:44.997131Z","caller":"traceutil/trace.go:171","msg":"trace[437325551] transaction","detail":"{read_only:false; response_revision:4589; number_of_response:1; }","duration":"213.215966ms","start":"2026-05-22T23:30:44.783883Z","end":"2026-05-22T23:30:44.997099Z","steps":["trace[437325551] 'process raft request' (duration: 212.97995ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T23:30:44.997191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.340507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-2h4nt\" ","response":"range_response_count:1 size:9757"} {"level":"info","ts":"2026-05-22T23:30:44.997225Z","caller":"traceutil/trace.go:171","msg":"trace[98775902] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-2h4nt; range_end:; response_count:1; response_revision:4589; }","duration":"103.455319ms","start":"2026-05-22T23:30:44.89376Z","end":"2026-05-22T23:30:44.997216Z","steps":["trace[98775902] 'agreement among raft nodes before linearized reading' (duration: 103.287531ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:30:45.041728Z","caller":"traceutil/trace.go:171","msg":"trace[79002212] transaction","detail":"{read_only:false; response_revision:4590; number_of_response:1; }","duration":"145.625879ms","start":"2026-05-22T23:30:44.896072Z","end":"2026-05-22T23:30:45.041698Z","steps":["trace[79002212] 'process raft request' (duration: 145.429867ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:30:50.434279Z","caller":"traceutil/trace.go:171","msg":"trace[699979233] transaction","detail":"{read_only:false; response_revision:4728; number_of_response:1; }","duration":"333.592659ms","start":"2026-05-22T23:30:50.100621Z","end":"2026-05-22T23:30:50.434213Z","steps":["trace[699979233] 'process raft request' (duration: 302.578168ms)","trace[699979233] 'compare' (duration: 30.661683ms)"],"step_count":2} {"level":"warn","ts":"2026-05-22T23:30:50.434547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T23:30:50.100608Z","time spent":"333.780739ms","remote":"127.0.0.1:56440","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7567,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-22T23:30:50.610443Z","caller":"traceutil/trace.go:171","msg":"trace[1337882315] transaction","detail":"{read_only:false; response_revision:4729; number_of_response:1; }","duration":"162.508206ms","start":"2026-05-22T23:30:50.447909Z","end":"2026-05-22T23:30:50.610417Z","steps":["trace[1337882315] 'process raft request' (duration: 92.659161ms)","trace[1337882315] 'compare' (duration: 69.570957ms)"],"step_count":2} {"level":"warn","ts":"2026-05-22T23:30:51.152988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.251491ms","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-05-22T23:30:51.153073Z","caller":"traceutil/trace.go:171","msg":"trace[1918011613] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:4730; }","duration":"158.442322ms","start":"2026-05-22T23:30:50.994611Z","end":"2026-05-22T23:30:51.153053Z","steps":["trace[1918011613] 'count revisions from in-memory index tree' (duration: 158.04369ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:30:51.153422Z","caller":"traceutil/trace.go:171","msg":"trace[788554897] linearizableReadLoop","detail":"{readStateIndex:4907; appliedIndex:4906; }","duration":"122.446069ms","start":"2026-05-22T23:30:51.030953Z","end":"2026-05-22T23:30:51.153399Z","steps":["trace[788554897] 'read index received' (duration: 122.285593ms)","trace[788554897] 'applied index is now lower than readState.Index' (duration: 159.496µs)"],"step_count":2} {"level":"warn","ts":"2026-05-22T23:30:51.153423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.342839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:16233"} {"level":"info","ts":"2026-05-22T23:30:51.153514Z","caller":"traceutil/trace.go:171","msg":"trace[415931517] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4730; }","duration":"196.511366ms","start":"2026-05-22T23:30:50.956987Z","end":"2026-05-22T23:30:51.153499Z","steps":["trace[415931517] 'range keys from in-memory index tree' (duration: 196.051197ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:30:51.153519Z","caller":"traceutil/trace.go:171","msg":"trace[228249238] transaction","detail":"{read_only:false; response_revision:4731; number_of_response:1; }","duration":"139.059323ms","start":"2026-05-22T23:30:51.014439Z","end":"2026-05-22T23:30:51.153499Z","steps":["trace[228249238] 'process raft request' (duration: 138.806327ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T23:30:51.153924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.994598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-05-22T23:30:51.153986Z","caller":"traceutil/trace.go:171","msg":"trace[1838314784] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4731; }","duration":"123.075145ms","start":"2026-05-22T23:30:51.030895Z","end":"2026-05-22T23:30:51.15397Z","steps":["trace[1838314784] 'agreement among raft nodes before linearized reading' (duration: 122.958792ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T23:30:51.153825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.171297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-bcbb987f4-dst6m.18b207231061426f\" ","response":"range_response_count:1 size:895"} {"level":"info","ts":"2026-05-22T23:30:51.154066Z","caller":"traceutil/trace.go:171","msg":"trace[121560118] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana-bcbb987f4-dst6m.18b207231061426f; range_end:; response_count:1; response_revision:4730; }","duration":"192.593261ms","start":"2026-05-22T23:30:50.961454Z","end":"2026-05-22T23:30:51.154047Z","steps":["trace[121560118] 'range keys from in-memory index tree' (duration: 191.696688ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:30:51.227743Z","caller":"traceutil/trace.go:171","msg":"trace[354852077] transaction","detail":"{read_only:false; response_revision:4732; number_of_response:1; }","duration":"171.806306ms","start":"2026-05-22T23:30:51.055904Z","end":"2026-05-22T23:30:51.22771Z","steps":["trace[354852077] 'process raft request' (duration: 171.547999ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:30:51.227774Z","caller":"traceutil/trace.go:171","msg":"trace[585078542] transaction","detail":"{read_only:false; response_revision:4733; number_of_response:1; }","duration":"170.827593ms","start":"2026-05-22T23:30:51.056921Z","end":"2026-05-22T23:30:51.227748Z","steps":["trace[585078542] 'process raft request' (duration: 170.712532ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:30:51.227988Z","caller":"traceutil/trace.go:171","msg":"trace[1164405759] transaction","detail":"{read_only:false; response_revision:4734; number_of_response:1; }","duration":"169.85161ms","start":"2026-05-22T23:30:51.058126Z","end":"2026-05-22T23:30:51.227978Z","steps":["trace[1164405759] 'process raft request' (duration: 169.56358ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:30:51.22815Z","caller":"traceutil/trace.go:171","msg":"trace[505789132] transaction","detail":"{read_only:false; response_revision:4735; number_of_response:1; }","duration":"169.910197ms","start":"2026-05-22T23:30:51.058231Z","end":"2026-05-22T23:30:51.228141Z","steps":["trace[505789132] 'process raft request' (duration: 169.707905ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:30:51.319209Z","caller":"traceutil/trace.go:171","msg":"trace[2141557816] transaction","detail":"{read_only:false; response_revision:4736; number_of_response:1; }","duration":"162.447944ms","start":"2026-05-22T23:30:51.156737Z","end":"2026-05-22T23:30:51.319185Z","steps":["trace[2141557816] 'process raft request' (duration: 101.825257ms)","trace[2141557816] 'compare' (duration: 60.451038ms)"],"step_count":2} {"level":"info","ts":"2026-05-22T23:30:51.319214Z","caller":"traceutil/trace.go:171","msg":"trace[544513897] linearizableReadLoop","detail":"{readStateIndex:4912; appliedIndex:4907; }","duration":"162.256394ms","start":"2026-05-22T23:30:51.156939Z","end":"2026-05-22T23:30:51.319195Z","steps":["trace[544513897] 'read index received' (duration: 70.47979ms)","trace[544513897] 'applied index is now lower than readState.Index' (duration: 91.775884ms)"],"step_count":2} {"level":"warn","ts":"2026-05-22T23:30:51.31953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.575958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-bba53a0f-dd01-40ff-9f88-0b71101eb2b6\" ","response":"range_response_count:1 size:1435"} {"level":"info","ts":"2026-05-22T23:30:51.319563Z","caller":"traceutil/trace.go:171","msg":"trace[376479050] range","detail":"{range_begin:/registry/persistentvolumes/pvc-bba53a0f-dd01-40ff-9f88-0b71101eb2b6; range_end:; response_count:1; response_revision:4737; }","duration":"162.634683ms","start":"2026-05-22T23:30:51.15692Z","end":"2026-05-22T23:30:51.319555Z","steps":["trace[376479050] 'agreement among raft nodes before linearized reading' (duration: 162.51178ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T23:30:51.319563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.842648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-22T23:30:51.31962Z","caller":"traceutil/trace.go:171","msg":"trace[686202891] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:4737; }","duration":"142.95468ms","start":"2026-05-22T23:30:51.176655Z","end":"2026-05-22T23:30:51.319609Z","steps":["trace[686202891] 'agreement among raft nodes before linearized reading' (duration: 142.842258ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:30:51.319625Z","caller":"traceutil/trace.go:171","msg":"trace[204540150] transaction","detail":"{read_only:false; response_revision:4737; number_of_response:1; }","duration":"155.184662ms","start":"2026-05-22T23:30:51.164417Z","end":"2026-05-22T23:30:51.319601Z","steps":["trace[204540150] 'process raft request' (duration: 154.727415ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:30:51.430592Z","caller":"traceutil/trace.go:171","msg":"trace[2019289987] linearizableReadLoop","detail":"{readStateIndex:4915; appliedIndex:4913; }","duration":"104.340641ms","start":"2026-05-22T23:30:51.326229Z","end":"2026-05-22T23:30:51.430569Z","steps":["trace[2019289987] 'read index received' (duration: 7.095733ms)","trace[2019289987] 'applied index is now lower than readState.Index' (duration: 97.243918ms)"],"step_count":2} {"level":"info","ts":"2026-05-22T23:30:51.430807Z","caller":"traceutil/trace.go:171","msg":"trace[1967295195] transaction","detail":"{read_only:false; response_revision:4740; number_of_response:1; }","duration":"104.508839ms","start":"2026-05-22T23:30:51.326273Z","end":"2026-05-22T23:30:51.430782Z","steps":["trace[1967295195] 'process raft request' (duration: 104.181264ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:30:51.430901Z","caller":"traceutil/trace.go:171","msg":"trace[2054512289] transaction","detail":"{read_only:false; response_revision:4741; number_of_response:1; }","duration":"101.665481ms","start":"2026-05-22T23:30:51.329222Z","end":"2026-05-22T23:30:51.430888Z","steps":["trace[2054512289] 'process raft request' (duration: 101.281691ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:30:51.431152Z","caller":"traceutil/trace.go:171","msg":"trace[1093933557] transaction","detail":"{read_only:false; response_revision:4739; number_of_response:1; }","duration":"105.09517ms","start":"2026-05-22T23:30:51.326044Z","end":"2026-05-22T23:30:51.431139Z","steps":["trace[1093933557] 'process raft request' (duration: 97.146217ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T23:30:51.431179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.932343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-70c085b0-8f73-4271-9db3-51a30ecba33c\" ","response":"range_response_count:1 size:1450"} {"level":"info","ts":"2026-05-22T23:30:51.431221Z","caller":"traceutil/trace.go:171","msg":"trace[1268799942] range","detail":"{range_begin:/registry/persistentvolumes/pvc-70c085b0-8f73-4271-9db3-51a30ecba33c; range_end:; response_count:1; response_revision:4741; }","duration":"104.99816ms","start":"2026-05-22T23:30:51.326209Z","end":"2026-05-22T23:30:51.431207Z","steps":["trace[1268799942] 'agreement among raft nodes before linearized reading' (duration: 104.859584ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T23:30:51.431646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.605278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-05-22T23:30:51.431679Z","caller":"traceutil/trace.go:171","msg":"trace[826681631] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4743; }","duration":"104.675286ms","start":"2026-05-22T23:30:51.326996Z","end":"2026-05-22T23:30:51.431671Z","steps":["trace[826681631] 'agreement among raft nodes before linearized reading' (duration: 104.553553ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:31:07.546473Z","caller":"traceutil/trace.go:171","msg":"trace[1999243766] transaction","detail":"{read_only:false; response_revision:4931; number_of_response:1; }","duration":"273.037884ms","start":"2026-05-22T23:31:07.273412Z","end":"2026-05-22T23:31:07.54645Z","steps":["trace[1999243766] 'process raft request' (duration: 272.90543ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:31:07.547003Z","caller":"traceutil/trace.go:171","msg":"trace[282678231] transaction","detail":"{read_only:false; response_revision:4932; number_of_response:1; }","duration":"272.627574ms","start":"2026-05-22T23:31:07.27436Z","end":"2026-05-22T23:31:07.546987Z","steps":["trace[282678231] 'process raft request' (duration: 272.025616ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:31:07.547019Z","caller":"traceutil/trace.go:171","msg":"trace[1134507848] linearizableReadLoop","detail":"{readStateIndex:5115; appliedIndex:5112; }","duration":"200.910952ms","start":"2026-05-22T23:31:07.3456Z","end":"2026-05-22T23:31:07.546511Z","steps":["trace[1134507848] 'read index received' (duration: 163.002573ms)","trace[1134507848] 'applied index is now lower than readState.Index' (duration: 37.907228ms)"],"step_count":2} {"level":"info","ts":"2026-05-22T23:31:07.547201Z","caller":"traceutil/trace.go:171","msg":"trace[2072104074] transaction","detail":"{read_only:false; response_revision:4930; number_of_response:1; }","duration":"275.738672ms","start":"2026-05-22T23:31:07.271025Z","end":"2026-05-22T23:31:07.546763Z","steps":["trace[2072104074] 'process raft request' (duration: 237.557678ms)","trace[2072104074] 'compare' (duration: 37.386198ms)"],"step_count":2} {"level":"warn","ts":"2026-05-22T23:31:07.547289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.679115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-22T23:31:07.547559Z","caller":"traceutil/trace.go:171","msg":"trace[385212633] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4932; }","duration":"201.991514ms","start":"2026-05-22T23:31:07.345554Z","end":"2026-05-22T23:31:07.547546Z","steps":["trace[385212633] 'agreement among raft nodes before linearized reading' (duration: 201.643021ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T23:31:08.070694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.9157ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:39"} {"level":"warn","ts":"2026-05-22T23:31:08.070842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T23:31:07.555264Z","time spent":"515.574355ms","remote":"127.0.0.1:44104","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-05-22T23:31:08.071744Z","caller":"traceutil/trace.go:171","msg":"trace[1917392703] transaction","detail":"{read_only:false; response_revision:4933; number_of_response:1; }","duration":"515.84791ms","start":"2026-05-22T23:31:07.55587Z","end":"2026-05-22T23:31:08.071718Z","steps":["trace[1917392703] 'process raft request' (duration: 515.64385ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:31:08.071792Z","caller":"traceutil/trace.go:171","msg":"trace[950795181] transaction","detail":"{read_only:false; response_revision:4934; number_of_response:1; }","duration":"514.557726ms","start":"2026-05-22T23:31:07.557202Z","end":"2026-05-22T23:31:08.071759Z","steps":["trace[950795181] 'process raft request' (duration: 514.450916ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:31:08.071826Z","caller":"traceutil/trace.go:171","msg":"trace[2030416679] transaction","detail":"{read_only:false; response_revision:4937; number_of_response:1; }","duration":"514.426024ms","start":"2026-05-22T23:31:07.557382Z","end":"2026-05-22T23:31:08.071808Z","steps":["trace[2030416679] 'process raft request' (duration: 514.348646ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:31:08.071848Z","caller":"traceutil/trace.go:171","msg":"trace[1592110549] transaction","detail":"{read_only:false; response_revision:4936; number_of_response:1; }","duration":"514.429344ms","start":"2026-05-22T23:31:07.557349Z","end":"2026-05-22T23:31:08.071778Z","steps":["trace[1592110549] 'process raft request' (duration: 514.356147ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T23:31:08.07196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T23:31:07.557196Z","time spent":"514.679757ms","remote":"127.0.0.1:44328","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-22T23:31:08.071997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.639661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-22T23:31:08.072066Z","caller":"traceutil/trace.go:171","msg":"trace[1618371282] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:4937; }","duration":"423.780403ms","start":"2026-05-22T23:31:07.648276Z","end":"2026-05-22T23:31:08.072057Z","steps":["trace[1618371282] 'agreement among raft nodes before linearized reading' (duration: 423.587015ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T23:31:08.072102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T23:31:07.555858Z","time spent":"515.942859ms","remote":"127.0.0.1:44328","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-22T23:31:08.072138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T23:31:07.648246Z","time spent":"423.881573ms","remote":"127.0.0.1:44600","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":40,"response size":29,"request content":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true "} {"level":"warn","ts":"2026-05-22T23:31:08.072022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T23:31:07.557376Z","time spent":"514.534413ms","remote":"127.0.0.1:44328","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-22T23:31:08.072128Z","caller":"traceutil/trace.go:171","msg":"trace[957880935] transaction","detail":"{read_only:false; response_revision:4935; number_of_response:1; }","duration":"514.8123ms","start":"2026-05-22T23:31:07.557292Z","end":"2026-05-22T23:31:08.072104Z","steps":["trace[957880935] 'process raft request' (duration: 514.38871ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T23:31:08.072127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T23:31:07.557337Z","time spent":"514.626442ms","remote":"127.0.0.1:44328","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-22T23:31:08.072247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T23:31:07.557287Z","time spent":"514.899078ms","remote":"127.0.0.1:44328","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-22T23:31:08.071784Z","caller":"traceutil/trace.go:171","msg":"trace[858159212] linearizableReadLoop","detail":"{readStateIndex:5121; appliedIndex:5115; }","duration":"423.443652ms","start":"2026-05-22T23:31:07.64831Z","end":"2026-05-22T23:31:08.071754Z","steps":["trace[858159212] 'read index received' (duration: 252.321045ms)","trace[858159212] 'applied index is now lower than readState.Index' (duration: 171.121827ms)"],"step_count":2} {"level":"warn","ts":"2026-05-22T23:31:08.072503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.294868ms","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-05-22T23:31:08.072547Z","caller":"traceutil/trace.go:171","msg":"trace[1141013424] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:4937; }","duration":"343.366725ms","start":"2026-05-22T23:31:07.729169Z","end":"2026-05-22T23:31:08.072536Z","steps":["trace[1141013424] 'agreement among raft nodes before linearized reading' (duration: 343.253584ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T23:31:08.072579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T23:31:07.729158Z","time spent":"343.412861ms","remote":"127.0.0.1:44242","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":32,"response size":29,"request content":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true "} {"level":"warn","ts":"2026-05-22T23:31:08.073535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.456352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:13878"} {"level":"info","ts":"2026-05-22T23:31:08.073825Z","caller":"traceutil/trace.go:171","msg":"trace[773571618] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4937; }","duration":"398.770033ms","start":"2026-05-22T23:31:07.675038Z","end":"2026-05-22T23:31:08.073808Z","steps":["trace[773571618] 'agreement among raft nodes before linearized reading' (duration: 397.306983ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T23:31:08.073878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T23:31:07.675027Z","time spent":"398.830238ms","remote":"127.0.0.1:44242","response type":"/etcdserverpb.KV/Range","request count":0,"request size":77,"response count":1,"response size":13900,"request content":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" "} {"level":"info","ts":"2026-05-22T23:32:34.562111Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2914} {"level":"info","ts":"2026-05-22T23:32:34.64677Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2914,"took":"82.710487ms","hash":3355368535,"current-db-size-bytes":54255616,"current-db-size":"54 MB","current-db-size-in-use-bytes":29319168,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-05-22T23:32:34.646836Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3355368535,"revision":2914,"compact-revision":-1} {"level":"info","ts":"2026-05-22T23:32:55.152891Z","caller":"traceutil/trace.go:171","msg":"trace[1648350138] linearizableReadLoop","detail":"{readStateIndex:5949; appliedIndex:5947; }","duration":"454.413565ms","start":"2026-05-22T23:32:54.698433Z","end":"2026-05-22T23:32:55.152846Z","steps":["trace[1648350138] 'read index received' (duration: 4.079188ms)","trace[1648350138] 'applied index is now lower than readState.Index' (duration: 450.333467ms)"],"step_count":2} {"level":"info","ts":"2026-05-22T23:32:55.152993Z","caller":"traceutil/trace.go:171","msg":"trace[552124591] transaction","detail":"{read_only:false; response_revision:5741; number_of_response:1; }","duration":"501.266112ms","start":"2026-05-22T23:32:54.651691Z","end":"2026-05-22T23:32:55.152957Z","steps":["trace[552124591] 'process raft request' (duration: 499.435926ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T23:32:55.153059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.175993ms","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-05-22T23:32:55.153083Z","caller":"traceutil/trace.go:171","msg":"trace[575985396] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5741; }","duration":"453.253987ms","start":"2026-05-22T23:32:54.699822Z","end":"2026-05-22T23:32:55.153076Z","steps":["trace[575985396] 'agreement among raft nodes before linearized reading' (duration: 453.151751ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T23:32:55.153106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T23:32:54.699802Z","time spent":"453.299319ms","remote":"127.0.0.1:44328","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-22T23:32:55.153115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.661238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-05-22T23:32:55.153126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.149071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-22T23:32:55.153159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T23:32:54.651681Z","time spent":"501.385578ms","remote":"127.0.0.1:44328","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-22T23:32:55.153199Z","caller":"traceutil/trace.go:171","msg":"trace[281259106] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5741; }","duration":"454.819308ms","start":"2026-05-22T23:32:54.69836Z","end":"2026-05-22T23:32:55.153179Z","steps":["trace[281259106] 'agreement among raft nodes before linearized reading' (duration: 454.591815ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:32:55.153207Z","caller":"traceutil/trace.go:171","msg":"trace[1519660050] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:5741; }","duration":"314.254427ms","start":"2026-05-22T23:32:54.838933Z","end":"2026-05-22T23:32:55.153187Z","steps":["trace[1519660050] 'agreement among raft nodes before linearized reading' (duration: 314.079317ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T23:32:55.153223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.594662ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-05-22T23:32:55.153299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T23:32:54.698337Z","time spent":"454.902142ms","remote":"127.0.0.1:44328","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-22T23:32:55.153323Z","caller":"traceutil/trace.go:171","msg":"trace[1232913886] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5741; }","duration":"450.72771ms","start":"2026-05-22T23:32:54.702581Z","end":"2026-05-22T23:32:55.153308Z","steps":["trace[1232913886] 'agreement among raft nodes before linearized reading' (duration: 450.533139ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T23:32:55.153387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T23:32:54.702568Z","time spent":"450.785193ms","remote":"127.0.0.1:44328","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-05-22T23:32:55.153841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T23:32:54.83888Z","time spent":"314.916885ms","remote":"127.0.0.1:37642","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"info","ts":"2026-05-22T23:37:34.567503Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5611} {"level":"info","ts":"2026-05-22T23:37:34.667574Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5611,"took":"97.96315ms","hash":568790426,"current-db-size-bytes":54255616,"current-db-size":"54 MB","current-db-size-in-use-bytes":18202624,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-05-22T23:37:34.66765Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":568790426,"revision":5611,"compact-revision":2914} {"level":"info","ts":"2026-05-22T23:37:38.835361Z","caller":"traceutil/trace.go:171","msg":"trace[1783106564] transaction","detail":"{read_only:false; response_revision:7455; number_of_response:1; }","duration":"465.034577ms","start":"2026-05-22T23:37:38.370295Z","end":"2026-05-22T23:37:38.83533Z","steps":["trace[1783106564] 'process raft request' (duration: 464.888612ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T23:37:38.83552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T23:37:38.370285Z","time spent":"465.15581ms","remote":"127.0.0.1:44328","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-22T23:37:40.578642Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.743461443s","expected-duration":"1s"} {"level":"warn","ts":"2026-05-22T23:37:40.973979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.975495ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-22T23:37:40.97411Z","caller":"traceutil/trace.go:171","msg":"trace[132206920] linearizableReadLoop","detail":"{readStateIndex:7731; appliedIndex:7729; }","duration":"2.398666775s","start":"2026-05-22T23:37:38.575419Z","end":"2026-05-22T23:37:40.974086Z","steps":["trace[132206920] 'read index received' (duration: 259.659827ms)","trace[132206920] 'applied index is now lower than readState.Index' (duration: 2.139005578s)"],"step_count":2} {"level":"info","ts":"2026-05-22T23:37:40.974939Z","caller":"traceutil/trace.go:171","msg":"trace[1953641843] transaction","detail":"{read_only:false; response_revision:7456; number_of_response:1; }","duration":"2.405452976s","start":"2026-05-22T23:37:38.569434Z","end":"2026-05-22T23:37:40.974887Z","steps":["trace[1953641843] 'process raft request' (duration: 2.009475298s)","trace[1953641843] 'compare' (duration: 394.484789ms)"],"step_count":2} {"level":"warn","ts":"2026-05-22T23:37:40.975112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T23:37:38.569401Z","time spent":"2.40560593s","remote":"127.0.0.1:44328","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-22T23:37:40.975176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.399752179s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-05-22T23:37:40.975206Z","caller":"traceutil/trace.go:171","msg":"trace[800045034] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:7456; }","duration":"2.399820241s","start":"2026-05-22T23:37:38.575378Z","end":"2026-05-22T23:37:40.975198Z","steps":["trace[800045034] 'agreement among raft nodes before linearized reading' (duration: 2.399693077s)"],"step_count":1} {"level":"warn","ts":"2026-05-22T23:37:40.975228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T23:37:38.575364Z","time spent":"2.399858864s","remote":"127.0.0.1:44328","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":552,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "} {"level":"info","ts":"2026-05-22T23:37:40.976123Z","caller":"traceutil/trace.go:171","msg":"trace[1789751353] transaction","detail":"{read_only:false; response_revision:7458; number_of_response:1; }","duration":"2.099511241s","start":"2026-05-22T23:37:38.876581Z","end":"2026-05-22T23:37:40.976092Z","steps":["trace[1789751353] 'process raft request' (duration: 2.099441629s)"],"step_count":1} {"level":"warn","ts":"2026-05-22T23:37:40.976313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T23:37:38.876573Z","time spent":"2.099625115s","remote":"127.0.0.1:44328","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-22T23:37:40.97633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.339180477s","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-05-22T23:37:40.976383Z","caller":"traceutil/trace.go:171","msg":"trace[789459966] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:7459; }","duration":"2.33927539s","start":"2026-05-22T23:37:38.637095Z","end":"2026-05-22T23:37:40.976371Z","steps":["trace[789459966] 'agreement among raft nodes before linearized reading' (duration: 2.339118855s)"],"step_count":1} {"level":"warn","ts":"2026-05-22T23:37:40.976421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T23:37:38.637079Z","time spent":"2.339334172s","remote":"127.0.0.1:44328","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-22T23:37:40.976532Z","caller":"traceutil/trace.go:171","msg":"trace[1662957733] transaction","detail":"{read_only:false; response_revision:7459; number_of_response:1; }","duration":"2.099838002s","start":"2026-05-22T23:37:38.876686Z","end":"2026-05-22T23:37:40.976524Z","steps":["trace[1662957733] 'process raft request' (duration: 2.099371917s)"],"step_count":1} {"level":"warn","ts":"2026-05-22T23:37:40.9766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T23:37:38.876665Z","time spent":"2.099891883s","remote":"127.0.0.1:44328","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-22T23:37:40.976723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.609321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-22T23:37:40.976754Z","caller":"traceutil/trace.go:171","msg":"trace[755670530] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:7459; }","duration":"286.678454ms","start":"2026-05-22T23:37:40.690067Z","end":"2026-05-22T23:37:40.976745Z","steps":["trace[755670530] 'agreement among raft nodes before linearized reading' (duration: 286.630371ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:37:40.976833Z","caller":"traceutil/trace.go:171","msg":"trace[1568594908] transaction","detail":"{read_only:false; response_revision:7457; number_of_response:1; }","duration":"2.101410453s","start":"2026-05-22T23:37:38.875211Z","end":"2026-05-22T23:37:40.976622Z","steps":["trace[1568594908] 'process raft request' (duration: 2.100680929s)"],"step_count":1} {"level":"warn","ts":"2026-05-22T23:37:40.976919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"836.270818ms","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-05-22T23:37:40.97694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T23:37:38.875187Z","time spent":"2.101681931s","remote":"127.0.0.1:44328","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-22T23:37:40.976954Z","caller":"traceutil/trace.go:171","msg":"trace[913642475] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7459; }","duration":"836.363661ms","start":"2026-05-22T23:37:40.140583Z","end":"2026-05-22T23:37:40.976947Z","steps":["trace[913642475] 'agreement among raft nodes before linearized reading' (duration: 836.279848ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T23:37:40.97698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T23:37:40.140566Z","time spent":"836.408342ms","remote":"127.0.0.1:44328","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-22T23:37:40.977086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.316939712s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-05-22T23:37:40.977109Z","caller":"traceutil/trace.go:171","msg":"trace[646506847] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7459; }","duration":"2.316987564s","start":"2026-05-22T23:37:38.660115Z","end":"2026-05-22T23:37:40.977103Z","steps":["trace[646506847] 'agreement among raft nodes before linearized reading' (duration: 2.316922702s)"],"step_count":1} {"level":"warn","ts":"2026-05-22T23:37:40.977129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T23:37:38.660103Z","time spent":"2.317020474s","remote":"127.0.0.1:44328","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-05-22T23:37:40.977216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.332116997s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-05-22T23:37:40.9772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.314130151s","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-05-22T23:37:40.977243Z","caller":"traceutil/trace.go:171","msg":"trace[1797731280] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7459; }","duration":"2.332184169s","start":"2026-05-22T23:37:38.645053Z","end":"2026-05-22T23:37:40.977237Z","steps":["trace[1797731280] 'agreement among raft nodes before linearized reading' (duration: 2.332120447s)"],"step_count":1} {"level":"warn","ts":"2026-05-22T23:37:40.97722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.631438083s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-22T23:37:40.977264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T23:37:38.645033Z","time spent":"2.332226551s","remote":"127.0.0.1:44328","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-22T23:37:40.977245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.425550482s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-22T23:37:40.977272Z","caller":"traceutil/trace.go:171","msg":"trace[139463323] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:7459; }","duration":"2.314249114s","start":"2026-05-22T23:37:38.663004Z","end":"2026-05-22T23:37:40.977253Z","steps":["trace[139463323] 'agreement among raft nodes before linearized reading' (duration: 2.313965946s)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:37:40.977283Z","caller":"traceutil/trace.go:171","msg":"trace[1876289321] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:7459; }","duration":"1.631535597s","start":"2026-05-22T23:37:39.345735Z","end":"2026-05-22T23:37:40.97727Z","steps":["trace[1876289321] 'agreement among raft nodes before linearized reading' (duration: 1.631449714s)"],"step_count":1} {"level":"warn","ts":"2026-05-22T23:37:40.977318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T23:37:38.662982Z","time spent":"2.314327657s","remote":"127.0.0.1:44328","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-22T23:37:40.977309Z","caller":"traceutil/trace.go:171","msg":"trace[1554166360] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:7459; }","duration":"1.425663166s","start":"2026-05-22T23:37:39.551629Z","end":"2026-05-22T23:37:40.977292Z","steps":["trace[1554166360] 'agreement among raft nodes before linearized reading' (duration: 1.425516651s)"],"step_count":1} {"level":"warn","ts":"2026-05-22T23:37:40.977319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T23:37:39.345717Z","time spent":"1.631594628s","remote":"127.0.0.1:44082","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-22T23:37:40.97748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.105193106s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/passwords/\" range_end:\"/registry/secretgen.k14s.io/passwords0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-22T23:37:40.977475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T23:37:39.551604Z","time spent":"1.42580478s","remote":"127.0.0.1:44244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":40,"response size":29,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true "} {"level":"warn","ts":"2026-05-22T23:37:40.977765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.016741687s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-22T23:37:40.9778Z","caller":"traceutil/trace.go:171","msg":"trace[1376754991] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:7459; }","duration":"1.0168192s","start":"2026-05-22T23:37:39.960971Z","end":"2026-05-22T23:37:40.97779Z","steps":["trace[1376754991] 'agreement among raft nodes before linearized reading' (duration: 1.016155538s)"],"step_count":1} {"level":"warn","ts":"2026-05-22T23:37:40.977822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T23:37:39.96095Z","time spent":"1.016866471s","remote":"127.0.0.1:44302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":27,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"info","ts":"2026-05-22T23:37:40.97792Z","caller":"traceutil/trace.go:171","msg":"trace[2009579216] range","detail":"{range_begin:/registry/secretgen.k14s.io/passwords/; range_end:/registry/secretgen.k14s.io/passwords0; response_count:0; response_revision:7459; }","duration":"1.105637912s","start":"2026-05-22T23:37:39.871895Z","end":"2026-05-22T23:37:40.977533Z","steps":["trace[2009579216] 'agreement among raft nodes before linearized reading' (duration: 1.105186557s)"],"step_count":1} {"level":"warn","ts":"2026-05-22T23:37:40.978055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T23:37:39.871868Z","time spent":"1.106162418s","remote":"127.0.0.1:39828","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":5,"response size":29,"request content":"key:\"/registry/secretgen.k14s.io/passwords/\" range_end:\"/registry/secretgen.k14s.io/passwords0\" count_only:true "} {"level":"warn","ts":"2026-05-22T23:39:03.735137Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.079467116s","expected-duration":"1s"} {"level":"info","ts":"2026-05-22T23:39:03.737598Z","caller":"traceutil/trace.go:171","msg":"trace[1201493913] transaction","detail":"{read_only:false; response_revision:7871; number_of_response:1; }","duration":"465.705425ms","start":"2026-05-22T23:39:03.271875Z","end":"2026-05-22T23:39:03.73758Z","steps":["trace[1201493913] 'process raft request' (duration: 465.54673ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T23:39:03.737692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T23:39:03.27186Z","time spent":"465.774164ms","remote":"127.0.0.1:44328","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-22T23:39:03.737884Z","caller":"traceutil/trace.go:171","msg":"trace[788731256] transaction","detail":"{read_only:false; response_revision:7872; number_of_response:1; }","duration":"465.059623ms","start":"2026-05-22T23:39:03.272807Z","end":"2026-05-22T23:39:03.737866Z","steps":["trace[788731256] 'process raft request' (duration: 464.733633ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:39:03.737913Z","caller":"traceutil/trace.go:171","msg":"trace[101801292] linearizableReadLoop","detail":"{readStateIndex:8163; appliedIndex:8161; }","duration":"465.15684ms","start":"2026-05-22T23:39:03.272728Z","end":"2026-05-22T23:39:03.737884Z","steps":["trace[101801292] 'read index received' (duration: 462.761768ms)","trace[101801292] 'applied index is now lower than readState.Index' (duration: 2.393882ms)"],"step_count":2} {"level":"warn","ts":"2026-05-22T23:39:03.73804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T23:39:03.272793Z","time spent":"465.172661ms","remote":"127.0.0.1:44328","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-22T23:39:03.738322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.140154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-05-22T23:39:03.738315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.114136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-05-22T23:39:03.738347Z","caller":"traceutil/trace.go:171","msg":"trace[1447732004] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:7874; }","duration":"404.187673ms","start":"2026-05-22T23:39:03.334152Z","end":"2026-05-22T23:39:03.73834Z","steps":["trace[1447732004] 'agreement among raft nodes before linearized reading' (duration: 404.136584ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T23:39:03.738366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T23:39:03.334138Z","time spent":"404.224331ms","remote":"127.0.0.1:44328","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-22T23:39:03.738362Z","caller":"traceutil/trace.go:171","msg":"trace[1919258833] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7874; }","duration":"384.213994ms","start":"2026-05-22T23:39:03.354135Z","end":"2026-05-22T23:39:03.738349Z","steps":["trace[1919258833] 'agreement among raft nodes before linearized reading' (duration: 384.045949ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:39:03.738061Z","caller":"traceutil/trace.go:171","msg":"trace[369055563] transaction","detail":"{read_only:false; response_revision:7873; number_of_response:1; }","duration":"465.188811ms","start":"2026-05-22T23:39:03.272858Z","end":"2026-05-22T23:39:03.738047Z","steps":["trace[369055563] 'process raft request' (duration: 464.863409ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T23:39:03.738533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.794933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-22T23:39:03.738577Z","caller":"traceutil/trace.go:171","msg":"trace[2006070131] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:7874; }","duration":"465.86786ms","start":"2026-05-22T23:39:03.272698Z","end":"2026-05-22T23:39:03.738566Z","steps":["trace[2006070131] 'agreement among raft nodes before linearized reading' (duration: 465.797902ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T23:39:03.738617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T23:39:03.272686Z","time spent":"465.917819ms","remote":"127.0.0.1:56312","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":29,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-05-22T23:39:03.7387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T23:39:03.272854Z","time spent":"465.697216ms","remote":"127.0.0.1:44328","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-22T23:39:03.738807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.69131ms","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-05-22T23:39:03.738833Z","caller":"traceutil/trace.go:171","msg":"trace[370494262] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:7874; }","duration":"197.74222ms","start":"2026-05-22T23:39:03.541084Z","end":"2026-05-22T23:39:03.738827Z","steps":["trace[370494262] 'agreement among raft nodes before linearized reading' (duration: 197.674932ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T23:39:03.738544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.964113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-05-22T23:39:03.738884Z","caller":"traceutil/trace.go:171","msg":"trace[998739399] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7874; }","duration":"406.324283ms","start":"2026-05-22T23:39:03.332547Z","end":"2026-05-22T23:39:03.738871Z","steps":["trace[998739399] 'agreement among raft nodes before linearized reading' (duration: 405.950853ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T23:39:03.738936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T23:39:03.332535Z","time spent":"406.387062ms","remote":"127.0.0.1:44328","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-22T23:39:03.738746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.509476ms","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-05-22T23:39:03.738997Z","caller":"traceutil/trace.go:171","msg":"trace[1100545902] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7874; }","duration":"384.784538ms","start":"2026-05-22T23:39:03.354205Z","end":"2026-05-22T23:39:03.73899Z","steps":["trace[1100545902] 'agreement among raft nodes before linearized reading' (duration: 384.499516ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T23:39:03.739018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T23:39:03.354192Z","time spent":"384.819527ms","remote":"127.0.0.1:44328","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-22T23:39:03.73814Z","caller":"traceutil/trace.go:171","msg":"trace[423379405] transaction","detail":"{read_only:false; response_revision:7874; number_of_response:1; }","duration":"465.266188ms","start":"2026-05-22T23:39:03.272863Z","end":"2026-05-22T23:39:03.738129Z","steps":["trace[423379405] 'process raft request' (duration: 464.968896ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T23:39:03.738181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.070359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-22T23:39:03.73909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T23:39:03.272854Z","time spent":"466.214961ms","remote":"127.0.0.1:44328","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-22T23:39:03.738259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.585946ms","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-05-22T23:39:03.739116Z","caller":"traceutil/trace.go:171","msg":"trace[312864821] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:7874; }","duration":"417.037182ms","start":"2026-05-22T23:39:03.322063Z","end":"2026-05-22T23:39:03.7391Z","steps":["trace[312864821] 'agreement among raft nodes before linearized reading' (duration: 416.089609ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T23:39:03.739135Z","caller":"traceutil/trace.go:171","msg":"trace[1979930351] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:7874; }","duration":"387.494911ms","start":"2026-05-22T23:39:03.351634Z","end":"2026-05-22T23:39:03.739129Z","steps":["trace[1979930351] 'agreement among raft nodes before linearized reading' (duration: 386.566807ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T23:39:03.739152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T23:39:03.351617Z","time spent":"387.53071ms","remote":"127.0.0.1:44328","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-22T23:39:03.739167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T23:39:03.322046Z","time spent":"417.10364ms","remote":"127.0.0.1:56302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":29,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-05-22T23:39:03.738281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.148943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-22T23:39:03.739198Z","caller":"traceutil/trace.go:171","msg":"trace[40980515] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:7874; }","duration":"394.085447ms","start":"2026-05-22T23:39:03.345107Z","end":"2026-05-22T23:39:03.739192Z","steps":["trace[40980515] 'agreement among raft nodes before linearized reading' (duration: 393.162063ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T23:39:03.739234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T23:39:03.345096Z","time spent":"394.118135ms","remote":"127.0.0.1:44082","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-22T23:39:03.738471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T23:39:03.354128Z","time spent":"384.265692ms","remote":"127.0.0.1:44328","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":"info","ts":"2026-05-22T23:42:34.574381Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7433} {"level":"info","ts":"2026-05-22T23:42:34.626497Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7433,"took":"50.925016ms","hash":2697826740,"current-db-size-bytes":54255616,"current-db-size":"54 MB","current-db-size-in-use-bytes":14848000,"current-db-size-in-use":"15 MB"} {"level":"info","ts":"2026-05-22T23:42:34.626569Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2697826740,"revision":7433,"compact-revision":5611}