{"level":"warn","ts":"2026-10-19T01:56:54.701484Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-19T01:56:54.7016Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.96: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.96:2380","--initial-cluster=instance=https://162.253.55.96:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.96:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.96: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-10-19T01:56:54.701675Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-19T01:56:54.701694Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.96:2380"]} {"level":"info","ts":"2026-10-19T01:56:54.701725Z","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-10-19T01:56:54.702605Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.96:2379"]} {"level":"info","ts":"2026-10-19T01:56:54.702717Z","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.96:2380"],"listen-peer-urls":["https://162.253.55.96:2380"],"advertise-client-urls":["https://162.253.55.96:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.96:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.96: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-10-19T01:56:54.70679Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.731ms"} {"level":"info","ts":"2026-10-19T01:56:54.713268Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"64a80de7883e6886","cluster-id":"8160e60c0578d165"} {"level":"info","ts":"2026-10-19T01:56:54.713356Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"64a80de7883e6886 switched to configuration voters=()"} {"level":"info","ts":"2026-10-19T01:56:54.713399Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"64a80de7883e6886 became follower at term 0"} {"level":"info","ts":"2026-10-19T01:56:54.713419Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 64a80de7883e6886 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-19T01:56:54.713435Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"64a80de7883e6886 became follower at term 1"} {"level":"info","ts":"2026-10-19T01:56:54.71348Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"64a80de7883e6886 switched to configuration voters=(7253062487954581638)"} {"level":"warn","ts":"2026-10-19T01:56:54.720016Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-19T01:56:54.721768Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-19T01:56:54.723381Z","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-10-19T01:56:54.725807Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"64a80de7883e6886","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-19T01:56:54.726074Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"64a80de7883e6886","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-19T01:56:54.726246Z","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-10-19T01:56:54.726332Z","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-10-19T01:56:54.726346Z","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-10-19T01:56:54.729427Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"64a80de7883e6886 switched to configuration voters=(7253062487954581638)"} {"level":"info","ts":"2026-10-19T01:56:54.729558Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"8160e60c0578d165","local-member-id":"64a80de7883e6886","added-peer-id":"64a80de7883e6886","added-peer-peer-urls":["https://162.253.55.96:2380"]} {"level":"info","ts":"2026-10-19T01:56:54.730711Z","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-10-19T01:56:54.730797Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.96:2380"} {"level":"info","ts":"2026-10-19T01:56:54.730824Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.96:2380"} {"level":"info","ts":"2026-10-19T01:56:54.731134Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"64a80de7883e6886","initial-advertise-peer-urls":["https://162.253.55.96:2380"],"listen-peer-urls":["https://162.253.55.96:2380"],"advertise-client-urls":["https://162.253.55.96:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.96:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-19T01:56:54.731201Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-19T01:56:55.713795Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"64a80de7883e6886 is starting a new election at term 1"} {"level":"info","ts":"2026-10-19T01:56:55.713894Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"64a80de7883e6886 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-19T01:56:55.713937Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"64a80de7883e6886 received MsgPreVoteResp from 64a80de7883e6886 at term 1"} {"level":"info","ts":"2026-10-19T01:56:55.713972Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"64a80de7883e6886 became candidate at term 2"} {"level":"info","ts":"2026-10-19T01:56:55.713994Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"64a80de7883e6886 received MsgVoteResp from 64a80de7883e6886 at term 2"} {"level":"info","ts":"2026-10-19T01:56:55.714024Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"64a80de7883e6886 became leader at term 2"} {"level":"info","ts":"2026-10-19T01:56:55.714049Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 64a80de7883e6886 elected leader 64a80de7883e6886 at term 2"} {"level":"info","ts":"2026-10-19T01:56:55.715353Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-19T01:56:55.716895Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-19T01:56:55.7169Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"64a80de7883e6886","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.96:2379]}","request-path":"/0/members/64a80de7883e6886/attributes","cluster-id":"8160e60c0578d165","publish-timeout":"7s"} {"level":"info","ts":"2026-10-19T01:56:55.716951Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-19T01:56:55.717251Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"8160e60c0578d165","local-member-id":"64a80de7883e6886","cluster-version":"3.5"} {"level":"info","ts":"2026-10-19T01:56:55.717363Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-19T01:56:55.71745Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-19T01:56:55.717524Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-19T01:56:55.717548Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-19T01:56:55.721044Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.96:2379"} {"level":"info","ts":"2026-10-19T01:56:55.721555Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-19T01:57:11.156207Z","caller":"traceutil/trace.go:171","msg":"trace[1201815415] transaction","detail":"{read_only:false; response_revision:410; number_of_response:1; }","duration":"101.880951ms","start":"2026-10-19T01:57:11.054284Z","end":"2026-10-19T01:57:11.156165Z","steps":["trace[1201815415] 'process raft request' (duration: 101.596044ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:57:21.955443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.561863ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-19T01:57:21.955646Z","caller":"traceutil/trace.go:171","msg":"trace[614421792] transaction","detail":"{read_only:false; response_revision:440; number_of_response:1; }","duration":"211.810785ms","start":"2026-10-19T01:57:21.743798Z","end":"2026-10-19T01:57:21.955609Z","steps":["trace[614421792] 'compare' (duration: 202.385198ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:57:27.834622Z","caller":"traceutil/trace.go:171","msg":"trace[1046118198] transaction","detail":"{read_only:false; response_revision:451; number_of_response:1; }","duration":"103.683024ms","start":"2026-10-19T01:57:27.730906Z","end":"2026-10-19T01:57:27.834589Z","steps":["trace[1046118198] 'process raft request' (duration: 86.811109ms)","trace[1046118198] 'compare' (duration: 16.738181ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T01:57:46.103037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.568933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T01:57:46.103152Z","caller":"traceutil/trace.go:171","msg":"trace[1180533341] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:556; }","duration":"219.763309ms","start":"2026-10-19T01:57:45.883364Z","end":"2026-10-19T01:57:46.103127Z","steps":["trace[1180533341] 'range keys from in-memory index tree' (duration: 219.40324ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:57:46.103118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.282939ms","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-10-19T01:57:46.103238Z","caller":"traceutil/trace.go:171","msg":"trace[1567425996] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:556; }","duration":"174.469795ms","start":"2026-10-19T01:57:45.928738Z","end":"2026-10-19T01:57:46.103207Z","steps":["trace[1567425996] 'range keys from in-memory index tree' (duration: 174.142266ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:57:48.580245Z","caller":"traceutil/trace.go:171","msg":"trace[529923945] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"156.07253ms","start":"2026-10-19T01:57:48.424146Z","end":"2026-10-19T01:57:48.580219Z","steps":["trace[529923945] 'process raft request' (duration: 155.763802ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:57:48.585466Z","caller":"traceutil/trace.go:171","msg":"trace[1925970742] linearizableReadLoop","detail":"{readStateIndex:661; appliedIndex:659; }","duration":"141.897227ms","start":"2026-10-19T01:57:48.443535Z","end":"2026-10-19T01:57:48.585432Z","steps":["trace[1925970742] 'read index received' (duration: 136.411945ms)","trace[1925970742] 'applied index is now lower than readState.Index' (duration: 5.484212ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:57:48.585781Z","caller":"traceutil/trace.go:171","msg":"trace[894209908] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"143.560028ms","start":"2026-10-19T01:57:48.442207Z","end":"2026-10-19T01:57:48.585767Z","steps":["trace[894209908] 'process raft request' (duration: 143.096916ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:57:48.586353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.760918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyextensionpolicies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:74769"} {"level":"info","ts":"2026-10-19T01:57:48.58641Z","caller":"traceutil/trace.go:171","msg":"trace[295941720] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/envoyextensionpolicies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:638; }","duration":"142.938273ms","start":"2026-10-19T01:57:48.443457Z","end":"2026-10-19T01:57:48.586396Z","steps":["trace[295941720] 'agreement among raft nodes before linearized reading' (duration: 142.617245ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:57:52.857538Z","caller":"traceutil/trace.go:171","msg":"trace[1596587242] transaction","detail":"{read_only:false; response_revision:663; number_of_response:1; }","duration":"103.690264ms","start":"2026-10-19T01:57:52.753817Z","end":"2026-10-19T01:57:52.857508Z","steps":["trace[1596587242] 'process raft request' (duration: 102.991517ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:57:53.2759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.051694ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T01:57:53.276016Z","caller":"traceutil/trace.go:171","msg":"trace[568912887] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:663; }","duration":"364.232378ms","start":"2026-10-19T01:57:52.911757Z","end":"2026-10-19T01:57:53.275989Z","steps":["trace[568912887] 'range keys from in-memory index tree' (duration: 363.94025ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:57:53.276056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:57:52.911731Z","time spent":"364.316969ms","remote":"127.0.0.1:57002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-10-19T01:57:53.331235Z","caller":"traceutil/trace.go:171","msg":"trace[1768771576] linearizableReadLoop","detail":"{readStateIndex:688; appliedIndex:687; }","duration":"118.108613ms","start":"2026-10-19T01:57:53.213098Z","end":"2026-10-19T01:57:53.331206Z","steps":["trace[1768771576] 'read index received' (duration: 117.879767ms)","trace[1768771576] 'applied index is now lower than readState.Index' (duration: 227.576µs)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:57:53.331436Z","caller":"traceutil/trace.go:171","msg":"trace[753166437] transaction","detail":"{read_only:false; response_revision:664; number_of_response:1; }","duration":"396.423646ms","start":"2026-10-19T01:57:52.934995Z","end":"2026-10-19T01:57:53.331419Z","steps":["trace[753166437] 'process raft request' (duration: 396.048777ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:57:53.331512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.40686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-6cn4n\" ","response":"range_response_count:1 size:16961"} {"level":"warn","ts":"2026-10-19T01:57:53.331546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:57:52.934978Z","time spent":"396.501427ms","remote":"127.0.0.1:57334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1092,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-19T01:57:53.331556Z","caller":"traceutil/trace.go:171","msg":"trace[1692716116] range","detail":"{range_begin:/registry/pods/kube-system/cilium-6cn4n; range_end:; response_count:1; response_revision:664; }","duration":"118.506433ms","start":"2026-10-19T01:57:53.213035Z","end":"2026-10-19T01:57:53.331541Z","steps":["trace[1692716116] 'agreement among raft nodes before linearized reading' (duration: 118.303068ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:57:53.927873Z","caller":"traceutil/trace.go:171","msg":"trace[541411772] transaction","detail":"{read_only:false; response_revision:665; number_of_response:1; }","duration":"574.092927ms","start":"2026-10-19T01:57:53.353743Z","end":"2026-10-19T01:57:53.927836Z","steps":["trace[541411772] 'process raft request' (duration: 544.755488ms)","trace[541411772] 'compare' (duration: 29.189745ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T01:57:53.928081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:57:53.353691Z","time spent":"574.285351ms","remote":"127.0.0.1:57196","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T01:57:53.932075Z","caller":"traceutil/trace.go:171","msg":"trace[512407936] transaction","detail":"{read_only:false; response_revision:666; number_of_response:1; }","duration":"144.001928ms","start":"2026-10-19T01:57:53.788031Z","end":"2026-10-19T01:57:53.932033Z","steps":["trace[512407936] 'process raft request' (duration: 142.690046ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:58:09.855942Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7531884799850790941,"retry-timeout":"500ms"} {"level":"info","ts":"2026-10-19T01:58:09.88633Z","caller":"traceutil/trace.go:171","msg":"trace[1199557676] linearizableReadLoop","detail":"{readStateIndex:866; appliedIndex:865; }","duration":"531.230871ms","start":"2026-10-19T01:58:09.355078Z","end":"2026-10-19T01:58:09.886309Z","steps":["trace[1199557676] 'read index received' (duration: 530.926224ms)","trace[1199557676] 'applied index is now lower than readState.Index' (duration: 303.867µs)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:58:09.886519Z","caller":"traceutil/trace.go:171","msg":"trace[22713681] transaction","detail":"{read_only:false; response_revision:836; number_of_response:1; }","duration":"547.020133ms","start":"2026-10-19T01:58:09.339482Z","end":"2026-10-19T01:58:09.886502Z","steps":["trace[22713681] 'process raft request' (duration: 546.631063ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:58:09.886584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"531.497558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-10-19T01:58:09.886627Z","caller":"traceutil/trace.go:171","msg":"trace[1647790760] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:836; }","duration":"531.61683ms","start":"2026-10-19T01:58:09.354997Z","end":"2026-10-19T01:58:09.886614Z","steps":["trace[1647790760] 'agreement among raft nodes before linearized reading' (duration: 531.387565ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:58:09.886658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:58:09.354962Z","time spent":"531.688422ms","remote":"127.0.0.1:57272","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":"warn","ts":"2026-10-19T01:58:09.886754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:58:09.339448Z","time spent":"547.165916ms","remote":"127.0.0.1:57196","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4027,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-19T01:59:30.446409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.846641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-1fe14c49-fed7-453d-aa41-cd47c2b40838\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-10-19T01:59:30.44656Z","caller":"traceutil/trace.go:171","msg":"trace[1523159589] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-1fe14c49-fed7-453d-aa41-cd47c2b40838; range_end:; response_count:1; response_revision:1917; }","duration":"305.079237ms","start":"2026-10-19T01:59:30.141446Z","end":"2026-10-19T01:59:30.446525Z","steps":["trace[1523159589] 'range keys from in-memory index tree' (duration: 304.600345ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:59:30.446624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:59:30.141401Z","time spent":"305.20834ms","remote":"127.0.0.1:57196","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3649,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-1fe14c49-fed7-453d-aa41-cd47c2b40838\" "} {"level":"warn","ts":"2026-10-19T01:59:30.446741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.728627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5700"} {"level":"info","ts":"2026-10-19T01:59:30.446899Z","caller":"traceutil/trace.go:171","msg":"trace[1419036717] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1917; }","duration":"252.966834ms","start":"2026-10-19T01:59:30.193892Z","end":"2026-10-19T01:59:30.446859Z","steps":["trace[1419036717] 'range keys from in-memory index tree' (duration: 252.274167ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:59:30.504295Z","caller":"traceutil/trace.go:171","msg":"trace[1022872814] linearizableReadLoop","detail":"{readStateIndex:1993; appliedIndex:1992; }","duration":"156.660427ms","start":"2026-10-19T01:59:30.347601Z","end":"2026-10-19T01:59:30.504261Z","steps":["trace[1022872814] 'read index received' (duration: 156.33122ms)","trace[1022872814] 'applied index is now lower than readState.Index' (duration: 328.077µs)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:59:30.504436Z","caller":"traceutil/trace.go:171","msg":"trace[1369840968] transaction","detail":"{read_only:false; response_revision:1918; number_of_response:1; }","duration":"173.622615ms","start":"2026-10-19T01:59:30.330802Z","end":"2026-10-19T01:59:30.504424Z","steps":["trace[1369840968] 'process raft request' (duration: 173.229916ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:59:30.504891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.278123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5700"} {"level":"info","ts":"2026-10-19T01:59:30.505001Z","caller":"traceutil/trace.go:171","msg":"trace[109834793] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1918; }","duration":"157.459327ms","start":"2026-10-19T01:59:30.347518Z","end":"2026-10-19T01:59:30.504978Z","steps":["trace[109834793] 'agreement among raft nodes before linearized reading' (duration: 157.154749ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:59:30.669188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.242169ms","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-10-19T01:59:30.669312Z","caller":"traceutil/trace.go:171","msg":"trace[1174559839] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1919; }","duration":"102.482695ms","start":"2026-10-19T01:59:30.566799Z","end":"2026-10-19T01:59:30.669282Z","steps":["trace[1174559839] 'range keys from in-memory index tree' (duration: 101.951672ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:59:30.999394Z","caller":"traceutil/trace.go:171","msg":"trace[1002883814] linearizableReadLoop","detail":"{readStateIndex:1996; appliedIndex:1995; }","duration":"202.335846ms","start":"2026-10-19T01:59:30.797009Z","end":"2026-10-19T01:59:30.999345Z","steps":["trace[1002883814] 'read index received' (duration: 200.186814ms)","trace[1002883814] 'applied index is now lower than readState.Index' (duration: 2.146612ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:59:30.999459Z","caller":"traceutil/trace.go:171","msg":"trace[878887170] transaction","detail":"{read_only:false; response_revision:1921; number_of_response:1; }","duration":"261.9642ms","start":"2026-10-19T01:59:30.737461Z","end":"2026-10-19T01:59:30.999425Z","steps":["trace[878887170] 'process raft request' (duration: 259.731026ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:59:30.999805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.775516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-1fe14c49-fed7-453d-aa41-cd47c2b40838\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-10-19T01:59:30.999873Z","caller":"traceutil/trace.go:171","msg":"trace[734654277] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-1fe14c49-fed7-453d-aa41-cd47c2b40838; range_end:; response_count:1; response_revision:1921; }","duration":"202.93851ms","start":"2026-10-19T01:59:30.796918Z","end":"2026-10-19T01:59:30.999856Z","steps":["trace[734654277] 'agreement among raft nodes before linearized reading' (duration: 202.650784ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:59:30.999923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.007348ms","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-10-19T01:59:31.000028Z","caller":"traceutil/trace.go:171","msg":"trace[1037518381] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1921; }","duration":"202.181032ms","start":"2026-10-19T01:59:30.79782Z","end":"2026-10-19T01:59:31.000001Z","steps":["trace[1037518381] 'agreement among raft nodes before linearized reading' (duration: 201.848754ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:59:46.684541Z","caller":"traceutil/trace.go:171","msg":"trace[1816642717] transaction","detail":"{read_only:false; response_revision:2057; number_of_response:1; }","duration":"107.263302ms","start":"2026-10-19T01:59:46.577247Z","end":"2026-10-19T01:59:46.68451Z","steps":["trace[1816642717] 'process raft request' (duration: 107.079538ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:00:15.394035Z","caller":"traceutil/trace.go:171","msg":"trace[1038178142] transaction","detail":"{read_only:false; response_revision:2223; number_of_response:1; }","duration":"120.984354ms","start":"2026-10-19T02:00:15.272997Z","end":"2026-10-19T02:00:15.393982Z","steps":["trace[1038178142] 'process raft request' (duration: 59.618436ms)","trace[1038178142] 'compare' (duration: 61.180223ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:00:15.39423Z","caller":"traceutil/trace.go:171","msg":"trace[1468654457] linearizableReadLoop","detail":"{readStateIndex:2309; appliedIndex:2308; }","duration":"114.308693ms","start":"2026-10-19T02:00:15.279877Z","end":"2026-10-19T02:00:15.394186Z","steps":["trace[1468654457] 'read index received' (duration: 52.74922ms)","trace[1468654457] 'applied index is now lower than readState.Index' (duration: 61.557553ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:00:15.394429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.533039ms","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-10-19T02:00:15.394511Z","caller":"traceutil/trace.go:171","msg":"trace[1063248119] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2224; }","duration":"114.673512ms","start":"2026-10-19T02:00:15.279823Z","end":"2026-10-19T02:00:15.394496Z","steps":["trace[1063248119] 'agreement among raft nodes before linearized reading' (duration: 114.457377ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:00:20.962294Z","caller":"traceutil/trace.go:171","msg":"trace[858691530] transaction","detail":"{read_only:false; response_revision:2251; number_of_response:1; }","duration":"133.237759ms","start":"2026-10-19T02:00:20.829019Z","end":"2026-10-19T02:00:20.962257Z","steps":["trace[858691530] 'process raft request' (duration: 132.934022ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:00:21.069384Z","caller":"traceutil/trace.go:171","msg":"trace[489762950] transaction","detail":"{read_only:false; response_revision:2253; number_of_response:1; }","duration":"100.262474ms","start":"2026-10-19T02:00:20.969087Z","end":"2026-10-19T02:00:21.069349Z","steps":["trace[489762950] 'process raft request' (duration: 86.183035ms)","trace[489762950] 'compare' (duration: 13.905365ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:00:27.445542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.474334ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-19T02:00:27.445811Z","caller":"traceutil/trace.go:171","msg":"trace[673667327] transaction","detail":"{read_only:false; response_revision:2283; number_of_response:1; }","duration":"349.200249ms","start":"2026-10-19T02:00:27.096587Z","end":"2026-10-19T02:00:27.445787Z","steps":["trace[673667327] 'process raft request' (duration: 349.114417ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:00:27.445872Z","caller":"traceutil/trace.go:171","msg":"trace[882061211] transaction","detail":"{read_only:false; response_revision:2282; number_of_response:1; }","duration":"349.536518ms","start":"2026-10-19T02:00:27.096305Z","end":"2026-10-19T02:00:27.445842Z","steps":["trace[882061211] 'process raft request' (duration: 154.631474ms)","trace[882061211] 'compare' (duration: 194.012302ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:00:27.445907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:00:27.096548Z","time spent":"349.318542ms","remote":"127.0.0.1:57272","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-19T02:00:27.446668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:00:27.09629Z","time spent":"349.644711ms","remote":"127.0.0.1:57272","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T02:00:27.542749Z","caller":"traceutil/trace.go:171","msg":"trace[293202546] transaction","detail":"{read_only:false; response_revision:2284; number_of_response:1; }","duration":"249.781995ms","start":"2026-10-19T02:00:27.292918Z","end":"2026-10-19T02:00:27.5427Z","steps":["trace[293202546] 'process raft request' (duration: 249.57177ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:01:44.219038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.749172ms","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-10-19T02:01:44.219149Z","caller":"traceutil/trace.go:171","msg":"trace[1825413728] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2862; }","duration":"171.928716ms","start":"2026-10-19T02:01:44.047198Z","end":"2026-10-19T02:01:44.219127Z","steps":["trace[1825413728] 'range keys from in-memory index tree' (duration: 171.484376ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:01:44.219163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.521295ms","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-10-19T02:01:44.219274Z","caller":"traceutil/trace.go:171","msg":"trace[1319879377] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2862; }","duration":"100.685258ms","start":"2026-10-19T02:01:44.118566Z","end":"2026-10-19T02:01:44.219251Z","steps":["trace[1319879377] 'range keys from in-memory index tree' (duration: 100.328399ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:01:44.219544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.080476ms","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-10-19T02:01:44.219588Z","caller":"traceutil/trace.go:171","msg":"trace[1242398527] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2862; }","duration":"154.166178ms","start":"2026-10-19T02:01:44.065408Z","end":"2026-10-19T02:01:44.219574Z","steps":["trace[1242398527] 'range keys from in-memory index tree' (duration: 153.258946ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:02:22.570229Z","caller":"traceutil/trace.go:171","msg":"trace[1756468367] transaction","detail":"{read_only:false; response_revision:3094; number_of_response:1; }","duration":"110.937936ms","start":"2026-10-19T02:02:22.459267Z","end":"2026-10-19T02:02:22.570204Z","steps":["trace[1756468367] 'process raft request' (duration: 110.803013ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:02:22.63124Z","caller":"traceutil/trace.go:171","msg":"trace[1194394478] linearizableReadLoop","detail":"{readStateIndex:3215; appliedIndex:3213; }","duration":"148.267863ms","start":"2026-10-19T02:02:22.482948Z","end":"2026-10-19T02:02:22.631216Z","steps":["trace[1194394478] 'read index received' (duration: 87.212256ms)","trace[1194394478] 'applied index is now lower than readState.Index' (duration: 61.054237ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:02:22.631348Z","caller":"traceutil/trace.go:171","msg":"trace[1335565611] transaction","detail":"{read_only:false; response_revision:3095; number_of_response:1; }","duration":"168.393717ms","start":"2026-10-19T02:02:22.462926Z","end":"2026-10-19T02:02:22.631319Z","steps":["trace[1335565611] 'process raft request' (duration: 132.041713ms)","trace[1335565611] 'compare' (duration: 36.128878ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:02:22.631594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.622841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-10-19T02:02:22.631634Z","caller":"traceutil/trace.go:171","msg":"trace[974359447] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3095; }","duration":"148.765295ms","start":"2026-10-19T02:02:22.482857Z","end":"2026-10-19T02:02:22.631623Z","steps":["trace[974359447] 'agreement among raft nodes before linearized reading' (duration: 148.446127ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:02:23.03452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.0093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T02:02:23.034611Z","caller":"traceutil/trace.go:171","msg":"trace[1816909921] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3097; }","duration":"124.163624ms","start":"2026-10-19T02:02:22.910429Z","end":"2026-10-19T02:02:23.034593Z","steps":["trace[1816909921] 'range keys from in-memory index tree' (duration: 123.923608ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:05:07.174094Z","caller":"traceutil/trace.go:171","msg":"trace[216812378] transaction","detail":"{read_only:false; response_revision:4105; number_of_response:1; }","duration":"126.497814ms","start":"2026-10-19T02:05:07.047468Z","end":"2026-10-19T02:05:07.173965Z","steps":["trace[216812378] 'process raft request' (duration: 114.25406ms)","trace[216812378] 'compare' (duration: 12.06376ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:05:07.174311Z","caller":"traceutil/trace.go:171","msg":"trace[1615348117] transaction","detail":"{read_only:false; response_revision:4106; number_of_response:1; }","duration":"123.991954ms","start":"2026-10-19T02:05:07.050295Z","end":"2026-10-19T02:05:07.174287Z","steps":["trace[1615348117] 'process raft request' (duration: 123.82229ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:05:07.174523Z","caller":"traceutil/trace.go:171","msg":"trace[7469851] transaction","detail":"{read_only:false; response_revision:4107; number_of_response:1; }","duration":"118.006709ms","start":"2026-10-19T02:05:07.0565Z","end":"2026-10-19T02:05:07.174507Z","steps":["trace[7469851] 'process raft request' (duration: 117.740043ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:05:07.174642Z","caller":"traceutil/trace.go:171","msg":"trace[1775658292] linearizableReadLoop","detail":"{readStateIndex:4269; appliedIndex:4264; }","duration":"102.125127ms","start":"2026-10-19T02:05:07.072469Z","end":"2026-10-19T02:05:07.174594Z","steps":["trace[1775658292] 'read index received' (duration: 89.266468ms)","trace[1775658292] 'applied index is now lower than readState.Index' (duration: 12.857939ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:05:07.174774Z","caller":"traceutil/trace.go:171","msg":"trace[461009420] transaction","detail":"{read_only:false; response_revision:4108; number_of_response:1; }","duration":"117.348744ms","start":"2026-10-19T02:05:07.057392Z","end":"2026-10-19T02:05:07.174741Z","steps":["trace[461009420] 'process raft request' (duration: 117.015936ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:05:07.174799Z","caller":"traceutil/trace.go:171","msg":"trace[2123439883] transaction","detail":"{read_only:false; response_revision:4109; number_of_response:1; }","duration":"116.499964ms","start":"2026-10-19T02:05:07.058273Z","end":"2026-10-19T02:05:07.174773Z","steps":["trace[2123439883] 'process raft request' (duration: 116.227247ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:05:07.174821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.318452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-19T02:05:07.174867Z","caller":"traceutil/trace.go:171","msg":"trace[1061641356] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:4109; }","duration":"102.395774ms","start":"2026-10-19T02:05:07.07246Z","end":"2026-10-19T02:05:07.174856Z","steps":["trace[1061641356] 'agreement among raft nodes before linearized reading' (duration: 102.263971ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:06:55.755398Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2933} {"level":"info","ts":"2026-10-19T02:06:55.834297Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2933,"took":"77.510965ms","hash":3749844480,"current-db-size-bytes":46649344,"current-db-size":"47 MB","current-db-size-in-use-bytes":21762048,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-10-19T02:06:55.834387Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3749844480,"revision":2933,"compact-revision":-1} {"level":"info","ts":"2026-10-19T02:07:06.237334Z","caller":"traceutil/trace.go:171","msg":"trace[370258346] transaction","detail":"{read_only:false; response_revision:5318; number_of_response:1; }","duration":"287.675403ms","start":"2026-10-19T02:07:05.949633Z","end":"2026-10-19T02:07:06.237308Z","steps":["trace[370258346] 'process raft request' (duration: 287.516819ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:07:06.274091Z","caller":"traceutil/trace.go:171","msg":"trace[842965919] linearizableReadLoop","detail":"{readStateIndex:5523; appliedIndex:5521; }","duration":"222.026593ms","start":"2026-10-19T02:07:06.052035Z","end":"2026-10-19T02:07:06.274062Z","steps":["trace[842965919] 'read index received' (duration: 185.050133ms)","trace[842965919] 'applied index is now lower than readState.Index' (duration: 36.97533ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:07:06.274114Z","caller":"traceutil/trace.go:171","msg":"trace[458595871] transaction","detail":"{read_only:false; response_revision:5319; number_of_response:1; }","duration":"276.389291ms","start":"2026-10-19T02:07:05.997702Z","end":"2026-10-19T02:07:06.274091Z","steps":["trace[458595871] 'process raft request' (duration: 276.237857ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:07:06.27435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.763088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-093f73a8-f7e9-4c2b-836e-88dd8837223f\" ","response":"range_response_count:1 size:3773"} {"level":"warn","ts":"2026-10-19T02:07:06.274363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.30666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-093f73a8-f7e9-4c2b-836e-88dd8837223f\" ","response":"range_response_count:1 size:3773"} {"level":"info","ts":"2026-10-19T02:07:06.274389Z","caller":"traceutil/trace.go:171","msg":"trace[1131057110] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-093f73a8-f7e9-4c2b-836e-88dd8837223f; range_end:; response_count:1; response_revision:5319; }","duration":"113.85244ms","start":"2026-10-19T02:07:06.160526Z","end":"2026-10-19T02:07:06.274379Z","steps":["trace[1131057110] 'agreement among raft nodes before linearized reading' (duration: 113.675226ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:07:06.274441Z","caller":"traceutil/trace.go:171","msg":"trace[642613123] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-093f73a8-f7e9-4c2b-836e-88dd8837223f; range_end:; response_count:1; response_revision:5319; }","duration":"222.393421ms","start":"2026-10-19T02:07:06.052006Z","end":"2026-10-19T02:07:06.274399Z","steps":["trace[642613123] 'agreement among raft nodes before linearized reading' (duration: 222.177486ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:07:08.418603Z","caller":"traceutil/trace.go:171","msg":"trace[668734803] linearizableReadLoop","detail":"{readStateIndex:5552; appliedIndex:5551; }","duration":"125.305495ms","start":"2026-10-19T02:07:08.293269Z","end":"2026-10-19T02:07:08.418575Z","steps":["trace[668734803] 'read index received' (duration: 125.121321ms)","trace[668734803] 'applied index is now lower than readState.Index' (duration: 183.134µs)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:07:08.418644Z","caller":"traceutil/trace.go:171","msg":"trace[484700848] transaction","detail":"{read_only:false; response_revision:5348; number_of_response:1; }","duration":"126.424082ms","start":"2026-10-19T02:07:08.292195Z","end":"2026-10-19T02:07:08.418619Z","steps":["trace[484700848] 'process raft request' (duration: 126.169716ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:07:08.418855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.565391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-10-19T02:07:08.418894Z","caller":"traceutil/trace.go:171","msg":"trace[867657443] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5348; }","duration":"125.646453ms","start":"2026-10-19T02:07:08.293236Z","end":"2026-10-19T02:07:08.418882Z","steps":["trace[867657443] 'agreement among raft nodes before linearized reading' (duration: 125.481739ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:07:08.418976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.10426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-10-19T02:07:08.419015Z","caller":"traceutil/trace.go:171","msg":"trace[653770366] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5348; }","duration":"125.201802ms","start":"2026-10-19T02:07:08.293803Z","end":"2026-10-19T02:07:08.419005Z","steps":["trace[653770366] 'agreement among raft nodes before linearized reading' (duration: 125.037068ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:07:08.41906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.373548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-49frl\" ","response":"range_response_count:1 size:6527"} {"level":"info","ts":"2026-10-19T02:07:08.419108Z","caller":"traceutil/trace.go:171","msg":"trace[1100263183] range","detail":"{range_begin:/registry/pods/openstack/keepalived-49frl; range_end:; response_count:1; response_revision:5348; }","duration":"123.42379ms","start":"2026-10-19T02:07:08.295672Z","end":"2026-10-19T02:07:08.419096Z","steps":["trace[1100263183] 'agreement among raft nodes before linearized reading' (duration: 123.285276ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:07:08.586673Z","caller":"traceutil/trace.go:171","msg":"trace[142054065] transaction","detail":"{read_only:false; response_revision:5350; number_of_response:1; }","duration":"162.717335ms","start":"2026-10-19T02:07:08.423924Z","end":"2026-10-19T02:07:08.586641Z","steps":["trace[142054065] 'process raft request' (duration: 162.636813ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:07:08.586987Z","caller":"traceutil/trace.go:171","msg":"trace[380886784] transaction","detail":"{read_only:false; response_revision:5349; number_of_response:1; }","duration":"163.067774ms","start":"2026-10-19T02:07:08.423864Z","end":"2026-10-19T02:07:08.586932Z","steps":["trace[380886784] 'process raft request' (duration: 135.479131ms)","trace[380886784] 'compare' (duration: 26.998479ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:07:08.587062Z","caller":"traceutil/trace.go:171","msg":"trace[153090490] linearizableReadLoop","detail":"{readStateIndex:5553; appliedIndex:5552; }","duration":"163.098275ms","start":"2026-10-19T02:07:08.42391Z","end":"2026-10-19T02:07:08.587008Z","steps":["trace[153090490] 'read index received' (duration: 135.47236ms)","trace[153090490] 'applied index is now lower than readState.Index' (duration: 27.624125ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:07:08.587321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.388152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:7 size:63563"} {"level":"info","ts":"2026-10-19T02:07:08.587357Z","caller":"traceutil/trace.go:171","msg":"trace[1597680885] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:7; response_revision:5350; }","duration":"163.455883ms","start":"2026-10-19T02:07:08.42389Z","end":"2026-10-19T02:07:08.587346Z","steps":["trace[1597680885] 'agreement among raft nodes before linearized reading' (duration: 163.213128ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:07:15.650317Z","caller":"traceutil/trace.go:171","msg":"trace[109020652] linearizableReadLoop","detail":"{readStateIndex:5826; appliedIndex:5825; }","duration":"121.754751ms","start":"2026-10-19T02:07:15.528533Z","end":"2026-10-19T02:07:15.650287Z","steps":["trace[109020652] 'read index received' (duration: 75.444572ms)","trace[109020652] 'applied index is now lower than readState.Index' (duration: 46.308829ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:07:15.650632Z","caller":"traceutil/trace.go:171","msg":"trace[269269397] transaction","detail":"{read_only:false; response_revision:5612; number_of_response:1; }","duration":"134.12737ms","start":"2026-10-19T02:07:15.516224Z","end":"2026-10-19T02:07:15.650351Z","steps":["trace[269269397] 'process raft request' (duration: 87.729439ms)","trace[269269397] 'compare' (duration: 46.192076ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:07:15.650928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.053278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1817"} {"level":"info","ts":"2026-10-19T02:07:15.651043Z","caller":"traceutil/trace.go:171","msg":"trace[1596106242] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:5612; }","duration":"122.5406ms","start":"2026-10-19T02:07:15.528476Z","end":"2026-10-19T02:07:15.651017Z","steps":["trace[1596106242] 'agreement among raft nodes before linearized reading' (duration: 121.966206ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:07:22.381223Z","caller":"traceutil/trace.go:171","msg":"trace[1467971395] linearizableReadLoop","detail":"{readStateIndex:5939; appliedIndex:5938; }","duration":"109.134817ms","start":"2026-10-19T02:07:22.272057Z","end":"2026-10-19T02:07:22.381192Z","steps":["trace[1467971395] 'read index received' (duration: 108.978253ms)","trace[1467971395] 'applied index is now lower than readState.Index' (duration: 155.344µs)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:07:22.381549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.480515ms","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-10-19T02:07:22.381272Z","caller":"traceutil/trace.go:171","msg":"trace[1991683574] transaction","detail":"{read_only:false; response_revision:5722; number_of_response:1; }","duration":"126.439105ms","start":"2026-10-19T02:07:22.254792Z","end":"2026-10-19T02:07:22.381231Z","steps":["trace[1991683574] 'process raft request' (duration: 126.202069ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:07:22.381619Z","caller":"traceutil/trace.go:171","msg":"trace[1210982198] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:5722; }","duration":"109.598868ms","start":"2026-10-19T02:07:22.272007Z","end":"2026-10-19T02:07:22.381605Z","steps":["trace[1210982198] 'agreement among raft nodes before linearized reading' (duration: 109.466344ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:07:22.676984Z","caller":"traceutil/trace.go:171","msg":"trace[1378543902] transaction","detail":"{read_only:false; response_revision:5725; number_of_response:1; }","duration":"194.485398ms","start":"2026-10-19T02:07:22.482476Z","end":"2026-10-19T02:07:22.676962Z","steps":["trace[1378543902] 'process raft request' (duration: 122.368886ms)","trace[1378543902] 'compare' (duration: 71.787674ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:07:22.677423Z","caller":"traceutil/trace.go:171","msg":"trace[940116150] linearizableReadLoop","detail":"{readStateIndex:5944; appliedIndex:5940; }","duration":"171.658317ms","start":"2026-10-19T02:07:22.505714Z","end":"2026-10-19T02:07:22.677372Z","steps":["trace[940116150] 'read index received' (duration: 13.590538ms)","trace[940116150] 'applied index is now lower than readState.Index' (duration: 158.066499ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:07:22.677462Z","caller":"traceutil/trace.go:171","msg":"trace[640367766] transaction","detail":"{read_only:false; response_revision:5727; number_of_response:1; }","duration":"193.915314ms","start":"2026-10-19T02:07:22.483521Z","end":"2026-10-19T02:07:22.677437Z","steps":["trace[640367766] 'process raft request' (duration: 193.690269ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:07:22.677534Z","caller":"traceutil/trace.go:171","msg":"trace[619967675] transaction","detail":"{read_only:false; response_revision:5726; number_of_response:1; }","duration":"194.003197ms","start":"2026-10-19T02:07:22.483508Z","end":"2026-10-19T02:07:22.677511Z","steps":["trace[619967675] 'process raft request' (duration: 193.381232ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:07:22.67758Z","caller":"traceutil/trace.go:171","msg":"trace[2004651916] transaction","detail":"{read_only:false; response_revision:5728; number_of_response:1; }","duration":"163.267574ms","start":"2026-10-19T02:07:22.514293Z","end":"2026-10-19T02:07:22.677561Z","steps":["trace[2004651916] 'process raft request' (duration: 163.006248ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:07:22.67773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.010845ms","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":"warn","ts":"2026-10-19T02:07:22.67773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.489441ms","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-10-19T02:07:22.67777Z","caller":"traceutil/trace.go:171","msg":"trace[256120736] 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:5728; }","duration":"172.082477ms","start":"2026-10-19T02:07:22.505671Z","end":"2026-10-19T02:07:22.677753Z","steps":["trace[256120736] 'agreement among raft nodes before linearized reading' (duration: 171.963614ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:07:22.67778Z","caller":"traceutil/trace.go:171","msg":"trace[1807914963] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5728; }","duration":"132.547962ms","start":"2026-10-19T02:07:22.545216Z","end":"2026-10-19T02:07:22.677764Z","steps":["trace[1807914963] 'agreement among raft nodes before linearized reading' (duration: 132.392189ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:07:22.896916Z","caller":"traceutil/trace.go:171","msg":"trace[1822477808] transaction","detail":"{read_only:false; response_revision:5731; number_of_response:1; }","duration":"213.367665ms","start":"2026-10-19T02:07:22.683523Z","end":"2026-10-19T02:07:22.896891Z","steps":["trace[1822477808] 'process raft request' (duration: 213.246742ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:07:22.89722Z","caller":"traceutil/trace.go:171","msg":"trace[1861880628] transaction","detail":"{read_only:false; response_revision:5730; number_of_response:1; }","duration":"213.967679ms","start":"2026-10-19T02:07:22.683233Z","end":"2026-10-19T02:07:22.897201Z","steps":["trace[1861880628] 'process raft request' (duration: 213.340954ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:07:22.897473Z","caller":"traceutil/trace.go:171","msg":"trace[1408996225] linearizableReadLoop","detail":"{readStateIndex:5950; appliedIndex:5945; }","duration":"211.655793ms","start":"2026-10-19T02:07:22.685796Z","end":"2026-10-19T02:07:22.897452Z","steps":["trace[1408996225] 'read index received' (duration: 85.582018ms)","trace[1408996225] 'applied index is now lower than readState.Index' (duration: 126.072975ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:07:22.897513Z","caller":"traceutil/trace.go:171","msg":"trace[15027287] transaction","detail":"{read_only:false; response_revision:5732; number_of_response:1; }","duration":"212.692858ms","start":"2026-10-19T02:07:22.684774Z","end":"2026-10-19T02:07:22.897467Z","steps":["trace[15027287] 'process raft request' (duration: 212.062323ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:07:22.897624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.820277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-49frl\" ","response":"range_response_count:1 size:6527"} {"level":"info","ts":"2026-10-19T02:07:22.897633Z","caller":"traceutil/trace.go:171","msg":"trace[1658087498] transaction","detail":"{read_only:false; response_revision:5735; number_of_response:1; }","duration":"211.156591ms","start":"2026-10-19T02:07:22.68646Z","end":"2026-10-19T02:07:22.897617Z","steps":["trace[1658087498] 'process raft request' (duration: 210.950796ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:07:22.897632Z","caller":"traceutil/trace.go:171","msg":"trace[1581666550] transaction","detail":"{read_only:false; response_revision:5734; number_of_response:1; }","duration":"211.583601ms","start":"2026-10-19T02:07:22.686016Z","end":"2026-10-19T02:07:22.8976Z","steps":["trace[1581666550] 'process raft request' (duration: 211.277084ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:07:22.897764Z","caller":"traceutil/trace.go:171","msg":"trace[1758553945] transaction","detail":"{read_only:false; response_revision:5733; number_of_response:1; }","duration":"212.610946ms","start":"2026-10-19T02:07:22.685126Z","end":"2026-10-19T02:07:22.897737Z","steps":["trace[1758553945] 'process raft request' (duration: 211.92227ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:07:22.897649Z","caller":"traceutil/trace.go:171","msg":"trace[1663759622] range","detail":"{range_begin:/registry/pods/openstack/keepalived-49frl; range_end:; response_count:1; response_revision:5735; }","duration":"211.887839ms","start":"2026-10-19T02:07:22.685753Z","end":"2026-10-19T02:07:22.897641Z","steps":["trace[1663759622] 'agreement among raft nodes before linearized reading' (duration: 211.771426ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:07:26.179606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.488058ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-19T02:07:26.179738Z","caller":"traceutil/trace.go:171","msg":"trace[279437692] transaction","detail":"{read_only:false; response_revision:5786; number_of_response:1; }","duration":"264.890799ms","start":"2026-10-19T02:07:25.914828Z","end":"2026-10-19T02:07:26.179719Z","steps":["trace[279437692] 'process raft request' (duration: 159.191206ms)","trace[279437692] 'compare' (duration: 104.608687ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:07:48.196229Z","caller":"traceutil/trace.go:171","msg":"trace[1158590145] transaction","detail":"{read_only:false; response_revision:6138; number_of_response:1; }","duration":"113.606354ms","start":"2026-10-19T02:07:48.082569Z","end":"2026-10-19T02:07:48.196175Z","steps":["trace[1158590145] 'process raft request' (duration: 113.310067ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:11:55.764234Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":4832} {"level":"info","ts":"2026-10-19T02:11:55.8305Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":4832,"took":"63.763844ms","hash":688583144,"current-db-size-bytes":46649344,"current-db-size":"47 MB","current-db-size-in-use-bytes":39772160,"current-db-size-in-use":"40 MB"} {"level":"info","ts":"2026-10-19T02:11:55.830593Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":688583144,"revision":4832,"compact-revision":2933} {"level":"warn","ts":"2026-10-19T02:13:59.020406Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7531884799850810357,"retry-timeout":"500ms"} {"level":"info","ts":"2026-10-19T02:13:59.108356Z","caller":"traceutil/trace.go:171","msg":"trace[269448831] transaction","detail":"{read_only:false; response_revision:8884; number_of_response:1; }","duration":"765.354224ms","start":"2026-10-19T02:13:58.342978Z","end":"2026-10-19T02:13:59.108332Z","steps":["trace[269448831] 'process raft request' (duration: 765.20132ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:13:59.108496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:13:58.342962Z","time spent":"765.457176ms","remote":"127.0.0.1:57272","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T02:13:59.132183Z","caller":"traceutil/trace.go:171","msg":"trace[1770096577] linearizableReadLoop","detail":"{readStateIndex:9200; appliedIndex:9198; }","duration":"612.203895ms","start":"2026-10-19T02:13:58.519949Z","end":"2026-10-19T02:13:59.132152Z","steps":["trace[1770096577] 'read index received' (duration: 588.22078ms)","trace[1770096577] 'applied index is now lower than readState.Index' (duration: 23.981315ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:13:59.132348Z","caller":"traceutil/trace.go:171","msg":"trace[1050218142] transaction","detail":"{read_only:false; response_revision:8885; number_of_response:1; }","duration":"285.459476ms","start":"2026-10-19T02:13:58.846823Z","end":"2026-10-19T02:13:59.132282Z","steps":["trace[1050218142] 'process raft request' (duration: 285.163369ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:13:59.132647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"612.545342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T02:13:59.132777Z","caller":"traceutil/trace.go:171","msg":"trace[749669526] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:8885; }","duration":"612.879321ms","start":"2026-10-19T02:13:58.519874Z","end":"2026-10-19T02:13:59.132753Z","steps":["trace[749669526] 'agreement among raft nodes before linearized reading' (duration: 612.550903ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:13:59.132837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:13:58.51984Z","time spent":"612.979272ms","remote":"127.0.0.1:54564","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"warn","ts":"2026-10-19T02:13:59.164259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.22336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T02:13:59.164336Z","caller":"traceutil/trace.go:171","msg":"trace[593798332] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8887; }","duration":"254.349453ms","start":"2026-10-19T02:13:58.909966Z","end":"2026-10-19T02:13:59.164316Z","steps":["trace[593798332] 'agreement among raft nodes before linearized reading' (duration: 254.202899ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:13:59.164334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.14212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/sshkeys/\" range_end:\"/registry/secretgen.k14s.io/sshkeys0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-19T02:13:59.164384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"499.397617ms","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-10-19T02:13:59.164427Z","caller":"traceutil/trace.go:171","msg":"trace[1853051098] range","detail":"{range_begin:/registry/secretgen.k14s.io/sshkeys/; range_end:/registry/secretgen.k14s.io/sshkeys0; response_count:0; response_revision:8887; }","duration":"423.321574ms","start":"2026-10-19T02:13:58.741085Z","end":"2026-10-19T02:13:59.164406Z","steps":["trace[1853051098] 'agreement among raft nodes before linearized reading' (duration: 423.116089ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:13:59.164456Z","caller":"traceutil/trace.go:171","msg":"trace[747190061] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8887; }","duration":"499.530091ms","start":"2026-10-19T02:13:58.664913Z","end":"2026-10-19T02:13:59.164443Z","steps":["trace[747190061] 'agreement among raft nodes before linearized reading' (duration: 499.326326ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:13:59.16447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:13:58.741065Z","time spent":"423.394506ms","remote":"127.0.0.1:47664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":28,"request content":"key:\"/registry/secretgen.k14s.io/sshkeys/\" range_end:\"/registry/secretgen.k14s.io/sshkeys0\" count_only:true "} {"level":"warn","ts":"2026-10-19T02:13:59.164486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:13:58.664886Z","time spent":"499.593632ms","remote":"127.0.0.1:57272","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":"warn","ts":"2026-10-19T02:14:09.413987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.489574ms","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-10-19T02:14:09.414107Z","caller":"traceutil/trace.go:171","msg":"trace[522120296] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8944; }","duration":"155.691518ms","start":"2026-10-19T02:14:09.258387Z","end":"2026-10-19T02:14:09.414079Z","steps":["trace[522120296] 'range keys from in-memory index tree' (duration: 155.257778ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:14:09.414256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.392698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-10-19T02:14:09.414343Z","caller":"traceutil/trace.go:171","msg":"trace[1965663798] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8944; }","duration":"185.551452ms","start":"2026-10-19T02:14:09.228771Z","end":"2026-10-19T02:14:09.414322Z","steps":["trace[1965663798] 'range keys from in-memory index tree' (duration: 185.116212ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:14:10.169021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.072376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T02:14:10.169098Z","caller":"traceutil/trace.go:171","msg":"trace[1834000340] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8949; }","duration":"257.20883ms","start":"2026-10-19T02:14:09.911871Z","end":"2026-10-19T02:14:10.16908Z","steps":["trace[1834000340] 'range keys from in-memory index tree' (duration: 256.941423ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:14:10.695181Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002435.wal"} {"level":"info","ts":"2026-10-19T02:14:10.696082Z","caller":"traceutil/trace.go:171","msg":"trace[177261089] transaction","detail":"{read_only:false; response_revision:8950; number_of_response:1; }","duration":"449.521171ms","start":"2026-10-19T02:14:10.246521Z","end":"2026-10-19T02:14:10.696043Z","steps":["trace[177261089] 'process raft request' (duration: 449.076611ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:14:10.696285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:14:10.246474Z","time spent":"449.708096ms","remote":"127.0.0.1:50302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":415339,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T02:14:10.725183Z","caller":"traceutil/trace.go:171","msg":"trace[695806928] transaction","detail":"{read_only:false; response_revision:8952; number_of_response:1; }","duration":"307.370002ms","start":"2026-10-19T02:14:10.417773Z","end":"2026-10-19T02:14:10.725143Z","steps":["trace[695806928] 'process raft request' (duration: 307.309811ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:14:10.725414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:14:10.417737Z","time spent":"307.557067ms","remote":"127.0.0.1:57272","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T02:14:10.725596Z","caller":"traceutil/trace.go:171","msg":"trace[1933621872] transaction","detail":"{read_only:false; response_revision:8951; number_of_response:1; }","duration":"366.240069ms","start":"2026-10-19T02:14:10.359345Z","end":"2026-10-19T02:14:10.725585Z","steps":["trace[1933621872] 'process raft request' (duration: 365.548543ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:14:10.725645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:14:10.359307Z","time spent":"366.309001ms","remote":"127.0.0.1:57272","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-19T02:14:11.654345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.958087ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-19T02:14:11.65459Z","caller":"traceutil/trace.go:171","msg":"trace[31346022] transaction","detail":"{read_only:false; response_revision:8956; number_of_response:1; }","duration":"429.89627ms","start":"2026-10-19T02:14:11.224648Z","end":"2026-10-19T02:14:11.654544Z","steps":["trace[31346022] 'process raft request' (duration: 429.836238ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:14:11.654651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:14:11.224632Z","time spent":"429.989922ms","remote":"127.0.0.1:57272","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T02:14:11.654688Z","caller":"traceutil/trace.go:171","msg":"trace[1415167324] linearizableReadLoop","detail":"{readStateIndex:9275; appliedIndex:9271; }","duration":"401.228914ms","start":"2026-10-19T02:14:11.253417Z","end":"2026-10-19T02:14:11.654645Z","steps":["trace[1415167324] 'read index received' (duration: 190.9981ms)","trace[1415167324] 'applied index is now lower than readState.Index' (duration: 210.229054ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:14:11.654819Z","caller":"traceutil/trace.go:171","msg":"trace[239084023] transaction","detail":"{read_only:false; response_revision:8954; number_of_response:1; }","duration":"467.462395ms","start":"2026-10-19T02:14:11.187346Z","end":"2026-10-19T02:14:11.654808Z","steps":["trace[239084023] 'process raft request' (duration: 256.962195ms)","trace[239084023] 'compare' (duration: 209.857315ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:14:11.654862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:14:11.187316Z","time spent":"467.524796ms","remote":"127.0.0.1:57272","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T02:14:11.654934Z","caller":"traceutil/trace.go:171","msg":"trace[863962916] transaction","detail":"{read_only:false; response_revision:8955; number_of_response:1; }","duration":"437.750055ms","start":"2026-10-19T02:14:11.217176Z","end":"2026-10-19T02:14:11.654926Z","steps":["trace[863962916] 'process raft request' (duration: 437.265773ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:14:11.654988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:14:11.217158Z","time spent":"437.808276ms","remote":"127.0.0.1:57272","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-19T02:14:11.655116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.008718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T02:14:11.655153Z","caller":"traceutil/trace.go:171","msg":"trace[1722739543] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:8957; }","duration":"193.09623ms","start":"2026-10-19T02:14:11.462045Z","end":"2026-10-19T02:14:11.655142Z","steps":["trace[1722739543] 'agreement among raft nodes before linearized reading' (duration: 193.009938ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:14:11.655259Z","caller":"traceutil/trace.go:171","msg":"trace[1469544424] transaction","detail":"{read_only:false; response_revision:8957; number_of_response:1; }","duration":"430.450532ms","start":"2026-10-19T02:14:11.224801Z","end":"2026-10-19T02:14:11.655252Z","steps":["trace[1469544424] 'process raft request' (duration: 429.711135ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:14:11.655298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:14:11.224791Z","time spent":"430.486573ms","remote":"127.0.0.1:57272","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-19T02:14:11.655499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.092964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:19651"} {"level":"info","ts":"2026-10-19T02:14:11.655523Z","caller":"traceutil/trace.go:171","msg":"trace[1166117698] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:8957; }","duration":"402.198397ms","start":"2026-10-19T02:14:11.253318Z","end":"2026-10-19T02:14:11.655517Z","steps":["trace[1166117698] 'agreement among raft nodes before linearized reading' (duration: 402.094714ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:14:11.655552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:14:11.253294Z","time spent":"402.241078ms","remote":"127.0.0.1:57182","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":19674,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-10-19T02:14:11.655859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.983288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-10-19T02:14:11.655915Z","caller":"traceutil/trace.go:171","msg":"trace[904260678] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8957; }","duration":"140.094701ms","start":"2026-10-19T02:14:11.515807Z","end":"2026-10-19T02:14:11.655902Z","steps":["trace[904260678] 'agreement among raft nodes before linearized reading' (duration: 139.897406ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:14:11.65594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.627865ms","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-10-19T02:14:11.656047Z","caller":"traceutil/trace.go:171","msg":"trace[174332885] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8957; }","duration":"174.818019ms","start":"2026-10-19T02:14:11.481203Z","end":"2026-10-19T02:14:11.656021Z","steps":["trace[174332885] 'agreement among raft nodes before linearized reading' (duration: 174.465061ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:14:11.656068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.481705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-10-19T02:14:11.656094Z","caller":"traceutil/trace.go:171","msg":"trace[1759831276] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8957; }","duration":"147.550957ms","start":"2026-10-19T02:14:11.508536Z","end":"2026-10-19T02:14:11.656087Z","steps":["trace[1759831276] 'agreement among raft nodes before linearized reading' (duration: 147.480845ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:14:11.656187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.16779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-10-19T02:14:11.656211Z","caller":"traceutil/trace.go:171","msg":"trace[1097095767] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8957; }","duration":"159.246012ms","start":"2026-10-19T02:14:11.496957Z","end":"2026-10-19T02:14:11.656203Z","steps":["trace[1097095767] 'agreement among raft nodes before linearized reading' (duration: 159.17819ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:14:41.452762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.486886ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-19T02:14:41.452899Z","caller":"traceutil/trace.go:171","msg":"trace[1718051008] transaction","detail":"{read_only:false; response_revision:9166; number_of_response:1; }","duration":"289.052131ms","start":"2026-10-19T02:14:41.163825Z","end":"2026-10-19T02:14:41.452878Z","steps":["trace[1718051008] 'process raft request' (duration: 51.32215ms)","trace[1718051008] 'compare' (duration: 236.961263ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:14:41.461251Z","caller":"traceutil/trace.go:171","msg":"trace[1975541946] transaction","detail":"{read_only:false; response_revision:9167; number_of_response:1; }","duration":"100.887027ms","start":"2026-10-19T02:14:41.360327Z","end":"2026-10-19T02:14:41.461214Z","steps":["trace[1975541946] 'process raft request' (duration: 100.610051ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:15:37.795102Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"64a80de7883e6886","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-19T02:15:37.802647Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-10-19T02:15:37.802851Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-10-19T02:16:55.771623Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7929} {"level":"info","ts":"2026-10-19T02:16:55.874776Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7929,"took":"100.415979ms","hash":3177466603,"current-db-size-bytes":46649344,"current-db-size":"47 MB","current-db-size-in-use-bytes":25784320,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-10-19T02:16:55.874875Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3177466603,"revision":7929,"compact-revision":4832} {"level":"info","ts":"2026-10-19T02:21:55.780602Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10319} {"level":"info","ts":"2026-10-19T02:21:55.873412Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10319,"took":"90.051554ms","hash":1337844479,"current-db-size-bytes":46649344,"current-db-size":"47 MB","current-db-size-in-use-bytes":26243072,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-10-19T02:21:55.873491Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1337844479,"revision":10319,"compact-revision":7929} {"level":"info","ts":"2026-10-19T02:22:09.938533Z","caller":"traceutil/trace.go:171","msg":"trace[1809826554] transaction","detail":"{read_only:false; response_revision:12572; number_of_response:1; }","duration":"174.544236ms","start":"2026-10-19T02:22:09.763953Z","end":"2026-10-19T02:22:09.938498Z","steps":["trace[1809826554] 'process raft request' (duration: 76.540871ms)","trace[1809826554] 'compare' (duration: 97.613885ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:22:10.40668Z","caller":"traceutil/trace.go:171","msg":"trace[956039257] transaction","detail":"{read_only:false; response_revision:12574; number_of_response:1; }","duration":"111.544078ms","start":"2026-10-19T02:22:10.295106Z","end":"2026-10-19T02:22:10.40665Z","steps":["trace[956039257] 'process raft request' (duration: 104.320945ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:26:55.789289Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12491} {"level":"info","ts":"2026-10-19T02:26:55.878334Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12491,"took":"86.006719ms","hash":3094062211,"current-db-size-bytes":46649344,"current-db-size":"47 MB","current-db-size-in-use-bytes":27693056,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-19T02:26:55.878414Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3094062211,"revision":12491,"compact-revision":10319} {"level":"info","ts":"2026-10-19T02:28:11.61573Z","caller":"traceutil/trace.go:171","msg":"trace[1195810915] transaction","detail":"{read_only:false; response_revision:15019; number_of_response:1; }","duration":"190.692304ms","start":"2026-10-19T02:28:11.425007Z","end":"2026-10-19T02:28:11.615699Z","steps":["trace[1195810915] 'process raft request' (duration: 190.543421ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:28:11.617553Z","caller":"traceutil/trace.go:171","msg":"trace[1294724713] linearizableReadLoop","detail":"{readStateIndex:15542; appliedIndex:15541; }","duration":"131.149676ms","start":"2026-10-19T02:28:11.486364Z","end":"2026-10-19T02:28:11.617513Z","steps":["trace[1294724713] 'read index received' (duration: 129.866995ms)","trace[1294724713] 'applied index is now lower than readState.Index' (duration: 1.281431ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:28:11.617655Z","caller":"traceutil/trace.go:171","msg":"trace[656026540] transaction","detail":"{read_only:false; response_revision:15020; number_of_response:1; }","duration":"178.184526ms","start":"2026-10-19T02:28:11.439438Z","end":"2026-10-19T02:28:11.617623Z","steps":["trace[656026540] 'process raft request' (duration: 177.829338ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:28:11.617781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.391651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T02:28:11.617875Z","caller":"traceutil/trace.go:171","msg":"trace[678380704] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:15021; }","duration":"131.559495ms","start":"2026-10-19T02:28:11.486298Z","end":"2026-10-19T02:28:11.617857Z","steps":["trace[678380704] 'agreement among raft nodes before linearized reading' (duration: 131.35348ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:28:15.151789Z","caller":"traceutil/trace.go:171","msg":"trace[665287162] transaction","detail":"{read_only:false; response_revision:15039; number_of_response:1; }","duration":"100.741261ms","start":"2026-10-19T02:28:15.050975Z","end":"2026-10-19T02:28:15.151716Z","steps":["trace[665287162] 'process raft request' (duration: 100.533576ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:28:37.949925Z","caller":"traceutil/trace.go:171","msg":"trace[1169172711] transaction","detail":"{read_only:false; response_revision:15157; number_of_response:1; }","duration":"202.607458ms","start":"2026-10-19T02:28:37.747292Z","end":"2026-10-19T02:28:37.9499Z","steps":["trace[1169172711] 'process raft request' (duration: 201.349198ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:28:37.950078Z","caller":"traceutil/trace.go:171","msg":"trace[1892411753] transaction","detail":"{read_only:false; response_revision:15158; number_of_response:1; }","duration":"193.928822ms","start":"2026-10-19T02:28:37.756106Z","end":"2026-10-19T02:28:37.950035Z","steps":["trace[1892411753] 'process raft request' (duration: 193.404539ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:28:55.885384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.482363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-49frl\" ","response":"range_response_count:1 size:6527"} {"level":"info","ts":"2026-10-19T02:28:55.885483Z","caller":"traceutil/trace.go:171","msg":"trace[1727739734] range","detail":"{range_begin:/registry/pods/openstack/keepalived-49frl; range_end:; response_count:1; response_revision:15262; }","duration":"101.638766ms","start":"2026-10-19T02:28:55.783825Z","end":"2026-10-19T02:28:55.885464Z","steps":["trace[1727739734] 'range keys from in-memory index tree' (duration: 101.259837ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:28:56.797739Z","caller":"traceutil/trace.go:171","msg":"trace[682568666] transaction","detail":"{read_only:false; response_revision:15266; number_of_response:1; }","duration":"115.80876ms","start":"2026-10-19T02:28:56.681886Z","end":"2026-10-19T02:28:56.797695Z","steps":["trace[682568666] 'process raft request' (duration: 115.570345ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:29:21.18776Z","caller":"traceutil/trace.go:171","msg":"trace[117073254] transaction","detail":"{read_only:false; response_revision:15591; number_of_response:1; }","duration":"123.047201ms","start":"2026-10-19T02:29:21.064636Z","end":"2026-10-19T02:29:21.187683Z","steps":["trace[117073254] 'process raft request' (duration: 122.811536ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:30:44.509192Z","caller":"traceutil/trace.go:171","msg":"trace[1121554348] linearizableReadLoop","detail":"{readStateIndex:16953; appliedIndex:16952; }","duration":"116.530257ms","start":"2026-10-19T02:30:44.392606Z","end":"2026-10-19T02:30:44.509136Z","steps":["trace[1121554348] 'read index received' (duration: 116.22534ms)","trace[1121554348] 'applied index is now lower than readState.Index' (duration: 303.727µs)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:30:44.51056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.93042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:76 size:740183"} {"level":"info","ts":"2026-10-19T02:30:44.510627Z","caller":"traceutil/trace.go:171","msg":"trace[1071267722] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:76; response_revision:16384; }","duration":"118.045253ms","start":"2026-10-19T02:30:44.392565Z","end":"2026-10-19T02:30:44.51061Z","steps":["trace[1071267722] 'agreement among raft nodes before linearized reading' (duration: 116.723162ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:30:44.511398Z","caller":"traceutil/trace.go:171","msg":"trace[1689448317] transaction","detail":"{read_only:false; response_revision:16384; number_of_response:1; }","duration":"123.121732ms","start":"2026-10-19T02:30:44.388258Z","end":"2026-10-19T02:30:44.51138Z","steps":["trace[1689448317] 'process raft request' (duration: 120.684335ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:30:44.69705Z","caller":"traceutil/trace.go:171","msg":"trace[1270868332] linearizableReadLoop","detail":"{readStateIndex:16955; appliedIndex:16953; }","duration":"179.737568ms","start":"2026-10-19T02:30:44.517288Z","end":"2026-10-19T02:30:44.697026Z","steps":["trace[1270868332] 'read index received' (duration: 162.122793ms)","trace[1270868332] 'applied index is now lower than readState.Index' (duration: 17.613515ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:30:44.697428Z","caller":"traceutil/trace.go:171","msg":"trace[1054991160] transaction","detail":"{read_only:false; response_revision:16385; number_of_response:1; }","duration":"215.854059ms","start":"2026-10-19T02:30:44.48155Z","end":"2026-10-19T02:30:44.697404Z","steps":["trace[1054991160] 'process raft request' (duration: 197.777563ms)","trace[1054991160] 'compare' (duration: 17.516143ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:30:44.697646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.337122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5524"} {"level":"info","ts":"2026-10-19T02:30:44.697759Z","caller":"traceutil/trace.go:171","msg":"trace[150731842] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16386; }","duration":"180.509756ms","start":"2026-10-19T02:30:44.517221Z","end":"2026-10-19T02:30:44.697731Z","steps":["trace[150731842] 'agreement among raft nodes before linearized reading' (duration: 180.204369ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:30:44.697706Z","caller":"traceutil/trace.go:171","msg":"trace[874385664] transaction","detail":"{read_only:false; response_revision:16386; number_of_response:1; }","duration":"208.820733ms","start":"2026-10-19T02:30:44.488801Z","end":"2026-10-19T02:30:44.697622Z","steps":["trace[874385664] 'process raft request' (duration: 208.173478ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:30:44.753634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.556033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-19T02:30:44.753712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.59895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-19T02:30:44.753748Z","caller":"traceutil/trace.go:171","msg":"trace[437903226] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:16386; }","duration":"106.689536ms","start":"2026-10-19T02:30:44.647033Z","end":"2026-10-19T02:30:44.753723Z","steps":["trace[437903226] 'agreement among raft nodes before linearized reading' (duration: 106.483881ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:30:44.75373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.367575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-19T02:30:44.753853Z","caller":"traceutil/trace.go:171","msg":"trace[362945984] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:16386; }","duration":"161.570999ms","start":"2026-10-19T02:30:44.592257Z","end":"2026-10-19T02:30:44.753828Z","steps":["trace[362945984] 'agreement among raft nodes before linearized reading' (duration: 161.329814ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:30:44.753861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.913294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-19T02:30:44.753886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.063367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5524"} {"level":"info","ts":"2026-10-19T02:30:44.753896Z","caller":"traceutil/trace.go:171","msg":"trace[2129657940] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:16386; }","duration":"160.977526ms","start":"2026-10-19T02:30:44.592908Z","end":"2026-10-19T02:30:44.753886Z","steps":["trace[2129657940] 'agreement among raft nodes before linearized reading' (duration: 160.907414ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:30:44.753879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.249335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5524"} {"level":"info","ts":"2026-10-19T02:30:44.755337Z","caller":"traceutil/trace.go:171","msg":"trace[2011501273] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16386; }","duration":"104.723049ms","start":"2026-10-19T02:30:44.650532Z","end":"2026-10-19T02:30:44.755255Z","steps":["trace[2011501273] 'agreement among raft nodes before linearized reading' (duration: 103.106381ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:30:44.753731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.418336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-19T02:30:44.755496Z","caller":"traceutil/trace.go:171","msg":"trace[1937753859] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:16386; }","duration":"163.150467ms","start":"2026-10-19T02:30:44.5923Z","end":"2026-10-19T02:30:44.755451Z","steps":["trace[1937753859] 'agreement among raft nodes before linearized reading' (duration: 161.406845ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:30:44.753942Z","caller":"traceutil/trace.go:171","msg":"trace[1814084169] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16386; }","duration":"147.137548ms","start":"2026-10-19T02:30:44.606782Z","end":"2026-10-19T02:30:44.75392Z","steps":["trace[1814084169] 'agreement among raft nodes before linearized reading' (duration: 146.982885ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:30:44.753776Z","caller":"traceutil/trace.go:171","msg":"trace[2097994529] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:16386; }","duration":"105.701442ms","start":"2026-10-19T02:30:44.648052Z","end":"2026-10-19T02:30:44.753754Z","steps":["trace[2097994529] 'agreement among raft nodes before linearized reading' (duration: 105.59623ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:30:44.753647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.581853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-19T02:30:44.755807Z","caller":"traceutil/trace.go:171","msg":"trace[884849771] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:16386; }","duration":"108.788575ms","start":"2026-10-19T02:30:44.646988Z","end":"2026-10-19T02:30:44.755776Z","steps":["trace[884849771] 'agreement among raft nodes before linearized reading' (duration: 106.545482ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:30:45.876382Z","caller":"traceutil/trace.go:171","msg":"trace[388433473] linearizableReadLoop","detail":"{readStateIndex:16957; appliedIndex:16956; }","duration":"143.279148ms","start":"2026-10-19T02:30:45.733074Z","end":"2026-10-19T02:30:45.876353Z","steps":["trace[388433473] 'read index received' (duration: 142.964411ms)","trace[388433473] 'applied index is now lower than readState.Index' (duration: 313.617µs)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:30:45.876483Z","caller":"traceutil/trace.go:171","msg":"trace[1965348810] transaction","detail":"{read_only:false; response_revision:16387; number_of_response:1; }","duration":"173.213034ms","start":"2026-10-19T02:30:45.703226Z","end":"2026-10-19T02:30:45.876439Z","steps":["trace[1965348810] 'process raft request' (duration: 172.881556ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:30:45.876604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.509524ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/passwords/\" range_end:\"/registry/secretgen.k14s.io/passwords0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-10-19T02:30:45.876659Z","caller":"traceutil/trace.go:171","msg":"trace[165053359] range","detail":"{range_begin:/registry/secretgen.k14s.io/passwords/; range_end:/registry/secretgen.k14s.io/passwords0; response_count:0; response_revision:16387; }","duration":"143.632176ms","start":"2026-10-19T02:30:45.733009Z","end":"2026-10-19T02:30:45.876641Z","steps":["trace[165053359] 'agreement among raft nodes before linearized reading' (duration: 143.513053ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:30:45.876764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.212569ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-10-19T02:30:45.876815Z","caller":"traceutil/trace.go:171","msg":"trace[196497032] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:16387; }","duration":"127.312442ms","start":"2026-10-19T02:30:45.74949Z","end":"2026-10-19T02:30:45.876802Z","steps":["trace[196497032] 'agreement among raft nodes before linearized reading' (duration: 127.122968ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:31:55.796844Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14523} {"level":"info","ts":"2026-10-19T02:31:55.894225Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14523,"took":"94.271412ms","hash":250526717,"current-db-size-bytes":46649344,"current-db-size":"47 MB","current-db-size-in-use-bytes":30113792,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-10-19T02:31:55.894313Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":250526717,"revision":14523,"compact-revision":12491} {"level":"info","ts":"2026-10-19T02:36:55.812869Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":16813} {"level":"info","ts":"2026-10-19T02:36:55.922832Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":16813,"took":"106.213896ms","hash":465249156,"current-db-size-bytes":47071232,"current-db-size":"47 MB","current-db-size-in-use-bytes":31637504,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-19T02:36:55.922893Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":465249156,"revision":16813,"compact-revision":14523} {"level":"info","ts":"2026-10-19T02:37:23.848756Z","caller":"traceutil/trace.go:171","msg":"trace[1674830442] transaction","detail":"{read_only:false; response_revision:19232; number_of_response:1; }","duration":"253.179215ms","start":"2026-10-19T02:37:23.595544Z","end":"2026-10-19T02:37:23.848723Z","steps":["trace[1674830442] 'process raft request' (duration: 252.936069ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:37:24.237492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.570641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-barbican-server-0\" ","response":"range_response_count:1 size:1866"} {"level":"info","ts":"2026-10-19T02:37:24.237582Z","caller":"traceutil/trace.go:171","msg":"trace[561236609] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-barbican-server-0; range_end:; response_count:1; response_revision:19233; }","duration":"131.736856ms","start":"2026-10-19T02:37:24.105824Z","end":"2026-10-19T02:37:24.237561Z","steps":["trace[561236609] 'range keys from in-memory index tree' (duration: 131.287454ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:37:24.535582Z","caller":"traceutil/trace.go:171","msg":"trace[863452887] transaction","detail":"{read_only:false; response_revision:19234; number_of_response:1; }","duration":"282.344971ms","start":"2026-10-19T02:37:24.253202Z","end":"2026-10-19T02:37:24.535547Z","steps":["trace[863452887] 'process raft request' (duration: 282.090645ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:37:24.585948Z","caller":"traceutil/trace.go:171","msg":"trace[449233009] linearizableReadLoop","detail":"{readStateIndex:19899; appliedIndex:19897; }","duration":"231.564199ms","start":"2026-10-19T02:37:24.354361Z","end":"2026-10-19T02:37:24.585925Z","steps":["trace[449233009] 'read index received' (duration: 180.862739ms)","trace[449233009] 'applied index is now lower than readState.Index' (duration: 50.70045ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:37:24.586065Z","caller":"traceutil/trace.go:171","msg":"trace[1488538311] transaction","detail":"{read_only:false; response_revision:19235; number_of_response:1; }","duration":"273.809557ms","start":"2026-10-19T02:37:24.312242Z","end":"2026-10-19T02:37:24.586051Z","steps":["trace[1488538311] 'process raft request' (duration: 236.048226ms)","trace[1488538311] 'compare' (duration: 37.462424ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:37:24.586345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.860776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-10-19T02:37:24.586406Z","caller":"traceutil/trace.go:171","msg":"trace[103160939] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:19236; }","duration":"232.081621ms","start":"2026-10-19T02:37:24.354309Z","end":"2026-10-19T02:37:24.586391Z","steps":["trace[103160939] 'agreement among raft nodes before linearized reading' (duration: 231.765174ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:37:24.600747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.618839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"warn","ts":"2026-10-19T02:37:24.600823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.061375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-10-19T02:37:24.600852Z","caller":"traceutil/trace.go:171","msg":"trace[818337891] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:19237; }","duration":"241.835094ms","start":"2026-10-19T02:37:24.358987Z","end":"2026-10-19T02:37:24.600822Z","steps":["trace[818337891] 'agreement among raft nodes before linearized reading' (duration: 241.479556ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:37:24.60089Z","caller":"traceutil/trace.go:171","msg":"trace[1979668329] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:19237; }","duration":"156.23817ms","start":"2026-10-19T02:37:24.444634Z","end":"2026-10-19T02:37:24.600872Z","steps":["trace[1979668329] 'agreement among raft nodes before linearized reading' (duration: 156.005785ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:37:24.60094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.638117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-k6dqw\" ","response":"range_response_count:1 size:22129"} {"level":"info","ts":"2026-10-19T02:37:24.601073Z","caller":"traceutil/trace.go:171","msg":"trace[615023495] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-k6dqw; range_end:; response_count:1; response_revision:19237; }","duration":"158.753311ms","start":"2026-10-19T02:37:24.442231Z","end":"2026-10-19T02:37:24.600985Z","steps":["trace[615023495] 'agreement among raft nodes before linearized reading' (duration: 158.617518ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:37:31.032556Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"64a80de7883e6886","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-19T02:37:31.094759Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-10-19T02:37:31.094946Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-10-19T02:41:55.820316Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19044} {"level":"info","ts":"2026-10-19T02:41:55.921225Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19044,"took":"97.193106ms","hash":925867956,"current-db-size-bytes":49188864,"current-db-size":"49 MB","current-db-size-in-use-bytes":33972224,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-10-19T02:41:55.92129Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":925867956,"revision":19044,"compact-revision":16813} {"level":"info","ts":"2026-10-19T02:43:24.642303Z","caller":"traceutil/trace.go:171","msg":"trace[1522614228] transaction","detail":"{read_only:false; response_revision:22007; number_of_response:1; }","duration":"356.241561ms","start":"2026-10-19T02:43:24.286034Z","end":"2026-10-19T02:43:24.642276Z","steps":["trace[1522614228] 'process raft request' (duration: 356.061698ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:43:24.642476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:43:24.28601Z","time spent":"356.373665ms","remote":"127.0.0.1:57272","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T02:43:24.669076Z","caller":"traceutil/trace.go:171","msg":"trace[1786006662] transaction","detail":"{read_only:false; response_revision:22009; number_of_response:1; }","duration":"305.079394ms","start":"2026-10-19T02:43:24.363973Z","end":"2026-10-19T02:43:24.669052Z","steps":["trace[1786006662] 'process raft request' (duration: 305.033853ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:43:24.669289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:43:24.363934Z","time spent":"305.215616ms","remote":"127.0.0.1:57272","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T02:43:24.669447Z","caller":"traceutil/trace.go:171","msg":"trace[1493923733] transaction","detail":"{read_only:false; response_revision:22008; number_of_response:1; }","duration":"326.627562ms","start":"2026-10-19T02:43:24.34277Z","end":"2026-10-19T02:43:24.669398Z","steps":["trace[1493923733] 'process raft request' (duration: 326.08692ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:43:24.669616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:43:24.342747Z","time spent":"326.781615ms","remote":"127.0.0.1:57272","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T02:43:35.117457Z","caller":"traceutil/trace.go:171","msg":"trace[646103723] transaction","detail":"{read_only:false; response_revision:22068; number_of_response:1; }","duration":"125.902475ms","start":"2026-10-19T02:43:34.991519Z","end":"2026-10-19T02:43:35.117421Z","steps":["trace[646103723] 'process raft request' (duration: 125.691481ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:43:35.119768Z","caller":"traceutil/trace.go:171","msg":"trace[1740882251] linearizableReadLoop","detail":"{readStateIndex:22828; appliedIndex:22826; }","duration":"112.648414ms","start":"2026-10-19T02:43:35.007101Z","end":"2026-10-19T02:43:35.11975Z","steps":["trace[1740882251] 'read index received' (duration: 110.072849ms)","trace[1740882251] 'applied index is now lower than readState.Index' (duration: 2.574095ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:43:35.120113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.995082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-10-19T02:43:35.120166Z","caller":"traceutil/trace.go:171","msg":"trace[842117977] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:22069; }","duration":"113.116305ms","start":"2026-10-19T02:43:35.007032Z","end":"2026-10-19T02:43:35.120148Z","steps":["trace[842117977] 'agreement among raft nodes before linearized reading' (duration: 112.787328ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:43:35.120228Z","caller":"traceutil/trace.go:171","msg":"trace[1050410432] transaction","detail":"{read_only:false; response_revision:22069; number_of_response:1; }","duration":"125.842165ms","start":"2026-10-19T02:43:34.994267Z","end":"2026-10-19T02:43:35.120109Z","steps":["trace[1050410432] 'process raft request' (duration: 125.408235ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:43:41.176047Z","caller":"traceutil/trace.go:171","msg":"trace[802169352] transaction","detail":"{read_only:false; response_revision:22095; number_of_response:1; }","duration":"434.27965ms","start":"2026-10-19T02:43:40.741733Z","end":"2026-10-19T02:43:41.176012Z","steps":["trace[802169352] 'process raft request' (duration: 434.208108ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:43:41.176189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:43:40.741698Z","time spent":"434.416773ms","remote":"127.0.0.1:57272","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T02:43:41.176138Z","caller":"traceutil/trace.go:171","msg":"trace[692040264] transaction","detail":"{read_only:false; response_revision:22094; number_of_response:1; }","duration":"436.895465ms","start":"2026-10-19T02:43:40.739176Z","end":"2026-10-19T02:43:41.176071Z","steps":["trace[692040264] 'process raft request' (duration: 436.599959ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:43:41.176363Z","caller":"traceutil/trace.go:171","msg":"trace[1785878900] transaction","detail":"{read_only:false; response_revision:22096; number_of_response:1; }","duration":"421.490679ms","start":"2026-10-19T02:43:40.754834Z","end":"2026-10-19T02:43:41.176325Z","steps":["trace[1785878900] 'process raft request' (duration: 421.140851ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:43:41.176387Z","caller":"traceutil/trace.go:171","msg":"trace[1067226328] linearizableReadLoop","detail":"{readStateIndex:22856; appliedIndex:22853; }","duration":"266.393952ms","start":"2026-10-19T02:43:40.909922Z","end":"2026-10-19T02:43:41.176316Z","steps":["trace[1067226328] 'read index received' (duration: 265.776799ms)","trace[1067226328] 'applied index is now lower than readState.Index' (duration: 592.553µs)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:43:41.176525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.595486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-19T02:43:41.176546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:43:40.754809Z","time spent":"421.643201ms","remote":"127.0.0.1:57272","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T02:43:41.176579Z","caller":"traceutil/trace.go:171","msg":"trace[218194926] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:22096; }","duration":"266.694009ms","start":"2026-10-19T02:43:40.909869Z","end":"2026-10-19T02:43:41.176563Z","steps":["trace[218194926] 'agreement among raft nodes before linearized reading' (duration: 266.606847ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:43:41.17679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.854494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"warn","ts":"2026-10-19T02:43:41.176391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:43:40.739145Z","time spent":"437.12009ms","remote":"127.0.0.1:57272","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T02:43:41.176844Z","caller":"traceutil/trace.go:171","msg":"trace[2034684616] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:22096; }","duration":"228.961126ms","start":"2026-10-19T02:43:40.94787Z","end":"2026-10-19T02:43:41.176832Z","steps":["trace[2034684616] 'agreement among raft nodes before linearized reading' (duration: 228.714061ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:43:41.17694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.114633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-19T02:43:41.176944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.437938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-10-19T02:43:41.176973Z","caller":"traceutil/trace.go:171","msg":"trace[594453372] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:22096; }","duration":"176.190605ms","start":"2026-10-19T02:43:41.00077Z","end":"2026-10-19T02:43:41.176961Z","steps":["trace[594453372] 'agreement among raft nodes before linearized reading' (duration: 176.103063ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:43:41.177072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.058958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-10-19T02:43:41.17711Z","caller":"traceutil/trace.go:171","msg":"trace[188520473] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:22096; }","duration":"229.13288ms","start":"2026-10-19T02:43:40.947967Z","end":"2026-10-19T02:43:41.1771Z","steps":["trace[188520473] 'agreement among raft nodes before linearized reading' (duration: 229.028768ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:43:41.176983Z","caller":"traceutil/trace.go:171","msg":"trace[640009847] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:22096; }","duration":"103.53307ms","start":"2026-10-19T02:43:41.073437Z","end":"2026-10-19T02:43:41.17697Z","steps":["trace[640009847] 'agreement among raft nodes before linearized reading' (duration: 103.440988ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:43:41.471447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.077087ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-19T02:43:41.471569Z","caller":"traceutil/trace.go:171","msg":"trace[782615870] transaction","detail":"{read_only:false; response_revision:22097; number_of_response:1; }","duration":"289.863871ms","start":"2026-10-19T02:43:41.181671Z","end":"2026-10-19T02:43:41.471535Z","steps":["trace[782615870] 'process raft request' (duration: 141.571629ms)","trace[782615870] 'compare' (duration: 147.953305ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:43:41.487204Z","caller":"traceutil/trace.go:171","msg":"trace[694528431] transaction","detail":"{read_only:false; response_revision:22099; number_of_response:1; }","duration":"304.8432ms","start":"2026-10-19T02:43:41.182341Z","end":"2026-10-19T02:43:41.487184Z","steps":["trace[694528431] 'process raft request' (duration: 304.748008ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:43:41.487487Z","caller":"traceutil/trace.go:171","msg":"trace[2040609567] transaction","detail":"{read_only:false; response_revision:22101; number_of_response:1; }","duration":"304.788218ms","start":"2026-10-19T02:43:41.182652Z","end":"2026-10-19T02:43:41.487441Z","steps":["trace[2040609567] 'process raft request' (duration: 304.690696ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:43:41.487504Z","caller":"traceutil/trace.go:171","msg":"trace[1500031006] transaction","detail":"{read_only:false; response_revision:22100; number_of_response:1; }","duration":"305.118375ms","start":"2026-10-19T02:43:41.182374Z","end":"2026-10-19T02:43:41.487492Z","steps":["trace[1500031006] 'process raft request' (duration: 304.777688ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:43:41.487638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:43:41.182635Z","time spent":"304.925581ms","remote":"127.0.0.1:57272","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T02:43:41.487208Z","caller":"traceutil/trace.go:171","msg":"trace[395135619] transaction","detail":"{read_only:false; response_revision:22098; number_of_response:1; }","duration":"304.975022ms","start":"2026-10-19T02:43:41.182203Z","end":"2026-10-19T02:43:41.487178Z","steps":["trace[395135619] 'process raft request' (duration: 304.675486ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:43:41.48769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:43:41.182339Z","time spent":"305.301509ms","remote":"127.0.0.1:57272","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-19T02:43:41.487743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:43:41.182327Z","time spent":"305.116785ms","remote":"127.0.0.1:57272","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-19T02:43:41.487767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:43:41.18217Z","time spent":"305.546664ms","remote":"127.0.0.1:57272","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T02:43:41.847616Z","caller":"traceutil/trace.go:171","msg":"trace[1597418667] transaction","detail":"{read_only:false; response_revision:22102; number_of_response:1; }","duration":"204.138397ms","start":"2026-10-19T02:43:41.643438Z","end":"2026-10-19T02:43:41.847576Z","steps":["trace[1597418667] 'process raft request' (duration: 186.275998ms)","trace[1597418667] 'compare' (duration: 17.378369ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:43:42.219157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.025388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-10-19T02:43:42.219244Z","caller":"traceutil/trace.go:171","msg":"trace[1896936107] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:22102; }","duration":"269.12925ms","start":"2026-10-19T02:43:41.950094Z","end":"2026-10-19T02:43:42.219224Z","steps":["trace[1896936107] 'count revisions from in-memory index tree' (duration: 268.921206ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:46:55.82821Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21412} {"level":"info","ts":"2026-10-19T02:46:55.952345Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21412,"took":"119.759819ms","hash":4182683026,"current-db-size-bytes":49188864,"current-db-size":"49 MB","current-db-size-in-use-bytes":29937664,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-10-19T02:46:55.952393Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4182683026,"revision":21412,"compact-revision":19044} {"level":"info","ts":"2026-10-19T02:47:59.198081Z","caller":"traceutil/trace.go:171","msg":"trace[2039683025] linearizableReadLoop","detail":"{readStateIndex:25502; appliedIndex:25501; }","duration":"166.722076ms","start":"2026-10-19T02:47:59.031314Z","end":"2026-10-19T02:47:59.198037Z","steps":["trace[2039683025] 'read index received' (duration: 161.87339ms)","trace[2039683025] 'applied index is now lower than readState.Index' (duration: 4.847456ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:47:59.198265Z","caller":"traceutil/trace.go:171","msg":"trace[1592910243] transaction","detail":"{read_only:false; response_revision:24662; number_of_response:1; }","duration":"174.548262ms","start":"2026-10-19T02:47:59.023692Z","end":"2026-10-19T02:47:59.19824Z","steps":["trace[1592910243] 'process raft request' (duration: 169.526832ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:47:59.198625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.297139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-10-19T02:47:59.198692Z","caller":"traceutil/trace.go:171","msg":"trace[1853935461] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:24662; }","duration":"167.418862ms","start":"2026-10-19T02:47:59.031255Z","end":"2026-10-19T02:47:59.198674Z","steps":["trace[1853935461] 'agreement among raft nodes before linearized reading' (duration: 167.213237ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:47:59.606852Z","caller":"traceutil/trace.go:171","msg":"trace[1212728008] transaction","detail":"{read_only:false; response_revision:24665; number_of_response:1; }","duration":"400.663739ms","start":"2026-10-19T02:47:59.206164Z","end":"2026-10-19T02:47:59.606828Z","steps":["trace[1212728008] 'process raft request' (duration: 399.211104ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:47:59.607032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:47:59.206136Z","time spent":"400.800462ms","remote":"127.0.0.1:57272","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T02:47:59.607023Z","caller":"traceutil/trace.go:171","msg":"trace[1009983446] linearizableReadLoop","detail":"{readStateIndex:25506; appliedIndex:25504; }","duration":"339.016703ms","start":"2026-10-19T02:47:59.267982Z","end":"2026-10-19T02:47:59.606998Z","steps":["trace[1009983446] 'read index received' (duration: 337.323833ms)","trace[1009983446] 'applied index is now lower than readState.Index' (duration: 1.69174ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:47:59.607246Z","caller":"traceutil/trace.go:171","msg":"trace[1667114517] transaction","detail":"{read_only:false; response_revision:24666; number_of_response:1; }","duration":"401.026037ms","start":"2026-10-19T02:47:59.206204Z","end":"2026-10-19T02:47:59.60723Z","steps":["trace[1667114517] 'process raft request' (duration: 400.575466ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:47:59.607403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:47:59.206174Z","time spent":"401.1175ms","remote":"127.0.0.1:57272","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-19T02:47:59.60745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.058537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-10-19T02:47:59.607487Z","caller":"traceutil/trace.go:171","msg":"trace[1540842005] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24666; }","duration":"311.135319ms","start":"2026-10-19T02:47:59.296341Z","end":"2026-10-19T02:47:59.607477Z","steps":["trace[1540842005] 'agreement among raft nodes before linearized reading' (duration: 311.018446ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:47:59.607513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:47:59.296319Z","time spent":"311.188551ms","remote":"127.0.0.1:57272","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-10-19T02:47:59.607619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.654227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.96\" ","response":"range_response_count:1 size:137"} {"level":"info","ts":"2026-10-19T02:47:59.607644Z","caller":"traceutil/trace.go:171","msg":"trace[309609227] range","detail":"{range_begin:/registry/masterleases/162.253.55.96; range_end:; response_count:1; response_revision:24666; }","duration":"339.7556ms","start":"2026-10-19T02:47:59.26788Z","end":"2026-10-19T02:47:59.607635Z","steps":["trace[309609227] 'agreement among raft nodes before linearized reading' (duration: 339.690288ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:47:59.607664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:47:59.267855Z","time spent":"339.805551ms","remote":"127.0.0.1:57056","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":160,"request content":"key:\"/registry/masterleases/162.253.55.96\" "} {"level":"warn","ts":"2026-10-19T02:47:59.607811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.701572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" ","response":"range_response_count:1 size:623"} {"level":"info","ts":"2026-10-19T02:47:59.607841Z","caller":"traceutil/trace.go:171","msg":"trace[906554222] range","detail":"{range_begin:/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi; range_end:; response_count:1; response_revision:24666; }","duration":"181.763063ms","start":"2026-10-19T02:47:59.426067Z","end":"2026-10-19T02:47:59.60783Z","steps":["trace[906554222] 'agreement among raft nodes before linearized reading' (duration: 181.699642ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:47:59.607951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.688835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretexports/\" range_end:\"/registry/secretgen.carvel.dev/secretexports0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-19T02:47:59.607978Z","caller":"traceutil/trace.go:171","msg":"trace[1386906338] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretexports/; range_end:/registry/secretgen.carvel.dev/secretexports0; response_count:0; response_revision:24666; }","duration":"251.719566ms","start":"2026-10-19T02:47:59.356251Z","end":"2026-10-19T02:47:59.607971Z","steps":["trace[1386906338] 'agreement among raft nodes before linearized reading' (duration: 251.633644ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:47:59.60831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.819457ms","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-10-19T02:47:59.608367Z","caller":"traceutil/trace.go:171","msg":"trace[622579256] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24666; }","duration":"306.892449ms","start":"2026-10-19T02:47:59.301456Z","end":"2026-10-19T02:47:59.608349Z","steps":["trace[622579256] 'agreement among raft nodes before linearized reading' (duration: 306.722495ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:47:59.608408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:47:59.301447Z","time spent":"306.95106ms","remote":"127.0.0.1:57272","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-10-19T02:49:33.816384Z","caller":"traceutil/trace.go:171","msg":"trace[1936003083] transaction","detail":"{read_only:false; response_revision:25641; number_of_response:1; }","duration":"135.225596ms","start":"2026-10-19T02:49:33.681111Z","end":"2026-10-19T02:49:33.816337Z","steps":["trace[1936003083] 'process raft request' (duration: 105.941289ms)","trace[1936003083] 'compare' (duration: 29.076622ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:49:49.696621Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006836.wal"} {"level":"info","ts":"2026-10-19T02:50:03.555527Z","caller":"traceutil/trace.go:171","msg":"trace[628245615] transaction","detail":"{read_only:false; response_revision:25932; number_of_response:1; }","duration":"324.036387ms","start":"2026-10-19T02:50:03.231454Z","end":"2026-10-19T02:50:03.55549Z","steps":["trace[628245615] 'process raft request' (duration: 323.803072ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:50:03.55575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:50:03.231423Z","time spent":"324.218722ms","remote":"127.0.0.1:57272","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":626,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T02:50:03.756976Z","caller":"traceutil/trace.go:171","msg":"trace[1002942585] transaction","detail":"{read_only:false; response_revision:25933; number_of_response:1; }","duration":"427.96802ms","start":"2026-10-19T02:50:03.328972Z","end":"2026-10-19T02:50:03.75694Z","steps":["trace[1002942585] 'process raft request' (duration: 427.607101ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:50:03.757218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:50:03.328939Z","time spent":"428.150603ms","remote":"127.0.0.1:57272","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T02:51:36.642953Z","caller":"traceutil/trace.go:171","msg":"trace[162882674] transaction","detail":"{read_only:false; response_revision:26787; number_of_response:1; }","duration":"130.320063ms","start":"2026-10-19T02:51:36.512578Z","end":"2026-10-19T02:51:36.642898Z","steps":["trace[162882674] 'process raft request' (duration: 129.660447ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:51:42.130636Z","caller":"traceutil/trace.go:171","msg":"trace[181800261] linearizableReadLoop","detail":"{readStateIndex:27724; appliedIndex:27723; }","duration":"217.33711ms","start":"2026-10-19T02:51:41.913247Z","end":"2026-10-19T02:51:42.130584Z","steps":["trace[181800261] 'read index received' (duration: 217.176536ms)","trace[181800261] 'applied index is now lower than readState.Index' (duration: 159.354µs)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:51:42.13078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.498375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-19T02:51:42.130746Z","caller":"traceutil/trace.go:171","msg":"trace[245649291] transaction","detail":"{read_only:false; response_revision:26831; number_of_response:1; }","duration":"341.439216ms","start":"2026-10-19T02:51:41.789258Z","end":"2026-10-19T02:51:42.130697Z","steps":["trace[245649291] 'process raft request' (duration: 341.146839ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:51:42.13084Z","caller":"traceutil/trace.go:171","msg":"trace[193120724] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26831; }","duration":"217.682329ms","start":"2026-10-19T02:51:41.913142Z","end":"2026-10-19T02:51:42.130825Z","steps":["trace[193120724] 'agreement among raft nodes before linearized reading' (duration: 217.537355ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:51:42.130933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.598257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-19T02:51:42.130978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:51:41.789223Z","time spent":"341.637741ms","remote":"127.0.0.1:57272","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T02:51:42.131003Z","caller":"traceutil/trace.go:171","msg":"trace[477159293] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters0; response_count:0; response_revision:26831; }","duration":"198.70563ms","start":"2026-10-19T02:51:41.932274Z","end":"2026-10-19T02:51:42.13098Z","steps":["trace[477159293] 'agreement among raft nodes before linearized reading' (duration: 198.594077ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:51:42.131039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.735868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-10-19T02:51:42.131109Z","caller":"traceutil/trace.go:171","msg":"trace[309129588] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:26831; }","duration":"167.84307ms","start":"2026-10-19T02:51:41.963244Z","end":"2026-10-19T02:51:42.131087Z","steps":["trace[309129588] 'agreement among raft nodes before linearized reading' (duration: 167.723937ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:51:42.404163Z","caller":"traceutil/trace.go:171","msg":"trace[196264870] transaction","detail":"{read_only:false; response_revision:26832; number_of_response:1; }","duration":"177.310243ms","start":"2026-10-19T02:51:42.226823Z","end":"2026-10-19T02:51:42.404133Z","steps":["trace[196264870] 'process raft request' (duration: 177.139619ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:51:42.799683Z","caller":"traceutil/trace.go:171","msg":"trace[830827671] linearizableReadLoop","detail":"{readStateIndex:27726; appliedIndex:27725; }","duration":"104.117443ms","start":"2026-10-19T02:51:42.695536Z","end":"2026-10-19T02:51:42.799653Z","steps":["trace[830827671] 'read index received' (duration: 103.961869ms)","trace[830827671] 'applied index is now lower than readState.Index' (duration: 153.874µs)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:51:42.79998Z","caller":"traceutil/trace.go:171","msg":"trace[169485090] transaction","detail":"{read_only:false; response_revision:26833; number_of_response:1; }","duration":"110.135115ms","start":"2026-10-19T02:51:42.689831Z","end":"2026-10-19T02:51:42.799966Z","steps":["trace[169485090] 'process raft request' (duration: 109.639743ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:51:42.800317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.777388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-10-19T02:51:42.800361Z","caller":"traceutil/trace.go:171","msg":"trace[2036832609] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26833; }","duration":"104.888441ms","start":"2026-10-19T02:51:42.695461Z","end":"2026-10-19T02:51:42.80035Z","steps":["trace[2036832609] 'agreement among raft nodes before linearized reading' (duration: 104.707277ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:51:42.881735Z","caller":"traceutil/trace.go:171","msg":"trace[183897450] transaction","detail":"{read_only:false; response_revision:26834; number_of_response:1; }","duration":"176.153467ms","start":"2026-10-19T02:51:42.705532Z","end":"2026-10-19T02:51:42.881685Z","steps":["trace[183897450] 'process raft request' (duration: 139.328496ms)","trace[183897450] 'compare' (duration: 36.416981ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:51:42.881862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.913754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/magnum-api-cd469f5b-2l97z\" ","response":"range_response_count:1 size:8638"} {"level":"info","ts":"2026-10-19T02:51:42.882049Z","caller":"traceutil/trace.go:171","msg":"trace[1559302328] range","detail":"{range_begin:/registry/pods/openstack/magnum-api-cd469f5b-2l97z; range_end:; response_count:1; response_revision:26834; }","duration":"174.121548ms","start":"2026-10-19T02:51:42.707881Z","end":"2026-10-19T02:51:42.882003Z","steps":["trace[1559302328] 'agreement among raft nodes before linearized reading' (duration: 173.712779ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:51:55.83778Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23589} {"level":"info","ts":"2026-10-19T02:51:55.968889Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23589,"took":"127.719491ms","hash":398225234,"current-db-size-bytes":53370880,"current-db-size":"53 MB","current-db-size-in-use-bytes":44625920,"current-db-size-in-use":"45 MB"} {"level":"info","ts":"2026-10-19T02:51:55.968979Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":398225234,"revision":23589,"compact-revision":21412} {"level":"warn","ts":"2026-10-19T02:52:47.136196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.868976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-19T02:52:47.136292Z","caller":"traceutil/trace.go:171","msg":"trace[621312193] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:27411; }","duration":"227.02757ms","start":"2026-10-19T02:52:46.909246Z","end":"2026-10-19T02:52:47.136273Z","steps":["trace[621312193] 'range keys from in-memory index tree' (duration: 226.763494ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:52:47.136663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.266215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/clusterclasses/\" range_end:\"/registry/cluster.x-k8s.io/clusterclasses0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-19T02:52:47.136767Z","caller":"traceutil/trace.go:171","msg":"trace[1845880176] range","detail":"{range_begin:/registry/cluster.x-k8s.io/clusterclasses/; range_end:/registry/cluster.x-k8s.io/clusterclasses0; response_count:0; response_revision:27411; }","duration":"205.384708ms","start":"2026-10-19T02:52:46.931342Z","end":"2026-10-19T02:52:47.136726Z","steps":["trace[1845880176] 'count revisions from in-memory index tree' (duration: 205.180544ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:52:47.531304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.002211ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-19T02:52:47.531586Z","caller":"traceutil/trace.go:171","msg":"trace[1950094183] transaction","detail":"{read_only:false; response_revision:27413; number_of_response:1; }","duration":"373.200028ms","start":"2026-10-19T02:52:47.158347Z","end":"2026-10-19T02:52:47.531547Z","steps":["trace[1950094183] 'process raft request' (duration: 161.834138ms)","trace[1950094183] 'compare' (duration: 210.882438ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:52:47.531641Z","caller":"traceutil/trace.go:171","msg":"trace[29186906] linearizableReadLoop","detail":"{readStateIndex:28322; appliedIndex:28321; }","duration":"372.518941ms","start":"2026-10-19T02:52:47.159103Z","end":"2026-10-19T02:52:47.531621Z","steps":["trace[29186906] 'read index received' (duration: 161.011988ms)","trace[29186906] 'applied index is now lower than readState.Index' (duration: 211.505513ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:52:47.531738Z","caller":"traceutil/trace.go:171","msg":"trace[395464053] transaction","detail":"{read_only:false; response_revision:27414; number_of_response:1; }","duration":"371.568759ms","start":"2026-10-19T02:52:47.160156Z","end":"2026-10-19T02:52:47.531725Z","steps":["trace[395464053] 'process raft request' (duration: 371.269812ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:52:47.531833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:52:47.158319Z","time spent":"373.371872ms","remote":"127.0.0.1:57272","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-19T02:52:47.531883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:52:47.160135Z","time spent":"371.670252ms","remote":"127.0.0.1:57272","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-19T02:52:47.532077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.940531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12429"} {"level":"info","ts":"2026-10-19T02:52:47.532197Z","caller":"traceutil/trace.go:171","msg":"trace[1023966011] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:27414; }","duration":"373.112215ms","start":"2026-10-19T02:52:47.159055Z","end":"2026-10-19T02:52:47.532167Z","steps":["trace[1023966011] 'agreement among raft nodes before linearized reading' (duration: 372.737856ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:52:47.532252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:52:47.159036Z","time spent":"373.206268ms","remote":"127.0.0.1:57196","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12452,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-10-19T02:52:47.58296Z","caller":"traceutil/trace.go:171","msg":"trace[428639441] transaction","detail":"{read_only:false; response_revision:27416; number_of_response:1; }","duration":"105.769082ms","start":"2026-10-19T02:52:47.477142Z","end":"2026-10-19T02:52:47.582911Z","steps":["trace[428639441] 'process raft request' (duration: 105.565927ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:52:47.583042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.7389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-10-19T02:52:47.583124Z","caller":"traceutil/trace.go:171","msg":"trace[2142787807] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:27416; }","duration":"135.848303ms","start":"2026-10-19T02:52:47.447255Z","end":"2026-10-19T02:52:47.583103Z","steps":["trace[2142787807] 'agreement among raft nodes before linearized reading' (duration: 135.600467ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:52:47.583038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.044659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-10-19T02:52:47.583184Z","caller":"traceutil/trace.go:171","msg":"trace[419130416] transaction","detail":"{read_only:false; response_revision:27415; number_of_response:1; }","duration":"239.832373ms","start":"2026-10-19T02:52:47.343341Z","end":"2026-10-19T02:52:47.583173Z","steps":["trace[419130416] 'process raft request' (duration: 239.162307ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:52:47.58322Z","caller":"traceutil/trace.go:171","msg":"trace[839288353] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:27416; }","duration":"295.284604ms","start":"2026-10-19T02:52:47.287918Z","end":"2026-10-19T02:52:47.583202Z","steps":["trace[839288353] 'agreement among raft nodes before linearized reading' (duration: 294.935416ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:52:47.583374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.34357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/glance-api\" ","response":"range_response_count:1 size:11793"} {"level":"info","ts":"2026-10-19T02:52:47.583439Z","caller":"traceutil/trace.go:171","msg":"trace[1283463575] range","detail":"{range_begin:/registry/deployments/openstack/glance-api; range_end:; response_count:1; response_revision:27416; }","duration":"422.435043ms","start":"2026-10-19T02:52:47.160987Z","end":"2026-10-19T02:52:47.583422Z","steps":["trace[1283463575] 'agreement among raft nodes before linearized reading' (duration: 422.106405ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:52:47.583545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:52:47.160973Z","time spent":"422.548205ms","remote":"127.0.0.1:57402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":11816,"request content":"key:\"/registry/deployments/openstack/glance-api\" "} {"level":"info","ts":"2026-10-19T02:55:38.659627Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"64a80de7883e6886","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-19T02:55:38.668918Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-10-19T02:55:38.669114Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-10-19T02:56:43.161914Z","caller":"traceutil/trace.go:171","msg":"trace[893457007] transaction","detail":"{read_only:false; response_revision:29696; number_of_response:1; }","duration":"100.072867ms","start":"2026-10-19T02:56:43.061785Z","end":"2026-10-19T02:56:43.161858Z","steps":["trace[893457007] 'process raft request' (duration: 94.149227ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:56:55.845531Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":26938} {"level":"info","ts":"2026-10-19T02:56:56.022248Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":26938,"took":"172.318276ms","hash":5763846,"current-db-size-bytes":55017472,"current-db-size":"55 MB","current-db-size-in-use-bytes":35528704,"current-db-size-in-use":"36 MB"} {"level":"info","ts":"2026-10-19T02:56:56.022338Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":5763846,"revision":26938,"compact-revision":23589} {"level":"info","ts":"2026-10-19T03:01:55.853066Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":29859} {"level":"info","ts":"2026-10-19T03:01:56.026826Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":29859,"took":"168.061555ms","hash":81917284,"current-db-size-bytes":55017472,"current-db-size":"55 MB","current-db-size-in-use-bytes":33099776,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-10-19T03:01:56.0269Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":81917284,"revision":29859,"compact-revision":26938} {"level":"info","ts":"2026-10-19T03:06:55.861684Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32240} {"level":"info","ts":"2026-10-19T03:06:56.043775Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32240,"took":"177.619307ms","hash":4287770864,"current-db-size-bytes":56061952,"current-db-size":"56 MB","current-db-size-in-use-bytes":31715328,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-19T03:06:56.043853Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4287770864,"revision":32240,"compact-revision":29859} {"level":"info","ts":"2026-10-19T03:11:55.87564Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":34500} {"level":"info","ts":"2026-10-19T03:11:56.011827Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":34500,"took":"131.793475ms","hash":2456745472,"current-db-size-bytes":56061952,"current-db-size":"56 MB","current-db-size-in-use-bytes":31973376,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-19T03:11:56.011892Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2456745472,"revision":34500,"compact-revision":32240} {"level":"info","ts":"2026-10-19T03:16:16.497469Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"64a80de7883e6886","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-19T03:16:16.506457Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-10-19T03:16:16.50667Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-10-19T03:16:55.883983Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":36729} {"level":"info","ts":"2026-10-19T03:16:56.065914Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":36729,"took":"173.308096ms","hash":2046352270,"current-db-size-bytes":56528896,"current-db-size":"56 MB","current-db-size-in-use-bytes":31150080,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-19T03:16:56.066006Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2046352270,"revision":36729,"compact-revision":34500} {"level":"info","ts":"2026-10-19T03:21:55.892507Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":39065} {"level":"info","ts":"2026-10-19T03:21:56.038577Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":39065,"took":"141.220421ms","hash":1485709416,"current-db-size-bytes":56528896,"current-db-size":"56 MB","current-db-size-in-use-bytes":31637504,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-19T03:21:56.038733Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1485709416,"revision":39065,"compact-revision":36729} {"level":"info","ts":"2026-10-19T03:26:55.906181Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":41300} {"level":"info","ts":"2026-10-19T03:26:56.040838Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":41300,"took":"131.088248ms","hash":3769068288,"current-db-size-bytes":58224640,"current-db-size":"58 MB","current-db-size-in-use-bytes":31285248,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-19T03:26:56.040893Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3769068288,"revision":41300,"compact-revision":39065}