{"level":"warn","ts":"2026-03-15T04:48:40.082359Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-15T04:48:40.082441Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.227: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.227:2380","--initial-cluster=instance=https://162.253.55.227:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.227:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.227: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-03-15T04:48:40.082503Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-15T04:48:40.082515Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.227:2380"]}
{"level":"info","ts":"2026-03-15T04:48:40.08253Z","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-03-15T04:48:40.083134Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.227:2379"]}
{"level":"info","ts":"2026-03-15T04:48:40.0832Z","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":16,"max-cpu-available":16,"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.227:2380"],"listen-peer-urls":["https://162.253.55.227:2380"],"advertise-client-urls":["https://162.253.55.227:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.227:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.227: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-03-15T04:48:40.086783Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.371373ms"}
{"level":"info","ts":"2026-03-15T04:48:40.092453Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"9bd37ed2859641e3","cluster-id":"47d0f4f0a1c3b0a9"}
{"level":"info","ts":"2026-03-15T04:48:40.092526Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd37ed2859641e3 switched to configuration voters=()"}
{"level":"info","ts":"2026-03-15T04:48:40.092546Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd37ed2859641e3 became follower at term 0"}
{"level":"info","ts":"2026-03-15T04:48:40.092557Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 9bd37ed2859641e3 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-03-15T04:48:40.092574Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd37ed2859641e3 became follower at term 1"}
{"level":"info","ts":"2026-03-15T04:48:40.092616Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd37ed2859641e3 switched to configuration voters=(11228457738614227427)"}
{"level":"warn","ts":"2026-03-15T04:48:40.098032Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-03-15T04:48:40.100012Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-03-15T04:48:40.101332Z","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-03-15T04:48:40.104557Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"9bd37ed2859641e3","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-03-15T04:48:40.104707Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"9bd37ed2859641e3","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-03-15T04:48:40.105031Z","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-03-15T04:48:40.105119Z","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-03-15T04:48:40.10514Z","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-03-15T04:48:40.108223Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd37ed2859641e3 switched to configuration voters=(11228457738614227427)"}
{"level":"info","ts":"2026-03-15T04:48:40.108376Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"47d0f4f0a1c3b0a9","local-member-id":"9bd37ed2859641e3","added-peer-id":"9bd37ed2859641e3","added-peer-peer-urls":["https://162.253.55.227:2380"]}
{"level":"info","ts":"2026-03-15T04:48:40.109717Z","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-03-15T04:48:40.109817Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.227:2380"}
{"level":"info","ts":"2026-03-15T04:48:40.109861Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.227:2380"}
{"level":"info","ts":"2026-03-15T04:48:40.110015Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"9bd37ed2859641e3","initial-advertise-peer-urls":["https://162.253.55.227:2380"],"listen-peer-urls":["https://162.253.55.227:2380"],"advertise-client-urls":["https://162.253.55.227:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.227:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-03-15T04:48:40.110053Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-03-15T04:48:40.793549Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd37ed2859641e3 is starting a new election at term 1"}
{"level":"info","ts":"2026-03-15T04:48:40.793638Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd37ed2859641e3 became pre-candidate at term 1"}
{"level":"info","ts":"2026-03-15T04:48:40.793668Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd37ed2859641e3 received MsgPreVoteResp from 9bd37ed2859641e3 at term 1"}
{"level":"info","ts":"2026-03-15T04:48:40.793688Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd37ed2859641e3 became candidate at term 2"}
{"level":"info","ts":"2026-03-15T04:48:40.793698Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd37ed2859641e3 received MsgVoteResp from 9bd37ed2859641e3 at term 2"}
{"level":"info","ts":"2026-03-15T04:48:40.793714Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd37ed2859641e3 became leader at term 2"}
{"level":"info","ts":"2026-03-15T04:48:40.793727Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 9bd37ed2859641e3 elected leader 9bd37ed2859641e3 at term 2"}
{"level":"info","ts":"2026-03-15T04:48:40.79482Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-15T04:48:40.795998Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-15T04:48:40.796007Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"9bd37ed2859641e3","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.227:2379]}","request-path":"/0/members/9bd37ed2859641e3/attributes","cluster-id":"47d0f4f0a1c3b0a9","publish-timeout":"7s"}
{"level":"info","ts":"2026-03-15T04:48:40.796047Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-15T04:48:40.796467Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-03-15T04:48:40.796499Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-03-15T04:48:40.796526Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"47d0f4f0a1c3b0a9","local-member-id":"9bd37ed2859641e3","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-15T04:48:40.796669Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-15T04:48:40.796712Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-15T04:48:40.79859Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.227:2379"}
{"level":"info","ts":"2026-03-15T04:48:40.799467Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-03-15T04:49:15.615063Z","caller":"traceutil/trace.go:171","msg":"trace[53417529] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"178.311486ms","start":"2026-03-15T04:49:15.436729Z","end":"2026-03-15T04:49:15.61504Z","steps":["trace[53417529] 'process raft request'  (duration: 178.159173ms)"],"step_count":1}
{"level":"info","ts":"2026-03-15T04:49:40.932032Z","caller":"traceutil/trace.go:171","msg":"trace[711677314] transaction","detail":"{read_only:false; response_revision:933; number_of_response:1; }","duration":"171.024608ms","start":"2026-03-15T04:49:40.760961Z","end":"2026-03-15T04:49:40.931986Z","steps":["trace[711677314] 'process raft request'  (duration: 170.082028ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-15T04:50:31.665116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.997303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-15T04:50:31.665236Z","caller":"traceutil/trace.go:171","msg":"trace[948030567] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1612; }","duration":"238.193736ms","start":"2026-03-15T04:50:31.42703Z","end":"2026-03-15T04:50:31.665223Z","steps":["trace[948030567] 'range keys from in-memory index tree'  (duration: 237.908201ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-15T04:50:31.665281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.190118ms","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-03-15T04:50:31.665376Z","caller":"traceutil/trace.go:171","msg":"trace[975592531] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1612; }","duration":"318.344171ms","start":"2026-03-15T04:50:31.347007Z","end":"2026-03-15T04:50:31.665351Z","steps":["trace[975592531] 'range keys from in-memory index tree'  (duration: 317.953823ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-15T04:50:31.665441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-15T04:50:31.346984Z","time spent":"318.444132ms","remote":"127.0.0.1:46390","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-03-15T04:50:32.06505Z","caller":"traceutil/trace.go:171","msg":"trace[1898909294] transaction","detail":"{read_only:false; response_revision:1614; number_of_response:1; }","duration":"214.239697ms","start":"2026-03-15T04:50:31.850771Z","end":"2026-03-15T04:50:32.065011Z","steps":["trace[1898909294] 'process raft request'  (duration: 213.945761ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-15T04:50:40.536216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.297757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-03-15T04:50:40.536323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.561052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-15T04:50:40.536377Z","caller":"traceutil/trace.go:171","msg":"trace[2095310933] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:1688; }","duration":"115.582812ms","start":"2026-03-15T04:50:40.42076Z","end":"2026-03-15T04:50:40.536343Z","steps":["trace[2095310933] 'count revisions from in-memory index tree'  (duration: 115.172255ms)"],"step_count":1}
{"level":"info","ts":"2026-03-15T04:50:40.536453Z","caller":"traceutil/trace.go:171","msg":"trace[2001794600] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1688; }","duration":"110.740186ms","start":"2026-03-15T04:50:40.425677Z","end":"2026-03-15T04:50:40.536418Z","steps":["trace[2001794600] 'range keys from in-memory index tree'  (duration: 110.48842ms)"],"step_count":1}
{"level":"info","ts":"2026-03-15T04:50:45.024595Z","caller":"traceutil/trace.go:171","msg":"trace[423692026] linearizableReadLoop","detail":"{readStateIndex:1783; appliedIndex:1782; }","duration":"147.110665ms","start":"2026-03-15T04:50:44.877461Z","end":"2026-03-15T04:50:45.024571Z","steps":["trace[423692026] 'read index received'  (duration: 146.886079ms)","trace[423692026] 'applied index is now lower than readState.Index'  (duration: 223.556µs)"],"step_count":2}
{"level":"info","ts":"2026-03-15T04:50:45.024731Z","caller":"traceutil/trace.go:171","msg":"trace[1050751030] transaction","detail":"{read_only:false; response_revision:1715; number_of_response:1; }","duration":"148.556103ms","start":"2026-03-15T04:50:44.876121Z","end":"2026-03-15T04:50:45.024677Z","steps":["trace[1050751030] 'process raft request'  (duration: 148.283657ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-15T04:50:45.024833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.345209ms","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-03-15T04:50:45.024897Z","caller":"traceutil/trace.go:171","msg":"trace[34859822] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1715; }","duration":"147.465832ms","start":"2026-03-15T04:50:44.87742Z","end":"2026-03-15T04:50:45.024886Z","steps":["trace[34859822] 'agreement among raft nodes before linearized reading'  (duration: 147.251288ms)"],"step_count":1}
{"level":"info","ts":"2026-03-15T04:51:17.063974Z","caller":"traceutil/trace.go:171","msg":"trace[450900316] transaction","detail":"{read_only:false; response_revision:1888; number_of_response:1; }","duration":"102.870989ms","start":"2026-03-15T04:51:16.961043Z","end":"2026-03-15T04:51:17.063914Z","steps":["trace[450900316] 'process raft request'  (duration: 42.819646ms)","trace[450900316] 'compare'  (duration: 59.311177ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-15T04:51:23.322831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.576455ms","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-03-15T04:51:23.322923Z","caller":"traceutil/trace.go:171","msg":"trace[2069366632] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1916; }","duration":"214.721137ms","start":"2026-03-15T04:51:23.108179Z","end":"2026-03-15T04:51:23.3229Z","steps":["trace[2069366632] 'range keys from in-memory index tree'  (duration: 214.416041ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-15T04:51:23.323037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.920051ms","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-03-15T04:51:23.323149Z","caller":"traceutil/trace.go:171","msg":"trace[1665073651] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1916; }","duration":"236.092754ms","start":"2026-03-15T04:51:23.087032Z","end":"2026-03-15T04:51:23.323125Z","steps":["trace[1665073651] 'range keys from in-memory index tree'  (duration: 235.684606ms)"],"step_count":1}
{"level":"info","ts":"2026-03-15T04:51:23.555989Z","caller":"traceutil/trace.go:171","msg":"trace[1729911075] linearizableReadLoop","detail":"{readStateIndex:1995; appliedIndex:1993; }","duration":"129.569353ms","start":"2026-03-15T04:51:23.426391Z","end":"2026-03-15T04:51:23.55596Z","steps":["trace[1729911075] 'read index received'  (duration: 129.305497ms)","trace[1729911075] 'applied index is now lower than readState.Index'  (duration: 262.226µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-15T04:51:23.556213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.791987ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-15T04:51:23.556301Z","caller":"traceutil/trace.go:171","msg":"trace[1093561508] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1919; }","duration":"129.94101ms","start":"2026-03-15T04:51:23.426343Z","end":"2026-03-15T04:51:23.556284Z","steps":["trace[1093561508] 'agreement among raft nodes before linearized reading'  (duration: 129.746876ms)"],"step_count":1}
{"level":"info","ts":"2026-03-15T04:51:23.55636Z","caller":"traceutil/trace.go:171","msg":"trace[1185632171] transaction","detail":"{read_only:false; response_revision:1919; number_of_response:1; }","duration":"229.010233ms","start":"2026-03-15T04:51:23.327318Z","end":"2026-03-15T04:51:23.556328Z","steps":["trace[1185632171] 'process raft request'  (duration: 228.588705ms)"],"step_count":1}
{"level":"info","ts":"2026-03-15T04:51:23.556349Z","caller":"traceutil/trace.go:171","msg":"trace[1173471106] transaction","detail":"{read_only:false; response_revision:1918; number_of_response:1; }","duration":"229.039953ms","start":"2026-03-15T04:51:23.327262Z","end":"2026-03-15T04:51:23.556302Z","steps":["trace[1173471106] 'process raft request'  (duration: 228.475652ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-15T04:52:13.950362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.693865ms","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-03-15T04:52:13.950511Z","caller":"traceutil/trace.go:171","msg":"trace[667384693] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2338; }","duration":"147.859168ms","start":"2026-03-15T04:52:13.802602Z","end":"2026-03-15T04:52:13.950461Z","steps":["trace[667384693] 'range keys from in-memory index tree'  (duration: 147.501401ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-15T04:52:13.950586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.384049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-03-15T04:52:13.950695Z","caller":"traceutil/trace.go:171","msg":"trace[587642474] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2338; }","duration":"148.539303ms","start":"2026-03-15T04:52:13.802132Z","end":"2026-03-15T04:52:13.950672Z","steps":["trace[587642474] 'range keys from in-memory index tree'  (duration: 148.154685ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-15T04:52:13.950927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.971572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.227\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-03-15T04:52:13.951186Z","caller":"traceutil/trace.go:171","msg":"trace[302812413] range","detail":"{range_begin:/registry/masterleases/162.253.55.227; range_end:; response_count:1; response_revision:2338; }","duration":"182.466682ms","start":"2026-03-15T04:52:13.768691Z","end":"2026-03-15T04:52:13.951158Z","steps":["trace[302812413] 'range keys from in-memory index tree'  (duration: 181.628525ms)"],"step_count":1}
{"level":"info","ts":"2026-03-15T04:52:47.445388Z","caller":"traceutil/trace.go:171","msg":"trace[85246267] transaction","detail":"{read_only:false; response_revision:2525; number_of_response:1; }","duration":"112.57591ms","start":"2026-03-15T04:52:47.332785Z","end":"2026-03-15T04:52:47.445361Z","steps":["trace[85246267] 'process raft request'  (duration: 112.423087ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-15T04:56:23.96944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.734727ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4747810986032677612 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:15-second id:41e39cefd32cc2eb>","response":"size:40"}
{"level":"info","ts":"2026-03-15T04:56:24.142356Z","caller":"traceutil/trace.go:171","msg":"trace[1388188895] linearizableReadLoop","detail":"{readStateIndex:4544; appliedIndex:4543; }","duration":"221.544479ms","start":"2026-03-15T04:56:23.920787Z","end":"2026-03-15T04:56:24.142332Z","steps":["trace[1388188895] 'read index received'  (duration: 221.517799ms)","trace[1388188895] 'applied index is now lower than readState.Index'  (duration: 25.61µs)"],"step_count":2}
{"level":"info","ts":"2026-03-15T04:56:24.142446Z","caller":"traceutil/trace.go:171","msg":"trace[470833164] transaction","detail":"{read_only:false; response_revision:4368; number_of_response:1; }","duration":"302.071892ms","start":"2026-03-15T04:56:23.840342Z","end":"2026-03-15T04:56:24.142414Z","steps":["trace[470833164] 'process raft request'  (duration: 301.808887ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-15T04:56:24.143009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-15T04:56:23.840308Z","time spent":"302.207654ms","remote":"127.0.0.1:46310","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":14482,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" mod_revision:4238 > success:<request_put:<key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" value_size:14403 >> failure:<request_range:<key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" > >"}
{"level":"warn","ts":"2026-03-15T04:56:24.143368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.55919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:50 size:2196043"}
{"level":"info","ts":"2026-03-15T04:56:24.143419Z","caller":"traceutil/trace.go:171","msg":"trace[1643713566] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:50; response_revision:4368; }","duration":"222.658251ms","start":"2026-03-15T04:56:23.920749Z","end":"2026-03-15T04:56:24.143407Z","steps":["trace[1643713566] 'agreement among raft nodes before linearized reading'  (duration: 221.687592ms)"],"step_count":1}
{"level":"info","ts":"2026-03-15T04:56:24.153194Z","caller":"traceutil/trace.go:171","msg":"trace[273052112] transaction","detail":"{read_only:false; response_revision:4369; number_of_response:1; }","duration":"182.442802ms","start":"2026-03-15T04:56:23.970728Z","end":"2026-03-15T04:56:24.153171Z","steps":["trace[273052112] 'process raft request'  (duration: 182.292259ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-15T04:56:24.153449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.420225ms","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-03-15T04:56:24.153499Z","caller":"traceutil/trace.go:171","msg":"trace[139762649] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4369; }","duration":"118.507917ms","start":"2026-03-15T04:56:24.034979Z","end":"2026-03-15T04:56:24.153487Z","steps":["trace[139762649] 'agreement among raft nodes before linearized reading'  (duration: 118.329973ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-15T04:56:24.153732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.608107ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:23 size:521825"}
{"level":"info","ts":"2026-03-15T04:56:24.153781Z","caller":"traceutil/trace.go:171","msg":"trace[2104747728] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:23; response_revision:4369; }","duration":"141.69486ms","start":"2026-03-15T04:56:24.012073Z","end":"2026-03-15T04:56:24.153768Z","steps":["trace[2104747728] 'agreement among raft nodes before linearized reading'  (duration: 141.337872ms)"],"step_count":1}
{"level":"info","ts":"2026-03-15T04:56:24.287934Z","caller":"traceutil/trace.go:171","msg":"trace[1121639383] transaction","detail":"{read_only:false; response_revision:4370; number_of_response:1; }","duration":"137.777061ms","start":"2026-03-15T04:56:24.150117Z","end":"2026-03-15T04:56:24.287894Z","steps":["trace[1121639383] 'process raft request'  (duration: 98.771605ms)","trace[1121639383] 'compare'  (duration: 38.848582ms)"],"step_count":2}
{"level":"info","ts":"2026-03-15T04:56:24.28807Z","caller":"traceutil/trace.go:171","msg":"trace[2040282037] linearizableReadLoop","detail":"{readStateIndex:4546; appliedIndex:4545; }","duration":"134.891111ms","start":"2026-03-15T04:56:24.153143Z","end":"2026-03-15T04:56:24.288035Z","steps":["trace[2040282037] 'read index received'  (duration: 95.757213ms)","trace[2040282037] 'applied index is now lower than readState.Index'  (duration: 39.127238ms)"],"step_count":2}
{"level":"info","ts":"2026-03-15T04:56:24.288229Z","caller":"traceutil/trace.go:171","msg":"trace[637079377] transaction","detail":"{read_only:false; response_revision:4371; number_of_response:1; }","duration":"131.537503ms","start":"2026-03-15T04:56:24.156651Z","end":"2026-03-15T04:56:24.288189Z","steps":["trace[637079377] 'process raft request'  (duration: 131.259598ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-15T04:56:24.288375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.768269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"}
{"level":"info","ts":"2026-03-15T04:56:24.288435Z","caller":"traceutil/trace.go:171","msg":"trace[2021575617] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:4372; }","duration":"133.856371ms","start":"2026-03-15T04:56:24.154565Z","end":"2026-03-15T04:56:24.288422Z","steps":["trace[2021575617] 'agreement among raft nodes before linearized reading'  (duration: 133.708688ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-15T04:56:24.28846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.995954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:14497"}
{"level":"info","ts":"2026-03-15T04:56:24.28852Z","caller":"traceutil/trace.go:171","msg":"trace[1341590684] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4372; }","duration":"139.101206ms","start":"2026-03-15T04:56:24.14939Z","end":"2026-03-15T04:56:24.288491Z","steps":["trace[1341590684] 'agreement among raft nodes before linearized reading'  (duration: 138.844441ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-15T04:56:24.288585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.382513ms","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-03-15T04:56:24.288588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.98075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"}
{"level":"info","ts":"2026-03-15T04:56:24.288624Z","caller":"traceutil/trace.go:171","msg":"trace[1488519938] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4372; }","duration":"114.459115ms","start":"2026-03-15T04:56:24.174153Z","end":"2026-03-15T04:56:24.288612Z","steps":["trace[1488519938] 'agreement among raft nodes before linearized reading'  (duration: 114.325192ms)"],"step_count":1}
{"level":"info","ts":"2026-03-15T04:56:24.288637Z","caller":"traceutil/trace.go:171","msg":"trace[663466129] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4372; }","duration":"126.063791ms","start":"2026-03-15T04:56:24.162556Z","end":"2026-03-15T04:56:24.28862Z","steps":["trace[663466129] 'agreement among raft nodes before linearized reading'  (duration: 125.891278ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-15T04:56:24.288764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.207805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:7 size:62983"}
{"level":"info","ts":"2026-03-15T04:56:24.288805Z","caller":"traceutil/trace.go:171","msg":"trace[2144999353] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:7; response_revision:4372; }","duration":"126.270826ms","start":"2026-03-15T04:56:24.162525Z","end":"2026-03-15T04:56:24.288796Z","steps":["trace[2144999353] 'agreement among raft nodes before linearized reading'  (duration: 126.091332ms)"],"step_count":1}
{"level":"info","ts":"2026-03-15T04:56:28.812693Z","caller":"traceutil/trace.go:171","msg":"trace[555618687] linearizableReadLoop","detail":"{readStateIndex:4692; appliedIndex:4691; }","duration":"177.589862ms","start":"2026-03-15T04:56:28.635079Z","end":"2026-03-15T04:56:28.812669Z","steps":["trace[555618687] 'read index received'  (duration: 143.787243ms)","trace[555618687] 'applied index is now lower than readState.Index'  (duration: 33.801639ms)"],"step_count":2}
{"level":"info","ts":"2026-03-15T04:56:28.81283Z","caller":"traceutil/trace.go:171","msg":"trace[498042007] transaction","detail":"{read_only:false; response_revision:4513; number_of_response:1; }","duration":"283.923961ms","start":"2026-03-15T04:56:28.528802Z","end":"2026-03-15T04:56:28.812726Z","steps":["trace[498042007] 'process raft request'  (duration: 249.961819ms)","trace[498042007] 'compare'  (duration: 33.606005ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-15T04:56:28.812997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.879872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-dd4b5bcc-ed4f-4887-a6e0-5bd8927af62e\" ","response":"range_response_count:1 size:3601"}
{"level":"warn","ts":"2026-03-15T04:56:28.813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.905558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-dd4b5bcc-ed4f-4887-a6e0-5bd8927af62e\" ","response":"range_response_count:1 size:3601"}
{"level":"info","ts":"2026-03-15T04:56:28.813066Z","caller":"traceutil/trace.go:171","msg":"trace[1811397026] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-dd4b5bcc-ed4f-4887-a6e0-5bd8927af62e; range_end:; response_count:1; response_revision:4513; }","duration":"163.033946ms","start":"2026-03-15T04:56:28.650015Z","end":"2026-03-15T04:56:28.813049Z","steps":["trace[1811397026] 'agreement among raft nodes before linearized reading'  (duration: 162.811231ms)"],"step_count":1}
{"level":"info","ts":"2026-03-15T04:56:28.813072Z","caller":"traceutil/trace.go:171","msg":"trace[1650922257] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-dd4b5bcc-ed4f-4887-a6e0-5bd8927af62e; range_end:; response_count:1; response_revision:4513; }","duration":"177.99358ms","start":"2026-03-15T04:56:28.635063Z","end":"2026-03-15T04:56:28.813056Z","steps":["trace[1650922257] 'agreement among raft nodes before linearized reading'  (duration: 177.749585ms)"],"step_count":1}
{"level":"info","ts":"2026-03-15T04:56:29.181157Z","caller":"traceutil/trace.go:171","msg":"trace[277848695] transaction","detail":"{read_only:false; response_revision:4526; number_of_response:1; }","duration":"142.482516ms","start":"2026-03-15T04:56:29.038647Z","end":"2026-03-15T04:56:29.181129Z","steps":["trace[277848695] 'process raft request'  (duration: 113.315701ms)","trace[277848695] 'compare'  (duration: 29.015282ms)"],"step_count":2}
{"level":"info","ts":"2026-03-15T04:56:29.192741Z","caller":"traceutil/trace.go:171","msg":"trace[1666559356] transaction","detail":"{read_only:false; response_revision:4527; number_of_response:1; }","duration":"153.825628ms","start":"2026-03-15T04:56:29.038885Z","end":"2026-03-15T04:56:29.192711Z","steps":["trace[1666559356] 'process raft request'  (duration: 153.637935ms)"],"step_count":1}
{"level":"info","ts":"2026-03-15T04:56:29.192886Z","caller":"traceutil/trace.go:171","msg":"trace[469537282] linearizableReadLoop","detail":"{readStateIndex:4707; appliedIndex:4704; }","duration":"134.497493ms","start":"2026-03-15T04:56:29.058361Z","end":"2026-03-15T04:56:29.192858Z","steps":["trace[469537282] 'read index received'  (duration: 93.616999ms)","trace[469537282] 'applied index is now lower than readState.Index'  (duration: 40.878924ms)"],"step_count":2}
{"level":"info","ts":"2026-03-15T04:56:29.192937Z","caller":"traceutil/trace.go:171","msg":"trace[1388938367] transaction","detail":"{read_only:false; response_revision:4528; number_of_response:1; }","duration":"151.47912ms","start":"2026-03-15T04:56:29.041425Z","end":"2026-03-15T04:56:29.192904Z","steps":["trace[1388938367] 'process raft request'  (duration: 151.231145ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-15T04:56:29.193524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.148717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:777665"}
{"level":"info","ts":"2026-03-15T04:56:29.193591Z","caller":"traceutil/trace.go:171","msg":"trace[818748243] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:4528; }","duration":"135.231599ms","start":"2026-03-15T04:56:29.058343Z","end":"2026-03-15T04:56:29.193575Z","steps":["trace[818748243] 'agreement among raft nodes before linearized reading'  (duration: 134.591296ms)"],"step_count":1}
{"level":"info","ts":"2026-03-15T04:56:47.605401Z","caller":"traceutil/trace.go:171","msg":"trace[1542435924] transaction","detail":"{read_only:false; response_revision:4895; number_of_response:1; }","duration":"191.709151ms","start":"2026-03-15T04:56:47.413666Z","end":"2026-03-15T04:56:47.605375Z","steps":["trace[1542435924] 'process raft request'  (duration: 191.572559ms)"],"step_count":1}
{"level":"info","ts":"2026-03-15T04:56:47.605543Z","caller":"traceutil/trace.go:171","msg":"trace[1305191112] linearizableReadLoop","detail":"{readStateIndex:5085; appliedIndex:5085; }","duration":"187.833881ms","start":"2026-03-15T04:56:47.417678Z","end":"2026-03-15T04:56:47.605511Z","steps":["trace[1305191112] 'read index received'  (duration: 187.819841ms)","trace[1305191112] 'applied index is now lower than readState.Index'  (duration: 11.63µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-15T04:56:47.605827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.098556ms","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-03-15T04:56:47.605931Z","caller":"traceutil/trace.go:171","msg":"trace[207297320] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4895; }","duration":"188.26857ms","start":"2026-03-15T04:56:47.417648Z","end":"2026-03-15T04:56:47.605916Z","steps":["trace[207297320] 'agreement among raft nodes before linearized reading'  (duration: 187.979804ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-15T04:56:47.654435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.789566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-15T04:56:47.654505Z","caller":"traceutil/trace.go:171","msg":"trace[1686584337] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4897; }","duration":"226.880618ms","start":"2026-03-15T04:56:47.427605Z","end":"2026-03-15T04:56:47.654486Z","steps":["trace[1686584337] 'agreement among raft nodes before linearized reading'  (duration: 226.782556ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-15T04:56:47.654429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.715116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-15T04:56:47.654601Z","caller":"traceutil/trace.go:171","msg":"trace[133504412] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:4897; }","duration":"178.924711ms","start":"2026-03-15T04:56:47.475659Z","end":"2026-03-15T04:56:47.654584Z","steps":["trace[133504412] 'agreement among raft nodes before linearized reading'  (duration: 178.704906ms)"],"step_count":1}
{"level":"info","ts":"2026-03-15T04:58:40.834366Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2791}
{"level":"info","ts":"2026-03-15T04:58:40.896037Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2791,"took":"59.44475ms","hash":384694926,"current-db-size-bytes":42262528,"current-db-size":"42 MB","current-db-size-in-use-bytes":31936512,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-03-15T04:58:40.896099Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":384694926,"revision":2791,"compact-revision":-1}
{"level":"warn","ts":"2026-03-15T05:02:59.825776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.109881ms","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-03-15T05:02:59.825854Z","caller":"traceutil/trace.go:171","msg":"trace[94016003] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7579; }","duration":"216.269744ms","start":"2026-03-15T05:02:59.609569Z","end":"2026-03-15T05:02:59.825839Z","steps":["trace[94016003] 'range keys from in-memory index tree'  (duration: 215.912395ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-15T05:02:59.825776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.822265ms","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-03-15T05:02:59.826034Z","caller":"traceutil/trace.go:171","msg":"trace[1682323024] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7579; }","duration":"222.120751ms","start":"2026-03-15T05:02:59.603888Z","end":"2026-03-15T05:02:59.826009Z","steps":["trace[1682323024] 'range keys from in-memory index tree'  (duration: 221.645992ms)"],"step_count":1}
{"level":"info","ts":"2026-03-15T05:02:59.985979Z","caller":"traceutil/trace.go:171","msg":"trace[381366405] transaction","detail":"{read_only:false; response_revision:7580; number_of_response:1; }","duration":"157.956765ms","start":"2026-03-15T05:02:59.827994Z","end":"2026-03-15T05:02:59.98595Z","steps":["trace[381366405] 'process raft request'  (duration: 157.810262ms)"],"step_count":1}
{"level":"info","ts":"2026-03-15T05:02:59.996942Z","caller":"traceutil/trace.go:171","msg":"trace[1656298286] transaction","detail":"{read_only:false; response_revision:7581; number_of_response:1; }","duration":"168.339822ms","start":"2026-03-15T05:02:59.828582Z","end":"2026-03-15T05:02:59.996922Z","steps":["trace[1656298286] 'process raft request'  (duration: 168.181539ms)"],"step_count":1}
{"level":"info","ts":"2026-03-15T05:02:59.997107Z","caller":"traceutil/trace.go:171","msg":"trace[1172017223] transaction","detail":"{read_only:false; response_revision:7582; number_of_response:1; }","duration":"166.827293ms","start":"2026-03-15T05:02:59.830273Z","end":"2026-03-15T05:02:59.997101Z","steps":["trace[1172017223] 'process raft request'  (duration: 166.615638ms)"],"step_count":1}
{"level":"info","ts":"2026-03-15T05:03:06.641376Z","caller":"traceutil/trace.go:171","msg":"trace[1503144779] linearizableReadLoop","detail":"{readStateIndex:7890; appliedIndex:7889; }","duration":"214.940456ms","start":"2026-03-15T05:03:06.426406Z","end":"2026-03-15T05:03:06.641347Z","steps":["trace[1503144779] 'read index received'  (duration: 214.686611ms)","trace[1503144779] 'applied index is now lower than readState.Index'  (duration: 252.745µs)"],"step_count":2}
{"level":"info","ts":"2026-03-15T05:03:06.641427Z","caller":"traceutil/trace.go:171","msg":"trace[1898910120] transaction","detail":"{read_only:false; response_revision:7611; number_of_response:1; }","duration":"237.760603ms","start":"2026-03-15T05:03:06.403637Z","end":"2026-03-15T05:03:06.641397Z","steps":["trace[1898910120] 'process raft request'  (duration: 237.525899ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-15T05:03:06.641512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.08099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-15T05:03:06.641555Z","caller":"traceutil/trace.go:171","msg":"trace[2028292894] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:7611; }","duration":"215.142301ms","start":"2026-03-15T05:03:06.426401Z","end":"2026-03-15T05:03:06.641543Z","steps":["trace[2028292894] 'agreement among raft nodes before linearized reading'  (duration: 215.057059ms)"],"step_count":1}
{"level":"info","ts":"2026-03-15T05:03:34.378958Z","caller":"traceutil/trace.go:171","msg":"trace[2084116408] transaction","detail":"{read_only:false; response_revision:7800; number_of_response:1; }","duration":"251.717539ms","start":"2026-03-15T05:03:34.127216Z","end":"2026-03-15T05:03:34.378933Z","steps":["trace[2084116408] 'process raft request'  (duration: 237.476653ms)","trace[2084116408] 'compare'  (duration: 13.792567ms)"],"step_count":2}
{"level":"info","ts":"2026-03-15T05:03:34.378956Z","caller":"traceutil/trace.go:171","msg":"trace[1901078955] linearizableReadLoop","detail":"{readStateIndex:8087; appliedIndex:8086; }","duration":"195.929948ms","start":"2026-03-15T05:03:34.18299Z","end":"2026-03-15T05:03:34.37892Z","steps":["trace[1901078955] 'read index received'  (duration: 181.792834ms)","trace[1901078955] 'applied index is now lower than readState.Index'  (duration: 14.135524ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-15T05:03:34.379273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.255335ms","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-03-15T05:03:34.379365Z","caller":"traceutil/trace.go:171","msg":"trace[1349615792] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7800; }","duration":"196.361477ms","start":"2026-03-15T05:03:34.182983Z","end":"2026-03-15T05:03:34.379345Z","steps":["trace[1349615792] 'agreement among raft nodes before linearized reading'  (duration: 196.028691ms)"],"step_count":1}
{"level":"info","ts":"2026-03-15T05:03:34.404511Z","caller":"traceutil/trace.go:171","msg":"trace[797532889] transaction","detail":"{read_only:false; response_revision:7801; number_of_response:1; }","duration":"131.993352ms","start":"2026-03-15T05:03:34.272483Z","end":"2026-03-15T05:03:34.404477Z","steps":["trace[797532889] 'process raft request'  (duration: 131.817599ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-15T05:03:34.404539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.584172ms","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-03-15T05:03:34.404594Z","caller":"traceutil/trace.go:171","msg":"trace[954639929] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7801; }","duration":"213.661804ms","start":"2026-03-15T05:03:34.190917Z","end":"2026-03-15T05:03:34.404579Z","steps":["trace[954639929] 'agreement among raft nodes before linearized reading'  (duration: 213.505651ms)"],"step_count":1}
{"level":"info","ts":"2026-03-15T05:03:40.841871Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5807}
{"level":"info","ts":"2026-03-15T05:03:40.926606Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5807,"took":"82.6248ms","hash":840342190,"current-db-size-bytes":43913216,"current-db-size":"44 MB","current-db-size-in-use-bytes":23617536,"current-db-size-in-use":"24 MB"}
{"level":"info","ts":"2026-03-15T05:03:40.926657Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":840342190,"revision":5807,"compact-revision":2791}
{"level":"info","ts":"2026-03-15T05:03:47.489787Z","caller":"traceutil/trace.go:171","msg":"trace[1997209041] linearizableReadLoop","detail":"{readStateIndex:8199; appliedIndex:8197; }","duration":"159.554097ms","start":"2026-03-15T05:03:47.330211Z","end":"2026-03-15T05:03:47.489766Z","steps":["trace[1997209041] 'read index received'  (duration: 20.134005ms)","trace[1997209041] 'applied index is now lower than readState.Index'  (duration: 139.419352ms)"],"step_count":2}
{"level":"info","ts":"2026-03-15T05:03:47.489828Z","caller":"traceutil/trace.go:171","msg":"trace[132247261] transaction","detail":"{read_only:false; response_revision:7907; number_of_response:1; }","duration":"200.703373ms","start":"2026-03-15T05:03:47.289098Z","end":"2026-03-15T05:03:47.489801Z","steps":["trace[132247261] 'process raft request'  (duration: 200.505649ms)"],"step_count":1}
{"level":"info","ts":"2026-03-15T05:03:47.489891Z","caller":"traceutil/trace.go:171","msg":"trace[1092449394] transaction","detail":"{read_only:false; response_revision:7908; number_of_response:1; }","duration":"159.055107ms","start":"2026-03-15T05:03:47.330828Z","end":"2026-03-15T05:03:47.489883Z","steps":["trace[1092449394] 'process raft request'  (duration: 158.895404ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-15T05:03:47.490105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.00462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-15T05:03:47.490178Z","caller":"traceutil/trace.go:171","msg":"trace[417027418] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:7908; }","duration":"108.119833ms","start":"2026-03-15T05:03:47.38204Z","end":"2026-03-15T05:03:47.49016Z","steps":["trace[417027418] 'agreement among raft nodes before linearized reading'  (duration: 107.95346ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-15T05:03:47.490245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.017626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-ps8bn\" ","response":"range_response_count:1 size:4645"}
{"level":"info","ts":"2026-03-15T05:03:47.490279Z","caller":"traceutil/trace.go:171","msg":"trace[652524329] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-ps8bn; range_end:; response_count:1; response_revision:7908; }","duration":"160.084717ms","start":"2026-03-15T05:03:47.330183Z","end":"2026-03-15T05:03:47.490268Z","steps":["trace[652524329] 'agreement among raft nodes before linearized reading'  (duration: 159.952814ms)"],"step_count":1}
{"level":"info","ts":"2026-03-15T05:05:04.302645Z","caller":"traceutil/trace.go:171","msg":"trace[2101163455] transaction","detail":"{read_only:false; response_revision:8620; number_of_response:1; }","duration":"148.473964ms","start":"2026-03-15T05:05:04.154119Z","end":"2026-03-15T05:05:04.302593Z","steps":["trace[2101163455] 'process raft request'  (duration: 148.24394ms)"],"step_count":1}
{"level":"info","ts":"2026-03-15T05:07:28.032151Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"9bd37ed2859641e3","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-03-15T05:07:28.040815Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-03-15T05:07:28.040911Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-03-15T05:08:40.848458Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7834}
{"level":"info","ts":"2026-03-15T05:08:40.91372Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7834,"took":"63.000176ms","hash":1693326295,"current-db-size-bytes":43913216,"current-db-size":"44 MB","current-db-size-in-use-bytes":25767936,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-03-15T05:08:40.913768Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1693326295,"revision":7834,"compact-revision":5807}
{"level":"info","ts":"2026-03-15T05:13:40.854725Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10027}
{"level":"info","ts":"2026-03-15T05:13:40.935263Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10027,"took":"78.247878ms","hash":4043692074,"current-db-size-bytes":43913216,"current-db-size":"44 MB","current-db-size-in-use-bytes":16908288,"current-db-size-in-use":"17 MB"}
{"level":"info","ts":"2026-03-15T05:13:40.935317Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4043692074,"revision":10027,"compact-revision":7834}