{"level":"warn","ts":"2026-09-09T00:58:23.957776Z","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-09T00:58:23.957901Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.109: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.109:2380","--initial-cluster=instance=https://162.253.55.109:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.109:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.109: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-09T00:58:23.957985Z","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-09T00:58:23.958024Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.109:2380"]} {"level":"info","ts":"2026-09-09T00:58:23.958042Z","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-09T00:58:23.958642Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.109:2379"]} {"level":"info","ts":"2026-09-09T00:58:23.958716Z","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.109:2380"],"listen-peer-urls":["https://162.253.55.109:2380"],"advertise-client-urls":["https://162.253.55.109:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.109:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.109: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-09T00:58:23.965777Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.83543ms"} {"level":"info","ts":"2026-09-09T00:58:23.975329Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1ee91cef4f0023c4","cluster-id":"8dccb05df97999f"} {"level":"info","ts":"2026-09-09T00:58:23.975407Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1ee91cef4f0023c4 switched to configuration voters=()"} {"level":"info","ts":"2026-09-09T00:58:23.975431Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1ee91cef4f0023c4 became follower at term 0"} {"level":"info","ts":"2026-09-09T00:58:23.975442Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1ee91cef4f0023c4 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-09T00:58:23.975452Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1ee91cef4f0023c4 became follower at term 1"} {"level":"info","ts":"2026-09-09T00:58:23.975489Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1ee91cef4f0023c4 switched to configuration voters=(2227343304859591620)"} {"level":"warn","ts":"2026-09-09T00:58:23.985888Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-09T00:58:23.989852Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-09T00:58:23.995759Z","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-09T00:58:23.999307Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1ee91cef4f0023c4","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-09T00:58:24.000657Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1ee91cef4f0023c4","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-09T00:58:24.000825Z","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-09T00:58:24.000859Z","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-09T00:58:24.00087Z","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-09T00:58:24.001154Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1ee91cef4f0023c4 switched to configuration voters=(2227343304859591620)"} {"level":"info","ts":"2026-09-09T00:58:24.001237Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"8dccb05df97999f","local-member-id":"1ee91cef4f0023c4","added-peer-id":"1ee91cef4f0023c4","added-peer-peer-urls":["https://162.253.55.109:2380"]} {"level":"info","ts":"2026-09-09T00:58:24.002889Z","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-09T00:58:24.003024Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.109:2380"} {"level":"info","ts":"2026-09-09T00:58:24.003059Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.109:2380"} {"level":"info","ts":"2026-09-09T00:58:24.00351Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1ee91cef4f0023c4","initial-advertise-peer-urls":["https://162.253.55.109:2380"],"listen-peer-urls":["https://162.253.55.109:2380"],"advertise-client-urls":["https://162.253.55.109:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.109:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-09T00:58:24.003551Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-09T00:58:24.776701Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1ee91cef4f0023c4 is starting a new election at term 1"} {"level":"info","ts":"2026-09-09T00:58:24.776789Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1ee91cef4f0023c4 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-09T00:58:24.776844Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1ee91cef4f0023c4 received MsgPreVoteResp from 1ee91cef4f0023c4 at term 1"} {"level":"info","ts":"2026-09-09T00:58:24.776875Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1ee91cef4f0023c4 became candidate at term 2"} {"level":"info","ts":"2026-09-09T00:58:24.776895Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1ee91cef4f0023c4 received MsgVoteResp from 1ee91cef4f0023c4 at term 2"} {"level":"info","ts":"2026-09-09T00:58:24.776912Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1ee91cef4f0023c4 became leader at term 2"} {"level":"info","ts":"2026-09-09T00:58:24.776936Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1ee91cef4f0023c4 elected leader 1ee91cef4f0023c4 at term 2"} {"level":"info","ts":"2026-09-09T00:58:24.778425Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-09T00:58:24.779586Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-09T00:58:24.779565Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1ee91cef4f0023c4","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.109:2379]}","request-path":"/0/members/1ee91cef4f0023c4/attributes","cluster-id":"8dccb05df97999f","publish-timeout":"7s"} {"level":"info","ts":"2026-09-09T00:58:24.779662Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-09T00:58:24.780129Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-09T00:58:24.780209Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-09T00:58:24.78053Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"8dccb05df97999f","local-member-id":"1ee91cef4f0023c4","cluster-version":"3.5"} {"level":"info","ts":"2026-09-09T00:58:24.780808Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-09T00:58:24.780877Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-09T00:58:24.783294Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-09T00:58:24.784226Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.109:2379"} {"level":"warn","ts":"2026-09-09T00:58:53.674735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.458487ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-09-09T00:59:37.126309Z","caller":"traceutil/trace.go:171","msg":"trace[2057741767] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"192.638206ms","start":"2026-09-09T00:59:36.933641Z","end":"2026-09-09T00:59:37.12628Z","steps":["trace[2057741767] 'process raft request' (duration: 192.456543ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T00:59:37.14681Z","caller":"traceutil/trace.go:171","msg":"trace[1732275371] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"209.725718ms","start":"2026-09-09T00:59:36.937063Z","end":"2026-09-09T00:59:37.146789Z","steps":["trace[1732275371] 'process raft request' (duration: 209.616926ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T00:59:37.146903Z","caller":"traceutil/trace.go:171","msg":"trace[110578757] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"198.751596ms","start":"2026-09-09T00:59:36.948111Z","end":"2026-09-09T00:59:37.146862Z","steps":["trace[110578757] 'process raft request' (duration: 198.614634ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T00:59:37.146951Z","caller":"traceutil/trace.go:171","msg":"trace[1383240864] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"194.871392ms","start":"2026-09-09T00:59:36.952049Z","end":"2026-09-09T00:59:37.146921Z","steps":["trace[1383240864] 'process raft request' (duration: 194.72045ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T00:59:37.14703Z","caller":"traceutil/trace.go:171","msg":"trace[1779034993] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"190.223646ms","start":"2026-09-09T00:59:36.956793Z","end":"2026-09-09T00:59:37.147016Z","steps":["trace[1779034993] 'process raft request' (duration: 190.093504ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T00:59:37.147086Z","caller":"traceutil/trace.go:171","msg":"trace[667984760] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"188.505527ms","start":"2026-09-09T00:59:36.958566Z","end":"2026-09-09T00:59:37.147071Z","steps":["trace[667984760] 'process raft request' (duration: 188.357064ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T00:59:37.147201Z","caller":"traceutil/trace.go:171","msg":"trace[1729168986] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"182.190633ms","start":"2026-09-09T00:59:36.965Z","end":"2026-09-09T00:59:37.147191Z","steps":["trace[1729168986] 'process raft request' (duration: 181.986459ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T00:59:37.146853Z","caller":"traceutil/trace.go:171","msg":"trace[2143976525] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"210.186306ms","start":"2026-09-09T00:59:36.936604Z","end":"2026-09-09T00:59:37.14679Z","steps":["trace[2143976525] 'process raft request' (duration: 209.915232ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T00:59:37.14736Z","caller":"traceutil/trace.go:171","msg":"trace[980636643] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"167.119692ms","start":"2026-09-09T00:59:36.980231Z","end":"2026-09-09T00:59:37.147351Z","steps":["trace[980636643] 'process raft request' (duration: 166.879758ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T00:59:37.14757Z","caller":"traceutil/trace.go:171","msg":"trace[185945692] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"148.105568ms","start":"2026-09-09T00:59:36.999455Z","end":"2026-09-09T00:59:37.14756Z","steps":["trace[185945692] 'process raft request' (duration: 147.827763ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T00:59:37.147761Z","caller":"traceutil/trace.go:171","msg":"trace[1244154538] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"128.877919ms","start":"2026-09-09T00:59:37.018776Z","end":"2026-09-09T00:59:37.147653Z","steps":["trace[1244154538] 'process raft request' (duration: 128.680196ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T00:59:43.768819Z","caller":"traceutil/trace.go:171","msg":"trace[69706068] linearizableReadLoop","detail":"{readStateIndex:759; appliedIndex:758; }","duration":"254.696627ms","start":"2026-09-09T00:59:43.514081Z","end":"2026-09-09T00:59:43.768778Z","steps":["trace[69706068] 'read index received' (duration: 253.400076ms)","trace[69706068] 'applied index is now lower than readState.Index' (duration: 1.295171ms)"],"step_count":2} {"level":"warn","ts":"2026-09-09T00:59:43.769074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.933191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-09T00:59:43.769143Z","caller":"traceutil/trace.go:171","msg":"trace[1395716099] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:725; }","duration":"255.076244ms","start":"2026-09-09T00:59:43.514039Z","end":"2026-09-09T00:59:43.769115Z","steps":["trace[1395716099] 'agreement among raft nodes before linearized reading' (duration: 254.900761ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T00:59:43.769521Z","caller":"traceutil/trace.go:171","msg":"trace[662857364] transaction","detail":"{read_only:false; response_revision:725; number_of_response:1; }","duration":"339.796909ms","start":"2026-09-09T00:59:43.429669Z","end":"2026-09-09T00:59:43.769466Z","steps":["trace[662857364] 'process raft request' (duration: 338.248504ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T00:59:43.770187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T00:59:43.429645Z","time spent":"339.990203ms","remote":"127.0.0.1:59386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036297,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-09T00:59:43.975011Z","caller":"traceutil/trace.go:171","msg":"trace[968993017] linearizableReadLoop","detail":"{readStateIndex:760; appliedIndex:759; }","duration":"102.886942ms","start":"2026-09-09T00:59:43.872091Z","end":"2026-09-09T00:59:43.974978Z","steps":["trace[968993017] 'read index received' (duration: 102.529656ms)","trace[968993017] 'applied index is now lower than readState.Index' (duration: 356.236µs)"],"step_count":2} {"level":"warn","ts":"2026-09-09T00:59:43.975343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.202657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-4vrlq\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-09-09T00:59:43.975257Z","caller":"traceutil/trace.go:171","msg":"trace[1717169789] transaction","detail":"{read_only:false; response_revision:726; number_of_response:1; }","duration":"132.579414ms","start":"2026-09-09T00:59:43.842645Z","end":"2026-09-09T00:59:43.975224Z","steps":["trace[1717169789] 'process raft request' (duration: 132.136467ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T00:59:43.975402Z","caller":"traceutil/trace.go:171","msg":"trace[1785655063] range","detail":"{range_begin:/registry/pods/kube-system/cilium-4vrlq; range_end:; response_count:1; response_revision:726; }","duration":"103.334589ms","start":"2026-09-09T00:59:43.872054Z","end":"2026-09-09T00:59:43.975389Z","steps":["trace[1785655063] 'agreement among raft nodes before linearized reading' (duration: 103.045844ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T00:59:44.372472Z","caller":"traceutil/trace.go:171","msg":"trace[1729595149] transaction","detail":"{read_only:false; response_revision:727; number_of_response:1; }","duration":"374.427576ms","start":"2026-09-09T00:59:43.998025Z","end":"2026-09-09T00:59:44.372453Z","steps":["trace[1729595149] 'process raft request' (duration: 374.269103ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T00:59:44.372585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T00:59:43.997981Z","time spent":"374.547208ms","remote":"127.0.0.1:59486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-09T00:59:44.593161Z","caller":"traceutil/trace.go:171","msg":"trace[1805781806] linearizableReadLoop","detail":"{readStateIndex:762; appliedIndex:761; }","duration":"267.543164ms","start":"2026-09-09T00:59:44.325592Z","end":"2026-09-09T00:59:44.593135Z","steps":["trace[1805781806] 'read index received' (duration: 47.435078ms)","trace[1805781806] 'applied index is now lower than readState.Index' (duration: 220.107196ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T00:59:44.593355Z","caller":"traceutil/trace.go:171","msg":"trace[1721625782] transaction","detail":"{read_only:false; response_revision:728; number_of_response:1; }","duration":"594.181835ms","start":"2026-09-09T00:59:43.999109Z","end":"2026-09-09T00:59:44.593291Z","steps":["trace[1721625782] 'process raft request' (duration: 567.678796ms)","trace[1721625782] 'compare' (duration: 26.221045ms)"],"step_count":2} {"level":"warn","ts":"2026-09-09T00:59:44.593725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.101933ms","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-09T00:59:44.593843Z","caller":"traceutil/trace.go:171","msg":"trace[1991993265] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:728; }","duration":"268.233135ms","start":"2026-09-09T00:59:44.325582Z","end":"2026-09-09T00:59:44.593815Z","steps":["trace[1991993265] 'agreement among raft nodes before linearized reading' (duration: 267.823408ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T00:59:44.593907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T00:59:43.99909Z","time spent":"594.44601ms","remote":"127.0.0.1:59486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-09T01:00:01.663022Z","caller":"traceutil/trace.go:171","msg":"trace[1724281419] linearizableReadLoop","detail":"{readStateIndex:933; appliedIndex:932; }","duration":"250.606437ms","start":"2026-09-09T01:00:01.412392Z","end":"2026-09-09T01:00:01.662998Z","steps":["trace[1724281419] 'read index received' (duration: 250.436355ms)","trace[1724281419] 'applied index is now lower than readState.Index' (duration: 169.232µs)"],"step_count":2} {"level":"warn","ts":"2026-09-09T01:00:01.663225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.82429ms","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-09T01:00:01.663254Z","caller":"traceutil/trace.go:171","msg":"trace[501379488] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:895; }","duration":"250.900222ms","start":"2026-09-09T01:00:01.412345Z","end":"2026-09-09T01:00:01.663245Z","steps":["trace[501379488] 'agreement among raft nodes before linearized reading' (duration: 250.73672ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:00:01.66363Z","caller":"traceutil/trace.go:171","msg":"trace[2120756431] transaction","detail":"{read_only:false; response_revision:895; number_of_response:1; }","duration":"258.937786ms","start":"2026-09-09T01:00:01.404656Z","end":"2026-09-09T01:00:01.663594Z","steps":["trace[2120756431] 'process raft request' (duration: 258.230355ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:00:39.585668Z","caller":"traceutil/trace.go:171","msg":"trace[2052689506] transaction","detail":"{read_only:false; response_revision:1331; number_of_response:1; }","duration":"158.752147ms","start":"2026-09-09T01:00:39.426885Z","end":"2026-09-09T01:00:39.585637Z","steps":["trace[2052689506] 'process raft request' (duration: 158.596895ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:01:30.72835Z","caller":"traceutil/trace.go:171","msg":"trace[1501026102] transaction","detail":"{read_only:false; response_revision:2019; number_of_response:1; }","duration":"288.876572ms","start":"2026-09-09T01:01:30.439409Z","end":"2026-09-09T01:01:30.728285Z","steps":["trace[1501026102] 'process raft request' (duration: 288.654204ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:01:30.743Z","caller":"traceutil/trace.go:171","msg":"trace[743176423] transaction","detail":"{read_only:false; response_revision:2020; number_of_response:1; }","duration":"233.895172ms","start":"2026-09-09T01:01:30.509075Z","end":"2026-09-09T01:01:30.74297Z","steps":["trace[743176423] 'process raft request' (duration: 233.369894ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:01:43.438241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.690315ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-09-09T01:01:43.438344Z","caller":"traceutil/trace.go:171","msg":"trace[1457136703] linearizableReadLoop","detail":"{readStateIndex:2212; appliedIndex:2211; }","duration":"137.998931ms","start":"2026-09-09T01:01:43.30033Z","end":"2026-09-09T01:01:43.438329Z","steps":["trace[1457136703] 'read index received' (duration: 2.156341ms)","trace[1457136703] 'applied index is now lower than readState.Index' (duration: 135.84123ms)"],"step_count":2} {"level":"warn","ts":"2026-09-09T01:01:43.438536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.202578ms","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-09T01:01:43.43857Z","caller":"traceutil/trace.go:171","msg":"trace[117431681] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2126; }","duration":"138.269841ms","start":"2026-09-09T01:01:43.300289Z","end":"2026-09-09T01:01:43.438559Z","steps":["trace[117431681] 'agreement among raft nodes before linearized reading' (duration: 138.125336ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:01:43.538785Z","caller":"traceutil/trace.go:171","msg":"trace[1605688429] linearizableReadLoop","detail":"{readStateIndex:2213; appliedIndex:2212; }","duration":"100.398354ms","start":"2026-09-09T01:01:43.438366Z","end":"2026-09-09T01:01:43.538764Z","steps":["trace[1605688429] 'read index received' (duration: 100.347253ms)","trace[1605688429] 'applied index is now lower than readState.Index' (duration: 50.201µs)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:01:43.538875Z","caller":"traceutil/trace.go:171","msg":"trace[1299363706] transaction","detail":"{read_only:false; response_revision:2127; number_of_response:1; }","duration":"231.213679ms","start":"2026-09-09T01:01:43.307651Z","end":"2026-09-09T01:01:43.538865Z","steps":["trace[1299363706] 'process raft request' (duration: 230.989481ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:01:43.539047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.669191ms","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-09T01:01:43.53918Z","caller":"traceutil/trace.go:171","msg":"trace[738600269] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2127; }","duration":"106.833126ms","start":"2026-09-09T01:01:43.432322Z","end":"2026-09-09T01:01:43.539155Z","steps":["trace[738600269] 'agreement among raft nodes before linearized reading' (duration: 106.560887ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:01:43.581263Z","caller":"traceutil/trace.go:171","msg":"trace[1895336077] transaction","detail":"{read_only:false; response_revision:2128; number_of_response:1; }","duration":"139.279033ms","start":"2026-09-09T01:01:43.44196Z","end":"2026-09-09T01:01:43.581239Z","steps":["trace[1895336077] 'process raft request' (duration: 139.098347ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:02:10.681576Z","caller":"traceutil/trace.go:171","msg":"trace[1229945267] transaction","detail":"{read_only:false; response_revision:2287; number_of_response:1; }","duration":"205.940012ms","start":"2026-09-09T01:02:10.475576Z","end":"2026-09-09T01:02:10.681516Z","steps":["trace[1229945267] 'process raft request' (duration: 205.760006ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:02:11.11876Z","caller":"traceutil/trace.go:171","msg":"trace[1173523303] transaction","detail":"{read_only:false; response_revision:2288; number_of_response:1; }","duration":"154.02462ms","start":"2026-09-09T01:02:10.964716Z","end":"2026-09-09T01:02:11.118741Z","steps":["trace[1173523303] 'process raft request' (duration: 153.895416ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:02:11.609969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.842575ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-09T01:02:11.610376Z","caller":"traceutil/trace.go:171","msg":"trace[474048716] transaction","detail":"{read_only:false; response_revision:2289; number_of_response:1; }","duration":"645.36256ms","start":"2026-09-09T01:02:10.964983Z","end":"2026-09-09T01:02:11.610346Z","steps":["trace[474048716] 'process raft request' (duration: 410.074042ms)","trace[474048716] 'compare' (duration: 234.742092ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:02:11.61042Z","caller":"traceutil/trace.go:171","msg":"trace[1905235461] transaction","detail":"{read_only:false; response_revision:2290; number_of_response:1; }","duration":"644.116243ms","start":"2026-09-09T01:02:10.966264Z","end":"2026-09-09T01:02:11.61038Z","steps":["trace[1905235461] 'process raft request' (duration: 643.99476ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:02:11.610487Z","caller":"traceutil/trace.go:171","msg":"trace[1311613325] transaction","detail":"{read_only:false; response_revision:2292; number_of_response:1; }","duration":"482.762406ms","start":"2026-09-09T01:02:11.127642Z","end":"2026-09-09T01:02:11.610405Z","steps":["trace[1311613325] 'process raft request' (duration: 482.721675ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:02:11.610573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:02:10.964977Z","time spent":"645.464363ms","remote":"127.0.0.1:59556","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-09T01:02:11.610662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:02:10.966246Z","time spent":"644.310169ms","remote":"127.0.0.1:59556","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-09T01:02:11.610699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"614.04827ms","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-09T01:02:11.610749Z","caller":"traceutil/trace.go:171","msg":"trace[1885036355] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2292; }","duration":"614.136733ms","start":"2026-09-09T01:02:10.996598Z","end":"2026-09-09T01:02:11.610735Z","steps":["trace[1885036355] 'agreement among raft nodes before linearized reading' (duration: 613.923587ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:02:11.610423Z","caller":"traceutil/trace.go:171","msg":"trace[1909424872] transaction","detail":"{read_only:false; response_revision:2291; number_of_response:1; }","duration":"624.280385ms","start":"2026-09-09T01:02:10.986105Z","end":"2026-09-09T01:02:11.610386Z","steps":["trace[1909424872] 'process raft request' (duration: 624.217983ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:02:11.6108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:02:10.996581Z","time spent":"614.207686ms","remote":"127.0.0.1:59556","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-09-09T01:02:11.61046Z","caller":"traceutil/trace.go:171","msg":"trace[854181089] linearizableReadLoop","detail":"{readStateIndex:2383; appliedIndex:2379; }","duration":"613.782823ms","start":"2026-09-09T01:02:10.996655Z","end":"2026-09-09T01:02:11.610438Z","steps":["trace[854181089] 'read index received' (duration: 121.927037ms)","trace[854181089] 'applied index is now lower than readState.Index' (duration: 491.852926ms)"],"step_count":2} {"level":"warn","ts":"2026-09-09T01:02:11.610906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:02:10.986089Z","time spent":"624.718317ms","remote":"127.0.0.1:59556","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-09T01:02:11.611018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:02:11.127615Z","time spent":"483.027354ms","remote":"127.0.0.1:59556","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":513,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-09T01:02:12.172348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.65906ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-09T01:02:12.172563Z","caller":"traceutil/trace.go:171","msg":"trace[1745565714] transaction","detail":"{read_only:false; response_revision:2294; number_of_response:1; }","duration":"556.357706ms","start":"2026-09-09T01:02:11.616163Z","end":"2026-09-09T01:02:12.172521Z","steps":["trace[1745565714] 'process raft request' (duration: 556.263753ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:02:12.172622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:02:11.616142Z","time spent":"556.450948ms","remote":"127.0.0.1:59556","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-09T01:02:12.172614Z","caller":"traceutil/trace.go:171","msg":"trace[1593272978] linearizableReadLoop","detail":"{readStateIndex:2385; appliedIndex:2384; }","duration":"561.714824ms","start":"2026-09-09T01:02:11.61087Z","end":"2026-09-09T01:02:12.172584Z","steps":["trace[1593272978] 'read index received' (duration: 345.757615ms)","trace[1593272978] 'applied index is now lower than readState.Index' (duration: 215.955559ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:02:12.172738Z","caller":"traceutil/trace.go:171","msg":"trace[1112602397] transaction","detail":"{read_only:false; response_revision:2293; number_of_response:1; }","duration":"597.150702ms","start":"2026-09-09T01:02:11.575575Z","end":"2026-09-09T01:02:12.172726Z","steps":["trace[1112602397] 'process raft request' (duration: 381.041899ms)","trace[1112602397] 'compare' (duration: 215.442493ms)"],"step_count":2} {"level":"warn","ts":"2026-09-09T01:02:12.172812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:02:11.575546Z","time spent":"597.212694ms","remote":"127.0.0.1:59556","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-09T01:02:12.172931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"969.072931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-09T01:02:12.172959Z","caller":"traceutil/trace.go:171","msg":"trace[778741696] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2294; }","duration":"969.101192ms","start":"2026-09-09T01:02:11.203849Z","end":"2026-09-09T01:02:12.172951Z","steps":["trace[778741696] 'agreement among raft nodes before linearized reading' (duration: 969.05864ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:02:12.17298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:02:11.2038Z","time spent":"969.174594ms","remote":"127.0.0.1:59310","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-09T01:02:12.173195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.445324ms","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-09T01:02:12.173229Z","caller":"traceutil/trace.go:171","msg":"trace[2060792706] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2294; }","duration":"425.514916ms","start":"2026-09-09T01:02:11.747703Z","end":"2026-09-09T01:02:12.173218Z","steps":["trace[2060792706] 'agreement among raft nodes before linearized reading' (duration: 425.389852ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:02:12.173255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:02:11.747644Z","time spent":"425.605058ms","remote":"127.0.0.1:59556","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-09-09T01:02:12.173351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"610.003601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-09T01:02:12.173378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.08122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-09T01:02:12.173399Z","caller":"traceutil/trace.go:171","msg":"trace[995165398] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:2294; }","duration":"610.315132ms","start":"2026-09-09T01:02:11.563073Z","end":"2026-09-09T01:02:12.173388Z","steps":["trace[995165398] 'agreement among raft nodes before linearized reading' (duration: 610.017703ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:02:12.173408Z","caller":"traceutil/trace.go:171","msg":"trace[1079233528] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:2294; }","duration":"316.149881ms","start":"2026-09-09T01:02:11.85725Z","end":"2026-09-09T01:02:12.1734Z","steps":["trace[1079233528] 'agreement among raft nodes before linearized reading' (duration: 316.087839ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:02:12.173433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:02:11.563051Z","time spent":"610.364832ms","remote":"127.0.0.1:49570","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true "} {"level":"warn","ts":"2026-09-09T01:02:12.173433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:02:11.857237Z","time spent":"316.188433ms","remote":"127.0.0.1:59452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":29,"request content":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true "} {"level":"warn","ts":"2026-09-09T01:02:12.173831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.218585ms","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-09T01:02:12.173876Z","caller":"traceutil/trace.go:171","msg":"trace[732922852] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2294; }","duration":"359.294928ms","start":"2026-09-09T01:02:11.814569Z","end":"2026-09-09T01:02:12.173864Z","steps":["trace[732922852] 'agreement among raft nodes before linearized reading' (duration: 359.156434ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:02:12.173904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:02:11.814555Z","time spent":"359.341149ms","remote":"127.0.0.1:57390","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5434,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-09-09T01:02:12.173945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.03268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-09T01:02:12.173975Z","caller":"traceutil/trace.go:171","msg":"trace[1106905185] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:2294; }","duration":"336.117792ms","start":"2026-09-09T01:02:11.837848Z","end":"2026-09-09T01:02:12.173966Z","steps":["trace[1106905185] 'agreement among raft nodes before linearized reading' (duration: 335.884415ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:02:12.173998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:02:11.837824Z","time spent":"336.166763ms","remote":"127.0.0.1:49548","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"warn","ts":"2026-09-09T01:02:12.174094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.932592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-09-09T01:02:12.17408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.570855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-09-09T01:02:12.174155Z","caller":"traceutil/trace.go:171","msg":"trace[2000373948] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2294; }","duration":"418.033255ms","start":"2026-09-09T01:02:11.756104Z","end":"2026-09-09T01:02:12.174138Z","steps":["trace[2000373948] 'agreement among raft nodes before linearized reading' (duration: 417.839169ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:02:12.174161Z","caller":"traceutil/trace.go:171","msg":"trace[647555313] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2294; }","duration":"408.691788ms","start":"2026-09-09T01:02:11.765453Z","end":"2026-09-09T01:02:12.174145Z","steps":["trace[647555313] 'agreement among raft nodes before linearized reading' (duration: 408.43957ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:02:12.174192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:02:11.756091Z","time spent":"418.092856ms","remote":"127.0.0.1:59556","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-09-09T01:02:12.174197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:02:11.765442Z","time spent":"408.7463ms","remote":"127.0.0.1:59556","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-09-09T01:03:30.140664Z","caller":"traceutil/trace.go:171","msg":"trace[1309623246] transaction","detail":"{read_only:false; response_revision:2757; number_of_response:1; }","duration":"113.033033ms","start":"2026-09-09T01:03:30.027598Z","end":"2026-09-09T01:03:30.140631Z","steps":["trace[1309623246] 'process raft request' (duration: 86.884634ms)","trace[1309623246] 'compare' (duration: 25.803311ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:03:30.1407Z","caller":"traceutil/trace.go:171","msg":"trace[792177734] transaction","detail":"{read_only:false; response_revision:2758; number_of_response:1; }","duration":"112.221285ms","start":"2026-09-09T01:03:30.028452Z","end":"2026-09-09T01:03:30.140673Z","steps":["trace[792177734] 'process raft request' (duration: 112.03076ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:03:30.141118Z","caller":"traceutil/trace.go:171","msg":"trace[264018169] transaction","detail":"{read_only:false; response_revision:2759; number_of_response:1; }","duration":"111.368394ms","start":"2026-09-09T01:03:30.029709Z","end":"2026-09-09T01:03:30.141078Z","steps":["trace[264018169] 'process raft request' (duration: 110.884523ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:03:40.917709Z","caller":"traceutil/trace.go:171","msg":"trace[1705985353] linearizableReadLoop","detail":"{readStateIndex:2978; appliedIndex:2977; }","duration":"217.461697ms","start":"2026-09-09T01:03:40.700226Z","end":"2026-09-09T01:03:40.917687Z","steps":["trace[1705985353] 'read index received' (duration: 217.245812ms)","trace[1705985353] 'applied index is now lower than readState.Index' (duration: 214.984µs)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:03:40.917765Z","caller":"traceutil/trace.go:171","msg":"trace[1600069877] transaction","detail":"{read_only:false; response_revision:2866; number_of_response:1; }","duration":"234.497825ms","start":"2026-09-09T01:03:40.683243Z","end":"2026-09-09T01:03:40.917741Z","steps":["trace[1600069877] 'process raft request' (duration: 234.2952ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:03:40.917929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.689702ms","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-09T01:03:40.917965Z","caller":"traceutil/trace.go:171","msg":"trace[1509066547] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2866; }","duration":"217.777585ms","start":"2026-09-09T01:03:40.700177Z","end":"2026-09-09T01:03:40.917954Z","steps":["trace[1509066547] 'agreement among raft nodes before linearized reading' (duration: 217.626691ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:03:40.917981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.634405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-09-09T01:03:40.918001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.054685ms","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-09T01:03:40.918034Z","caller":"traceutil/trace.go:171","msg":"trace[214602945] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2866; }","duration":"171.736156ms","start":"2026-09-09T01:03:40.746287Z","end":"2026-09-09T01:03:40.918023Z","steps":["trace[214602945] 'agreement among raft nodes before linearized reading' (duration: 171.590283ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:03:40.918073Z","caller":"traceutil/trace.go:171","msg":"trace[1556721365] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2866; }","duration":"216.176768ms","start":"2026-09-09T01:03:40.701881Z","end":"2026-09-09T01:03:40.918058Z","steps":["trace[1556721365] 'agreement among raft nodes before linearized reading' (duration: 215.967103ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:07:12.399887Z","caller":"traceutil/trace.go:171","msg":"trace[1437310993] transaction","detail":"{read_only:false; response_revision:4068; number_of_response:1; }","duration":"109.226966ms","start":"2026-09-09T01:07:12.290618Z","end":"2026-09-09T01:07:12.399844Z","steps":["trace[1437310993] 'process raft request' (duration: 54.588112ms)","trace[1437310993] 'compare' (duration: 54.121755ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:07:14.636015Z","caller":"traceutil/trace.go:171","msg":"trace[1428585280] linearizableReadLoop","detail":"{readStateIndex:4239; appliedIndex:4238; }","duration":"140.025005ms","start":"2026-09-09T01:07:14.495965Z","end":"2026-09-09T01:07:14.63599Z","steps":["trace[1428585280] 'read index received' (duration: 84.526138ms)","trace[1428585280] 'applied index is now lower than readState.Index' (duration: 55.497737ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:07:14.636114Z","caller":"traceutil/trace.go:171","msg":"trace[614089622] transaction","detail":"{read_only:false; response_revision:4079; number_of_response:1; }","duration":"151.781767ms","start":"2026-09-09T01:07:14.484311Z","end":"2026-09-09T01:07:14.636093Z","steps":["trace[614089622] 'process raft request' (duration: 96.223669ms)","trace[614089622] 'compare' (duration: 55.229493ms)"],"step_count":2} {"level":"warn","ts":"2026-09-09T01:07:14.636177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.198608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-09T01:07:14.636213Z","caller":"traceutil/trace.go:171","msg":"trace[988260210] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:4079; }","duration":"140.30142ms","start":"2026-09-09T01:07:14.495902Z","end":"2026-09-09T01:07:14.636204Z","steps":["trace[988260210] 'agreement among raft nodes before linearized reading' (duration: 140.189288ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:07:14.964634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.861665ms","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-09T01:07:14.964747Z","caller":"traceutil/trace.go:171","msg":"trace[2045585945] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:4079; }","duration":"219.012607ms","start":"2026-09-09T01:07:14.745687Z","end":"2026-09-09T01:07:14.964699Z","steps":["trace[2045585945] 'range keys from in-memory index tree' (duration: 218.792874ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:07:14.96511Z","caller":"traceutil/trace.go:171","msg":"trace[1091968576] transaction","detail":"{read_only:false; response_revision:4080; number_of_response:1; }","duration":"120.888835ms","start":"2026-09-09T01:07:14.844174Z","end":"2026-09-09T01:07:14.965062Z","steps":["trace[1091968576] 'process raft request' (duration: 37.432996ms)","trace[1091968576] 'compare' (duration: 83.212365ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:08:24.812944Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2691} {"level":"info","ts":"2026-09-09T01:08:24.888288Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2691,"took":"74.502535ms","hash":1990179640,"current-db-size-bytes":42381312,"current-db-size":"42 MB","current-db-size-in-use-bytes":16814080,"current-db-size-in-use":"17 MB"} {"level":"info","ts":"2026-09-09T01:08:24.888348Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1990179640,"revision":2691,"compact-revision":-1} {"level":"info","ts":"2026-09-09T01:08:57.174956Z","caller":"traceutil/trace.go:171","msg":"trace[1144503275] linearizableReadLoop","detail":"{readStateIndex:5469; appliedIndex:5468; }","duration":"136.53511ms","start":"2026-09-09T01:08:57.038391Z","end":"2026-09-09T01:08:57.174927Z","steps":["trace[1144503275] 'read index received' (duration: 136.355227ms)","trace[1144503275] 'applied index is now lower than readState.Index' (duration: 178.353µs)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:08:57.175Z","caller":"traceutil/trace.go:171","msg":"trace[1168656313] transaction","detail":"{read_only:false; response_revision:5265; number_of_response:1; }","duration":"165.818174ms","start":"2026-09-09T01:08:57.009152Z","end":"2026-09-09T01:08:57.17497Z","steps":["trace[1168656313] 'process raft request' (duration: 165.613321ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:08:57.175422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.988087ms","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-09T01:08:57.17548Z","caller":"traceutil/trace.go:171","msg":"trace[356198478] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5265; }","duration":"137.097809ms","start":"2026-09-09T01:08:57.038367Z","end":"2026-09-09T01:08:57.175465Z","steps":["trace[356198478] 'agreement among raft nodes before linearized reading' (duration: 136.707762ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:08:57.464041Z","caller":"traceutil/trace.go:171","msg":"trace[30078089] transaction","detail":"{read_only:false; response_revision:5266; number_of_response:1; }","duration":"417.625541ms","start":"2026-09-09T01:08:57.046376Z","end":"2026-09-09T01:08:57.464001Z","steps":["trace[30078089] 'process raft request' (duration: 378.043896ms)","trace[30078089] 'compare' (duration: 39.2629ms)"],"step_count":2} {"level":"warn","ts":"2026-09-09T01:08:57.464227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:08:57.046363Z","time spent":"417.747433ms","remote":"127.0.0.1:59386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2610,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-09T01:08:57.464333Z","caller":"traceutil/trace.go:171","msg":"trace[1377868563] linearizableReadLoop","detail":"{readStateIndex:5470; appliedIndex:5469; }","duration":"289.274386ms","start":"2026-09-09T01:08:57.17504Z","end":"2026-09-09T01:08:57.464314Z","steps":["trace[1377868563] 'read index received' (duration: 249.365436ms)","trace[1377868563] 'applied index is now lower than readState.Index' (duration: 39.90791ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:08:57.464483Z","caller":"traceutil/trace.go:171","msg":"trace[1119206486] transaction","detail":"{read_only:false; response_revision:5267; number_of_response:1; }","duration":"283.911618ms","start":"2026-09-09T01:08:57.180565Z","end":"2026-09-09T01:08:57.464477Z","steps":["trace[1119206486] 'process raft request' (duration: 283.41941ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:08:57.464546Z","caller":"traceutil/trace.go:171","msg":"trace[643017674] transaction","detail":"{read_only:false; response_revision:5268; number_of_response:1; }","duration":"102.15429ms","start":"2026-09-09T01:08:57.362387Z","end":"2026-09-09T01:08:57.464541Z","steps":["trace[643017674] 'process raft request' (duration: 101.668602ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:08:57.4646Z","caller":"traceutil/trace.go:171","msg":"trace[1691568168] transaction","detail":"{read_only:false; response_revision:5269; number_of_response:1; }","duration":"100.465422ms","start":"2026-09-09T01:08:57.364129Z","end":"2026-09-09T01:08:57.464595Z","steps":["trace[1691568168] 'process raft request' (duration: 99.945853ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:08:57.464759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.395242ms","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-09T01:08:57.464776Z","caller":"traceutil/trace.go:171","msg":"trace[1854950020] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5270; }","duration":"343.444063ms","start":"2026-09-09T01:08:57.121327Z","end":"2026-09-09T01:08:57.464771Z","steps":["trace[1854950020] 'agreement among raft nodes before linearized reading' (duration: 343.368871ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:08:57.46479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:08:57.121294Z","time spent":"343.490634ms","remote":"127.0.0.1:59556","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-09-09T01:08:57.464885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.061281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-09-09T01:08:57.464898Z","caller":"traceutil/trace.go:171","msg":"trace[1533467999] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5270; }","duration":"414.086942ms","start":"2026-09-09T01:08:57.050807Z","end":"2026-09-09T01:08:57.464894Z","steps":["trace[1533467999] 'agreement among raft nodes before linearized reading' (duration: 414.044521ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:08:57.464912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:08:57.050802Z","time spent":"414.107342ms","remote":"127.0.0.1:59556","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-09-09T01:08:57.465153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.25323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-09-09T01:08:57.46522Z","caller":"traceutil/trace.go:171","msg":"trace[501091014] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5270; }","duration":"285.360722ms","start":"2026-09-09T01:08:57.179846Z","end":"2026-09-09T01:08:57.465206Z","steps":["trace[501091014] 'agreement among raft nodes before linearized reading' (duration: 285.137318ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:08:57.466264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.015122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-09T01:08:57.466314Z","caller":"traceutil/trace.go:171","msg":"trace[2146628661] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5270; }","duration":"263.105243ms","start":"2026-09-09T01:08:57.203196Z","end":"2026-09-09T01:08:57.466301Z","steps":["trace[2146628661] 'agreement among raft nodes before linearized reading' (duration: 263.027482ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:08:57.466459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.707994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a96011d0-d968-4e08-aaa6-84d749df6da1\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-09-09T01:08:57.466519Z","caller":"traceutil/trace.go:171","msg":"trace[1893963499] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a96011d0-d968-4e08-aaa6-84d749df6da1; range_end:; response_count:1; response_revision:5270; }","duration":"225.950318ms","start":"2026-09-09T01:08:57.240548Z","end":"2026-09-09T01:08:57.466498Z","steps":["trace[1893963499] 'agreement among raft nodes before linearized reading' (duration: 225.611303ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:08:57.466985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.485894ms","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-09T01:08:57.467019Z","caller":"traceutil/trace.go:171","msg":"trace[571338068] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:5270; }","duration":"166.569596ms","start":"2026-09-09T01:08:57.300439Z","end":"2026-09-09T01:08:57.467009Z","steps":["trace[571338068] 'agreement among raft nodes before linearized reading' (duration: 166.306841ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:08:57.774284Z","caller":"traceutil/trace.go:171","msg":"trace[1170554941] linearizableReadLoop","detail":"{readStateIndex:5486; appliedIndex:5480; }","duration":"185.854176ms","start":"2026-09-09T01:08:57.588409Z","end":"2026-09-09T01:08:57.774263Z","steps":["trace[1170554941] 'read index received' (duration: 142.872774ms)","trace[1170554941] 'applied index is now lower than readState.Index' (duration: 42.980222ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:08:57.774372Z","caller":"traceutil/trace.go:171","msg":"trace[1191622958] transaction","detail":"{read_only:false; response_revision:5281; number_of_response:1; }","duration":"206.568539ms","start":"2026-09-09T01:08:57.567794Z","end":"2026-09-09T01:08:57.774363Z","steps":["trace[1191622958] 'process raft request' (duration: 206.337285ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:08:57.774481Z","caller":"traceutil/trace.go:171","msg":"trace[825966452] transaction","detail":"{read_only:false; response_revision:5280; number_of_response:1; }","duration":"206.704872ms","start":"2026-09-09T01:08:57.567736Z","end":"2026-09-09T01:08:57.774441Z","steps":["trace[825966452] 'process raft request' (duration: 206.370166ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:08:57.774608Z","caller":"traceutil/trace.go:171","msg":"trace[1311667451] transaction","detail":"{read_only:false; response_revision:5277; number_of_response:1; }","duration":"206.888544ms","start":"2026-09-09T01:08:57.567693Z","end":"2026-09-09T01:08:57.774581Z","steps":["trace[1311667451] 'process raft request' (duration: 163.575897ms)","trace[1311667451] 'compare' (duration: 42.670496ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:08:57.774709Z","caller":"traceutil/trace.go:171","msg":"trace[1637147669] transaction","detail":"{read_only:false; response_revision:5282; number_of_response:1; }","duration":"202.834957ms","start":"2026-09-09T01:08:57.571863Z","end":"2026-09-09T01:08:57.774698Z","steps":["trace[1637147669] 'process raft request' (duration: 202.302428ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:08:57.774686Z","caller":"traceutil/trace.go:171","msg":"trace[891469084] transaction","detail":"{read_only:false; response_revision:5279; number_of_response:1; }","duration":"206.784972ms","start":"2026-09-09T01:08:57.567694Z","end":"2026-09-09T01:08:57.774479Z","steps":["trace[891469084] 'process raft request' (duration: 206.382546ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:08:57.774833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.404705ms","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-09T01:08:57.774892Z","caller":"traceutil/trace.go:171","msg":"trace[1768804969] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:5282; }","duration":"186.504407ms","start":"2026-09-09T01:08:57.588373Z","end":"2026-09-09T01:08:57.774877Z","steps":["trace[1768804969] 'agreement among raft nodes before linearized reading' (duration: 186.404405ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:08:57.774507Z","caller":"traceutil/trace.go:171","msg":"trace[651515362] transaction","detail":"{read_only:false; response_revision:5278; number_of_response:1; }","duration":"206.783312ms","start":"2026-09-09T01:08:57.567701Z","end":"2026-09-09T01:08:57.774484Z","steps":["trace[651515362] 'process raft request' (duration: 206.340385ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:08:57.780702Z","caller":"traceutil/trace.go:171","msg":"trace[1970756094] transaction","detail":"{read_only:false; response_revision:5283; number_of_response:1; }","duration":"184.809129ms","start":"2026-09-09T01:08:57.595875Z","end":"2026-09-09T01:08:57.780684Z","steps":["trace[1970756094] 'process raft request' (duration: 184.663536ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:08:57.780876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.844489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-47jsx\" ","response":"range_response_count:1 size:9352"} {"level":"warn","ts":"2026-09-09T01:08:57.780881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.314813ms","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-09T01:08:57.780947Z","caller":"traceutil/trace.go:171","msg":"trace[460616868] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-47jsx; range_end:; response_count:1; response_revision:5283; }","duration":"184.956931ms","start":"2026-09-09T01:08:57.59597Z","end":"2026-09-09T01:08:57.780927Z","steps":["trace[460616868] 'agreement among raft nodes before linearized reading' (duration: 184.717227ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:08:57.780957Z","caller":"traceutil/trace.go:171","msg":"trace[501557171] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0; range_end:; response_count:1; response_revision:5283; }","duration":"186.397085ms","start":"2026-09-09T01:08:57.594541Z","end":"2026-09-09T01:08:57.780938Z","steps":["trace[501557171] 'agreement among raft nodes before linearized reading' (duration: 186.141381ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:08:57.898406Z","caller":"traceutil/trace.go:171","msg":"trace[382599351] transaction","detail":"{read_only:false; response_revision:5285; number_of_response:1; }","duration":"115.920558ms","start":"2026-09-09T01:08:57.782461Z","end":"2026-09-09T01:08:57.898381Z","steps":["trace[382599351] 'process raft request' (duration: 97.572515ms)","trace[382599351] 'compare' (duration: 18.175611ms)"],"step_count":2} {"level":"warn","ts":"2026-09-09T01:08:57.898744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.851681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-1\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-09T01:08:57.898791Z","caller":"traceutil/trace.go:171","msg":"trace[285270497] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-1; range_end:; response_count:0; response_revision:5287; }","duration":"114.950972ms","start":"2026-09-09T01:08:57.783826Z","end":"2026-09-09T01:08:57.898777Z","steps":["trace[285270497] 'agreement among raft nodes before linearized reading' (duration: 114.869021ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:08:57.898759Z","caller":"traceutil/trace.go:171","msg":"trace[633308714] transaction","detail":"{read_only:false; response_revision:5286; number_of_response:1; }","duration":"111.77849ms","start":"2026-09-09T01:08:57.786948Z","end":"2026-09-09T01:08:57.898726Z","steps":["trace[633308714] 'process raft request' (duration: 111.383304ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:08:57.898957Z","caller":"traceutil/trace.go:171","msg":"trace[1884080620] transaction","detail":"{read_only:false; response_revision:5287; number_of_response:1; }","duration":"105.362034ms","start":"2026-09-09T01:08:57.793578Z","end":"2026-09-09T01:08:57.89894Z","steps":["trace[1884080620] 'process raft request' (duration: 104.832005ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:08:58.029129Z","caller":"traceutil/trace.go:171","msg":"trace[595435250] transaction","detail":"{read_only:false; response_revision:5288; number_of_response:1; }","duration":"119.213263ms","start":"2026-09-09T01:08:57.909883Z","end":"2026-09-09T01:08:58.029096Z","steps":["trace[595435250] 'process raft request' (duration: 93.0378ms)","trace[595435250] 'compare' (duration: 26.02952ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:08:58.066166Z","caller":"traceutil/trace.go:171","msg":"trace[1700482175] linearizableReadLoop","detail":"{readStateIndex:5493; appliedIndex:5491; }","duration":"153.591932ms","start":"2026-09-09T01:08:57.912552Z","end":"2026-09-09T01:08:58.066144Z","steps":["trace[1700482175] 'read index received' (duration: 90.396226ms)","trace[1700482175] 'applied index is now lower than readState.Index' (duration: 63.194716ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:08:58.066209Z","caller":"traceutil/trace.go:171","msg":"trace[714088949] transaction","detail":"{read_only:false; response_revision:5289; number_of_response:1; }","duration":"153.836676ms","start":"2026-09-09T01:08:57.912356Z","end":"2026-09-09T01:08:58.066193Z","steps":["trace[714088949] 'process raft request' (duration: 153.654233ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:08:58.066454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.880397ms","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-09T01:08:58.066563Z","caller":"traceutil/trace.go:171","msg":"trace[557530501] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:5289; }","duration":"153.969538ms","start":"2026-09-09T01:08:57.91253Z","end":"2026-09-09T01:08:58.0665Z","steps":["trace[557530501] 'agreement among raft nodes before linearized reading' (duration: 153.722274ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:08:58.178223Z","caller":"traceutil/trace.go:171","msg":"trace[175545613] linearizableReadLoop","detail":"{readStateIndex:5495; appliedIndex:5493; }","duration":"111.971193ms","start":"2026-09-09T01:08:58.066226Z","end":"2026-09-09T01:08:58.178197Z","steps":["trace[175545613] 'read index received' (duration: 111.593356ms)","trace[175545613] 'applied index is now lower than readState.Index' (duration: 376.447µs)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:08:58.178345Z","caller":"traceutil/trace.go:171","msg":"trace[1824800113] transaction","detail":"{read_only:false; response_revision:5290; number_of_response:1; }","duration":"135.839907ms","start":"2026-09-09T01:08:58.042496Z","end":"2026-09-09T01:08:58.178336Z","steps":["trace[1824800113] 'process raft request' (duration: 135.450991ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:08:58.178287Z","caller":"traceutil/trace.go:171","msg":"trace[899218856] transaction","detail":"{read_only:false; number_of_response:1; response_revision:5290; }","duration":"130.716183ms","start":"2026-09-09T01:08:58.047542Z","end":"2026-09-09T01:08:58.178258Z","steps":["trace[899218856] 'process raft request' (duration: 130.604691ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:08:58.178611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.548333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"} {"level":"info","ts":"2026-09-09T01:08:58.178709Z","caller":"traceutil/trace.go:171","msg":"trace[1432857030] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:5290; }","duration":"248.681235ms","start":"2026-09-09T01:08:57.93001Z","end":"2026-09-09T01:08:58.178691Z","steps":["trace[1432857030] 'agreement among raft nodes before linearized reading' (duration: 248.427231ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:08:58.178771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.29656ms","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-09T01:08:58.178847Z","caller":"traceutil/trace.go:171","msg":"trace[1129642554] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:5290; }","duration":"262.510683ms","start":"2026-09-09T01:08:57.91632Z","end":"2026-09-09T01:08:58.17883Z","steps":["trace[1129642554] 'agreement among raft nodes before linearized reading' (duration: 262.143477ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:08:58.341727Z","caller":"traceutil/trace.go:171","msg":"trace[1630651010] transaction","detail":"{read_only:false; response_revision:5293; number_of_response:1; }","duration":"140.999813ms","start":"2026-09-09T01:08:58.200698Z","end":"2026-09-09T01:08:58.341698Z","steps":["trace[1630651010] 'process raft request' (duration: 74.475542ms)","trace[1630651010] 'compare' (duration: 66.209865ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:08:58.341733Z","caller":"traceutil/trace.go:171","msg":"trace[1894213824] transaction","detail":"{read_only:false; number_of_response:1; response_revision:5294; }","duration":"104.621541ms","start":"2026-09-09T01:08:58.237091Z","end":"2026-09-09T01:08:58.341712Z","steps":["trace[1894213824] 'process raft request' (duration: 104.512149ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:08:58.342013Z","caller":"traceutil/trace.go:171","msg":"trace[2009529565] linearizableReadLoop","detail":"{readStateIndex:5499; appliedIndex:5498; }","duration":"106.020914ms","start":"2026-09-09T01:08:58.235981Z","end":"2026-09-09T01:08:58.342002Z","steps":["trace[2009529565] 'read index received' (duration: 39.259439ms)","trace[2009529565] 'applied index is now lower than readState.Index' (duration: 66.760415ms)"],"step_count":2} {"level":"warn","ts":"2026-09-09T01:08:58.342257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.673617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:6 size:60876"} {"level":"info","ts":"2026-09-09T01:08:58.342293Z","caller":"traceutil/trace.go:171","msg":"trace[53050192] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:6; response_revision:5294; }","duration":"137.733439ms","start":"2026-09-09T01:08:58.20455Z","end":"2026-09-09T01:08:58.342284Z","steps":["trace[53050192] 'agreement among raft nodes before linearized reading' (duration: 137.519086ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:08:58.342462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.161046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0\" ","response":"range_response_count:1 size:1342"} {"level":"info","ts":"2026-09-09T01:08:58.342499Z","caller":"traceutil/trace.go:171","msg":"trace[1050857956] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0; range_end:; response_count:1; response_revision:5294; }","duration":"103.198937ms","start":"2026-09-09T01:08:58.239288Z","end":"2026-09-09T01:08:58.342487Z","steps":["trace[1050857956] 'agreement among raft nodes before linearized reading' (duration: 103.103025ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:08:58.342539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.087425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"info","ts":"2026-09-09T01:08:58.342591Z","caller":"traceutil/trace.go:171","msg":"trace[1303004608] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:5294; }","duration":"138.148576ms","start":"2026-09-09T01:08:58.204427Z","end":"2026-09-09T01:08:58.342576Z","steps":["trace[1303004608] 'agreement among raft nodes before linearized reading' (duration: 137.988533ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:09:12.497901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.831035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-09T01:09:12.497997Z","caller":"traceutil/trace.go:171","msg":"trace[1691069423] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5493; }","duration":"293.966327ms","start":"2026-09-09T01:09:12.204007Z","end":"2026-09-09T01:09:12.497974Z","steps":["trace[1691069423] 'range keys from in-memory index tree' (duration: 293.764923ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:09:13.018902Z","caller":"traceutil/trace.go:171","msg":"trace[415172904] transaction","detail":"{read_only:false; response_revision:5496; number_of_response:1; }","duration":"100.09531ms","start":"2026-09-09T01:09:12.918776Z","end":"2026-09-09T01:09:13.018871Z","steps":["trace[415172904] 'process raft request' (duration: 58.066197ms)","trace[415172904] 'compare' (duration: 41.911101ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:09:51.759699Z","caller":"traceutil/trace.go:171","msg":"trace[1261609659] transaction","detail":"{read_only:false; response_revision:5823; number_of_response:1; }","duration":"114.780261ms","start":"2026-09-09T01:09:51.644894Z","end":"2026-09-09T01:09:51.759674Z","steps":["trace[1261609659] 'process raft request' (duration: 114.627405ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:09:51.771027Z","caller":"traceutil/trace.go:171","msg":"trace[475138422] transaction","detail":"{read_only:false; response_revision:5824; number_of_response:1; }","duration":"125.841152ms","start":"2026-09-09T01:09:51.645162Z","end":"2026-09-09T01:09:51.771003Z","steps":["trace[475138422] 'process raft request' (duration: 125.670805ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:09:51.771356Z","caller":"traceutil/trace.go:171","msg":"trace[290991543] transaction","detail":"{read_only:false; response_revision:5825; number_of_response:1; }","duration":"126.136995ms","start":"2026-09-09T01:09:51.645197Z","end":"2026-09-09T01:09:51.771334Z","steps":["trace[290991543] 'process raft request' (duration: 125.76907ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:10:11.325985Z","caller":"traceutil/trace.go:171","msg":"trace[740710951] transaction","detail":"{read_only:false; response_revision:5957; number_of_response:1; }","duration":"103.315312ms","start":"2026-09-09T01:10:11.222642Z","end":"2026-09-09T01:10:11.325957Z","steps":["trace[740710951] 'process raft request' (duration: 56.144257ms)","trace[740710951] 'compare' (duration: 47.046141ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:13:02.355983Z","caller":"traceutil/trace.go:171","msg":"trace[1719476202] transaction","detail":"{read_only:false; response_revision:7134; number_of_response:1; }","duration":"104.373836ms","start":"2026-09-09T01:13:02.25158Z","end":"2026-09-09T01:13:02.355954Z","steps":["trace[1719476202] 'process raft request' (duration: 104.154069ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:13:24.819762Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":4523} {"level":"info","ts":"2026-09-09T01:13:24.88025Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":4523,"took":"58.879698ms","hash":1273064181,"current-db-size-bytes":42381312,"current-db-size":"42 MB","current-db-size-in-use-bytes":33370112,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-09-09T01:13:24.880326Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1273064181,"revision":4523,"compact-revision":2691} {"level":"info","ts":"2026-09-09T01:13:25.205997Z","caller":"traceutil/trace.go:171","msg":"trace[346143246] transaction","detail":"{read_only:false; response_revision:7309; number_of_response:1; }","duration":"104.934997ms","start":"2026-09-09T01:13:25.101032Z","end":"2026-09-09T01:13:25.205967Z","steps":["trace[346143246] 'process raft request' (duration: 30.883953ms)","trace[346143246] 'compare' (duration: 73.857209ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:13:25.214135Z","caller":"traceutil/trace.go:171","msg":"trace[606101922] transaction","detail":"{read_only:false; response_revision:7310; number_of_response:1; }","duration":"111.267777ms","start":"2026-09-09T01:13:25.102843Z","end":"2026-09-09T01:13:25.21411Z","steps":["trace[606101922] 'process raft request' (duration: 111.154853ms)"],"step_count":1}