{"level":"warn","ts":"2026-04-23T14:41:44.950945Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-23T14:41:44.951076Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.223:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.223:2380","--initial-cluster=instance=https://199.204.45.223:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.223:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.223:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-23T14:41:44.951165Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-23T14:41:44.951179Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.223:2380"]} {"level":"info","ts":"2026-04-23T14:41:44.951201Z","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-04-23T14:41:44.952801Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.223:2379"]} {"level":"info","ts":"2026-04-23T14:41:44.952947Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.223:2380"],"listen-peer-urls":["https://199.204.45.223:2380"],"advertise-client-urls":["https://199.204.45.223:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.223:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.223:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-23T14:41:44.957782Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.467998ms"} {"level":"info","ts":"2026-04-23T14:41:44.967302Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"11f26225a5bb9fe3","cluster-id":"75c25101f01fd4c6"} {"level":"info","ts":"2026-04-23T14:41:44.967476Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 switched to configuration voters=()"} {"level":"info","ts":"2026-04-23T14:41:44.967561Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became follower at term 0"} {"level":"info","ts":"2026-04-23T14:41:44.967586Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 11f26225a5bb9fe3 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-23T14:41:44.967597Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became follower at term 1"} {"level":"info","ts":"2026-04-23T14:41:44.967694Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 switched to configuration voters=(1293203956842602467)"} {"level":"warn","ts":"2026-04-23T14:41:44.974341Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-23T14:41:44.976826Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-23T14:41:44.978525Z","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-04-23T14:41:44.981352Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"11f26225a5bb9fe3","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-23T14:41:44.982303Z","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-04-23T14:41:44.982411Z","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-04-23T14:41:44.982423Z","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-04-23T14:41:44.982528Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"11f26225a5bb9fe3","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-23T14:41:44.983456Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 switched to configuration voters=(1293203956842602467)"} {"level":"info","ts":"2026-04-23T14:41:44.983635Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"75c25101f01fd4c6","local-member-id":"11f26225a5bb9fe3","added-peer-id":"11f26225a5bb9fe3","added-peer-peer-urls":["https://199.204.45.223:2380"]} {"level":"info","ts":"2026-04-23T14:41:44.986312Z","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-04-23T14:41:44.986424Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.223:2380"} {"level":"info","ts":"2026-04-23T14:41:44.986472Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.223:2380"} {"level":"info","ts":"2026-04-23T14:41:44.986569Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"11f26225a5bb9fe3","initial-advertise-peer-urls":["https://199.204.45.223:2380"],"listen-peer-urls":["https://199.204.45.223:2380"],"advertise-client-urls":["https://199.204.45.223:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.223:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-23T14:41:44.986615Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-23T14:41:45.668269Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 is starting a new election at term 1"} {"level":"info","ts":"2026-04-23T14:41:45.668336Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-23T14:41:45.668364Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 received MsgPreVoteResp from 11f26225a5bb9fe3 at term 1"} {"level":"info","ts":"2026-04-23T14:41:45.668382Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became candidate at term 2"} {"level":"info","ts":"2026-04-23T14:41:45.668439Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 received MsgVoteResp from 11f26225a5bb9fe3 at term 2"} {"level":"info","ts":"2026-04-23T14:41:45.668458Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became leader at term 2"} {"level":"info","ts":"2026-04-23T14:41:45.668472Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 11f26225a5bb9fe3 elected leader 11f26225a5bb9fe3 at term 2"} {"level":"info","ts":"2026-04-23T14:41:45.712381Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-23T14:41:45.712364Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"11f26225a5bb9fe3","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.223:2379]}","request-path":"/0/members/11f26225a5bb9fe3/attributes","cluster-id":"75c25101f01fd4c6","publish-timeout":"7s"} {"level":"info","ts":"2026-04-23T14:41:45.712517Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-23T14:41:45.712547Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-23T14:41:45.712881Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-23T14:41:45.712956Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-23T14:41:45.714797Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-23T14:41:45.716555Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.223:2379"} {"level":"info","ts":"2026-04-23T14:41:45.732544Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"75c25101f01fd4c6","local-member-id":"11f26225a5bb9fe3","cluster-version":"3.5"} {"level":"info","ts":"2026-04-23T14:41:45.732727Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-23T14:41:45.732814Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-23T14:42:04.908424Z","caller":"traceutil/trace.go:171","msg":"trace[198480035] transaction","detail":"{read_only:false; response_revision:419; number_of_response:1; }","duration":"171.954233ms","start":"2026-04-23T14:42:04.736446Z","end":"2026-04-23T14:42:04.908401Z","steps":["trace[198480035] 'process raft request' (duration: 171.804815ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T14:42:19.464299Z","caller":"traceutil/trace.go:171","msg":"trace[2088862550] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"193.975865ms","start":"2026-04-23T14:42:19.2703Z","end":"2026-04-23T14:42:19.464276Z","steps":["trace[2088862550] 'process raft request' (duration: 193.809876ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T14:42:19.47344Z","caller":"traceutil/trace.go:171","msg":"trace[637011682] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"193.88439ms","start":"2026-04-23T14:42:19.279543Z","end":"2026-04-23T14:42:19.473427Z","steps":["trace[637011682] 'process raft request' (duration: 193.758563ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T14:42:19.473445Z","caller":"traceutil/trace.go:171","msg":"trace[382912939] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"200.36682ms","start":"2026-04-23T14:42:19.273023Z","end":"2026-04-23T14:42:19.47339Z","steps":["trace[382912939] 'process raft request' (duration: 200.182709ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T14:42:19.473536Z","caller":"traceutil/trace.go:171","msg":"trace[1166777046] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"165.123864ms","start":"2026-04-23T14:42:19.308403Z","end":"2026-04-23T14:42:19.473527Z","steps":["trace[1166777046] 'process raft request' (duration: 165.024799ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T14:42:19.473537Z","caller":"traceutil/trace.go:171","msg":"trace[1951625972] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"173.036473ms","start":"2026-04-23T14:42:19.300464Z","end":"2026-04-23T14:42:19.4735Z","steps":["trace[1951625972] 'process raft request' (duration: 172.882264ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T14:42:19.473654Z","caller":"traceutil/trace.go:171","msg":"trace[1084743367] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"147.632443ms","start":"2026-04-23T14:42:19.326015Z","end":"2026-04-23T14:42:19.473647Z","steps":["trace[1084743367] 'process raft request' (duration: 147.535707ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T14:42:19.473642Z","caller":"traceutil/trace.go:171","msg":"trace[382198032] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"157.159622ms","start":"2026-04-23T14:42:19.316464Z","end":"2026-04-23T14:42:19.473623Z","steps":["trace[382198032] 'process raft request' (duration: 157.049506ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T14:42:19.473619Z","caller":"traceutil/trace.go:171","msg":"trace[287009790] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"163.541086ms","start":"2026-04-23T14:42:19.310072Z","end":"2026-04-23T14:42:19.473613Z","steps":["trace[287009790] 'process raft request' (duration: 163.404008ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T14:42:19.473522Z","caller":"traceutil/trace.go:171","msg":"trace[186773256] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"181.052317ms","start":"2026-04-23T14:42:19.292439Z","end":"2026-04-23T14:42:19.473491Z","steps":["trace[186773256] 'process raft request' (duration: 180.880928ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T14:42:19.473756Z","caller":"traceutil/trace.go:171","msg":"trace[1832520642] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"138.02109ms","start":"2026-04-23T14:42:19.335712Z","end":"2026-04-23T14:42:19.473733Z","steps":["trace[1832520642] 'process raft request' (duration: 137.882332ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T14:42:19.473786Z","caller":"traceutil/trace.go:171","msg":"trace[1146568850] linearizableReadLoop","detail":"{readStateIndex:546; appliedIndex:535; }","duration":"115.231315ms","start":"2026-04-23T14:42:19.358543Z","end":"2026-04-23T14:42:19.473775Z","steps":["trace[1146568850] 'read index received' (duration: 105.610291ms)","trace[1146568850] 'applied index is now lower than readState.Index' (duration: 9.620294ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T14:42:19.473782Z","caller":"traceutil/trace.go:171","msg":"trace[130167729] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"127.996583ms","start":"2026-04-23T14:42:19.345778Z","end":"2026-04-23T14:42:19.473775Z","steps":["trace[130167729] 'process raft request' (duration: 127.857195ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T14:42:19.473942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.360402ms","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-04-23T14:42:19.473989Z","caller":"traceutil/trace.go:171","msg":"trace[700019987] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:528; }","duration":"115.472748ms","start":"2026-04-23T14:42:19.358508Z","end":"2026-04-23T14:42:19.473981Z","steps":["trace[700019987] 'agreement among raft nodes before linearized reading' (duration: 115.3171ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T14:42:25.54314Z","caller":"traceutil/trace.go:171","msg":"trace[45695715] linearizableReadLoop","detail":"{readStateIndex:646; appliedIndex:645; }","duration":"123.136503ms","start":"2026-04-23T14:42:25.41998Z","end":"2026-04-23T14:42:25.543117Z","steps":["trace[45695715] 'read index received' (duration: 122.345181ms)","trace[45695715] 'applied index is now lower than readState.Index' (duration: 790.392µs)"],"step_count":2} {"level":"info","ts":"2026-04-23T14:42:25.543263Z","caller":"traceutil/trace.go:171","msg":"trace[2078579073] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"134.738637ms","start":"2026-04-23T14:42:25.408515Z","end":"2026-04-23T14:42:25.543253Z","steps":["trace[2078579073] 'process raft request' (duration: 134.097227ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T14:42:25.543448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.433367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T14:42:25.543547Z","caller":"traceutil/trace.go:171","msg":"trace[1537049118] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:622; }","duration":"123.57746ms","start":"2026-04-23T14:42:25.419951Z","end":"2026-04-23T14:42:25.543528Z","steps":["trace[1537049118] 'agreement among raft nodes before linearized reading' (duration: 123.411301ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T14:42:25.54341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.355442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T14:42:25.543768Z","caller":"traceutil/trace.go:171","msg":"trace[1263735528] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:622; }","duration":"123.775544ms","start":"2026-04-23T14:42:25.419986Z","end":"2026-04-23T14:42:25.543762Z","steps":["trace[1263735528] 'agreement among raft nodes before linearized reading' (duration: 123.309081ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T14:42:25.543934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.183615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T14:42:25.543997Z","caller":"traceutil/trace.go:171","msg":"trace[427702270] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:622; }","duration":"123.273178ms","start":"2026-04-23T14:42:25.420706Z","end":"2026-04-23T14:42:25.543979Z","steps":["trace[427702270] 'agreement among raft nodes before linearized reading' (duration: 123.174826ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T14:42:25.668714Z","caller":"traceutil/trace.go:171","msg":"trace[482353127] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"118.592501ms","start":"2026-04-23T14:42:25.550103Z","end":"2026-04-23T14:42:25.668696Z","steps":["trace[482353127] 'process raft request' (duration: 118.432951ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T14:42:25.790357Z","caller":"traceutil/trace.go:171","msg":"trace[1576658380] linearizableReadLoop","detail":"{readStateIndex:649; appliedIndex:646; }","duration":"168.20142ms","start":"2026-04-23T14:42:25.62212Z","end":"2026-04-23T14:42:25.790321Z","steps":["trace[1576658380] 'read index received' (duration: 46.383601ms)","trace[1576658380] 'applied index is now lower than readState.Index' (duration: 121.817339ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T14:42:25.790504Z","caller":"traceutil/trace.go:171","msg":"trace[9082302] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"233.299797ms","start":"2026-04-23T14:42:25.557198Z","end":"2026-04-23T14:42:25.790497Z","steps":["trace[9082302] 'process raft request' (duration: 191.877731ms)","trace[9082302] 'compare' (duration: 41.110744ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T14:42:25.790635Z","caller":"traceutil/trace.go:171","msg":"trace[2060914891] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"182.108045ms","start":"2026-04-23T14:42:25.608521Z","end":"2026-04-23T14:42:25.790629Z","steps":["trace[2060914891] 'process raft request' (duration: 181.771427ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T14:42:25.790717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.591679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T14:42:25.790756Z","caller":"traceutil/trace.go:171","msg":"trace[29393745] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:625; }","duration":"168.685141ms","start":"2026-04-23T14:42:25.622065Z","end":"2026-04-23T14:42:25.79075Z","steps":["trace[29393745] 'agreement among raft nodes before linearized reading' (duration: 168.621993ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T14:42:25.790842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.652867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T14:42:25.790861Z","caller":"traceutil/trace.go:171","msg":"trace[1117902218] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:625; }","duration":"168.673673ms","start":"2026-04-23T14:42:25.622182Z","end":"2026-04-23T14:42:25.790856Z","steps":["trace[1117902218] 'agreement among raft nodes before linearized reading' (duration: 168.646998ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T14:42:25.791006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.881871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-lfqzv\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-23T14:42:25.791025Z","caller":"traceutil/trace.go:171","msg":"trace[1056283547] range","detail":"{range_begin:/registry/pods/kube-system/cilium-lfqzv; range_end:; response_count:1; response_revision:625; }","duration":"131.942299ms","start":"2026-04-23T14:42:25.659078Z","end":"2026-04-23T14:42:25.791021Z","steps":["trace[1056283547] 'agreement among raft nodes before linearized reading' (duration: 131.875352ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T14:42:26.167286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.756901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T14:42:26.167385Z","caller":"traceutil/trace.go:171","msg":"trace[898932184] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:626; }","duration":"122.906733ms","start":"2026-04-23T14:42:26.044457Z","end":"2026-04-23T14:42:26.167363Z","steps":["trace[898932184] 'range keys from in-memory index tree' (duration: 122.698442ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T14:42:26.167521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.827468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T14:42:26.167664Z","caller":"traceutil/trace.go:171","msg":"trace[1446398069] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:626; }","duration":"122.984008ms","start":"2026-04-23T14:42:26.044637Z","end":"2026-04-23T14:42:26.167621Z","steps":["trace[1446398069] 'count revisions from in-memory index tree' (duration: 122.780256ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T14:42:26.167778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.034903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T14:42:26.167831Z","caller":"traceutil/trace.go:171","msg":"trace[887457932] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:626; }","duration":"191.110278ms","start":"2026-04-23T14:42:25.976704Z","end":"2026-04-23T14:42:26.167814Z","steps":["trace[887457932] 'count revisions from in-memory index tree' (duration: 190.952937ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T14:42:26.167873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.072925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-23T14:42:26.167916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.070592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T14:42:26.168015Z","caller":"traceutil/trace.go:171","msg":"trace[611398117] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:626; }","duration":"123.205317ms","start":"2026-04-23T14:42:26.044772Z","end":"2026-04-23T14:42:26.167977Z","steps":["trace[611398117] 'range keys from in-memory index tree' (duration: 122.945995ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T14:42:26.168073Z","caller":"traceutil/trace.go:171","msg":"trace[580312101] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:626; }","duration":"191.328528ms","start":"2026-04-23T14:42:25.976639Z","end":"2026-04-23T14:42:26.167967Z","steps":["trace[580312101] 'range keys from in-memory index tree' (duration: 191.013946ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T14:42:26.168128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.682822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T14:42:26.16824Z","caller":"traceutil/trace.go:171","msg":"trace[769704294] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:626; }","duration":"179.817307ms","start":"2026-04-23T14:42:25.988387Z","end":"2026-04-23T14:42:26.168204Z","steps":["trace[769704294] 'range keys from in-memory index tree' (duration: 179.629222ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T14:42:26.168441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.883291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T14:42:26.168512Z","caller":"traceutil/trace.go:171","msg":"trace[579221643] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:626; }","duration":"159.952019ms","start":"2026-04-23T14:42:26.008519Z","end":"2026-04-23T14:42:26.168471Z","steps":["trace[579221643] 'count revisions from in-memory index tree' (duration: 159.83597ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T14:42:26.168606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.486645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T14:42:26.168673Z","caller":"traceutil/trace.go:171","msg":"trace[626913446] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:626; }","duration":"220.550124ms","start":"2026-04-23T14:42:25.948109Z","end":"2026-04-23T14:42:26.168659Z","steps":["trace[626913446] 'range keys from in-memory index tree' (duration: 220.370756ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T14:42:26.168756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.025565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T14:42:26.1688Z","caller":"traceutil/trace.go:171","msg":"trace[1159918656] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:626; }","duration":"160.146814ms","start":"2026-04-23T14:42:26.008641Z","end":"2026-04-23T14:42:26.168788Z","steps":["trace[1159918656] 'range keys from in-memory index tree' (duration: 159.896209ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T14:42:26.168992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.769684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T14:42:26.169063Z","caller":"traceutil/trace.go:171","msg":"trace[1367314793] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:626; }","duration":"220.842531ms","start":"2026-04-23T14:42:25.948211Z","end":"2026-04-23T14:42:26.169053Z","steps":["trace[1367314793] 'count revisions from in-memory index tree' (duration: 220.641188ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T14:42:26.169264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.283378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T14:42:26.169334Z","caller":"traceutil/trace.go:171","msg":"trace[1081257146] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:626; }","duration":"218.368343ms","start":"2026-04-23T14:42:25.950942Z","end":"2026-04-23T14:42:26.16931Z","steps":["trace[1081257146] 'range keys from in-memory index tree' (duration: 218.209942ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T14:42:26.171139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.002847ms","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-04-23T14:42:26.171221Z","caller":"traceutil/trace.go:171","msg":"trace[1029158543] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:626; }","duration":"216.129523ms","start":"2026-04-23T14:42:25.955078Z","end":"2026-04-23T14:42:26.171208Z","steps":["trace[1029158543] 'range keys from in-memory index tree' (duration: 214.288835ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T14:42:26.317347Z","caller":"traceutil/trace.go:171","msg":"trace[190869390] linearizableReadLoop","detail":"{readStateIndex:651; appliedIndex:650; }","duration":"126.101442ms","start":"2026-04-23T14:42:26.191216Z","end":"2026-04-23T14:42:26.317317Z","steps":["trace[190869390] 'read index received' (duration: 125.955508ms)","trace[190869390] 'applied index is now lower than readState.Index' (duration: 144.454µs)"],"step_count":2} {"level":"info","ts":"2026-04-23T14:42:26.317491Z","caller":"traceutil/trace.go:171","msg":"trace[1602147092] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"138.223239ms","start":"2026-04-23T14:42:26.179255Z","end":"2026-04-23T14:42:26.317478Z","steps":["trace[1602147092] 'process raft request' (duration: 137.858946ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T14:42:26.317616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.371111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T14:42:26.317723Z","caller":"traceutil/trace.go:171","msg":"trace[1036684471] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:627; }","duration":"126.508757ms","start":"2026-04-23T14:42:26.191173Z","end":"2026-04-23T14:42:26.317682Z","steps":["trace[1036684471] 'agreement among raft nodes before linearized reading' (duration: 126.33461ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T14:42:26.336273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.666707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-23T14:42:26.336334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.07708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T14:42:26.336376Z","caller":"traceutil/trace.go:171","msg":"trace[915611469] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:628; }","duration":"128.795663ms","start":"2026-04-23T14:42:26.207561Z","end":"2026-04-23T14:42:26.336356Z","steps":["trace[915611469] 'agreement among raft nodes before linearized reading' (duration: 128.59421ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T14:42:26.336422Z","caller":"traceutil/trace.go:171","msg":"trace[798970144] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:628; }","duration":"145.196828ms","start":"2026-04-23T14:42:26.191202Z","end":"2026-04-23T14:42:26.336398Z","steps":["trace[798970144] 'agreement among raft nodes before linearized reading' (duration: 145.042417ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T14:42:26.336542Z","caller":"traceutil/trace.go:171","msg":"trace[846344072] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"125.739948ms","start":"2026-04-23T14:42:26.210782Z","end":"2026-04-23T14:42:26.336522Z","steps":["trace[846344072] 'process raft request' (duration: 124.779816ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T14:42:26.336636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.084919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T14:42:26.336732Z","caller":"traceutil/trace.go:171","msg":"trace[1275151698] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:628; }","duration":"129.228073ms","start":"2026-04-23T14:42:26.207484Z","end":"2026-04-23T14:42:26.336712Z","steps":["trace[1275151698] 'agreement among raft nodes before linearized reading' (duration: 129.014113ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T14:42:26.336843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.953923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T14:42:26.33693Z","caller":"traceutil/trace.go:171","msg":"trace[1654133962] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:628; }","duration":"145.061284ms","start":"2026-04-23T14:42:26.191851Z","end":"2026-04-23T14:42:26.336913Z","steps":["trace[1654133962] 'agreement among raft nodes before linearized reading' (duration: 144.933796ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T14:42:26.336873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.234262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T14:42:26.337167Z","caller":"traceutil/trace.go:171","msg":"trace[1557870589] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:628; }","duration":"129.562391ms","start":"2026-04-23T14:42:26.207584Z","end":"2026-04-23T14:42:26.337147Z","steps":["trace[1557870589] 'agreement among raft nodes before linearized reading' (duration: 129.252319ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T14:42:40.728419Z","caller":"traceutil/trace.go:171","msg":"trace[75279805] transaction","detail":"{read_only:false; response_revision:781; number_of_response:1; }","duration":"292.563795ms","start":"2026-04-23T14:42:40.435818Z","end":"2026-04-23T14:42:40.728382Z","steps":["trace[75279805] 'process raft request' (duration: 237.005581ms)","trace[75279805] 'compare' (duration: 55.406269ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T14:43:09.327506Z","caller":"traceutil/trace.go:171","msg":"trace[1849234285] transaction","detail":"{read_only:false; response_revision:1179; number_of_response:1; }","duration":"124.818038ms","start":"2026-04-23T14:43:09.202644Z","end":"2026-04-23T14:43:09.327462Z","steps":["trace[1849234285] 'process raft request' (duration: 124.501308ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T14:43:56.276622Z","caller":"traceutil/trace.go:171","msg":"trace[1945687768] transaction","detail":"{read_only:false; response_revision:1858; number_of_response:1; }","duration":"137.492968ms","start":"2026-04-23T14:43:56.13909Z","end":"2026-04-23T14:43:56.276583Z","steps":["trace[1945687768] 'process raft request' (duration: 124.454713ms)","trace[1945687768] 'compare' (duration: 12.783265ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T14:44:04.621241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.462125ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-23T14:44:04.621333Z","caller":"traceutil/trace.go:171","msg":"trace[1326258980] linearizableReadLoop","detail":"{readStateIndex:2006; appliedIndex:2005; }","duration":"120.706854ms","start":"2026-04-23T14:44:04.500612Z","end":"2026-04-23T14:44:04.621319Z","steps":["trace[1326258980] 'read index received' (duration: 5.722045ms)","trace[1326258980] 'applied index is now lower than readState.Index' (duration: 114.983779ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T14:44:04.621365Z","caller":"traceutil/trace.go:171","msg":"trace[1097281175] transaction","detail":"{read_only:false; response_revision:1934; number_of_response:1; }","duration":"131.088021ms","start":"2026-04-23T14:44:04.49024Z","end":"2026-04-23T14:44:04.621328Z","steps":["trace[1097281175] 'process raft request' (duration: 16.13963ms)","trace[1097281175] 'compare' (duration: 114.355533ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T14:44:04.621672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.017672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-23T14:44:04.6218Z","caller":"traceutil/trace.go:171","msg":"trace[1950073713] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1934; }","duration":"121.211779ms","start":"2026-04-23T14:44:04.500558Z","end":"2026-04-23T14:44:04.62177Z","steps":["trace[1950073713] 'agreement among raft nodes before linearized reading' (duration: 120.808268ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T14:44:08.62745Z","caller":"traceutil/trace.go:171","msg":"trace[1172117168] linearizableReadLoop","detail":"{readStateIndex:2030; appliedIndex:2029; }","duration":"108.599211ms","start":"2026-04-23T14:44:08.518827Z","end":"2026-04-23T14:44:08.627426Z","steps":["trace[1172117168] 'read index received' (duration: 108.357037ms)","trace[1172117168] 'applied index is now lower than readState.Index' (duration: 240.854µs)"],"step_count":2} {"level":"info","ts":"2026-04-23T14:44:08.627559Z","caller":"traceutil/trace.go:171","msg":"trace[1855190651] transaction","detail":"{read_only:false; response_revision:1958; number_of_response:1; }","duration":"125.075227ms","start":"2026-04-23T14:44:08.502458Z","end":"2026-04-23T14:44:08.627533Z","steps":["trace[1855190651] 'process raft request' (duration: 124.802665ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T14:44:08.627631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.76514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T14:44:08.627666Z","caller":"traceutil/trace.go:171","msg":"trace[1833863013] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1958; }","duration":"108.862723ms","start":"2026-04-23T14:44:08.518793Z","end":"2026-04-23T14:44:08.627656Z","steps":["trace[1833863013] 'agreement among raft nodes before linearized reading' (duration: 108.733722ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T14:44:31.117127Z","caller":"traceutil/trace.go:171","msg":"trace[321211870] transaction","detail":"{read_only:false; response_revision:2098; number_of_response:1; }","duration":"108.674625ms","start":"2026-04-23T14:44:31.00842Z","end":"2026-04-23T14:44:31.117095Z","steps":["trace[321211870] 'process raft request' (duration: 108.3904ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T14:44:31.412835Z","caller":"traceutil/trace.go:171","msg":"trace[374831120] transaction","detail":"{read_only:false; response_revision:2100; number_of_response:1; }","duration":"195.29379ms","start":"2026-04-23T14:44:31.2174Z","end":"2026-04-23T14:44:31.412694Z","steps":["trace[374831120] 'process raft request' (duration: 114.95224ms)","trace[374831120] 'compare' (duration: 79.920562ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T14:44:31.918601Z","caller":"traceutil/trace.go:171","msg":"trace[843491774] linearizableReadLoop","detail":"{readStateIndex:2180; appliedIndex:2179; }","duration":"120.683793ms","start":"2026-04-23T14:44:31.797891Z","end":"2026-04-23T14:44:31.918575Z","steps":["trace[843491774] 'read index received' (duration: 120.5562ms)","trace[843491774] 'applied index is now lower than readState.Index' (duration: 126.823µs)"],"step_count":2} {"level":"info","ts":"2026-04-23T14:44:31.918731Z","caller":"traceutil/trace.go:171","msg":"trace[81123577] transaction","detail":"{read_only:false; response_revision:2103; number_of_response:1; }","duration":"182.625317ms","start":"2026-04-23T14:44:31.736073Z","end":"2026-04-23T14:44:31.918699Z","steps":["trace[81123577] 'process raft request' (duration: 182.342421ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T14:44:31.918912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.000236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-23T14:44:31.91899Z","caller":"traceutil/trace.go:171","msg":"trace[1096986217] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2103; }","duration":"121.11724ms","start":"2026-04-23T14:44:31.797852Z","end":"2026-04-23T14:44:31.918969Z","steps":["trace[1096986217] 'agreement among raft nodes before linearized reading' (duration: 120.904112ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T14:44:32.405636Z","caller":"traceutil/trace.go:171","msg":"trace[2076345746] transaction","detail":"{read_only:false; response_revision:2106; number_of_response:1; }","duration":"106.295644ms","start":"2026-04-23T14:44:32.299312Z","end":"2026-04-23T14:44:32.405608Z","steps":["trace[2076345746] 'process raft request' (duration: 106.087254ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T14:46:07.98084Z","caller":"traceutil/trace.go:171","msg":"trace[35145778] transaction","detail":"{read_only:false; response_revision:2727; number_of_response:1; }","duration":"204.788395ms","start":"2026-04-23T14:46:07.776032Z","end":"2026-04-23T14:46:07.980821Z","steps":["trace[35145778] 'process raft request' (duration: 204.668366ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T14:46:07.980896Z","caller":"traceutil/trace.go:171","msg":"trace[1383320368] linearizableReadLoop","detail":"{readStateIndex:2826; appliedIndex:2826; }","duration":"179.87889ms","start":"2026-04-23T14:46:07.800996Z","end":"2026-04-23T14:46:07.980875Z","steps":["trace[1383320368] 'read index received' (duration: 179.85824ms)","trace[1383320368] 'applied index is now lower than readState.Index' (duration: 19.13µs)"],"step_count":2} {"level":"warn","ts":"2026-04-23T14:46:07.981003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.973589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterrestores/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterrestores0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T14:46:07.981059Z","caller":"traceutil/trace.go:171","msg":"trace[1507182236] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterrestores/; range_end:/registry/pxc.percona.com/perconaxtradbclusterrestores0; response_count:0; response_revision:2727; }","duration":"180.098077ms","start":"2026-04-23T14:46:07.800947Z","end":"2026-04-23T14:46:07.981045Z","steps":["trace[1507182236] 'agreement among raft nodes before linearized reading' (duration: 179.987298ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T14:46:08.0364Z","caller":"traceutil/trace.go:171","msg":"trace[963383698] transaction","detail":"{read_only:false; response_revision:2728; number_of_response:1; }","duration":"195.904257ms","start":"2026-04-23T14:46:07.840444Z","end":"2026-04-23T14:46:08.036348Z","steps":["trace[963383698] 'process raft request' (duration: 195.5866ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T14:46:08.036465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.601042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-23T14:46:08.036755Z","caller":"traceutil/trace.go:171","msg":"trace[2070028844] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2728; }","duration":"142.897589ms","start":"2026-04-23T14:46:07.8938Z","end":"2026-04-23T14:46:08.036698Z","steps":["trace[2070028844] 'agreement among raft nodes before linearized reading' (duration: 142.453133ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T14:47:58.790612Z","caller":"traceutil/trace.go:171","msg":"trace[1722318594] transaction","detail":"{read_only:false; response_revision:3391; number_of_response:1; }","duration":"114.709788ms","start":"2026-04-23T14:47:58.675876Z","end":"2026-04-23T14:47:58.790586Z","steps":["trace[1722318594] 'process raft request' (duration: 113.906698ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T14:47:58.790834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.404752ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.223\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-23T14:47:58.791005Z","caller":"traceutil/trace.go:171","msg":"trace[1320014371] range","detail":"{range_begin:/registry/masterleases/199.204.45.223; range_end:; response_count:1; response_revision:3390; }","duration":"134.802748ms","start":"2026-04-23T14:47:58.656176Z","end":"2026-04-23T14:47:58.790978Z","steps":["trace[1320014371] 'range keys from in-memory index tree' (duration: 134.18774ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T14:47:59.902823Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11521225697325229520,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-23T14:48:00.403794Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11521225697325229520,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-23T14:48:00.904213Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11521225697325229520,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-23T14:48:01.333849Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.058281792s","expected-duration":"1s"} {"level":"info","ts":"2026-04-23T14:48:01.334256Z","caller":"traceutil/trace.go:171","msg":"trace[1512580873] transaction","detail":"{read_only:false; response_revision:3394; number_of_response:1; }","duration":"2.058774107s","start":"2026-04-23T14:47:59.275449Z","end":"2026-04-23T14:48:01.334223Z","steps":["trace[1512580873] 'process raft request' (duration: 2.058615005s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T14:48:01.334461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T14:47:59.275425Z","time spent":"2.058923639s","remote":"127.0.0.1:35290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T14:48:01.339293Z","caller":"traceutil/trace.go:171","msg":"trace[2056007674] transaction","detail":"{read_only:false; response_revision:3395; number_of_response:1; }","duration":"1.856491256s","start":"2026-04-23T14:47:59.482781Z","end":"2026-04-23T14:48:01.339272Z","steps":["trace[2056007674] 'process raft request' (duration: 1.856353755s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T14:48:01.339428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T14:47:59.482758Z","time spent":"1.856585607s","remote":"127.0.0.1:35290","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-04-23T14:48:01.339713Z","caller":"traceutil/trace.go:171","msg":"trace[1646082520] transaction","detail":"{read_only:false; response_revision:3397; number_of_response:1; }","duration":"925.497986ms","start":"2026-04-23T14:48:00.414188Z","end":"2026-04-23T14:48:01.339686Z","steps":["trace[1646082520] 'process raft request' (duration: 925.315423ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T14:48:01.339755Z","caller":"traceutil/trace.go:171","msg":"trace[372191362] linearizableReadLoop","detail":"{readStateIndex:3522; appliedIndex:3519; }","duration":"1.937652747s","start":"2026-04-23T14:47:59.402086Z","end":"2026-04-23T14:48:01.339739Z","steps":["trace[372191362] 'read index received' (duration: 1.932126716s)","trace[372191362] 'applied index is now lower than readState.Index' (duration: 5.525291ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T14:48:01.339717Z","caller":"traceutil/trace.go:171","msg":"trace[1047399205] transaction","detail":"{read_only:false; response_revision:3396; number_of_response:1; }","duration":"1.449095906s","start":"2026-04-23T14:47:59.890555Z","end":"2026-04-23T14:48:01.339651Z","steps":["trace[1047399205] 'process raft request' (duration: 1.448683091s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T14:48:01.339837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T14:48:00.414164Z","time spent":"925.613567ms","remote":"127.0.0.1:35290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T14:48:01.339884Z","caller":"traceutil/trace.go:171","msg":"trace[1621295954] transaction","detail":"{read_only:false; response_revision:3398; number_of_response:1; }","duration":"225.062203ms","start":"2026-04-23T14:48:01.114806Z","end":"2026-04-23T14:48:01.339868Z","steps":["trace[1621295954] 'process raft request' (duration: 224.80151ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T14:48:01.339893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.677874672s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T14:48:01.339925Z","caller":"traceutil/trace.go:171","msg":"trace[1267448690] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:3398; }","duration":"1.677950842s","start":"2026-04-23T14:47:59.661963Z","end":"2026-04-23T14:48:01.339914Z","steps":["trace[1267448690] 'agreement among raft nodes before linearized reading' (duration: 1.677887962s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T14:48:01.339951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T14:47:59.661944Z","time spent":"1.678001433s","remote":"127.0.0.1:60974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-04-23T14:48:01.339966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.684374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-23T14:48:01.340001Z","caller":"traceutil/trace.go:171","msg":"trace[1392734134] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:3398; }","duration":"226.757355ms","start":"2026-04-23T14:48:01.113235Z","end":"2026-04-23T14:48:01.339993Z","steps":["trace[1392734134] 'agreement among raft nodes before linearized reading' (duration: 226.649924ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T14:48:01.340064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.272406788s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T14:48:01.340093Z","caller":"traceutil/trace.go:171","msg":"trace[1479720115] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3398; }","duration":"1.272478429s","start":"2026-04-23T14:48:00.067608Z","end":"2026-04-23T14:48:01.340086Z","steps":["trace[1479720115] 'agreement among raft nodes before linearized reading' (duration: 1.272419978s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T14:48:01.34011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T14:48:00.067592Z","time spent":"1.272513579s","remote":"127.0.0.1:35056","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-04-23T14:48:01.340115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.584939244s","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-04-23T14:48:01.340134Z","caller":"traceutil/trace.go:171","msg":"trace[320216610] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3398; }","duration":"1.584972844s","start":"2026-04-23T14:47:59.755156Z","end":"2026-04-23T14:48:01.340129Z","steps":["trace[320216610] 'agreement among raft nodes before linearized reading' (duration: 1.584913133s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T14:48:01.340151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T14:47:59.75512Z","time spent":"1.585027644s","remote":"127.0.0.1:35290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-23T14:48:01.340172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.964427ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T14:48:01.340223Z","caller":"traceutil/trace.go:171","msg":"trace[369153528] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:3398; }","duration":"209.046488ms","start":"2026-04-23T14:48:01.131168Z","end":"2026-04-23T14:48:01.340215Z","steps":["trace[369153528] 'agreement among raft nodes before linearized reading' (duration: 208.978087ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T14:48:01.340171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.938030142s","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-04-23T14:48:01.340306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"727.182678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-23T14:48:01.340334Z","caller":"traceutil/trace.go:171","msg":"trace[410926034] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3398; }","duration":"727.26198ms","start":"2026-04-23T14:48:00.613066Z","end":"2026-04-23T14:48:01.340328Z","steps":["trace[410926034] 'agreement among raft nodes before linearized reading' (duration: 727.156788ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T14:48:01.340353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T14:48:00.613036Z","time spent":"727.31321ms","remote":"127.0.0.1:35290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-23T14:48:01.340349Z","caller":"traceutil/trace.go:171","msg":"trace[1813929021] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3398; }","duration":"1.938287514s","start":"2026-04-23T14:47:59.40203Z","end":"2026-04-23T14:48:01.340318Z","steps":["trace[1813929021] 'agreement among raft nodes before linearized reading' (duration: 1.937821489s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T14:48:01.340417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T14:47:59.402008Z","time spent":"1.938397517s","remote":"127.0.0.1:35290","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-04-23T14:48:01.340443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T14:47:59.890528Z","time spent":"1.449277108s","remote":"127.0.0.1:35290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T14:49:52.161787Z","caller":"traceutil/trace.go:171","msg":"trace[1780915624] transaction","detail":"{read_only:false; response_revision:4529; number_of_response:1; }","duration":"103.409651ms","start":"2026-04-23T14:49:52.058247Z","end":"2026-04-23T14:49:52.161656Z","steps":["trace[1780915624] 'process raft request' (duration: 103.252287ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T14:49:58.994145Z","caller":"traceutil/trace.go:171","msg":"trace[1396619606] transaction","detail":"{read_only:false; response_revision:4700; number_of_response:1; }","duration":"114.330313ms","start":"2026-04-23T14:49:58.879776Z","end":"2026-04-23T14:49:58.994106Z","steps":["trace[1396619606] 'process raft request' (duration: 114.160249ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T14:49:59.206384Z","caller":"traceutil/trace.go:171","msg":"trace[1829367854] transaction","detail":"{read_only:false; response_revision:4701; number_of_response:1; }","duration":"206.354253ms","start":"2026-04-23T14:49:59.00001Z","end":"2026-04-23T14:49:59.206364Z","steps":["trace[1829367854] 'process raft request' (duration: 108.774365ms)","trace[1829367854] 'compare' (duration: 97.392324ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T14:49:59.227586Z","caller":"traceutil/trace.go:171","msg":"trace[2107440973] linearizableReadLoop","detail":"{readStateIndex:4877; appliedIndex:4875; }","duration":"160.618242ms","start":"2026-04-23T14:49:59.066929Z","end":"2026-04-23T14:49:59.227547Z","steps":["trace[2107440973] 'read index received' (duration: 41.905377ms)","trace[2107440973] 'applied index is now lower than readState.Index' (duration: 118.711715ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T14:49:59.227626Z","caller":"traceutil/trace.go:171","msg":"trace[84115870] transaction","detail":"{read_only:false; response_revision:4702; number_of_response:1; }","duration":"220.700639ms","start":"2026-04-23T14:49:59.006903Z","end":"2026-04-23T14:49:59.227603Z","steps":["trace[84115870] 'process raft request' (duration: 220.462444ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T14:49:59.227724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.768016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T14:49:59.227875Z","caller":"traceutil/trace.go:171","msg":"trace[910863960] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4702; }","duration":"160.968739ms","start":"2026-04-23T14:49:59.066892Z","end":"2026-04-23T14:49:59.22786Z","steps":["trace[910863960] 'agreement among raft nodes before linearized reading' (duration: 160.772595ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T14:50:11.516302Z","caller":"traceutil/trace.go:171","msg":"trace[1356034816] linearizableReadLoop","detail":"{readStateIndex:5044; appliedIndex:5043; }","duration":"393.014525ms","start":"2026-04-23T14:50:11.123258Z","end":"2026-04-23T14:50:11.516272Z","steps":["trace[1356034816] 'read index received' (duration: 392.869872ms)","trace[1356034816] 'applied index is now lower than readState.Index' (duration: 143.733µs)"],"step_count":2} {"level":"info","ts":"2026-04-23T14:50:11.516439Z","caller":"traceutil/trace.go:171","msg":"trace[1770668858] transaction","detail":"{read_only:false; response_revision:4865; number_of_response:1; }","duration":"409.455068ms","start":"2026-04-23T14:50:11.106942Z","end":"2026-04-23T14:50:11.516397Z","steps":["trace[1770668858] 'process raft request' (duration: 409.130981ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T14:50:11.516555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.270481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-04-23T14:50:11.516597Z","caller":"traceutil/trace.go:171","msg":"trace[2005212270] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4865; }","duration":"393.354042ms","start":"2026-04-23T14:50:11.123229Z","end":"2026-04-23T14:50:11.516583Z","steps":["trace[2005212270] 'agreement among raft nodes before linearized reading' (duration: 393.186148ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T14:50:11.516635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T14:50:11.123215Z","time spent":"393.412034ms","remote":"127.0.0.1:35188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1887,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "} {"level":"warn","ts":"2026-04-23T14:50:11.516683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T14:50:11.106924Z","time spent":"409.630951ms","remote":"127.0.0.1:35200","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10670,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T14:50:11.988045Z","caller":"traceutil/trace.go:171","msg":"trace[1481451030] transaction","detail":"{read_only:false; response_revision:4874; number_of_response:1; }","duration":"133.150777ms","start":"2026-04-23T14:50:11.854873Z","end":"2026-04-23T14:50:11.988023Z","steps":["trace[1481451030] 'process raft request' (duration: 133.090996ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T14:50:11.988054Z","caller":"traceutil/trace.go:171","msg":"trace[1880267150] transaction","detail":"{read_only:false; response_revision:4872; number_of_response:1; }","duration":"146.544621ms","start":"2026-04-23T14:50:11.84148Z","end":"2026-04-23T14:50:11.988025Z","steps":["trace[1880267150] 'process raft request' (duration: 139.618504ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T14:50:11.98809Z","caller":"traceutil/trace.go:171","msg":"trace[590636149] transaction","detail":"{read_only:false; response_revision:4873; number_of_response:1; }","duration":"145.971948ms","start":"2026-04-23T14:50:11.84209Z","end":"2026-04-23T14:50:11.988062Z","steps":["trace[590636149] 'process raft request' (duration: 145.828265ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T14:50:11.988265Z","caller":"traceutil/trace.go:171","msg":"trace[268579139] transaction","detail":"{read_only:false; response_revision:4875; number_of_response:1; }","duration":"133.311172ms","start":"2026-04-23T14:50:11.854944Z","end":"2026-04-23T14:50:11.988255Z","steps":["trace[268579139] 'process raft request' (duration: 133.045706ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T14:50:44.384864Z","caller":"traceutil/trace.go:171","msg":"trace[4058372] linearizableReadLoop","detail":"{readStateIndex:5373; appliedIndex:5371; }","duration":"134.854656ms","start":"2026-04-23T14:50:44.249978Z","end":"2026-04-23T14:50:44.384833Z","steps":["trace[4058372] 'read index received' (duration: 132.257534ms)","trace[4058372] 'applied index is now lower than readState.Index' (duration: 2.595972ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T14:50:44.385042Z","caller":"traceutil/trace.go:171","msg":"trace[654915717] transaction","detail":"{read_only:false; response_revision:5185; number_of_response:1; }","duration":"136.531566ms","start":"2026-04-23T14:50:44.248498Z","end":"2026-04-23T14:50:44.38503Z","steps":["trace[654915717] 'process raft request' (duration: 136.197609ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T14:50:44.384899Z","caller":"traceutil/trace.go:171","msg":"trace[731587528] transaction","detail":"{read_only:false; response_revision:5184; number_of_response:1; }","duration":"136.396213ms","start":"2026-04-23T14:50:44.248463Z","end":"2026-04-23T14:50:44.384859Z","steps":["trace[731587528] 'process raft request' (duration: 133.910504ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T14:50:44.385324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.330808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-04-23T14:50:44.385325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.781244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-23T14:50:44.385364Z","caller":"traceutil/trace.go:171","msg":"trace[1699759161] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5185; }","duration":"135.4493ms","start":"2026-04-23T14:50:44.249904Z","end":"2026-04-23T14:50:44.385353Z","steps":["trace[1699759161] 'agreement among raft nodes before linearized reading' (duration: 135.336747ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T14:50:44.38537Z","caller":"traceutil/trace.go:171","msg":"trace[1090460026] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5185; }","duration":"134.852946ms","start":"2026-04-23T14:50:44.250506Z","end":"2026-04-23T14:50:44.385359Z","steps":["trace[1090460026] 'agreement among raft nodes before linearized reading' (duration: 134.705563ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T14:51:45.736606Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2925} {"level":"info","ts":"2026-04-23T14:51:45.820394Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2925,"took":"81.939503ms","hash":3936911473,"current-db-size-bytes":53886976,"current-db-size":"54 MB","current-db-size-in-use-bytes":29470720,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-04-23T14:51:45.820471Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3936911473,"revision":2925,"compact-revision":-1} {"level":"info","ts":"2026-04-23T14:56:45.743861Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5636} {"level":"info","ts":"2026-04-23T14:56:45.830867Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5636,"took":"85.830674ms","hash":606423354,"current-db-size-bytes":53886976,"current-db-size":"54 MB","current-db-size-in-use-bytes":18350080,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-04-23T14:56:45.830927Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":606423354,"revision":5636,"compact-revision":2925}