{"level":"warn","ts":"2026-04-16T05:59:51.124045Z","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-16T05:59:51.12413Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.141: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.141:2380","--initial-cluster=instance=https://199.204.45.141:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.141:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.141: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-16T05:59:51.124188Z","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-16T05:59:51.124199Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.141:2380"]} {"level":"info","ts":"2026-04-16T05:59:51.124215Z","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-16T05:59:51.12485Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.141:2379"]} {"level":"info","ts":"2026-04-16T05:59:51.124921Z","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.141:2380"],"listen-peer-urls":["https://199.204.45.141:2380"],"advertise-client-urls":["https://199.204.45.141:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.141:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.141: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-16T05:59:51.128131Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.016117ms"} {"level":"info","ts":"2026-04-16T05:59:51.134217Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"9ef3b4f68930dc2","cluster-id":"b19a5957e6e65747"} {"level":"info","ts":"2026-04-16T05:59:51.134403Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 switched to configuration voters=()"} {"level":"info","ts":"2026-04-16T05:59:51.134459Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 became follower at term 0"} {"level":"info","ts":"2026-04-16T05:59:51.134522Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 9ef3b4f68930dc2 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-16T05:59:51.134564Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 became follower at term 1"} {"level":"info","ts":"2026-04-16T05:59:51.134679Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 switched to configuration voters=(715856078018121154)"} {"level":"warn","ts":"2026-04-16T05:59:51.144098Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-16T05:59:51.145572Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-16T05:59:51.146619Z","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-16T05:59:51.149231Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"9ef3b4f68930dc2","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-16T05:59:51.154681Z","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-16T05:59:51.15566Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"9ef3b4f68930dc2","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-16T05:59:51.155899Z","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-16T05:59:51.155949Z","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-16T05:59:51.155965Z","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-16T05:59:51.15605Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.141:2380"} {"level":"info","ts":"2026-04-16T05:59:51.15614Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.141:2380"} {"level":"info","ts":"2026-04-16T05:59:51.156443Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"9ef3b4f68930dc2","initial-advertise-peer-urls":["https://199.204.45.141:2380"],"listen-peer-urls":["https://199.204.45.141:2380"],"advertise-client-urls":["https://199.204.45.141:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.141:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-16T05:59:51.156487Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-16T05:59:51.157057Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 switched to configuration voters=(715856078018121154)"} {"level":"info","ts":"2026-04-16T05:59:51.15717Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b19a5957e6e65747","local-member-id":"9ef3b4f68930dc2","added-peer-id":"9ef3b4f68930dc2","added-peer-peer-urls":["https://199.204.45.141:2380"]} {"level":"info","ts":"2026-04-16T05:59:51.536189Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 is starting a new election at term 1"} {"level":"info","ts":"2026-04-16T05:59:51.536284Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-16T05:59:51.536323Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 received MsgPreVoteResp from 9ef3b4f68930dc2 at term 1"} {"level":"info","ts":"2026-04-16T05:59:51.536347Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 became candidate at term 2"} {"level":"info","ts":"2026-04-16T05:59:51.536469Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 received MsgVoteResp from 9ef3b4f68930dc2 at term 2"} {"level":"info","ts":"2026-04-16T05:59:51.53652Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 became leader at term 2"} {"level":"info","ts":"2026-04-16T05:59:51.536542Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 9ef3b4f68930dc2 elected leader 9ef3b4f68930dc2 at term 2"} {"level":"info","ts":"2026-04-16T05:59:51.538937Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"9ef3b4f68930dc2","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.141:2379]}","request-path":"/0/members/9ef3b4f68930dc2/attributes","cluster-id":"b19a5957e6e65747","publish-timeout":"7s"} {"level":"info","ts":"2026-04-16T05:59:51.539316Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T05:59:51.540014Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-16T05:59:51.540677Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-16T05:59:51.540931Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-16T05:59:51.540955Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-16T05:59:51.540994Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b19a5957e6e65747","local-member-id":"9ef3b4f68930dc2","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T05:59:51.541102Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T05:59:51.541135Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T05:59:51.544017Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.141:2379"} {"level":"info","ts":"2026-04-16T05:59:51.548809Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-04-16T05:59:54.78452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.222672ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-16T05:59:54.784648Z","caller":"traceutil/trace.go:171","msg":"trace[1163001144] transaction","detail":"{read_only:false; response_revision:201; number_of_response:1; }","duration":"348.68074ms","start":"2026-04-16T05:59:54.43595Z","end":"2026-04-16T05:59:54.78463Z","steps":["trace[1163001144] 'process raft request' (duration: 144.901343ms)","trace[1163001144] 'compare' (duration: 203.133231ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T05:59:54.784711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T05:59:54.435934Z","time spent":"348.75513ms","remote":"127.0.0.1:33932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":740,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-16T05:59:54.881574Z","caller":"traceutil/trace.go:171","msg":"trace[1530352742] transaction","detail":"{read_only:false; response_revision:202; number_of_response:1; }","duration":"104.331025ms","start":"2026-04-16T05:59:54.777187Z","end":"2026-04-16T05:59:54.881518Z","steps":["trace[1530352742] 'process raft request' (duration: 103.984502ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T05:59:55.056521Z","caller":"traceutil/trace.go:171","msg":"trace[2142511914] transaction","detail":"{read_only:false; response_revision:203; number_of_response:1; }","duration":"170.77377ms","start":"2026-04-16T05:59:54.885701Z","end":"2026-04-16T05:59:55.056475Z","steps":["trace[2142511914] 'process raft request' (duration: 100.205268ms)","trace[2142511914] 'compare' (duration: 70.35918ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:00:28.579256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.79504ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T06:00:28.579289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.679476ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:00:28.579456Z","caller":"traceutil/trace.go:171","msg":"trace[133449542] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:615; }","duration":"161.999637ms","start":"2026-04-16T06:00:28.417396Z","end":"2026-04-16T06:00:28.579395Z","steps":["trace[133449542] 'range keys from in-memory index tree' (duration: 161.768289ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:00:28.579481Z","caller":"traceutil/trace.go:171","msg":"trace[1375843113] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:615; }","duration":"112.932076ms","start":"2026-04-16T06:00:28.466526Z","end":"2026-04-16T06:00:28.579458Z","steps":["trace[1375843113] 'range keys from in-memory index tree' (duration: 112.542421ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:00:29.081834Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":991528130711151625,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-16T06:00:29.13928Z","caller":"traceutil/trace.go:171","msg":"trace[1533108706] linearizableReadLoop","detail":"{readStateIndex:639; appliedIndex:638; }","duration":"558.340593ms","start":"2026-04-16T06:00:28.580917Z","end":"2026-04-16T06:00:29.139257Z","steps":["trace[1533108706] 'read index received' (duration: 557.012624ms)","trace[1533108706] 'applied index is now lower than readState.Index' (duration: 1.327069ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:00:29.139361Z","caller":"traceutil/trace.go:171","msg":"trace[1079200134] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"648.375048ms","start":"2026-04-16T06:00:28.490953Z","end":"2026-04-16T06:00:29.139328Z","steps":["trace[1079200134] 'process raft request' (duration: 647.281348ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:00:29.139463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"558.541851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T06:00:29.139514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.790855ms","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-16T06:00:29.139524Z","caller":"traceutil/trace.go:171","msg":"trace[1513823598] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:616; }","duration":"558.642114ms","start":"2026-04-16T06:00:28.580868Z","end":"2026-04-16T06:00:29.13951Z","steps":["trace[1513823598] 'agreement among raft nodes before linearized reading' (duration: 558.516059ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:00:29.139559Z","caller":"traceutil/trace.go:171","msg":"trace[1334102672] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:616; }","duration":"374.877047ms","start":"2026-04-16T06:00:28.764671Z","end":"2026-04-16T06:00:29.139548Z","steps":["trace[1334102672] 'agreement among raft nodes before linearized reading' (duration: 374.727102ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:00:29.139565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:00:28.580848Z","time spent":"558.709667ms","remote":"127.0.0.1:33582","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-16T06:00:29.139601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:00:28.764659Z","time spent":"374.93428ms","remote":"127.0.0.1:33832","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-16T06:00:29.13971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:00:28.490927Z","time spent":"648.490013ms","remote":"127.0.0.1:33654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T06:00:29.139849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.154788ms","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-16T06:00:29.140482Z","caller":"traceutil/trace.go:171","msg":"trace[1555946421] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:616; }","duration":"214.899704ms","start":"2026-04-16T06:00:28.925556Z","end":"2026-04-16T06:00:29.140455Z","steps":["trace[1555946421] 'agreement among raft nodes before linearized reading' (duration: 213.891048ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:00:29.345676Z","caller":"traceutil/trace.go:171","msg":"trace[553483740] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"201.07554ms","start":"2026-04-16T06:00:29.144573Z","end":"2026-04-16T06:00:29.345648Z","steps":["trace[553483740] 'process raft request' (duration: 194.526662ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:00:29.362116Z","caller":"traceutil/trace.go:171","msg":"trace[1738997464] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"215.470213ms","start":"2026-04-16T06:00:29.146619Z","end":"2026-04-16T06:00:29.36209Z","steps":["trace[1738997464] 'process raft request' (duration: 215.245805ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:00:29.362471Z","caller":"traceutil/trace.go:171","msg":"trace[895797305] linearizableReadLoop","detail":"{readStateIndex:642; appliedIndex:639; }","duration":"120.447693ms","start":"2026-04-16T06:00:29.242007Z","end":"2026-04-16T06:00:29.362454Z","steps":["trace[895797305] 'read index received' (duration: 97.019323ms)","trace[895797305] 'applied index is now lower than readState.Index' (duration: 23.42736ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:00:29.36255Z","caller":"traceutil/trace.go:171","msg":"trace[1622888047] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"162.916295ms","start":"2026-04-16T06:00:29.199587Z","end":"2026-04-16T06:00:29.362503Z","steps":["trace[1622888047] 'process raft request' (duration: 162.410756ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:00:29.362836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.816678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-55vsp\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-16T06:00:29.362881Z","caller":"traceutil/trace.go:171","msg":"trace[2133581892] range","detail":"{range_begin:/registry/pods/kube-system/cilium-55vsp; range_end:; response_count:1; response_revision:619; }","duration":"120.900941ms","start":"2026-04-16T06:00:29.241972Z","end":"2026-04-16T06:00:29.362873Z","steps":["trace[2133581892] 'agreement among raft nodes before linearized reading' (duration: 120.545447ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:00:29.928534Z","caller":"traceutil/trace.go:171","msg":"trace[1317502044] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"505.98868ms","start":"2026-04-16T06:00:29.42252Z","end":"2026-04-16T06:00:29.928509Z","steps":["trace[1317502044] 'process raft request' (duration: 492.509382ms)","trace[1317502044] 'compare' (duration: 13.119095ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:00:29.928657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:00:29.422506Z","time spent":"506.086504ms","remote":"127.0.0.1:33832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T06:00:29.929022Z","caller":"traceutil/trace.go:171","msg":"trace[1542708725] linearizableReadLoop","detail":"{readStateIndex:644; appliedIndex:643; }","duration":"460.807641ms","start":"2026-04-16T06:00:29.468198Z","end":"2026-04-16T06:00:29.929006Z","steps":["trace[1542708725] 'read index received' (duration: 447.00703ms)","trace[1542708725] 'applied index is now lower than readState.Index' (duration: 13.797891ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:00:29.929135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.937995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:00:29.929172Z","caller":"traceutil/trace.go:171","msg":"trace[1079030726] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:621; }","duration":"461.021289ms","start":"2026-04-16T06:00:29.468142Z","end":"2026-04-16T06:00:29.929163Z","steps":["trace[1079030726] 'agreement among raft nodes before linearized reading' (duration: 460.958016ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:00:29.929229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:00:29.468125Z","time spent":"461.099621ms","remote":"127.0.0.1:33572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-16T06:00:29.929886Z","caller":"traceutil/trace.go:171","msg":"trace[1989357813] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"142.060188ms","start":"2026-04-16T06:00:29.787812Z","end":"2026-04-16T06:00:29.929872Z","steps":["trace[1989357813] 'process raft request' (duration: 140.807953ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:00:29.930051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.477206ms","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-04-16T06:00:29.930127Z","caller":"traceutil/trace.go:171","msg":"trace[2080449725] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:622; }","duration":"141.680275ms","start":"2026-04-16T06:00:29.78843Z","end":"2026-04-16T06:00:29.930111Z","steps":["trace[2080449725] 'agreement among raft nodes before linearized reading' (duration: 141.372224ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:00:45.518578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.258402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-16T06:00:45.518579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.15426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-r2mwz\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-04-16T06:00:45.51877Z","caller":"traceutil/trace.go:171","msg":"trace[735589386] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:779; }","duration":"100.474969ms","start":"2026-04-16T06:00:45.418229Z","end":"2026-04-16T06:00:45.518704Z","steps":["trace[735589386] 'range keys from in-memory index tree' (duration: 100.097627ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:00:45.518785Z","caller":"traceutil/trace.go:171","msg":"trace[450153535] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-r2mwz; range_end:; response_count:1; response_revision:779; }","duration":"163.48107ms","start":"2026-04-16T06:00:45.355276Z","end":"2026-04-16T06:00:45.518757Z","steps":["trace[450153535] 'range keys from in-memory index tree' (duration: 162.655004ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:00:45.518842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.562745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.141\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-16T06:00:45.518914Z","caller":"traceutil/trace.go:171","msg":"trace[1883761127] range","detail":"{range_begin:/registry/masterleases/199.204.45.141; range_end:; response_count:1; response_revision:779; }","duration":"231.660188ms","start":"2026-04-16T06:00:45.287222Z","end":"2026-04-16T06:00:45.518882Z","steps":["trace[1883761127] 'range keys from in-memory index tree' (duration: 231.439291ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:00:45.518928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.126335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-04-16T06:00:45.519057Z","caller":"traceutil/trace.go:171","msg":"trace[2101181817] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:779; }","duration":"267.309001ms","start":"2026-04-16T06:00:45.251718Z","end":"2026-04-16T06:00:45.519027Z","steps":["trace[2101181817] 'range keys from in-memory index tree' (duration: 266.93682ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:01:04.562052Z","caller":"traceutil/trace.go:171","msg":"trace[451837971] transaction","detail":"{read_only:false; response_revision:1084; number_of_response:1; }","duration":"452.973052ms","start":"2026-04-16T06:01:04.109061Z","end":"2026-04-16T06:01:04.562034Z","steps":["trace[451837971] 'process raft request' (duration: 415.245069ms)","trace[451837971] 'compare' (duration: 36.896882ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:01:04.562524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.487283ms","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-16T06:01:04.562554Z","caller":"traceutil/trace.go:171","msg":"trace[1388570068] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1085; }","duration":"411.540585ms","start":"2026-04-16T06:01:04.151006Z","end":"2026-04-16T06:01:04.562547Z","steps":["trace[1388570068] 'agreement among raft nodes before linearized reading' (duration: 411.456633ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:01:04.562593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:01:04.150991Z","time spent":"411.596476ms","remote":"127.0.0.1:33832","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-16T06:01:04.562713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:01:04.109036Z","time spent":"453.063183ms","remote":"127.0.0.1:33654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":211570,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T06:01:04.563368Z","caller":"traceutil/trace.go:171","msg":"trace[139935595] linearizableReadLoop","detail":"{readStateIndex:1118; appliedIndex:1117; }","duration":"412.306594ms","start":"2026-04-16T06:01:04.151037Z","end":"2026-04-16T06:01:04.563344Z","steps":["trace[139935595] 'read index received' (duration: 373.208965ms)","trace[139935595] 'applied index is now lower than readState.Index' (duration: 38.068323ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:01:04.563576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.878691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/cert-manager/cert-manager-cainjector\" ","response":"range_response_count:1 size:986"} {"level":"info","ts":"2026-04-16T06:01:04.563618Z","caller":"traceutil/trace.go:171","msg":"trace[421018961] range","detail":"{range_begin:/registry/serviceaccounts/cert-manager/cert-manager-cainjector; range_end:; response_count:1; response_revision:1085; }","duration":"369.949793ms","start":"2026-04-16T06:01:04.193654Z","end":"2026-04-16T06:01:04.563604Z","steps":["trace[421018961] 'agreement among raft nodes before linearized reading' (duration: 369.83311ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:01:04.563654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:01:04.193636Z","time spent":"370.009984ms","remote":"127.0.0.1:33754","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":1009,"request content":"key:\"/registry/serviceaccounts/cert-manager/cert-manager-cainjector\" "} {"level":"warn","ts":"2026-04-16T06:01:04.563937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.54762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/cert-manager/cert-manager\" ","response":"range_response_count:1 size:968"} {"level":"info","ts":"2026-04-16T06:01:04.563971Z","caller":"traceutil/trace.go:171","msg":"trace[524961074] range","detail":"{range_begin:/registry/serviceaccounts/cert-manager/cert-manager; range_end:; response_count:1; response_revision:1085; }","duration":"269.660543ms","start":"2026-04-16T06:01:04.294301Z","end":"2026-04-16T06:01:04.563962Z","steps":["trace[524961074] 'agreement among raft nodes before linearized reading' (duration: 269.52724ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:01:04.564055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.647953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/cert-manager/cert-manager-webhook\" ","response":"range_response_count:1 size:971"} {"level":"info","ts":"2026-04-16T06:01:04.564117Z","caller":"traceutil/trace.go:171","msg":"trace[1230776452] range","detail":"{range_begin:/registry/serviceaccounts/cert-manager/cert-manager-webhook; range_end:; response_count:1; response_revision:1085; }","duration":"269.743445ms","start":"2026-04-16T06:01:04.294358Z","end":"2026-04-16T06:01:04.564102Z","steps":["trace[1230776452] 'agreement among raft nodes before linearized reading' (duration: 269.246692ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:01:04.56416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.709891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-04-16T06:01:04.564199Z","caller":"traceutil/trace.go:171","msg":"trace[2086574605] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1085; }","duration":"368.787293ms","start":"2026-04-16T06:01:04.195402Z","end":"2026-04-16T06:01:04.564189Z","steps":["trace[2086574605] 'agreement among raft nodes before linearized reading' (duration: 368.696271ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:01:04.564232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:01:04.195379Z","time spent":"368.846344ms","remote":"127.0.0.1:33832","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-16T06:01:05.245647Z","caller":"traceutil/trace.go:171","msg":"trace[1847690776] transaction","detail":"{read_only:false; response_revision:1091; number_of_response:1; }","duration":"494.729452ms","start":"2026-04-16T06:01:04.750893Z","end":"2026-04-16T06:01:05.245622Z","steps":["trace[1847690776] 'process raft request' (duration: 494.681331ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:01:05.245772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:01:04.750873Z","time spent":"494.841976ms","remote":"127.0.0.1:44006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2257,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-16T06:01:05.245784Z","caller":"traceutil/trace.go:171","msg":"trace[977602613] transaction","detail":"{read_only:false; response_revision:1090; number_of_response:1; }","duration":"538.680314ms","start":"2026-04-16T06:01:04.707068Z","end":"2026-04-16T06:01:05.245748Z","steps":["trace[977602613] 'process raft request' (duration: 538.314194ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:01:05.245945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:01:04.707043Z","time spent":"538.816058ms","remote":"127.0.0.1:33654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":211614,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T06:01:05.246074Z","caller":"traceutil/trace.go:171","msg":"trace[2044241259] transaction","detail":"{read_only:false; response_revision:1089; number_of_response:1; }","duration":"568.846874ms","start":"2026-04-16T06:01:04.67718Z","end":"2026-04-16T06:01:05.246026Z","steps":["trace[2044241259] 'process raft request' (duration: 552.139772ms)","trace[2044241259] 'compare' (duration: 15.8393ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:01:05.246325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:01:04.677161Z","time spent":"569.015138ms","remote":"127.0.0.1:33832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T06:01:05.951741Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":991528130711152546,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-16T06:01:05.991759Z","caller":"traceutil/trace.go:171","msg":"trace[55901604] transaction","detail":"{read_only:false; response_revision:1093; number_of_response:1; }","duration":"733.953156ms","start":"2026-04-16T06:01:05.257768Z","end":"2026-04-16T06:01:05.991721Z","steps":["trace[55901604] 'process raft request' (duration: 733.219237ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:01:05.991955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:01:05.257751Z","time spent":"734.1193ms","remote":"127.0.0.1:43978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2949,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-16T06:01:05.995979Z","caller":"traceutil/trace.go:171","msg":"trace[1691989765] transaction","detail":"{read_only:false; response_revision:1094; number_of_response:1; }","duration":"733.078883ms","start":"2026-04-16T06:01:05.262868Z","end":"2026-04-16T06:01:05.995947Z","steps":["trace[1691989765] 'process raft request' (duration: 732.919809ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:01:05.995988Z","caller":"traceutil/trace.go:171","msg":"trace[1788801920] linearizableReadLoop","detail":"{readStateIndex:1128; appliedIndex:1126; }","duration":"652.755591ms","start":"2026-04-16T06:01:05.343212Z","end":"2026-04-16T06:01:05.995968Z","steps":["trace[1788801920] 'read index received' (duration: 647.702385ms)","trace[1788801920] 'applied index is now lower than readState.Index' (duration: 5.052216ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:01:05.996101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:01:05.262842Z","time spent":"733.201626ms","remote":"127.0.0.1:44006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-16T06:01:05.996229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"652.997857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.141\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-16T06:01:05.996255Z","caller":"traceutil/trace.go:171","msg":"trace[22444166] range","detail":"{range_begin:/registry/masterleases/199.204.45.141; range_end:; response_count:1; response_revision:1096; }","duration":"653.082299ms","start":"2026-04-16T06:01:05.343164Z","end":"2026-04-16T06:01:05.996246Z","steps":["trace[22444166] 'agreement among raft nodes before linearized reading' (duration: 652.917665ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:01:05.996283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:01:05.343144Z","time spent":"653.132061ms","remote":"127.0.0.1:33606","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.141\" "} {"level":"info","ts":"2026-04-16T06:01:16.245465Z","caller":"traceutil/trace.go:171","msg":"trace[96946274] transaction","detail":"{read_only:false; response_revision:1189; number_of_response:1; }","duration":"120.735416ms","start":"2026-04-16T06:01:16.1247Z","end":"2026-04-16T06:01:16.245435Z","steps":["trace[96946274] 'process raft request' (duration: 53.138572ms)","trace[96946274] 'compare' (duration: 67.483512ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:01:37.791069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.363458ms","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-16T06:01:37.791243Z","caller":"traceutil/trace.go:171","msg":"trace[2097434260] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:1441; }","duration":"116.590782ms","start":"2026-04-16T06:01:37.674626Z","end":"2026-04-16T06:01:37.791217Z","steps":["trace[2097434260] 'count revisions from in-memory index tree' (duration: 116.275716ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:01:37.791288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.475697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/ingress-nginx/ingress-nginx-admission-patch-7rd28\" ","response":"range_response_count:1 size:4179"} {"level":"info","ts":"2026-04-16T06:01:37.791377Z","caller":"traceutil/trace.go:171","msg":"trace[113363225] range","detail":"{range_begin:/registry/pods/ingress-nginx/ingress-nginx-admission-patch-7rd28; range_end:; response_count:1; response_revision:1441; }","duration":"196.61408ms","start":"2026-04-16T06:01:37.594742Z","end":"2026-04-16T06:01:37.791356Z","steps":["trace[113363225] 'range keys from in-memory index tree' (duration: 196.071899ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:02:05.155991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.23828ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T06:02:05.156097Z","caller":"traceutil/trace.go:171","msg":"trace[536343176] linearizableReadLoop","detail":"{readStateIndex:1943; appliedIndex:1942; }","duration":"264.256334ms","start":"2026-04-16T06:02:04.891824Z","end":"2026-04-16T06:02:05.156081Z","steps":["trace[536343176] 'read index received' (duration: 61.081µs)","trace[536343176] 'applied index is now lower than readState.Index' (duration: 264.194243ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:02:05.156709Z","caller":"traceutil/trace.go:171","msg":"trace[2101210500] transaction","detail":"{read_only:false; response_revision:1868; number_of_response:1; }","duration":"304.405819ms","start":"2026-04-16T06:02:04.852287Z","end":"2026-04-16T06:02:05.156693Z","steps":["trace[2101210500] 'process raft request' (duration: 15.374076ms)","trace[2101210500] 'compare' (duration: 288.111188ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:02:05.156953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.114858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-16T06:02:05.15707Z","caller":"traceutil/trace.go:171","msg":"trace[861985816] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1868; }","duration":"265.28333ms","start":"2026-04-16T06:02:04.891767Z","end":"2026-04-16T06:02:05.157051Z","steps":["trace[861985816] 'agreement among raft nodes before linearized reading' (duration: 264.933714ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:02:05.157355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:02:04.852257Z","time spent":"304.49414ms","remote":"127.0.0.1:33832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T06:02:05.174079Z","caller":"traceutil/trace.go:171","msg":"trace[424515324] transaction","detail":"{read_only:false; response_revision:1869; number_of_response:1; }","duration":"245.406109ms","start":"2026-04-16T06:02:04.928629Z","end":"2026-04-16T06:02:05.174035Z","steps":["trace[424515324] 'process raft request' (duration: 245.196666ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:02:05.174184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.746724ms","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-04-16T06:02:05.174271Z","caller":"traceutil/trace.go:171","msg":"trace[1577896707] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1869; }","duration":"254.879386ms","start":"2026-04-16T06:02:04.919372Z","end":"2026-04-16T06:02:05.174252Z","steps":["trace[1577896707] 'agreement among raft nodes before linearized reading' (duration: 254.590981ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:02:05.360584Z","caller":"traceutil/trace.go:171","msg":"trace[249297983] transaction","detail":"{read_only:false; response_revision:1870; number_of_response:1; }","duration":"198.864046ms","start":"2026-04-16T06:02:05.161669Z","end":"2026-04-16T06:02:05.360533Z","steps":["trace[249297983] 'process raft request' (duration: 198.679883ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:02:05.370466Z","caller":"traceutil/trace.go:171","msg":"trace[1752847434] transaction","detail":"{read_only:false; response_revision:1871; number_of_response:1; }","duration":"191.964061ms","start":"2026-04-16T06:02:05.178473Z","end":"2026-04-16T06:02:05.370437Z","steps":["trace[1752847434] 'process raft request' (duration: 191.711747ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:02:05.499569Z","caller":"traceutil/trace.go:171","msg":"trace[1746022329] transaction","detail":"{read_only:false; response_revision:1872; number_of_response:1; }","duration":"111.165841ms","start":"2026-04-16T06:02:05.388369Z","end":"2026-04-16T06:02:05.499535Z","steps":["trace[1746022329] 'process raft request' (duration: 69.741068ms)","trace[1746022329] 'compare' (duration: 41.27075ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:02:06.058924Z","caller":"traceutil/trace.go:171","msg":"trace[349821595] transaction","detail":"{read_only:false; response_revision:1873; number_of_response:1; }","duration":"406.45701ms","start":"2026-04-16T06:02:05.652409Z","end":"2026-04-16T06:02:06.058866Z","steps":["trace[349821595] 'process raft request' (duration: 351.52572ms)","trace[349821595] 'compare' (duration: 54.830968ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:02:06.059047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:02:05.652384Z","time spent":"406.603752ms","remote":"127.0.0.1:33832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T06:02:06.058907Z","caller":"traceutil/trace.go:171","msg":"trace[611169896] linearizableReadLoop","detail":"{readStateIndex:1949; appliedIndex:1948; }","duration":"292.859769ms","start":"2026-04-16T06:02:05.766006Z","end":"2026-04-16T06:02:06.058866Z","steps":["trace[611169896] 'read index received' (duration: 237.910128ms)","trace[611169896] 'applied index is now lower than readState.Index' (duration: 54.948791ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:02:06.059095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.071853ms","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-16T06:02:06.059159Z","caller":"traceutil/trace.go:171","msg":"trace[932059895] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1873; }","duration":"293.183974ms","start":"2026-04-16T06:02:05.76596Z","end":"2026-04-16T06:02:06.059144Z","steps":["trace[932059895] 'agreement among raft nodes before linearized reading' (duration: 293.014972ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:02:44.390773Z","caller":"traceutil/trace.go:171","msg":"trace[1212752810] transaction","detail":"{read_only:false; response_revision:2132; number_of_response:1; }","duration":"187.8506ms","start":"2026-04-16T06:02:44.202893Z","end":"2026-04-16T06:02:44.390743Z","steps":["trace[1212752810] 'process raft request' (duration: 187.618417ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:02:44.948946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.056124ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T06:02:44.949122Z","caller":"traceutil/trace.go:171","msg":"trace[558417196] transaction","detail":"{read_only:false; response_revision:2135; number_of_response:1; }","duration":"318.849061ms","start":"2026-04-16T06:02:44.630258Z","end":"2026-04-16T06:02:44.949107Z","steps":["trace[558417196] 'process raft request' (duration: 318.7896ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:02:44.949199Z","caller":"traceutil/trace.go:171","msg":"trace[2121236163] transaction","detail":"{read_only:false; response_revision:2134; number_of_response:1; }","duration":"321.073332ms","start":"2026-04-16T06:02:44.62811Z","end":"2026-04-16T06:02:44.949183Z","steps":["trace[2121236163] 'process raft request' (duration: 101.705343ms)","trace[2121236163] 'compare' (duration: 218.874901ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:02:44.949239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:02:44.630246Z","time spent":"318.957122ms","remote":"127.0.0.1:33832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T06:02:44.949295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:02:44.628087Z","time spent":"321.144913ms","remote":"127.0.0.1:33832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T06:02:44.957629Z","caller":"traceutil/trace.go:171","msg":"trace[1238458645] transaction","detail":"{read_only:false; response_revision:2136; number_of_response:1; }","duration":"156.297692ms","start":"2026-04-16T06:02:44.801311Z","end":"2026-04-16T06:02:44.957609Z","steps":["trace[1238458645] 'process raft request' (duration: 156.211661ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:02:45.456586Z","caller":"traceutil/trace.go:171","msg":"trace[1116835912] transaction","detail":"{read_only:false; response_revision:2137; number_of_response:1; }","duration":"129.9563ms","start":"2026-04-16T06:02:45.326603Z","end":"2026-04-16T06:02:45.456559Z","steps":["trace[1116835912] 'process raft request' (duration: 129.779218ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:02:45.457878Z","caller":"traceutil/trace.go:171","msg":"trace[2143933407] linearizableReadLoop","detail":"{readStateIndex:2221; appliedIndex:2219; }","duration":"109.463756ms","start":"2026-04-16T06:02:45.348378Z","end":"2026-04-16T06:02:45.457842Z","steps":["trace[2143933407] 'read index received' (duration: 107.968706ms)","trace[2143933407] 'applied index is now lower than readState.Index' (duration: 1.49356ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:02:45.458035Z","caller":"traceutil/trace.go:171","msg":"trace[902578002] transaction","detail":"{read_only:false; response_revision:2138; number_of_response:1; }","duration":"129.906018ms","start":"2026-04-16T06:02:45.328094Z","end":"2026-04-16T06:02:45.458Z","steps":["trace[902578002] 'process raft request' (duration: 129.549384ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:02:45.458329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.894562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.141\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-16T06:02:45.458392Z","caller":"traceutil/trace.go:171","msg":"trace[1785103492] range","detail":"{range_begin:/registry/masterleases/199.204.45.141; range_end:; response_count:1; response_revision:2138; }","duration":"110.033714ms","start":"2026-04-16T06:02:45.348342Z","end":"2026-04-16T06:02:45.458375Z","steps":["trace[1785103492] 'agreement among raft nodes before linearized reading' (duration: 109.678959ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:04:12.607992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.424944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-16T06:04:12.60813Z","caller":"traceutil/trace.go:171","msg":"trace[1126852261] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:2719; }","duration":"117.622917ms","start":"2026-04-16T06:04:12.490473Z","end":"2026-04-16T06:04:12.608096Z","steps":["trace[1126852261] 'count revisions from in-memory index tree' (duration: 117.286622ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:07:50.238535Z","caller":"traceutil/trace.go:171","msg":"trace[1053584388] transaction","detail":"{read_only:false; response_revision:4378; number_of_response:1; }","duration":"107.782303ms","start":"2026-04-16T06:07:50.130726Z","end":"2026-04-16T06:07:50.238509Z","steps":["trace[1053584388] 'process raft request' (duration: 107.652021ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:07:50.248934Z","caller":"traceutil/trace.go:171","msg":"trace[1250043578] transaction","detail":"{read_only:false; response_revision:4379; number_of_response:1; }","duration":"114.767899ms","start":"2026-04-16T06:07:50.134149Z","end":"2026-04-16T06:07:50.248917Z","steps":["trace[1250043578] 'process raft request' (duration: 114.356125ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:07:50.249191Z","caller":"traceutil/trace.go:171","msg":"trace[1661586569] transaction","detail":"{read_only:false; response_revision:4380; number_of_response:1; }","duration":"112.757307ms","start":"2026-04-16T06:07:50.136418Z","end":"2026-04-16T06:07:50.249175Z","steps":["trace[1661586569] 'process raft request' (duration: 112.292942ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:07:54.653436Z","caller":"traceutil/trace.go:171","msg":"trace[959492832] transaction","detail":"{read_only:false; response_revision:4519; number_of_response:1; }","duration":"101.577676ms","start":"2026-04-16T06:07:54.551833Z","end":"2026-04-16T06:07:54.653411Z","steps":["trace[959492832] 'process raft request' (duration: 72.54157ms)","trace[959492832] 'compare' (duration: 28.840904ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:07:54.666317Z","caller":"traceutil/trace.go:171","msg":"trace[1305928713] transaction","detail":"{read_only:false; response_revision:4520; number_of_response:1; }","duration":"106.586589ms","start":"2026-04-16T06:07:54.55971Z","end":"2026-04-16T06:07:54.666296Z","steps":["trace[1305928713] 'process raft request' (duration: 106.378637ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:07:54.850026Z","caller":"traceutil/trace.go:171","msg":"trace[1167534465] linearizableReadLoop","detail":"{readStateIndex:4696; appliedIndex:4695; }","duration":"122.31192ms","start":"2026-04-16T06:07:54.727691Z","end":"2026-04-16T06:07:54.850003Z","steps":["trace[1167534465] 'read index received' (duration: 79.514805ms)","trace[1167534465] 'applied index is now lower than readState.Index' (duration: 42.796275ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:07:54.850087Z","caller":"traceutil/trace.go:171","msg":"trace[263161796] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4525; }","duration":"133.014797ms","start":"2026-04-16T06:07:54.717042Z","end":"2026-04-16T06:07:54.850056Z","steps":["trace[263161796] 'process raft request' (duration: 90.208001ms)","trace[263161796] 'compare' (duration: 42.653104ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:07:54.850298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.584524ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c78c3f36-f0bc-4837-98e2-57627c7152b2\" ","response":"range_response_count:1 size:4064"} {"level":"info","ts":"2026-04-16T06:07:54.850446Z","caller":"traceutil/trace.go:171","msg":"trace[584880908] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c78c3f36-f0bc-4837-98e2-57627c7152b2; range_end:; response_count:1; response_revision:4525; }","duration":"122.764576ms","start":"2026-04-16T06:07:54.727666Z","end":"2026-04-16T06:07:54.850431Z","steps":["trace[584880908] 'agreement among raft nodes before linearized reading' (duration: 122.486363ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:07:57.708482Z","caller":"traceutil/trace.go:171","msg":"trace[1943695018] transaction","detail":"{read_only:false; response_revision:4602; number_of_response:1; }","duration":"112.756096ms","start":"2026-04-16T06:07:57.595704Z","end":"2026-04-16T06:07:57.708461Z","steps":["trace[1943695018] 'process raft request' (duration: 86.893355ms)","trace[1943695018] 'compare' (duration: 25.71938ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:07:57.720535Z","caller":"traceutil/trace.go:171","msg":"trace[1266002114] linearizableReadLoop","detail":"{readStateIndex:4779; appliedIndex:4777; }","duration":"122.720975ms","start":"2026-04-16T06:07:57.597796Z","end":"2026-04-16T06:07:57.720517Z","steps":["trace[1266002114] 'read index received' (duration: 84.773523ms)","trace[1266002114] 'applied index is now lower than readState.Index' (duration: 37.946682ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:07:57.720563Z","caller":"traceutil/trace.go:171","msg":"trace[2034993097] transaction","detail":"{read_only:false; response_revision:4604; number_of_response:1; }","duration":"116.588788ms","start":"2026-04-16T06:07:57.603954Z","end":"2026-04-16T06:07:57.720542Z","steps":["trace[2034993097] 'process raft request' (duration: 116.485347ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:07:57.720716Z","caller":"traceutil/trace.go:171","msg":"trace[366435911] transaction","detail":"{read_only:false; response_revision:4603; number_of_response:1; }","duration":"124.729367ms","start":"2026-04-16T06:07:57.595959Z","end":"2026-04-16T06:07:57.720688Z","steps":["trace[366435911] 'process raft request' (duration: 124.414314ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:07:57.72079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.944908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" ","response":"range_response_count:1 size:708"} {"level":"info","ts":"2026-04-16T06:07:57.720886Z","caller":"traceutil/trace.go:171","msg":"trace[300791390] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:4605; }","duration":"123.094199ms","start":"2026-04-16T06:07:57.597781Z","end":"2026-04-16T06:07:57.720876Z","steps":["trace[300791390] 'agreement among raft nodes before linearized reading' (duration: 122.794196ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:07:57.916572Z","caller":"traceutil/trace.go:171","msg":"trace[717458734] transaction","detail":"{read_only:false; response_revision:4607; number_of_response:1; }","duration":"134.22441ms","start":"2026-04-16T06:07:57.782282Z","end":"2026-04-16T06:07:57.916507Z","steps":["trace[717458734] 'process raft request' (duration: 91.371234ms)","trace[717458734] 'compare' (duration: 42.322491ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:07:57.91612Z","caller":"traceutil/trace.go:171","msg":"trace[2068994494] linearizableReadLoop","detail":"{readStateIndex:4783; appliedIndex:4782; }","duration":"130.999686ms","start":"2026-04-16T06:07:57.78509Z","end":"2026-04-16T06:07:57.91609Z","steps":["trace[2068994494] 'read index received' (duration: 88.713636ms)","trace[2068994494] 'applied index is now lower than readState.Index' (duration: 42.28472ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:07:57.917001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.886515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:2643"} {"level":"info","ts":"2026-04-16T06:07:57.917069Z","caller":"traceutil/trace.go:171","msg":"trace[1358560332] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4607; }","duration":"131.983016ms","start":"2026-04-16T06:07:57.785067Z","end":"2026-04-16T06:07:57.91705Z","steps":["trace[1358560332] 'agreement among raft nodes before linearized reading' (duration: 131.786354ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:07:57.920049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.726364ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1821"} {"level":"info","ts":"2026-04-16T06:07:57.920123Z","caller":"traceutil/trace.go:171","msg":"trace[1713968134] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4608; }","duration":"122.846206ms","start":"2026-04-16T06:07:57.79726Z","end":"2026-04-16T06:07:57.920106Z","steps":["trace[1713968134] 'agreement among raft nodes before linearized reading' (duration: 122.652934ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:07:57.920374Z","caller":"traceutil/trace.go:171","msg":"trace[921817129] transaction","detail":"{read_only:false; response_revision:4608; number_of_response:1; }","duration":"132.500573ms","start":"2026-04-16T06:07:57.787862Z","end":"2026-04-16T06:07:57.920362Z","steps":["trace[921817129] 'process raft request' (duration: 131.961226ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:07:57.920484Z","caller":"traceutil/trace.go:171","msg":"trace[1659639137] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4607; }","duration":"135.365034ms","start":"2026-04-16T06:07:57.785093Z","end":"2026-04-16T06:07:57.920458Z","steps":["trace[1659639137] 'process raft request' (duration: 134.643285ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:08:04.083329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.490238ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-16T06:08:04.083436Z","caller":"traceutil/trace.go:171","msg":"trace[54434469] linearizableReadLoop","detail":"{readStateIndex:4896; appliedIndex:4895; }","duration":"173.522828ms","start":"2026-04-16T06:08:03.909898Z","end":"2026-04-16T06:08:04.08342Z","steps":["trace[54434469] 'read index received' (duration: 38.08µs)","trace[54434469] 'applied index is now lower than readState.Index' (duration: 173.483428ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:08:04.083761Z","caller":"traceutil/trace.go:171","msg":"trace[1865812043] transaction","detail":"{read_only:false; response_revision:4717; number_of_response:1; }","duration":"289.852934ms","start":"2026-04-16T06:08:03.793884Z","end":"2026-04-16T06:08:04.083737Z","steps":["trace[1865812043] 'process raft request' (duration: 35.86162ms)","trace[1865812043] 'compare' (duration: 253.291076ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:08:04.084305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.407617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2193165"} {"level":"info","ts":"2026-04-16T06:08:04.084384Z","caller":"traceutil/trace.go:171","msg":"trace[550766117] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4717; }","duration":"174.516959ms","start":"2026-04-16T06:08:03.909854Z","end":"2026-04-16T06:08:04.084371Z","steps":["trace[550766117] 'agreement among raft nodes before linearized reading' (duration: 173.609219ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:08:04.559348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.04769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T06:08:04.559359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.172108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:12975"} {"level":"info","ts":"2026-04-16T06:08:04.559437Z","caller":"traceutil/trace.go:171","msg":"trace[86431643] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:4722; }","duration":"113.235622ms","start":"2026-04-16T06:08:04.446184Z","end":"2026-04-16T06:08:04.559419Z","steps":["trace[86431643] 'count revisions from in-memory index tree' (duration: 112.948388ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:08:04.559563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.56337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-7546db9f59-fcw44.18a6c1573b0029d2\" ","response":"range_response_count:1 size:898"} {"level":"info","ts":"2026-04-16T06:08:04.559669Z","caller":"traceutil/trace.go:171","msg":"trace[579516012] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana-7546db9f59-fcw44.18a6c1573b0029d2; range_end:; response_count:1; response_revision:4722; }","duration":"107.729883ms","start":"2026-04-16T06:08:04.451917Z","end":"2026-04-16T06:08:04.559647Z","steps":["trace[579516012] 'range keys from in-memory index tree' (duration: 107.379378ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:08:04.55991Z","caller":"traceutil/trace.go:171","msg":"trace[1103731789] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4722; }","duration":"109.300569ms","start":"2026-04-16T06:08:04.450125Z","end":"2026-04-16T06:08:04.559426Z","steps":["trace[1103731789] 'range keys from in-memory index tree' (duration: 109.005916ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:08:04.679335Z","caller":"traceutil/trace.go:171","msg":"trace[1497875128] transaction","detail":"{read_only:false; response_revision:4726; number_of_response:1; }","duration":"100.038377ms","start":"2026-04-16T06:08:04.579256Z","end":"2026-04-16T06:08:04.679294Z","steps":["trace[1497875128] 'process raft request' (duration: 93.487416ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:08:04.749962Z","caller":"traceutil/trace.go:171","msg":"trace[1750878528] transaction","detail":"{read_only:false; response_revision:4727; number_of_response:1; }","duration":"116.570598ms","start":"2026-04-16T06:08:04.633376Z","end":"2026-04-16T06:08:04.749946Z","steps":["trace[1750878528] 'process raft request' (duration: 116.442527ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:08:04.750191Z","caller":"traceutil/trace.go:171","msg":"trace[849192928] transaction","detail":"{read_only:false; response_revision:4728; number_of_response:1; }","duration":"115.329875ms","start":"2026-04-16T06:08:04.634856Z","end":"2026-04-16T06:08:04.750186Z","steps":["trace[849192928] 'process raft request' (duration: 115.064012ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:08:04.750365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.385469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-c78c3f36-f0bc-4837-98e2-57627c7152b2\" ","response":"range_response_count:1 size:1450"} {"level":"info","ts":"2026-04-16T06:08:04.750384Z","caller":"traceutil/trace.go:171","msg":"trace[541435243] range","detail":"{range_begin:/registry/persistentvolumes/pvc-c78c3f36-f0bc-4837-98e2-57627c7152b2; range_end:; response_count:1; response_revision:4730; }","duration":"119.547521ms","start":"2026-04-16T06:08:04.630829Z","end":"2026-04-16T06:08:04.750377Z","steps":["trace[541435243] 'agreement among raft nodes before linearized reading' (duration: 119.44645ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:08:04.750469Z","caller":"traceutil/trace.go:171","msg":"trace[177724666] transaction","detail":"{read_only:false; response_revision:4730; number_of_response:1; }","duration":"112.909679ms","start":"2026-04-16T06:08:04.637555Z","end":"2026-04-16T06:08:04.750464Z","steps":["trace[177724666] 'process raft request' (duration: 112.678427ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:08:04.750472Z","caller":"traceutil/trace.go:171","msg":"trace[1013744278] transaction","detail":"{read_only:false; response_revision:4729; number_of_response:1; }","duration":"113.00657ms","start":"2026-04-16T06:08:04.637449Z","end":"2026-04-16T06:08:04.750456Z","steps":["trace[1013744278] 'process raft request' (duration: 112.628636ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:08:17.919977Z","caller":"traceutil/trace.go:171","msg":"trace[919778208] linearizableReadLoop","detail":"{readStateIndex:5087; appliedIndex:5086; }","duration":"334.995914ms","start":"2026-04-16T06:08:17.584953Z","end":"2026-04-16T06:08:17.919949Z","steps":["trace[919778208] 'read index received' (duration: 334.851513ms)","trace[919778208] 'applied index is now lower than readState.Index' (duration: 143.241µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:08:17.920119Z","caller":"traceutil/trace.go:171","msg":"trace[18909800] transaction","detail":"{read_only:false; response_revision:4902; number_of_response:1; }","duration":"339.685824ms","start":"2026-04-16T06:08:17.580374Z","end":"2026-04-16T06:08:17.92006Z","steps":["trace[18909800] 'process raft request' (duration: 339.361431ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:08:17.920289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:08:17.580357Z","time spent":"339.828306ms","remote":"127.0.0.1:33744","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":13860,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T06:08:17.920377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.398568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-04-16T06:08:17.920465Z","caller":"traceutil/trace.go:171","msg":"trace[334628735] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4902; }","duration":"335.539109ms","start":"2026-04-16T06:08:17.584902Z","end":"2026-04-16T06:08:17.920441Z","steps":["trace[334628735] 'agreement among raft nodes before linearized reading' (duration: 335.183015ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:08:17.920527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:08:17.584876Z","time spent":"335.63736ms","remote":"127.0.0.1:33716","response type":"/etcdserverpb.KV/Range","request count":0,"request size":147,"response count":1,"response size":1958,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" "} {"level":"warn","ts":"2026-04-16T06:08:17.930082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.05159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:08:17.930174Z","caller":"traceutil/trace.go:171","msg":"trace[793234482] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:4903; }","duration":"274.192762ms","start":"2026-04-16T06:08:17.655958Z","end":"2026-04-16T06:08:17.930151Z","steps":["trace[793234482] 'agreement among raft nodes before linearized reading' (duration: 274.04523ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:08:17.930414Z","caller":"traceutil/trace.go:171","msg":"trace[1805038417] transaction","detail":"{read_only:false; response_revision:4903; number_of_response:1; }","duration":"144.489862ms","start":"2026-04-16T06:08:17.785911Z","end":"2026-04-16T06:08:17.930401Z","steps":["trace[1805038417] 'process raft request' (duration: 143.916485ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:08:56.719219Z","caller":"traceutil/trace.go:171","msg":"trace[1527872202] transaction","detail":"{read_only:false; response_revision:5240; number_of_response:1; }","duration":"103.761367ms","start":"2026-04-16T06:08:56.615432Z","end":"2026-04-16T06:08:56.719193Z","steps":["trace[1527872202] 'process raft request' (duration: 77.841726ms)","trace[1527872202] 'compare' (duration: 25.81843ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:08:58.704056Z","caller":"traceutil/trace.go:171","msg":"trace[224997063] transaction","detail":"{read_only:false; response_revision:5249; number_of_response:1; }","duration":"121.805674ms","start":"2026-04-16T06:08:58.582235Z","end":"2026-04-16T06:08:58.70404Z","steps":["trace[224997063] 'process raft request' (duration: 121.710953ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:09:51.585013Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2921} {"level":"info","ts":"2026-04-16T06:09:51.672126Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2921,"took":"85.292877ms","hash":1103141399,"current-db-size-bytes":53297152,"current-db-size":"53 MB","current-db-size-in-use-bytes":29675520,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-04-16T06:09:51.672266Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1103141399,"revision":2921,"compact-revision":-1} {"level":"info","ts":"2026-04-16T06:12:58.115793Z","caller":"traceutil/trace.go:171","msg":"trace[1337091589] transaction","detail":"{read_only:false; response_revision:6866; number_of_response:1; }","duration":"134.916845ms","start":"2026-04-16T06:12:57.980853Z","end":"2026-04-16T06:12:58.11577Z","steps":["trace[1337091589] 'process raft request' (duration: 110.410448ms)","trace[1337091589] 'compare' (duration: 24.286205ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:14:51.591353Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5662} {"level":"info","ts":"2026-04-16T06:14:51.674165Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5662,"took":"81.276362ms","hash":3936295169,"current-db-size-bytes":53297152,"current-db-size":"53 MB","current-db-size-in-use-bytes":18210816,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-04-16T06:14:51.674322Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3936295169,"revision":5662,"compact-revision":2921}