{"level":"warn","ts":"2026-09-18T01:30:31.711701Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-18T01:30:31.711794Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.59:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.59:2380","--initial-cluster=instance=https://162.253.55.59:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.59:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.59: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-09-18T01:30:31.711849Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-18T01:30:31.711914Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.59:2380"]} {"level":"info","ts":"2026-09-18T01:30:31.711938Z","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-09-18T01:30:31.712519Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.59:2379"]} {"level":"info","ts":"2026-09-18T01:30:31.71261Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.59:2380"],"listen-peer-urls":["https://162.253.55.59:2380"],"advertise-client-urls":["https://162.253.55.59:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.59:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.59: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-09-18T01:30:31.717974Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.14218ms"} {"level":"info","ts":"2026-09-18T01:30:31.729272Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f5132dc9ac390b66","cluster-id":"458d1cb56ab56fc4"} {"level":"info","ts":"2026-09-18T01:30:31.729354Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f5132dc9ac390b66 switched to configuration voters=()"} {"level":"info","ts":"2026-09-18T01:30:31.729373Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f5132dc9ac390b66 became follower at term 0"} {"level":"info","ts":"2026-09-18T01:30:31.729389Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f5132dc9ac390b66 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-18T01:30:31.729398Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f5132dc9ac390b66 became follower at term 1"} {"level":"info","ts":"2026-09-18T01:30:31.729472Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f5132dc9ac390b66 switched to configuration voters=(17659508908050942822)"} {"level":"warn","ts":"2026-09-18T01:30:31.743171Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-18T01:30:31.750307Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-18T01:30:31.751605Z","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-09-18T01:30:31.75394Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f5132dc9ac390b66","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-18T01:30:31.754092Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f5132dc9ac390b66","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-18T01:30:31.754201Z","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-09-18T01:30:31.754292Z","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-09-18T01:30:31.754305Z","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-09-18T01:30:31.75952Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f5132dc9ac390b66 switched to configuration voters=(17659508908050942822)"} {"level":"info","ts":"2026-09-18T01:30:31.761091Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"458d1cb56ab56fc4","local-member-id":"f5132dc9ac390b66","added-peer-id":"f5132dc9ac390b66","added-peer-peer-urls":["https://162.253.55.59:2380"]} {"level":"info","ts":"2026-09-18T01:30:31.762625Z","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-09-18T01:30:31.762805Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.59:2380"} {"level":"info","ts":"2026-09-18T01:30:31.762885Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.59:2380"} {"level":"info","ts":"2026-09-18T01:30:31.762894Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f5132dc9ac390b66","initial-advertise-peer-urls":["https://162.253.55.59:2380"],"listen-peer-urls":["https://162.253.55.59:2380"],"advertise-client-urls":["https://162.253.55.59:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.59:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-18T01:30:31.762938Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-18T01:30:32.430188Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f5132dc9ac390b66 is starting a new election at term 1"} {"level":"info","ts":"2026-09-18T01:30:32.430247Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f5132dc9ac390b66 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-18T01:30:32.430286Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f5132dc9ac390b66 received MsgPreVoteResp from f5132dc9ac390b66 at term 1"} {"level":"info","ts":"2026-09-18T01:30:32.430304Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f5132dc9ac390b66 became candidate at term 2"} {"level":"info","ts":"2026-09-18T01:30:32.430314Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f5132dc9ac390b66 received MsgVoteResp from f5132dc9ac390b66 at term 2"} {"level":"info","ts":"2026-09-18T01:30:32.430328Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f5132dc9ac390b66 became leader at term 2"} {"level":"info","ts":"2026-09-18T01:30:32.43034Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f5132dc9ac390b66 elected leader f5132dc9ac390b66 at term 2"} {"level":"info","ts":"2026-09-18T01:30:32.431528Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T01:30:32.4334Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"458d1cb56ab56fc4","local-member-id":"f5132dc9ac390b66","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T01:30:32.4335Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T01:30:32.433527Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T01:30:32.433562Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f5132dc9ac390b66","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.59:2379]}","request-path":"/0/members/f5132dc9ac390b66/attributes","cluster-id":"458d1cb56ab56fc4","publish-timeout":"7s"} {"level":"info","ts":"2026-09-18T01:30:32.433864Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-18T01:30:32.434235Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-18T01:30:32.434427Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-18T01:30:32.434444Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-18T01:30:32.436753Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.59:2379"} {"level":"info","ts":"2026-09-18T01:30:32.438534Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-09-18T01:30:35.336979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.223092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-18T01:30:35.337122Z","caller":"traceutil/trace.go:171","msg":"trace[67991691] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:120; }","duration":"347.447287ms","start":"2026-09-18T01:30:34.989648Z","end":"2026-09-18T01:30:35.337096Z","steps":["trace[67991691] 'range keys from in-memory index tree' (duration: 347.09804ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:30:35.337199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T01:30:34.989625Z","time spent":"347.559119ms","remote":"127.0.0.1:35298","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-09-18T01:30:35.337211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.904135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:monitoring\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-18T01:30:35.337323Z","caller":"traceutil/trace.go:171","msg":"trace[338072479] range","detail":"{range_begin:/registry/clusterroles/system:monitoring; range_end:; response_count:0; response_revision:120; }","duration":"367.040479ms","start":"2026-09-18T01:30:34.970258Z","end":"2026-09-18T01:30:35.337299Z","steps":["trace[338072479] 'range keys from in-memory index tree' (duration: 366.782013ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:30:35.337376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T01:30:34.970199Z","time spent":"367.167731ms","remote":"127.0.0.1:35646","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":27,"request content":"key:\"/registry/clusterroles/system:monitoring\" "} {"level":"info","ts":"2026-09-18T01:30:35.891806Z","caller":"traceutil/trace.go:171","msg":"trace[620428245] transaction","detail":"{read_only:false; response_revision:121; number_of_response:1; }","duration":"550.419485ms","start":"2026-09-18T01:30:35.341362Z","end":"2026-09-18T01:30:35.891781Z","steps":["trace[620428245] 'process raft request' (duration: 550.275481ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:30:35.892416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T01:30:35.341339Z","time spent":"550.556527ms","remote":"127.0.0.1:35646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":621,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-18T01:30:36.303254Z","caller":"traceutil/trace.go:171","msg":"trace[1896092339] linearizableReadLoop","detail":"{readStateIndex:127; appliedIndex:126; }","duration":"407.862263ms","start":"2026-09-18T01:30:35.895355Z","end":"2026-09-18T01:30:36.303218Z","steps":["trace[1896092339] 'read index received' (duration: 407.492015ms)","trace[1896092339] 'applied index is now lower than readState.Index' (duration: 368.938µs)"],"step_count":2} {"level":"warn","ts":"2026-09-18T01:30:36.303473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.107879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:basic-user\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-18T01:30:36.303509Z","caller":"traceutil/trace.go:171","msg":"trace[767340632] range","detail":"{range_begin:/registry/clusterroles/system:basic-user; range_end:; response_count:0; response_revision:122; }","duration":"408.211011ms","start":"2026-09-18T01:30:35.895286Z","end":"2026-09-18T01:30:36.303497Z","steps":["trace[767340632] 'agreement among raft nodes before linearized reading' (duration: 408.067297ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:30:36.303541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T01:30:35.895263Z","time spent":"408.271422ms","remote":"127.0.0.1:35646","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":27,"request content":"key:\"/registry/clusterroles/system:basic-user\" "} {"level":"info","ts":"2026-09-18T01:30:36.303614Z","caller":"traceutil/trace.go:171","msg":"trace[1717323767] transaction","detail":"{read_only:false; response_revision:122; number_of_response:1; }","duration":"411.288635ms","start":"2026-09-18T01:30:35.892182Z","end":"2026-09-18T01:30:36.30347Z","steps":["trace[1717323767] 'process raft request' (duration: 410.636951ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:30:36.303977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T01:30:35.892167Z","time spent":"411.662053ms","remote":"127.0.0.1:35484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5877,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-18T01:30:36.311348Z","caller":"traceutil/trace.go:171","msg":"trace[577124807] transaction","detail":"{read_only:false; response_revision:123; number_of_response:1; }","duration":"404.130395ms","start":"2026-09-18T01:30:35.907203Z","end":"2026-09-18T01:30:36.311333Z","steps":["trace[577124807] 'process raft request' (duration: 404.035293ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:30:36.311475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T01:30:35.907177Z","time spent":"404.229906ms","remote":"127.0.0.1:35484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5498,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-18T01:30:36.311743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.71677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:430"} {"level":"warn","ts":"2026-09-18T01:30:36.311744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.358274ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-09-18T01:30:36.311802Z","caller":"traceutil/trace.go:171","msg":"trace[843442033] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:123; }","duration":"268.823284ms","start":"2026-09-18T01:30:36.042961Z","end":"2026-09-18T01:30:36.311785Z","steps":["trace[843442033] 'agreement among raft nodes before linearized reading' (duration: 268.500936ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:30:36.311845Z","caller":"traceutil/trace.go:171","msg":"trace[1579976278] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:123; }","duration":"269.562369ms","start":"2026-09-18T01:30:36.042257Z","end":"2026-09-18T01:30:36.31182Z","steps":["trace[1579976278] 'agreement among raft nodes before linearized reading' (duration: 269.227972ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:30:36.312306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.931919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-18T01:30:36.312361Z","caller":"traceutil/trace.go:171","msg":"trace[1149540917] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:123; }","duration":"322.053551ms","start":"2026-09-18T01:30:35.990291Z","end":"2026-09-18T01:30:36.312345Z","steps":["trace[1149540917] 'agreement among raft nodes before linearized reading' (duration: 321.07773ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:30:36.312389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T01:30:35.990256Z","time spent":"322.125793ms","remote":"127.0.0.1:35298","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-09-18T01:31:32.486093Z","caller":"traceutil/trace.go:171","msg":"trace[848678265] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"266.779028ms","start":"2026-09-18T01:31:32.219278Z","end":"2026-09-18T01:31:32.486057Z","steps":["trace[848678265] 'process raft request' (duration: 266.634296ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:31:32.493281Z","caller":"traceutil/trace.go:171","msg":"trace[861712056] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"106.362904ms","start":"2026-09-18T01:31:32.38691Z","end":"2026-09-18T01:31:32.493273Z","steps":["trace[861712056] 'process raft request' (duration: 106.215001ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:31:32.493236Z","caller":"traceutil/trace.go:171","msg":"trace[965610122] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"113.494793ms","start":"2026-09-18T01:31:32.37972Z","end":"2026-09-18T01:31:32.493215Z","steps":["trace[965610122] 'process raft request' (duration: 113.192468ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:31:32.493603Z","caller":"traceutil/trace.go:171","msg":"trace[1778847941] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"102.136423ms","start":"2026-09-18T01:31:32.391458Z","end":"2026-09-18T01:31:32.493594Z","steps":["trace[1778847941] 'process raft request' (duration: 101.709605ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:31:32.796115Z","caller":"traceutil/trace.go:171","msg":"trace[383770171] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"110.556874ms","start":"2026-09-18T01:31:32.685539Z","end":"2026-09-18T01:31:32.796096Z","steps":["trace[383770171] 'process raft request' (duration: 104.746956ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:31:32.796947Z","caller":"traceutil/trace.go:171","msg":"trace[1164088605] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"110.998411ms","start":"2026-09-18T01:31:32.685918Z","end":"2026-09-18T01:31:32.796917Z","steps":["trace[1164088605] 'process raft request' (duration: 110.854808ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:31:32.797201Z","caller":"traceutil/trace.go:171","msg":"trace[1034462480] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"103.809711ms","start":"2026-09-18T01:31:32.693369Z","end":"2026-09-18T01:31:32.797178Z","steps":["trace[1034462480] 'process raft request' (duration: 103.479526ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:31:38.251092Z","caller":"traceutil/trace.go:171","msg":"trace[1760150810] transaction","detail":"{read_only:false; response_revision:684; number_of_response:1; }","duration":"310.105552ms","start":"2026-09-18T01:31:37.940965Z","end":"2026-09-18T01:31:38.251071Z","steps":["trace[1760150810] 'process raft request' (duration: 309.297929ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:31:38.251324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T01:31:37.940937Z","time spent":"310.208075ms","remote":"127.0.0.1:35386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036261,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T01:31:39.018148Z","caller":"traceutil/trace.go:171","msg":"trace[1394901052] transaction","detail":"{read_only:false; response_revision:691; number_of_response:1; }","duration":"162.292434ms","start":"2026-09-18T01:31:38.855823Z","end":"2026-09-18T01:31:39.018116Z","steps":["trace[1394901052] 'process raft request' (duration: 154.251812ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:31:39.038071Z","caller":"traceutil/trace.go:171","msg":"trace[491543597] transaction","detail":"{read_only:false; response_revision:692; number_of_response:1; }","duration":"180.39841ms","start":"2026-09-18T01:31:38.857655Z","end":"2026-09-18T01:31:39.038053Z","steps":["trace[491543597] 'process raft request' (duration: 180.157256ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:31:39.038109Z","caller":"traceutil/trace.go:171","msg":"trace[1941222872] transaction","detail":"{read_only:false; response_revision:693; number_of_response:1; }","duration":"115.371513ms","start":"2026-09-18T01:31:38.922716Z","end":"2026-09-18T01:31:39.038088Z","steps":["trace[1941222872] 'process raft request' (duration: 115.17544ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:31:39.891619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.197131ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-18T01:31:39.892072Z","caller":"traceutil/trace.go:171","msg":"trace[601763730] transaction","detail":"{read_only:false; response_revision:694; number_of_response:1; }","duration":"832.748025ms","start":"2026-09-18T01:31:39.059284Z","end":"2026-09-18T01:31:39.892032Z","steps":["trace[601763730] 'process raft request' (duration: 461.872102ms)","trace[601763730] 'compare' (duration: 369.947148ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T01:31:39.892144Z","caller":"traceutil/trace.go:171","msg":"trace[2040984664] linearizableReadLoop","detail":"{readStateIndex:724; appliedIndex:723; }","duration":"752.036673ms","start":"2026-09-18T01:31:39.140072Z","end":"2026-09-18T01:31:39.892109Z","steps":["trace[2040984664] 'read index received' (duration: 381.451275ms)","trace[2040984664] 'applied index is now lower than readState.Index' (duration: 370.580248ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T01:31:39.892254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T01:31:39.059259Z","time spent":"832.917297ms","remote":"127.0.0.1:35484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T01:31:39.892458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"752.345398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-18T01:31:39.892504Z","caller":"traceutil/trace.go:171","msg":"trace[1141141900] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:694; }","duration":"752.435679ms","start":"2026-09-18T01:31:39.140054Z","end":"2026-09-18T01:31:39.892489Z","steps":["trace[1141141900] 'agreement among raft nodes before linearized reading' (duration: 752.278827ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:31:39.892582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T01:31:39.139969Z","time spent":"752.598321ms","remote":"127.0.0.1:35782","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":1,"response size":30,"request content":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-09-18T01:31:39.892914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.821215ms","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-09-18T01:31:39.893007Z","caller":"traceutil/trace.go:171","msg":"trace[1802063255] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:695; }","duration":"212.930747ms","start":"2026-09-18T01:31:39.680033Z","end":"2026-09-18T01:31:39.892964Z","steps":["trace[1802063255] 'agreement among raft nodes before linearized reading' (duration: 212.730834ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:31:39.893074Z","caller":"traceutil/trace.go:171","msg":"trace[1960897049] transaction","detail":"{read_only:false; response_revision:695; number_of_response:1; }","duration":"437.461912ms","start":"2026-09-18T01:31:39.455598Z","end":"2026-09-18T01:31:39.89306Z","steps":["trace[1960897049] 'process raft request' (duration: 436.498407ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:31:39.893286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T01:31:39.455571Z","time spent":"437.575514ms","remote":"127.0.0.1:35386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036313,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T01:31:56.501656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.876957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-2kscc\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-09-18T01:31:56.501884Z","caller":"traceutil/trace.go:171","msg":"trace[1091884205] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-2kscc; range_end:; response_count:1; response_revision:860; }","duration":"437.186421ms","start":"2026-09-18T01:31:56.064672Z","end":"2026-09-18T01:31:56.501858Z","steps":["trace[1091884205] 'range keys from in-memory index tree' (duration: 436.636832ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:31:56.501974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T01:31:56.064656Z","time spent":"437.304144ms","remote":"127.0.0.1:35484","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3987,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-2kscc\" "} {"level":"warn","ts":"2026-09-18T01:32:44.92745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.757144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-18T01:32:44.927547Z","caller":"traceutil/trace.go:171","msg":"trace[233269431] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1404; }","duration":"111.878766ms","start":"2026-09-18T01:32:44.815647Z","end":"2026-09-18T01:32:44.927526Z","steps":["trace[233269431] 'count revisions from in-memory index tree' (duration: 111.607821ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:33:19.043801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.55687ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-18T01:33:19.043984Z","caller":"traceutil/trace.go:171","msg":"trace[673559503] linearizableReadLoop","detail":"{readStateIndex:2040; appliedIndex:2039; }","duration":"253.552381ms","start":"2026-09-18T01:33:18.790411Z","end":"2026-09-18T01:33:19.043963Z","steps":["trace[673559503] 'read index received' (duration: 51.842µs)","trace[673559503] 'applied index is now lower than readState.Index' (duration: 253.498949ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T01:33:19.044079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.678917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T01:33:19.044143Z","caller":"traceutil/trace.go:171","msg":"trace[1234652777] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1961; }","duration":"253.786943ms","start":"2026-09-18T01:33:18.790343Z","end":"2026-09-18T01:33:19.04413Z","steps":["trace[1234652777] 'agreement among raft nodes before linearized reading' (duration: 253.674668ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:33:19.044406Z","caller":"traceutil/trace.go:171","msg":"trace[1735674354] transaction","detail":"{read_only:false; response_revision:1961; number_of_response:1; }","duration":"413.635373ms","start":"2026-09-18T01:33:18.630751Z","end":"2026-09-18T01:33:19.044386Z","steps":["trace[1735674354] 'process raft request' (duration: 83.373986ms)","trace[1735674354] 'compare' (duration: 329.054293ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T01:33:19.044499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T01:33:18.630724Z","time spent":"413.727618ms","remote":"127.0.0.1:35580","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T01:33:19.079747Z","caller":"traceutil/trace.go:171","msg":"trace[229626403] transaction","detail":"{read_only:false; response_revision:1962; number_of_response:1; }","duration":"288.685305ms","start":"2026-09-18T01:33:18.791038Z","end":"2026-09-18T01:33:19.079723Z","steps":["trace[229626403] 'process raft request' (duration: 288.562428ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:33:31.971768Z","caller":"traceutil/trace.go:171","msg":"trace[196597430] linearizableReadLoop","detail":"{readStateIndex:2149; appliedIndex:2147; }","duration":"283.331227ms","start":"2026-09-18T01:33:31.688405Z","end":"2026-09-18T01:33:31.971736Z","steps":["trace[196597430] 'read index received' (duration: 22.04455ms)","trace[196597430] 'applied index is now lower than readState.Index' (duration: 261.285207ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T01:33:31.971982Z","caller":"traceutil/trace.go:171","msg":"trace[2099035911] transaction","detail":"{read_only:false; response_revision:2067; number_of_response:1; }","duration":"284.059732ms","start":"2026-09-18T01:33:31.687902Z","end":"2026-09-18T01:33:31.971961Z","steps":["trace[2099035911] 'process raft request' (duration: 267.144407ms)","trace[2099035911] 'compare' (duration: 16.460833ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T01:33:31.97202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.58573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T01:33:31.972079Z","caller":"traceutil/trace.go:171","msg":"trace[1129871071] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2067; }","duration":"283.703805ms","start":"2026-09-18T01:33:31.688358Z","end":"2026-09-18T01:33:31.972061Z","steps":["trace[1129871071] 'agreement among raft nodes before linearized reading' (duration: 283.585579ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:33:31.97895Z","caller":"traceutil/trace.go:171","msg":"trace[1402393051] transaction","detail":"{read_only:false; response_revision:2069; number_of_response:1; }","duration":"149.274434ms","start":"2026-09-18T01:33:31.829653Z","end":"2026-09-18T01:33:31.978928Z","steps":["trace[1402393051] 'process raft request' (duration: 148.39254ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:33:31.979123Z","caller":"traceutil/trace.go:171","msg":"trace[755084603] transaction","detail":"{read_only:false; response_revision:2068; number_of_response:1; }","duration":"200.558937ms","start":"2026-09-18T01:33:31.778528Z","end":"2026-09-18T01:33:31.979087Z","steps":["trace[755084603] 'process raft request' (duration: 199.381429ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:33:32.154123Z","caller":"traceutil/trace.go:171","msg":"trace[908908114] transaction","detail":"{read_only:false; response_revision:2073; number_of_response:1; }","duration":"128.34892ms","start":"2026-09-18T01:33:32.02574Z","end":"2026-09-18T01:33:32.154089Z","steps":["trace[908908114] 'process raft request' (duration: 70.79345ms)","trace[908908114] 'compare' (duration: 57.465075ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T01:33:32.159464Z","caller":"traceutil/trace.go:171","msg":"trace[1197832351] transaction","detail":"{read_only:false; response_revision:2075; number_of_response:1; }","duration":"132.782147ms","start":"2026-09-18T01:33:32.026657Z","end":"2026-09-18T01:33:32.159439Z","steps":["trace[1197832351] 'process raft request' (duration: 132.6385ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:33:32.159515Z","caller":"traceutil/trace.go:171","msg":"trace[123567027] transaction","detail":"{read_only:false; response_revision:2074; number_of_response:1; }","duration":"133.732054ms","start":"2026-09-18T01:33:32.025758Z","end":"2026-09-18T01:33:32.15949Z","steps":["trace[123567027] 'process raft request' (duration: 133.44294ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:33:32.159517Z","caller":"traceutil/trace.go:171","msg":"trace[1428263739] transaction","detail":"{read_only:false; response_revision:2076; number_of_response:1; }","duration":"132.566147ms","start":"2026-09-18T01:33:32.026933Z","end":"2026-09-18T01:33:32.159499Z","steps":["trace[1428263739] 'process raft request' (duration: 132.408169ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:33:32.160318Z","caller":"traceutil/trace.go:171","msg":"trace[2020499546] transaction","detail":"{read_only:false; response_revision:2077; number_of_response:1; }","duration":"130.484493ms","start":"2026-09-18T01:33:32.029814Z","end":"2026-09-18T01:33:32.160298Z","steps":["trace[2020499546] 'process raft request' (duration: 129.574099ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:33:35.362577Z","caller":"traceutil/trace.go:171","msg":"trace[1904233565] transaction","detail":"{read_only:false; response_revision:2094; number_of_response:1; }","duration":"263.519044ms","start":"2026-09-18T01:33:35.09903Z","end":"2026-09-18T01:33:35.362549Z","steps":["trace[1904233565] 'process raft request' (duration: 263.336845ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:33:35.402351Z","caller":"traceutil/trace.go:171","msg":"trace[582888190] linearizableReadLoop","detail":"{readStateIndex:2178; appliedIndex:2176; }","duration":"167.4193ms","start":"2026-09-18T01:33:35.234842Z","end":"2026-09-18T01:33:35.402262Z","steps":["trace[582888190] 'read index received' (duration: 127.595721ms)","trace[582888190] 'applied index is now lower than readState.Index' (duration: 39.822389ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T01:33:35.402591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.744316ms","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-09-18T01:33:35.402634Z","caller":"traceutil/trace.go:171","msg":"trace[1013184739] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2096; }","duration":"167.861721ms","start":"2026-09-18T01:33:35.234761Z","end":"2026-09-18T01:33:35.402622Z","steps":["trace[1013184739] 'agreement among raft nodes before linearized reading' (duration: 167.717525ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:33:35.402697Z","caller":"traceutil/trace.go:171","msg":"trace[441006014] transaction","detail":"{read_only:false; response_revision:2095; number_of_response:1; }","duration":"270.65711ms","start":"2026-09-18T01:33:35.132021Z","end":"2026-09-18T01:33:35.402678Z","steps":["trace[441006014] 'process raft request' (duration: 270.042681ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:33:58.031989Z","caller":"traceutil/trace.go:171","msg":"trace[222097590] transaction","detail":"{read_only:false; response_revision:2224; number_of_response:1; }","duration":"191.329879ms","start":"2026-09-18T01:33:57.840633Z","end":"2026-09-18T01:33:58.031963Z","steps":["trace[222097590] 'process raft request' (duration: 145.590187ms)","trace[222097590] 'compare' (duration: 45.543543ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T01:33:59.747091Z","caller":"traceutil/trace.go:171","msg":"trace[52497645] transaction","detail":"{read_only:false; response_revision:2229; number_of_response:1; }","duration":"300.270912ms","start":"2026-09-18T01:33:59.446795Z","end":"2026-09-18T01:33:59.747066Z","steps":["trace[52497645] 'process raft request' (duration: 300.086464ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:33:59.747333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T01:33:59.44678Z","time spent":"300.420069ms","remote":"127.0.0.1:35580","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T01:33:59.86019Z","caller":"traceutil/trace.go:171","msg":"trace[1867810712] transaction","detail":"{read_only:false; response_revision:2231; number_of_response:1; }","duration":"374.615879ms","start":"2026-09-18T01:33:59.485548Z","end":"2026-09-18T01:33:59.860164Z","steps":["trace[1867810712] 'process raft request' (duration: 374.42121ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:33:59.860344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T01:33:59.48552Z","time spent":"374.740264ms","remote":"127.0.0.1:35580","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T01:33:59.860363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.648223ms","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-09-18T01:33:59.860174Z","caller":"traceutil/trace.go:171","msg":"trace[827160661] transaction","detail":"{read_only:false; response_revision:2230; number_of_response:1; }","duration":"381.305208ms","start":"2026-09-18T01:33:59.478832Z","end":"2026-09-18T01:33:59.860137Z","steps":["trace[827160661] 'process raft request' (duration: 338.607711ms)","trace[827160661] 'compare' (duration: 42.194465ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T01:33:59.860398Z","caller":"traceutil/trace.go:171","msg":"trace[1928914292] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2231; }","duration":"329.720906ms","start":"2026-09-18T01:33:59.530667Z","end":"2026-09-18T01:33:59.860388Z","steps":["trace[1928914292] 'agreement among raft nodes before linearized reading' (duration: 329.57363ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:33:59.860516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T01:33:59.530654Z","time spent":"329.850012ms","remote":"127.0.0.1:35580","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-09-18T01:33:59.860542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T01:33:59.478818Z","time spent":"381.59528ms","remote":"127.0.0.1:35580","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-09-18T01:33:59.860205Z","caller":"traceutil/trace.go:171","msg":"trace[107261250] linearizableReadLoop","detail":"{readStateIndex:2320; appliedIndex:2317; }","duration":"329.249285ms","start":"2026-09-18T01:33:59.530938Z","end":"2026-09-18T01:33:59.860187Z","steps":["trace[107261250] 'read index received' (duration: 215.908301ms)","trace[107261250] 'applied index is now lower than readState.Index' (duration: 113.339604ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T01:33:59.861372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.243267ms","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-09-18T01:33:59.86144Z","caller":"traceutil/trace.go:171","msg":"trace[179198043] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2231; }","duration":"247.351572ms","start":"2026-09-18T01:33:59.614066Z","end":"2026-09-18T01:33:59.861417Z","steps":["trace[179198043] 'agreement among raft nodes before linearized reading' (duration: 246.744275ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:34:00.235617Z","caller":"traceutil/trace.go:171","msg":"trace[194456485] transaction","detail":"{read_only:false; response_revision:2234; number_of_response:1; }","duration":"101.674199ms","start":"2026-09-18T01:34:00.133918Z","end":"2026-09-18T01:34:00.235593Z","steps":["trace[194456485] 'process raft request' (duration: 101.597606ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:34:00.235756Z","caller":"traceutil/trace.go:171","msg":"trace[1043019551] transaction","detail":"{read_only:false; response_revision:2233; number_of_response:1; }","duration":"369.639908ms","start":"2026-09-18T01:33:59.866088Z","end":"2026-09-18T01:34:00.235728Z","steps":["trace[1043019551] 'process raft request' (duration: 269.62121ms)","trace[1043019551] 'compare' (duration: 99.668443ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T01:34:00.235776Z","caller":"traceutil/trace.go:171","msg":"trace[1899323287] linearizableReadLoop","detail":"{readStateIndex:2322; appliedIndex:2321; }","duration":"199.779785ms","start":"2026-09-18T01:34:00.035968Z","end":"2026-09-18T01:34:00.235748Z","steps":["trace[1899323287] 'read index received' (duration: 99.808588ms)","trace[1899323287] 'applied index is now lower than readState.Index' (duration: 99.968607ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T01:34:00.23592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T01:33:59.86607Z","time spent":"369.748283ms","remote":"127.0.0.1:35580","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T01:34:00.236165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.196723ms","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-09-18T01:34:00.236224Z","caller":"traceutil/trace.go:171","msg":"trace[1147176287] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2234; }","duration":"200.295886ms","start":"2026-09-18T01:34:00.035911Z","end":"2026-09-18T01:34:00.236207Z","steps":["trace[1147176287] 'agreement among raft nodes before linearized reading' (duration: 200.037975ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:34:49.493587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.901798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5651"} {"level":"info","ts":"2026-09-18T01:34:49.493651Z","caller":"traceutil/trace.go:171","msg":"trace[1631157743] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2548; }","duration":"132.004372ms","start":"2026-09-18T01:34:49.361633Z","end":"2026-09-18T01:34:49.493637Z","steps":["trace[1631157743] 'range keys from in-memory index tree' (duration: 131.760324ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:35:31.088137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.277655ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-18T01:35:31.088261Z","caller":"traceutil/trace.go:171","msg":"trace[1726350906] linearizableReadLoop","detail":"{readStateIndex:2937; appliedIndex:2936; }","duration":"472.924578ms","start":"2026-09-18T01:35:30.615321Z","end":"2026-09-18T01:35:31.088246Z","steps":["trace[1726350906] 'read index received' (duration: 369.412587ms)","trace[1726350906] 'applied index is now lower than readState.Index' (duration: 103.510981ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T01:35:31.08843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.085803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T01:35:31.08852Z","caller":"traceutil/trace.go:171","msg":"trace[1731089843] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:2828; }","duration":"473.219167ms","start":"2026-09-18T01:35:30.615282Z","end":"2026-09-18T01:35:31.088501Z","steps":["trace[1731089843] 'agreement among raft nodes before linearized reading' (duration: 473.078583ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:35:31.088571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T01:35:30.615262Z","time spent":"473.29407ms","remote":"127.0.0.1:35690","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":28,"request content":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true "} {"level":"warn","ts":"2026-09-18T01:35:31.088588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.881268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-09-18T01:35:31.088621Z","caller":"traceutil/trace.go:171","msg":"trace[1021321992] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2828; }","duration":"381.948561ms","start":"2026-09-18T01:35:30.706662Z","end":"2026-09-18T01:35:31.088611Z","steps":["trace[1021321992] 'agreement among raft nodes before linearized reading' (duration: 381.833597ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:35:31.088652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T01:35:30.706644Z","time spent":"382.001423ms","remote":"127.0.0.1:35580","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-09-18T01:35:31.088826Z","caller":"traceutil/trace.go:171","msg":"trace[1733707769] transaction","detail":"{read_only:false; response_revision:2828; number_of_response:1; }","duration":"525.569456ms","start":"2026-09-18T01:35:30.563236Z","end":"2026-09-18T01:35:31.088805Z","steps":["trace[1733707769] 'process raft request' (duration: 421.553288ms)","trace[1733707769] 'compare' (duration: 103.164762ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T01:35:31.088932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T01:35:30.563213Z","time spent":"525.664898ms","remote":"127.0.0.1:35580","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T01:35:31.088944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.765871ms","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-09-18T01:35:31.088994Z","caller":"traceutil/trace.go:171","msg":"trace[1531673130] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2828; }","duration":"371.818182ms","start":"2026-09-18T01:35:30.717165Z","end":"2026-09-18T01:35:31.088983Z","steps":["trace[1531673130] 'agreement among raft nodes before linearized reading' (duration: 371.694969ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:35:31.08902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T01:35:30.717111Z","time spent":"371.902155ms","remote":"127.0.0.1:35580","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-09-18T01:35:31.088823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.825035ms","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-09-18T01:35:31.089141Z","caller":"traceutil/trace.go:171","msg":"trace[1607173338] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2828; }","duration":"243.126084ms","start":"2026-09-18T01:35:30.845938Z","end":"2026-09-18T01:35:31.089064Z","steps":["trace[1607173338] 'agreement among raft nodes before linearized reading' (duration: 242.745342ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:35:36.410473Z","caller":"traceutil/trace.go:171","msg":"trace[1924897455] transaction","detail":"{read_only:false; response_revision:2856; number_of_response:1; }","duration":"146.116558ms","start":"2026-09-18T01:35:36.264334Z","end":"2026-09-18T01:35:36.41045Z","steps":["trace[1924897455] 'process raft request' (duration: 145.974853ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:35:36.718313Z","caller":"traceutil/trace.go:171","msg":"trace[2069254915] linearizableReadLoop","detail":"{readStateIndex:2969; appliedIndex:2968; }","duration":"215.760265ms","start":"2026-09-18T01:35:36.50253Z","end":"2026-09-18T01:35:36.71829Z","steps":["trace[2069254915] 'read index received' (duration: 215.551689ms)","trace[2069254915] 'applied index is now lower than readState.Index' (duration: 207.796µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T01:35:36.718473Z","caller":"traceutil/trace.go:171","msg":"trace[918267405] transaction","detail":"{read_only:false; response_revision:2859; number_of_response:1; }","duration":"278.851946ms","start":"2026-09-18T01:35:36.439538Z","end":"2026-09-18T01:35:36.71839Z","steps":["trace[918267405] 'process raft request' (duration: 278.606568ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:35:36.719136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.003422ms","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-09-18T01:35:36.719238Z","caller":"traceutil/trace.go:171","msg":"trace[1250406753] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2859; }","duration":"216.701163ms","start":"2026-09-18T01:35:36.502522Z","end":"2026-09-18T01:35:36.719223Z","steps":["trace[1250406753] 'agreement among raft nodes before linearized reading' (duration: 215.864208ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:39:10.517361Z","caller":"traceutil/trace.go:171","msg":"trace[673357803] transaction","detail":"{read_only:false; response_revision:4103; number_of_response:1; }","duration":"125.952878ms","start":"2026-09-18T01:39:10.391374Z","end":"2026-09-18T01:39:10.517327Z","steps":["trace[673357803] 'process raft request' (duration: 36.628739ms)","trace[673357803] 'compare' (duration: 88.992982ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T01:39:59.763034Z","caller":"traceutil/trace.go:171","msg":"trace[1245847273] linearizableReadLoop","detail":"{readStateIndex:4999; appliedIndex:4998; }","duration":"116.373892ms","start":"2026-09-18T01:39:59.646642Z","end":"2026-09-18T01:39:59.763016Z","steps":["trace[1245847273] 'read index received' (duration: 74.034084ms)","trace[1245847273] 'applied index is now lower than readState.Index' (duration: 42.338718ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T01:39:59.763185Z","caller":"traceutil/trace.go:171","msg":"trace[348368117] transaction","detail":"{read_only:false; response_revision:4811; number_of_response:1; }","duration":"123.536884ms","start":"2026-09-18T01:39:59.639497Z","end":"2026-09-18T01:39:59.763034Z","steps":["trace[348368117] 'process raft request' (duration: 81.250838ms)","trace[348368117] 'compare' (duration: 42.166704ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T01:39:59.763378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.605236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:4 size:30890"} {"level":"info","ts":"2026-09-18T01:39:59.763496Z","caller":"traceutil/trace.go:171","msg":"trace[1130056834] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:4; response_revision:4811; }","duration":"116.756589ms","start":"2026-09-18T01:39:59.64672Z","end":"2026-09-18T01:39:59.763477Z","steps":["trace[1130056834] 'agreement among raft nodes before linearized reading' (duration: 116.458584ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:39:59.763233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.574925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"info","ts":"2026-09-18T01:39:59.763556Z","caller":"traceutil/trace.go:171","msg":"trace[34634793] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:4811; }","duration":"116.924963ms","start":"2026-09-18T01:39:59.646612Z","end":"2026-09-18T01:39:59.763537Z","steps":["trace[34634793] 'agreement among raft nodes before linearized reading' (duration: 116.511965ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:39:59.764089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.972546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:18 size:493565"} {"level":"info","ts":"2026-09-18T01:39:59.764145Z","caller":"traceutil/trace.go:171","msg":"trace[1039676354] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:18; response_revision:4811; }","duration":"104.051788ms","start":"2026-09-18T01:39:59.660081Z","end":"2026-09-18T01:39:59.764133Z","steps":["trace[1039676354] 'agreement among raft nodes before linearized reading' (duration: 103.63442ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:40:00.086764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.665263ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-18T01:40:00.086989Z","caller":"traceutil/trace.go:171","msg":"trace[2011417174] transaction","detail":"{read_only:false; response_revision:4818; number_of_response:1; }","duration":"258.309617ms","start":"2026-09-18T01:39:59.82864Z","end":"2026-09-18T01:40:00.086949Z","steps":["trace[2011417174] 'process raft request' (duration: 35.393579ms)","trace[2011417174] 'compare' (duration: 222.50705ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T01:40:00.087019Z","caller":"traceutil/trace.go:171","msg":"trace[366507216] transaction","detail":"{read_only:false; response_revision:4819; number_of_response:1; }","duration":"256.278338ms","start":"2026-09-18T01:39:59.830719Z","end":"2026-09-18T01:40:00.086997Z","steps":["trace[366507216] 'process raft request' (duration: 256.141775ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:40:00.087209Z","caller":"traceutil/trace.go:171","msg":"trace[1012436151] linearizableReadLoop","detail":"{readStateIndex:5007; appliedIndex:5005; }","duration":"256.396549ms","start":"2026-09-18T01:39:59.830792Z","end":"2026-09-18T01:40:00.087188Z","steps":["trace[1012436151] 'read index received' (duration: 33.257428ms)","trace[1012436151] 'applied index is now lower than readState.Index' (duration: 223.138121ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T01:40:00.087493Z","caller":"traceutil/trace.go:171","msg":"trace[398955131] transaction","detail":"{read_only:false; response_revision:4820; number_of_response:1; }","duration":"254.42822ms","start":"2026-09-18T01:39:59.83305Z","end":"2026-09-18T01:40:00.087478Z","steps":["trace[398955131] 'process raft request' (duration: 253.88549ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:40:00.08754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.553686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/bindings/\" range_end:\"/registry/rabbitmq.com/bindings0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T01:40:00.087587Z","caller":"traceutil/trace.go:171","msg":"trace[1599848394] range","detail":"{range_begin:/registry/rabbitmq.com/bindings/; range_end:/registry/rabbitmq.com/bindings0; response_count:0; response_revision:4820; }","duration":"106.643668ms","start":"2026-09-18T01:39:59.980931Z","end":"2026-09-18T01:40:00.087575Z","steps":["trace[1599848394] 'agreement among raft nodes before linearized reading' (duration: 106.567236ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:40:00.087545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.995365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1817"} {"level":"warn","ts":"2026-09-18T01:40:00.087893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.735273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-09-18T01:40:00.087918Z","caller":"traceutil/trace.go:171","msg":"trace[1481950820] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4820; }","duration":"245.399273ms","start":"2026-09-18T01:39:59.842508Z","end":"2026-09-18T01:40:00.087908Z","steps":["trace[1481950820] 'agreement among raft nodes before linearized reading' (duration: 244.938953ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:40:00.087927Z","caller":"traceutil/trace.go:171","msg":"trace[1894031245] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:4820; }","duration":"182.804945ms","start":"2026-09-18T01:39:59.905111Z","end":"2026-09-18T01:40:00.087916Z","steps":["trace[1894031245] 'agreement among raft nodes before linearized reading' (duration: 182.455018ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:40:00.088451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.651184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0\" ","response":"range_response_count:1 size:650"} {"level":"info","ts":"2026-09-18T01:40:00.088502Z","caller":"traceutil/trace.go:171","msg":"trace[1540974303] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0; range_end:; response_count:1; response_revision:4820; }","duration":"257.721996ms","start":"2026-09-18T01:39:59.83077Z","end":"2026-09-18T01:40:00.088492Z","steps":["trace[1540974303] 'agreement among raft nodes before linearized reading' (duration: 256.589344ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:40:00.088678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.737802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:18 size:493565"} {"level":"info","ts":"2026-09-18T01:40:00.088748Z","caller":"traceutil/trace.go:171","msg":"trace[596882584] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:18; response_revision:4820; }","duration":"187.877885ms","start":"2026-09-18T01:39:59.900853Z","end":"2026-09-18T01:40:00.088731Z","steps":["trace[596882584] 'agreement among raft nodes before linearized reading' (duration: 186.727063ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:40:00.408382Z","caller":"traceutil/trace.go:171","msg":"trace[414207651] transaction","detail":"{read_only:false; response_revision:4826; number_of_response:1; }","duration":"194.140987ms","start":"2026-09-18T01:40:00.214217Z","end":"2026-09-18T01:40:00.408358Z","steps":["trace[414207651] 'process raft request' (duration: 194.053216ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:40:00.40854Z","caller":"traceutil/trace.go:171","msg":"trace[1077684822] linearizableReadLoop","detail":"{readStateIndex:5014; appliedIndex:5011; }","duration":"153.161708ms","start":"2026-09-18T01:40:00.255348Z","end":"2026-09-18T01:40:00.40851Z","steps":["trace[1077684822] 'read index received' (duration: 24.674118ms)","trace[1077684822] 'applied index is now lower than readState.Index' (duration: 128.48452ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T01:40:00.408586Z","caller":"traceutil/trace.go:171","msg":"trace[141663596] transaction","detail":"{read_only:false; response_revision:4827; number_of_response:1; }","duration":"148.006155ms","start":"2026-09-18T01:40:00.260554Z","end":"2026-09-18T01:40:00.40856Z","steps":["trace[141663596] 'process raft request' (duration: 147.76083ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:40:00.408725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.853377ms","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-09-18T01:40:00.408762Z","caller":"traceutil/trace.go:171","msg":"trace[1177956912] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterrestores/; range_end:/registry/pxc.percona.com/perconaxtradbclusterrestores0; response_count:0; response_revision:4827; }","duration":"211.915758ms","start":"2026-09-18T01:40:00.196835Z","end":"2026-09-18T01:40:00.408751Z","steps":["trace[1177956912] 'agreement among raft nodes before linearized reading' (duration: 211.815996ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:40:00.408827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.853972ms","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":"warn","ts":"2026-09-18T01:40:00.408832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.807938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T01:40:00.40888Z","caller":"traceutil/trace.go:171","msg":"trace[245405227] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:4827; }","duration":"149.914493ms","start":"2026-09-18T01:40:00.258947Z","end":"2026-09-18T01:40:00.408862Z","steps":["trace[245405227] 'agreement among raft nodes before linearized reading' (duration: 149.74161ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:40:00.408898Z","caller":"traceutil/trace.go:171","msg":"trace[858900161] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0; range_end:; response_count:0; response_revision:4827; }","duration":"123.921629ms","start":"2026-09-18T01:40:00.28496Z","end":"2026-09-18T01:40:00.408882Z","steps":["trace[858900161] 'agreement among raft nodes before linearized reading' (duration: 123.795027ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:40:00.408898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.480574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/local-path-storage/\" range_end:\"/registry/limitranges/local-path-storage0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T01:40:00.408945Z","caller":"traceutil/trace.go:171","msg":"trace[1132390314] range","detail":"{range_begin:/registry/limitranges/local-path-storage/; range_end:/registry/limitranges/local-path-storage0; response_count:0; response_revision:4827; }","duration":"147.553216ms","start":"2026-09-18T01:40:00.261379Z","end":"2026-09-18T01:40:00.408932Z","steps":["trace[1132390314] 'agreement among raft nodes before linearized reading' (duration: 147.483555ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:40:00.409103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.75553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0.18d646aa8786659b\" ","response":"range_response_count:1 size:1203"} {"level":"info","ts":"2026-09-18T01:40:00.409147Z","caller":"traceutil/trace.go:171","msg":"trace[42702357] range","detail":"{range_begin:/registry/events/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0.18d646aa8786659b; range_end:; response_count:1; response_revision:4827; }","duration":"148.848742ms","start":"2026-09-18T01:40:00.260283Z","end":"2026-09-18T01:40:00.409132Z","steps":["trace[42702357] 'agreement among raft nodes before linearized reading' (duration: 148.699989ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:40:00.408401Z","caller":"traceutil/trace.go:171","msg":"trace[1098415189] transaction","detail":"{read_only:false; response_revision:4825; number_of_response:1; }","duration":"201.088555ms","start":"2026-09-18T01:40:00.207275Z","end":"2026-09-18T01:40:00.408364Z","steps":["trace[1098415189] 'process raft request' (duration: 200.685857ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:40:00.680482Z","caller":"traceutil/trace.go:171","msg":"trace[1065053122] linearizableReadLoop","detail":"{readStateIndex:5020; appliedIndex:5019; }","duration":"179.889896ms","start":"2026-09-18T01:40:00.500569Z","end":"2026-09-18T01:40:00.680459Z","steps":["trace[1065053122] 'read index received' (duration: 179.631141ms)","trace[1065053122] 'applied index is now lower than readState.Index' (duration: 257.615µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T01:40:00.680604Z","caller":"traceutil/trace.go:171","msg":"trace[920192073] transaction","detail":"{read_only:false; response_revision:4832; number_of_response:1; }","duration":"183.362065ms","start":"2026-09-18T01:40:00.497229Z","end":"2026-09-18T01:40:00.680592Z","steps":["trace[920192073] 'process raft request' (duration: 183.024769ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:40:00.680804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.222123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:4736"} {"level":"info","ts":"2026-09-18T01:40:00.680841Z","caller":"traceutil/trace.go:171","msg":"trace[706116688] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4832; }","duration":"180.309225ms","start":"2026-09-18T01:40:00.500522Z","end":"2026-09-18T01:40:00.680831Z","steps":["trace[706116688] 'agreement among raft nodes before linearized reading' (duration: 180.179462ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:40:00.681048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.786163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T01:40:00.681097Z","caller":"traceutil/trace.go:171","msg":"trace[652345965] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config; range_end:; response_count:0; response_revision:4832; }","duration":"178.850564ms","start":"2026-09-18T01:40:00.502232Z","end":"2026-09-18T01:40:00.681083Z","steps":["trace[652345965] 'agreement among raft nodes before linearized reading' (duration: 178.790823ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:40:00.681267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.171898ms","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-09-18T01:40:00.681336Z","caller":"traceutil/trace.go:171","msg":"trace[453047755] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4832; }","duration":"107.284241ms","start":"2026-09-18T01:40:00.574035Z","end":"2026-09-18T01:40:00.681319Z","steps":["trace[453047755] 'agreement among raft nodes before linearized reading' (duration: 107.084526ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:40:00.681296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.643892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1285"} {"level":"info","ts":"2026-09-18T01:40:00.681431Z","caller":"traceutil/trace.go:171","msg":"trace[1793268810] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:4832; }","duration":"176.775554ms","start":"2026-09-18T01:40:00.504625Z","end":"2026-09-18T01:40:00.681401Z","steps":["trace[1793268810] 'agreement among raft nodes before linearized reading' (duration: 176.60491ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:40:02.19707Z","caller":"traceutil/trace.go:171","msg":"trace[1320158022] transaction","detail":"{read_only:false; response_revision:4869; number_of_response:1; }","duration":"162.630491ms","start":"2026-09-18T01:40:02.034416Z","end":"2026-09-18T01:40:02.197047Z","steps":["trace[1320158022] 'process raft request' (duration: 162.484838ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:40:02.602747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.903188ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-18T01:40:02.60284Z","caller":"traceutil/trace.go:171","msg":"trace[2073919628] linearizableReadLoop","detail":"{readStateIndex:5058; appliedIndex:5057; }","duration":"249.936215ms","start":"2026-09-18T01:40:02.352888Z","end":"2026-09-18T01:40:02.602824Z","steps":["trace[2073919628] 'read index received' (duration: 56.947125ms)","trace[2073919628] 'applied index is now lower than readState.Index' (duration: 192.98795ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T01:40:02.602944Z","caller":"traceutil/trace.go:171","msg":"trace[596700981] transaction","detail":"{read_only:false; response_revision:4870; number_of_response:1; }","duration":"402.15469ms","start":"2026-09-18T01:40:02.200778Z","end":"2026-09-18T01:40:02.602933Z","steps":["trace[596700981] 'process raft request' (duration: 208.996437ms)","trace[596700981] 'compare' (duration: 192.791386ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T01:40:02.60299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T01:40:02.200764Z","time spent":"402.202531ms","remote":"127.0.0.1:35372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":853,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-18T01:40:02.603324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.435944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c4e8b9cc-559b-4c94-82ba-cad4cff7279b\" ","response":"range_response_count:1 size:3773"} {"level":"info","ts":"2026-09-18T01:40:02.603361Z","caller":"traceutil/trace.go:171","msg":"trace[1978040261] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c4e8b9cc-559b-4c94-82ba-cad4cff7279b; range_end:; response_count:1; response_revision:4870; }","duration":"250.519676ms","start":"2026-09-18T01:40:02.352832Z","end":"2026-09-18T01:40:02.603352Z","steps":["trace[1978040261] 'agreement among raft nodes before linearized reading' (duration: 250.332823ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:40:02.684009Z","caller":"traceutil/trace.go:171","msg":"trace[1845479604] transaction","detail":"{read_only:false; response_revision:4871; number_of_response:1; }","duration":"268.261816ms","start":"2026-09-18T01:40:02.41572Z","end":"2026-09-18T01:40:02.683982Z","steps":["trace[1845479604] 'process raft request' (duration: 268.093323ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:40:03.080665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.032381ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-09-18T01:40:03.081094Z","caller":"traceutil/trace.go:171","msg":"trace[254067153] linearizableReadLoop","detail":"{readStateIndex:5060; appliedIndex:5058; }","duration":"478.16478ms","start":"2026-09-18T01:40:02.602904Z","end":"2026-09-18T01:40:03.081069Z","steps":["trace[254067153] 'read index received' (duration: 81.022519ms)","trace[254067153] 'applied index is now lower than readState.Index' (duration: 397.140841ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T01:40:03.081286Z","caller":"traceutil/trace.go:171","msg":"trace[1323634435] transaction","detail":"{read_only:false; response_revision:4872; number_of_response:1; }","duration":"470.171832ms","start":"2026-09-18T01:40:02.611081Z","end":"2026-09-18T01:40:03.081253Z","steps":["trace[1323634435] 'process raft request' (duration: 469.710373ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:40:03.081429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"583.781545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c4e8b9cc-559b-4c94-82ba-cad4cff7279b\" ","response":"range_response_count:1 size:3890"} {"level":"info","ts":"2026-09-18T01:40:03.081511Z","caller":"traceutil/trace.go:171","msg":"trace[460149116] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c4e8b9cc-559b-4c94-82ba-cad4cff7279b; range_end:; response_count:1; response_revision:4872; }","duration":"583.925928ms","start":"2026-09-18T01:40:02.497564Z","end":"2026-09-18T01:40:03.08149Z","steps":["trace[460149116] 'agreement among raft nodes before linearized reading' (duration: 583.708224ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:40:03.08156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T01:40:02.497554Z","time spent":"583.996159ms","remote":"127.0.0.1:35484","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3913,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c4e8b9cc-559b-4c94-82ba-cad4cff7279b\" "} {"level":"warn","ts":"2026-09-18T01:40:03.081531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"588.011888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-09-18T01:40:03.081557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"588.301524ms","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-09-18T01:40:03.081656Z","caller":"traceutil/trace.go:171","msg":"trace[1612803501] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:4872; }","duration":"588.463568ms","start":"2026-09-18T01:40:02.493171Z","end":"2026-09-18T01:40:03.081635Z","steps":["trace[1612803501] 'agreement among raft nodes before linearized reading' (duration: 588.160292ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:40:03.081626Z","caller":"traceutil/trace.go:171","msg":"trace[2024566183] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4872; }","duration":"588.172512ms","start":"2026-09-18T01:40:02.493433Z","end":"2026-09-18T01:40:03.081605Z","steps":["trace[2024566183] 'agreement among raft nodes before linearized reading' (duration: 587.788645ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:40:03.081707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T01:40:02.493141Z","time spent":"588.554599ms","remote":"127.0.0.1:35364","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-09-18T01:40:03.081741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T01:40:02.493422Z","time spent":"588.302584ms","remote":"127.0.0.1:35580","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":"warn","ts":"2026-09-18T01:40:03.081999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T01:40:02.611061Z","time spent":"470.419717ms","remote":"127.0.0.1:35484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3875,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T01:40:03.082256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.529375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T01:40:03.083811Z","caller":"traceutil/trace.go:171","msg":"trace[1597130772] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4872; }","duration":"293.067826ms","start":"2026-09-18T01:40:02.790715Z","end":"2026-09-18T01:40:03.083783Z","steps":["trace[1597130772] 'agreement among raft nodes before linearized reading' (duration: 291.510415ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:40:03.082299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.419853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-09-18T01:40:03.084044Z","caller":"traceutil/trace.go:171","msg":"trace[1893967022] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4872; }","duration":"369.173689ms","start":"2026-09-18T01:40:02.71483Z","end":"2026-09-18T01:40:03.084003Z","steps":["trace[1893967022] 'agreement among raft nodes before linearized reading' (duration: 367.384833ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:40:03.084089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T01:40:02.71481Z","time spent":"369.26464ms","remote":"127.0.0.1:35580","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-09-18T01:40:03.082408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.816288ms","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-09-18T01:40:03.084209Z","caller":"traceutil/trace.go:171","msg":"trace[33708100] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4872; }","duration":"304.697055ms","start":"2026-09-18T01:40:02.779502Z","end":"2026-09-18T01:40:03.084199Z","steps":["trace[33708100] 'agreement among raft nodes before linearized reading' (duration: 302.785727ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:40:03.084235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T01:40:02.779481Z","time spent":"304.746016ms","remote":"127.0.0.1:35580","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-09-18T01:40:03.296829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.663315ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-18T01:40:03.296934Z","caller":"traceutil/trace.go:171","msg":"trace[1760172437] linearizableReadLoop","detail":"{readStateIndex:5062; appliedIndex:5061; }","duration":"208.997445ms","start":"2026-09-18T01:40:03.087919Z","end":"2026-09-18T01:40:03.296917Z","steps":["trace[1760172437] 'read index received' (duration: 104.170576ms)","trace[1760172437] 'applied index is now lower than readState.Index' (duration: 104.825719ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T01:40:03.297Z","caller":"traceutil/trace.go:171","msg":"trace[87606595] transaction","detail":"{read_only:false; response_revision:4873; number_of_response:1; }","duration":"209.25579ms","start":"2026-09-18T01:40:03.087734Z","end":"2026-09-18T01:40:03.296989Z","steps":["trace[87606595] 'process raft request' (duration: 104.34642ms)","trace[87606595] 'compare' (duration: 104.523812ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T01:40:03.297278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.353001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a24411c3-8eb4-472d-bf7c-85ca5889c009\" ","response":"range_response_count:1 size:3759"} {"level":"info","ts":"2026-09-18T01:40:03.297318Z","caller":"traceutil/trace.go:171","msg":"trace[657060557] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a24411c3-8eb4-472d-bf7c-85ca5889c009; range_end:; response_count:1; response_revision:4873; }","duration":"209.419143ms","start":"2026-09-18T01:40:03.087886Z","end":"2026-09-18T01:40:03.297305Z","steps":["trace[657060557] 'agreement among raft nodes before linearized reading' (duration: 209.283651ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:40:03.300854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.228757ms","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-09-18T01:40:03.300906Z","caller":"traceutil/trace.go:171","msg":"trace[786143257] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4875; }","duration":"176.31393ms","start":"2026-09-18T01:40:03.124581Z","end":"2026-09-18T01:40:03.300895Z","steps":["trace[786143257] 'agreement among raft nodes before linearized reading' (duration: 176.175546ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:40:03.301172Z","caller":"traceutil/trace.go:171","msg":"trace[842542197] transaction","detail":"{read_only:false; response_revision:4875; number_of_response:1; }","duration":"212.218048ms","start":"2026-09-18T01:40:03.088939Z","end":"2026-09-18T01:40:03.301157Z","steps":["trace[842542197] 'process raft request' (duration: 211.778659ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:40:03.301327Z","caller":"traceutil/trace.go:171","msg":"trace[314514173] transaction","detail":"{read_only:false; response_revision:4874; number_of_response:1; }","duration":"212.442042ms","start":"2026-09-18T01:40:03.08887Z","end":"2026-09-18T01:40:03.301312Z","steps":["trace[314514173] 'process raft request' (duration: 211.765469ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:40:03.30136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.700717ms","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-09-18T01:40:03.301463Z","caller":"traceutil/trace.go:171","msg":"trace[1303905057] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4875; }","duration":"176.852459ms","start":"2026-09-18T01:40:03.124593Z","end":"2026-09-18T01:40:03.301446Z","steps":["trace[1303905057] 'agreement among raft nodes before linearized reading' (duration: 176.610314ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:40:14.869063Z","caller":"traceutil/trace.go:171","msg":"trace[1103193254] transaction","detail":"{read_only:false; response_revision:5028; number_of_response:1; }","duration":"386.103973ms","start":"2026-09-18T01:40:14.48294Z","end":"2026-09-18T01:40:14.869044Z","steps":["trace[1103193254] 'process raft request' (duration: 385.999201ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:40:14.869189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T01:40:14.482925Z","time spent":"386.195484ms","remote":"127.0.0.1:35372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T01:40:14.940119Z","caller":"traceutil/trace.go:171","msg":"trace[216702031] transaction","detail":"{read_only:false; response_revision:5029; number_of_response:1; }","duration":"449.19454ms","start":"2026-09-18T01:40:14.490899Z","end":"2026-09-18T01:40:14.940093Z","steps":["trace[216702031] 'process raft request' (duration: 434.074764ms)","trace[216702031] 'compare' (duration: 14.843061ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T01:40:14.94037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T01:40:14.490867Z","time spent":"449.350093ms","remote":"127.0.0.1:35484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":13279,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T01:40:14.940697Z","caller":"traceutil/trace.go:171","msg":"trace[1764167360] transaction","detail":"{read_only:false; response_revision:5030; number_of_response:1; }","duration":"215.787692ms","start":"2026-09-18T01:40:14.724895Z","end":"2026-09-18T01:40:14.940683Z","steps":["trace[1764167360] 'process raft request' (duration: 215.125978ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:40:14.940446Z","caller":"traceutil/trace.go:171","msg":"trace[1432181099] linearizableReadLoop","detail":"{readStateIndex:5225; appliedIndex:5223; }","duration":"362.627863ms","start":"2026-09-18T01:40:14.577795Z","end":"2026-09-18T01:40:14.940423Z","steps":["trace[1432181099] 'read index received' (duration: 291.149301ms)","trace[1432181099] 'applied index is now lower than readState.Index' (duration: 71.477102ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T01:40:14.941217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.415058ms","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-09-18T01:40:14.941252Z","caller":"traceutil/trace.go:171","msg":"trace[2001653939] 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:5030; }","duration":"363.459738ms","start":"2026-09-18T01:40:14.577779Z","end":"2026-09-18T01:40:14.941239Z","steps":["trace[2001653939] 'agreement among raft nodes before linearized reading' (duration: 363.334396ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:40:14.9413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T01:40:14.577736Z","time spent":"363.55469ms","remote":"127.0.0.1:35454","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":"info","ts":"2026-09-18T01:40:15.108254Z","caller":"traceutil/trace.go:171","msg":"trace[1937663328] transaction","detail":"{read_only:false; response_revision:5036; number_of_response:1; }","duration":"128.52751ms","start":"2026-09-18T01:40:14.979697Z","end":"2026-09-18T01:40:15.108224Z","steps":["trace[1937663328] 'process raft request' (duration: 78.240354ms)","trace[1937663328] 'compare' (duration: 50.144962ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T01:40:15.614677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.227597ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-18T01:40:15.614767Z","caller":"traceutil/trace.go:171","msg":"trace[1500416737] linearizableReadLoop","detail":"{readStateIndex:5233; appliedIndex:5232; }","duration":"270.763958ms","start":"2026-09-18T01:40:15.343987Z","end":"2026-09-18T01:40:15.614751Z","steps":["trace[1500416737] 'read index received' (duration: 101.342157ms)","trace[1500416737] 'applied index is now lower than readState.Index' (duration: 169.420801ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T01:40:15.614826Z","caller":"traceutil/trace.go:171","msg":"trace[1445755945] transaction","detail":"{read_only:false; response_revision:5037; number_of_response:1; }","duration":"493.627576ms","start":"2026-09-18T01:40:15.121189Z","end":"2026-09-18T01:40:15.614817Z","steps":["trace[1445755945] 'process raft request' (duration: 324.196925ms)","trace[1445755945] 'compare' (duration: 169.104065ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T01:40:15.614868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T01:40:15.121163Z","time spent":"493.684037ms","remote":"127.0.0.1:35372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":814,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-18T01:40:15.615105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.101105ms","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-09-18T01:40:15.61517Z","caller":"traceutil/trace.go:171","msg":"trace[843306207] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5037; }","duration":"271.195676ms","start":"2026-09-18T01:40:15.343958Z","end":"2026-09-18T01:40:15.615153Z","steps":["trace[843306207] 'agreement among raft nodes before linearized reading' (duration: 270.962441ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:40:15.630791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.903311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-09-18T01:40:15.6308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.984632ms","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-09-18T01:40:15.63096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.066328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-09-18T01:40:15.631031Z","caller":"traceutil/trace.go:171","msg":"trace[1801149940] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5038; }","duration":"261.15522ms","start":"2026-09-18T01:40:15.369864Z","end":"2026-09-18T01:40:15.631019Z","steps":["trace[1801149940] 'agreement among raft nodes before linearized reading' (duration: 261.033458ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:40:15.630948Z","caller":"traceutil/trace.go:171","msg":"trace[881476738] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5038; }","duration":"273.153425ms","start":"2026-09-18T01:40:15.357778Z","end":"2026-09-18T01:40:15.630931Z","steps":["trace[881476738] 'agreement among raft nodes before linearized reading' (duration: 272.90944ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:40:15.630875Z","caller":"traceutil/trace.go:171","msg":"trace[219002811] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5038; }","duration":"269.019003ms","start":"2026-09-18T01:40:15.36184Z","end":"2026-09-18T01:40:15.630859Z","steps":["trace[219002811] 'agreement among raft nodes before linearized reading' (duration: 268.821639ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:40:15.631146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.90346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-09-18T01:40:15.631356Z","caller":"traceutil/trace.go:171","msg":"trace[1430149753] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5038; }","duration":"274.149114ms","start":"2026-09-18T01:40:15.357188Z","end":"2026-09-18T01:40:15.631337Z","steps":["trace[1430149753] 'agreement among raft nodes before linearized reading' (duration: 273.816678ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:40:19.923296Z","caller":"traceutil/trace.go:171","msg":"trace[448675008] linearizableReadLoop","detail":"{readStateIndex:5332; appliedIndex:5331; }","duration":"229.677533ms","start":"2026-09-18T01:40:19.693593Z","end":"2026-09-18T01:40:19.923271Z","steps":["trace[448675008] 'read index received' (duration: 229.569581ms)","trace[448675008] 'applied index is now lower than readState.Index' (duration: 106.982µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T01:40:19.923355Z","caller":"traceutil/trace.go:171","msg":"trace[1190467694] transaction","detail":"{read_only:false; response_revision:5135; number_of_response:1; }","duration":"233.753163ms","start":"2026-09-18T01:40:19.689565Z","end":"2026-09-18T01:40:19.923318Z","steps":["trace[1190467694] 'process raft request' (duration: 233.515618ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:40:19.923592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.98536ms","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-09-18T01:40:19.923635Z","caller":"traceutil/trace.go:171","msg":"trace[1991573493] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5135; }","duration":"230.079162ms","start":"2026-09-18T01:40:19.693546Z","end":"2026-09-18T01:40:19.923625Z","steps":["trace[1991573493] 'agreement among raft nodes before linearized reading' (duration: 229.844107ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:40:19.927141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.368461ms","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-09-18T01:40:19.927238Z","caller":"traceutil/trace.go:171","msg":"trace[555288794] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5137; }","duration":"221.488512ms","start":"2026-09-18T01:40:19.705712Z","end":"2026-09-18T01:40:19.927201Z","steps":["trace[555288794] 'agreement among raft nodes before linearized reading' (duration: 221.222027ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:40:19.927368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.600529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-09-18T01:40:19.927411Z","caller":"traceutil/trace.go:171","msg":"trace[1653673671] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5137; }","duration":"209.672211ms","start":"2026-09-18T01:40:19.717727Z","end":"2026-09-18T01:40:19.927399Z","steps":["trace[1653673671] 'agreement among raft nodes before linearized reading' (duration: 209.526208ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:40:19.927401Z","caller":"traceutil/trace.go:171","msg":"trace[1893044563] transaction","detail":"{read_only:false; response_revision:5137; number_of_response:1; }","duration":"100.363192ms","start":"2026-09-18T01:40:19.827005Z","end":"2026-09-18T01:40:19.927368Z","steps":["trace[1893044563] 'process raft request' (duration: 99.884493ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:40:19.927524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.749642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-09-18T01:40:19.927557Z","caller":"traceutil/trace.go:171","msg":"trace[356002168] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5137; }","duration":"212.798383ms","start":"2026-09-18T01:40:19.71475Z","end":"2026-09-18T01:40:19.927548Z","steps":["trace[356002168] 'agreement among raft nodes before linearized reading' (duration: 212.7073ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:40:19.927624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.276247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T01:40:19.927659Z","caller":"traceutil/trace.go:171","msg":"trace[1111916490] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5137; }","duration":"136.351568ms","start":"2026-09-18T01:40:19.791298Z","end":"2026-09-18T01:40:19.927649Z","steps":["trace[1111916490] 'agreement among raft nodes before linearized reading' (duration: 136.301747ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:40:19.927692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.334684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-09-18T01:40:19.927742Z","caller":"traceutil/trace.go:171","msg":"trace[301241401] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5137; }","duration":"213.416145ms","start":"2026-09-18T01:40:19.71431Z","end":"2026-09-18T01:40:19.927726Z","steps":["trace[301241401] 'agreement among raft nodes before linearized reading' (duration: 213.236572ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:40:30.076828Z","caller":"traceutil/trace.go:171","msg":"trace[1543304939] transaction","detail":"{read_only:false; response_revision:5269; number_of_response:1; }","duration":"112.853496ms","start":"2026-09-18T01:40:29.963947Z","end":"2026-09-18T01:40:30.0768Z","steps":["trace[1543304939] 'process raft request' (duration: 84.80255ms)","trace[1543304939] 'compare' (duration: 27.823431ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T01:40:30.077444Z","caller":"traceutil/trace.go:171","msg":"trace[2108559818] transaction","detail":"{read_only:false; response_revision:5270; number_of_response:1; }","duration":"112.02776ms","start":"2026-09-18T01:40:29.965242Z","end":"2026-09-18T01:40:30.07727Z","steps":["trace[2108559818] 'process raft request' (duration: 111.456869ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:40:32.479631Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2836} {"level":"info","ts":"2026-09-18T01:40:32.547234Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2836,"took":"66.32562ms","hash":1459695021,"current-db-size-bytes":51175424,"current-db-size":"51 MB","current-db-size-in-use-bytes":27459584,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-18T01:40:32.547285Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1459695021,"revision":2836,"compact-revision":-1} {"level":"warn","ts":"2026-09-18T01:41:46.886208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.085778ms","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-09-18T01:41:46.886321Z","caller":"traceutil/trace.go:171","msg":"trace[1463416654] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5885; }","duration":"217.258995ms","start":"2026-09-18T01:41:46.669036Z","end":"2026-09-18T01:41:46.886295Z","steps":["trace[1463416654] 'range keys from in-memory index tree' (duration: 216.879118ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:44:09.465683Z","caller":"traceutil/trace.go:171","msg":"trace[1369457388] linearizableReadLoop","detail":"{readStateIndex:7113; appliedIndex:7111; }","duration":"132.588703ms","start":"2026-09-18T01:44:09.333073Z","end":"2026-09-18T01:44:09.465662Z","steps":["trace[1369457388] 'read index received' (duration: 69.836757ms)","trace[1369457388] 'applied index is now lower than readState.Index' (duration: 62.750976ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T01:44:09.465847Z","caller":"traceutil/trace.go:171","msg":"trace[1535119557] transaction","detail":"{read_only:false; response_revision:6859; number_of_response:1; }","duration":"135.736713ms","start":"2026-09-18T01:44:09.3301Z","end":"2026-09-18T01:44:09.465836Z","steps":["trace[1535119557] 'process raft request' (duration: 134.846462ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:44:09.466296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.151698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-09-18T01:44:09.466362Z","caller":"traceutil/trace.go:171","msg":"trace[712978348] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6859; }","duration":"101.284742ms","start":"2026-09-18T01:44:09.365065Z","end":"2026-09-18T01:44:09.46635Z","steps":["trace[712978348] 'agreement among raft nodes before linearized reading' (duration: 101.099476ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:44:09.466672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.599498ms","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-09-18T01:44:09.466719Z","caller":"traceutil/trace.go:171","msg":"trace[1883228277] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6859; }","duration":"133.648149ms","start":"2026-09-18T01:44:09.33306Z","end":"2026-09-18T01:44:09.466708Z","steps":["trace[1883228277] 'agreement among raft nodes before linearized reading' (duration: 133.195394ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:44:15.296972Z","caller":"traceutil/trace.go:171","msg":"trace[746675640] transaction","detail":"{read_only:false; response_revision:6887; number_of_response:1; }","duration":"180.056304ms","start":"2026-09-18T01:44:15.116879Z","end":"2026-09-18T01:44:15.296935Z","steps":["trace[746675640] 'process raft request' (duration: 131.7252ms)","trace[746675640] 'compare' (duration: 48.134367ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T01:45:32.486391Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5292} {"level":"info","ts":"2026-09-18T01:45:32.59795Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5292,"took":"110.42244ms","hash":3720451724,"current-db-size-bytes":51175424,"current-db-size":"51 MB","current-db-size-in-use-bytes":18948096,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-18T01:45:32.598228Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3720451724,"revision":5292,"compact-revision":2836}