{"level":"warn","ts":"2026-08-10T16:01:17.380296Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-10T16:01:17.380397Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.171:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.171:2380","--initial-cluster=instance=https://199.19.213.171:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.171:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.171: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-08-10T16:01:17.380479Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-10T16:01:17.380494Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.171:2380"]} {"level":"info","ts":"2026-08-10T16:01:17.380515Z","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-08-10T16:01:17.381239Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.171:2379"]} {"level":"info","ts":"2026-08-10T16:01:17.381323Z","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://199.19.213.171:2380"],"listen-peer-urls":["https://199.19.213.171:2380"],"advertise-client-urls":["https://199.19.213.171:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.171:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.171: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-08-10T16:01:17.384183Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.595602ms"} {"level":"info","ts":"2026-08-10T16:01:17.389981Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"837e89131cc6bd81","cluster-id":"8af92e75ab8f3e69"} {"level":"info","ts":"2026-08-10T16:01:17.390076Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"837e89131cc6bd81 switched to configuration voters=()"} {"level":"info","ts":"2026-08-10T16:01:17.390101Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"837e89131cc6bd81 became follower at term 0"} {"level":"info","ts":"2026-08-10T16:01:17.390123Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 837e89131cc6bd81 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-10T16:01:17.390147Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"837e89131cc6bd81 became follower at term 1"} {"level":"info","ts":"2026-08-10T16:01:17.390202Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"837e89131cc6bd81 switched to configuration voters=(9475161381214272897)"} {"level":"warn","ts":"2026-08-10T16:01:17.401111Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-10T16:01:17.403422Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-10T16:01:17.404912Z","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-08-10T16:01:17.407537Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"837e89131cc6bd81","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-10T16:01:17.407713Z","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-08-10T16:01:17.407819Z","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-08-10T16:01:17.407759Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"837e89131cc6bd81","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-10T16:01:17.407836Z","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-08-10T16:01:17.4123Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"837e89131cc6bd81 switched to configuration voters=(9475161381214272897)"} {"level":"info","ts":"2026-08-10T16:01:17.412437Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"8af92e75ab8f3e69","local-member-id":"837e89131cc6bd81","added-peer-id":"837e89131cc6bd81","added-peer-peer-urls":["https://199.19.213.171:2380"]} {"level":"info","ts":"2026-08-10T16:01:17.413536Z","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-08-10T16:01:17.413639Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.171:2380"} {"level":"info","ts":"2026-08-10T16:01:17.413692Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.171:2380"} {"level":"info","ts":"2026-08-10T16:01:17.414007Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"837e89131cc6bd81","initial-advertise-peer-urls":["https://199.19.213.171:2380"],"listen-peer-urls":["https://199.19.213.171:2380"],"advertise-client-urls":["https://199.19.213.171:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.171:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-10T16:01:17.414087Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-10T16:01:18.391125Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"837e89131cc6bd81 is starting a new election at term 1"} {"level":"info","ts":"2026-08-10T16:01:18.39126Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"837e89131cc6bd81 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-10T16:01:18.391306Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"837e89131cc6bd81 received MsgPreVoteResp from 837e89131cc6bd81 at term 1"} {"level":"info","ts":"2026-08-10T16:01:18.391333Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"837e89131cc6bd81 became candidate at term 2"} {"level":"info","ts":"2026-08-10T16:01:18.391345Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"837e89131cc6bd81 received MsgVoteResp from 837e89131cc6bd81 at term 2"} {"level":"info","ts":"2026-08-10T16:01:18.391364Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"837e89131cc6bd81 became leader at term 2"} {"level":"info","ts":"2026-08-10T16:01:18.391387Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 837e89131cc6bd81 elected leader 837e89131cc6bd81 at term 2"} {"level":"info","ts":"2026-08-10T16:01:18.392899Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-10T16:01:18.393831Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"837e89131cc6bd81","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.171:2379]}","request-path":"/0/members/837e89131cc6bd81/attributes","cluster-id":"8af92e75ab8f3e69","publish-timeout":"7s"} {"level":"info","ts":"2026-08-10T16:01:18.393833Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-10T16:01:18.393887Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-10T16:01:18.394284Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-10T16:01:18.394334Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-10T16:01:18.394489Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"8af92e75ab8f3e69","local-member-id":"837e89131cc6bd81","cluster-version":"3.5"} {"level":"info","ts":"2026-08-10T16:01:18.394643Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-10T16:01:18.394683Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-10T16:01:18.397276Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-10T16:01:18.398873Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.171:2379"} {"level":"info","ts":"2026-08-10T16:01:31.337007Z","caller":"traceutil/trace.go:171","msg":"trace[28545338] transaction","detail":"{read_only:false; response_revision:400; number_of_response:1; }","duration":"143.482182ms","start":"2026-08-10T16:01:31.193496Z","end":"2026-08-10T16:01:31.336978Z","steps":["trace[28545338] 'process raft request' (duration: 143.162534ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:01:55.969992Z","caller":"traceutil/trace.go:171","msg":"trace[1900749465] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"123.004721ms","start":"2026-08-10T16:01:55.846953Z","end":"2026-08-10T16:01:55.969958Z","steps":["trace[1900749465] 'process raft request' (duration: 122.743735ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:01:55.991843Z","caller":"traceutil/trace.go:171","msg":"trace[1047474665] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"141.506774ms","start":"2026-08-10T16:01:55.850294Z","end":"2026-08-10T16:01:55.991801Z","steps":["trace[1047474665] 'process raft request' (duration: 141.172296ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:01:55.991886Z","caller":"traceutil/trace.go:171","msg":"trace[1407664652] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"140.792888ms","start":"2026-08-10T16:01:55.851054Z","end":"2026-08-10T16:01:55.991847Z","steps":["trace[1407664652] 'process raft request' (duration: 140.602563ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:01:55.991938Z","caller":"traceutil/trace.go:171","msg":"trace[1436213482] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"131.925925ms","start":"2026-08-10T16:01:55.859954Z","end":"2026-08-10T16:01:55.99188Z","steps":["trace[1436213482] 'process raft request' (duration: 131.756341ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:01:55.992077Z","caller":"traceutil/trace.go:171","msg":"trace[2082740436] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"128.961604ms","start":"2026-08-10T16:01:55.863101Z","end":"2026-08-10T16:01:55.992062Z","steps":["trace[2082740436] 'process raft request' (duration: 128.655297ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:01:55.992218Z","caller":"traceutil/trace.go:171","msg":"trace[375951923] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"127.96247ms","start":"2026-08-10T16:01:55.864188Z","end":"2026-08-10T16:01:55.992151Z","steps":["trace[375951923] 'process raft request' (duration: 127.625712ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:01:55.992277Z","caller":"traceutil/trace.go:171","msg":"trace[1392441208] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"126.325101ms","start":"2026-08-10T16:01:55.865939Z","end":"2026-08-10T16:01:55.992264Z","steps":["trace[1392441208] 'process raft request' (duration: 125.924061ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:01:55.992543Z","caller":"traceutil/trace.go:171","msg":"trace[318917835] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"126.577727ms","start":"2026-08-10T16:01:55.865942Z","end":"2026-08-10T16:01:55.992519Z","steps":["trace[318917835] 'process raft request' (duration: 126.249859ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:01:55.99261Z","caller":"traceutil/trace.go:171","msg":"trace[148482080] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"103.917773ms","start":"2026-08-10T16:01:55.888682Z","end":"2026-08-10T16:01:55.992599Z","steps":["trace[148482080] 'process raft request' (duration: 103.606635ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:01:56.102453Z","caller":"traceutil/trace.go:171","msg":"trace[1242131431] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"103.551954ms","start":"2026-08-10T16:01:55.998871Z","end":"2026-08-10T16:01:56.102423Z","steps":["trace[1242131431] 'process raft request' (duration: 101.524935ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:02:02.656232Z","caller":"traceutil/trace.go:171","msg":"trace[402638424] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"311.80283ms","start":"2026-08-10T16:02:02.344398Z","end":"2026-08-10T16:02:02.656201Z","steps":["trace[402638424] 'process raft request' (duration: 311.589535ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T16:02:02.656862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T16:02:02.344377Z","time spent":"311.959095ms","remote":"127.0.0.1:42084","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-10T16:02:02.66002Z","caller":"traceutil/trace.go:171","msg":"trace[1038931305] linearizableReadLoop","detail":"{readStateIndex:652; appliedIndex:650; }","duration":"260.955801ms","start":"2026-08-10T16:02:02.399025Z","end":"2026-08-10T16:02:02.659981Z","steps":["trace[1038931305] 'read index received' (duration: 257.034617ms)","trace[1038931305] 'applied index is now lower than readState.Index' (duration: 3.919374ms)"],"step_count":2} {"level":"info","ts":"2026-08-10T16:02:02.660212Z","caller":"traceutil/trace.go:171","msg":"trace[1305608887] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"262.012056ms","start":"2026-08-10T16:02:02.398145Z","end":"2026-08-10T16:02:02.660157Z","steps":["trace[1305608887] 'process raft request' (duration: 261.703919ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T16:02:02.660261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.215857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-08-10T16:02:02.66045Z","caller":"traceutil/trace.go:171","msg":"trace[74641909] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:628; }","duration":"261.455324ms","start":"2026-08-10T16:02:02.398984Z","end":"2026-08-10T16:02:02.660439Z","steps":["trace[74641909] 'agreement among raft nodes before linearized reading' (duration: 261.107284ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T16:02:03.145024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.062641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-08-10T16:02:03.145111Z","caller":"traceutil/trace.go:171","msg":"trace[1057675163] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:629; }","duration":"123.205656ms","start":"2026-08-10T16:02:03.021879Z","end":"2026-08-10T16:02:03.145084Z","steps":["trace[1057675163] 'range keys from in-memory index tree' (duration: 122.873757ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:03:40.725093Z","caller":"traceutil/trace.go:171","msg":"trace[386319543] linearizableReadLoop","detail":"{readStateIndex:1965; appliedIndex:1964; }","duration":"173.159377ms","start":"2026-08-10T16:03:40.551906Z","end":"2026-08-10T16:03:40.725065Z","steps":["trace[386319543] 'read index received' (duration: 172.86009ms)","trace[386319543] 'applied index is now lower than readState.Index' (duration: 298.157µs)"],"step_count":2} {"level":"info","ts":"2026-08-10T16:03:40.72516Z","caller":"traceutil/trace.go:171","msg":"trace[84639066] transaction","detail":"{read_only:false; response_revision:1892; number_of_response:1; }","duration":"195.077875ms","start":"2026-08-10T16:03:40.530048Z","end":"2026-08-10T16:03:40.725126Z","steps":["trace[84639066] 'process raft request' (duration: 194.808228ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T16:03:40.725302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.371812ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-10T16:03:40.725377Z","caller":"traceutil/trace.go:171","msg":"trace[1649482350] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1892; }","duration":"173.475445ms","start":"2026-08-10T16:03:40.55186Z","end":"2026-08-10T16:03:40.725336Z","steps":["trace[1649482350] 'agreement among raft nodes before linearized reading' (duration: 173.379432ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:03:53.64382Z","caller":"traceutil/trace.go:171","msg":"trace[1581538707] linearizableReadLoop","detail":"{readStateIndex:2083; appliedIndex:2082; }","duration":"105.029183ms","start":"2026-08-10T16:03:53.538748Z","end":"2026-08-10T16:03:53.643778Z","steps":["trace[1581538707] 'read index received' (duration: 104.678415ms)","trace[1581538707] 'applied index is now lower than readState.Index' (duration: 348.968µs)"],"step_count":2} {"level":"warn","ts":"2026-08-10T16:03:53.643983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.205057ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-10T16:03:53.644021Z","caller":"traceutil/trace.go:171","msg":"trace[850551853] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:2006; }","duration":"105.30724ms","start":"2026-08-10T16:03:53.538701Z","end":"2026-08-10T16:03:53.644008Z","steps":["trace[850551853] 'agreement among raft nodes before linearized reading' (duration: 105.190857ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:03:53.644097Z","caller":"traceutil/trace.go:171","msg":"trace[1869399544] transaction","detail":"{read_only:false; response_revision:2006; number_of_response:1; }","duration":"127.4231ms","start":"2026-08-10T16:03:53.516642Z","end":"2026-08-10T16:03:53.644065Z","steps":["trace[1869399544] 'process raft request' (duration: 126.811596ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:03:53.668523Z","caller":"traceutil/trace.go:171","msg":"trace[1328725433] transaction","detail":"{read_only:false; response_revision:2007; number_of_response:1; }","duration":"125.686779ms","start":"2026-08-10T16:03:53.54281Z","end":"2026-08-10T16:03:53.668497Z","steps":["trace[1328725433] 'process raft request' (duration: 125.491674ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T16:04:24.063657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.605911ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-10T16:04:24.063953Z","caller":"traceutil/trace.go:171","msg":"trace[1717432983] transaction","detail":"{read_only:false; response_revision:2188; number_of_response:1; }","duration":"299.700106ms","start":"2026-08-10T16:04:23.764219Z","end":"2026-08-10T16:04:24.063919Z","steps":["trace[1717432983] 'process raft request' (duration: 163.518021ms)","trace[1717432983] 'compare' (duration: 135.150071ms)"],"step_count":2} {"level":"info","ts":"2026-08-10T16:04:24.063996Z","caller":"traceutil/trace.go:171","msg":"trace[464963285] linearizableReadLoop","detail":"{readStateIndex:2271; appliedIndex:2270; }","duration":"183.049631ms","start":"2026-08-10T16:04:23.880909Z","end":"2026-08-10T16:04:24.063958Z","steps":["trace[464963285] 'read index received' (duration: 46.842435ms)","trace[464963285] 'applied index is now lower than readState.Index' (duration: 136.203496ms)"],"step_count":2} {"level":"warn","ts":"2026-08-10T16:04:24.064522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.581584ms","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-08-10T16:04:24.064716Z","caller":"traceutil/trace.go:171","msg":"trace[1704351189] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2189; }","duration":"183.798619ms","start":"2026-08-10T16:04:23.880841Z","end":"2026-08-10T16:04:24.06464Z","steps":["trace[1704351189] 'agreement among raft nodes before linearized reading' (duration: 183.328108ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:04:30.329548Z","caller":"traceutil/trace.go:171","msg":"trace[1320088259] linearizableReadLoop","detail":"{readStateIndex:2306; appliedIndex:2305; }","duration":"223.532335ms","start":"2026-08-10T16:04:30.105942Z","end":"2026-08-10T16:04:30.329474Z","steps":["trace[1320088259] 'read index received' (duration: 223.232717ms)","trace[1320088259] 'applied index is now lower than readState.Index' (duration: 298.078µs)"],"step_count":2} {"level":"info","ts":"2026-08-10T16:04:30.329664Z","caller":"traceutil/trace.go:171","msg":"trace[1552113401] transaction","detail":"{read_only:false; response_revision:2221; number_of_response:1; }","duration":"244.323326ms","start":"2026-08-10T16:04:30.085281Z","end":"2026-08-10T16:04:30.329605Z","steps":["trace[1552113401] 'process raft request' (duration: 243.977306ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T16:04:30.329901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.046984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-08-10T16:04:30.329967Z","caller":"traceutil/trace.go:171","msg":"trace[1042918619] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2221; }","duration":"216.383384ms","start":"2026-08-10T16:04:30.113572Z","end":"2026-08-10T16:04:30.329955Z","steps":["trace[1042918619] 'agreement among raft nodes before linearized reading' (duration: 216.145058ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T16:04:30.32999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.003296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-08-10T16:04:30.33013Z","caller":"traceutil/trace.go:171","msg":"trace[1969408527] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2221; }","duration":"224.208351ms","start":"2026-08-10T16:04:30.105883Z","end":"2026-08-10T16:04:30.330091Z","steps":["trace[1969408527] 'agreement among raft nodes before linearized reading' (duration: 223.814532ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:04:36.474156Z","caller":"traceutil/trace.go:171","msg":"trace[1547083130] transaction","detail":"{read_only:false; response_revision:2250; number_of_response:1; }","duration":"677.413549ms","start":"2026-08-10T16:04:35.796711Z","end":"2026-08-10T16:04:36.474125Z","steps":["trace[1547083130] 'process raft request' (duration: 677.220534ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T16:04:36.474357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T16:04:35.796668Z","time spent":"677.588413ms","remote":"127.0.0.1:42182","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-10T16:04:36.720522Z","caller":"traceutil/trace.go:171","msg":"trace[1323578454] linearizableReadLoop","detail":"{readStateIndex:2337; appliedIndex:2335; }","duration":"475.842342ms","start":"2026-08-10T16:04:36.244654Z","end":"2026-08-10T16:04:36.720496Z","steps":["trace[1323578454] 'read index received' (duration: 229.380266ms)","trace[1323578454] 'applied index is now lower than readState.Index' (duration: 246.461266ms)"],"step_count":2} {"level":"info","ts":"2026-08-10T16:04:36.720565Z","caller":"traceutil/trace.go:171","msg":"trace[1044023942] transaction","detail":"{read_only:false; response_revision:2251; number_of_response:1; }","duration":"915.083104ms","start":"2026-08-10T16:04:35.805441Z","end":"2026-08-10T16:04:36.720524Z","steps":["trace[1044023942] 'process raft request' (duration: 886.767913ms)","trace[1044023942] 'compare' (duration: 27.87486ms)"],"step_count":2} {"level":"info","ts":"2026-08-10T16:04:36.720665Z","caller":"traceutil/trace.go:171","msg":"trace[818979008] transaction","detail":"{read_only:false; response_revision:2252; number_of_response:1; }","duration":"369.69184ms","start":"2026-08-10T16:04:36.350923Z","end":"2026-08-10T16:04:36.720615Z","steps":["trace[818979008] 'process raft request' (duration: 369.448364ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T16:04:36.72084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T16:04:35.805412Z","time spent":"915.33658ms","remote":"127.0.0.1:42182","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-10T16:04:36.720897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T16:04:36.350884Z","time spent":"369.894385ms","remote":"127.0.0.1:42182","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-10T16:04:36.759711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"515.009393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-10T16:04:36.759821Z","caller":"traceutil/trace.go:171","msg":"trace[1906814578] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:2252; }","duration":"515.203868ms","start":"2026-08-10T16:04:36.244591Z","end":"2026-08-10T16:04:36.759795Z","steps":["trace[1906814578] 'agreement among raft nodes before linearized reading' (duration: 476.048336ms)","trace[1906814578] 'count revisions from in-memory index tree' (duration: 38.979207ms)"],"step_count":2} {"level":"warn","ts":"2026-08-10T16:04:36.759826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.389774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-10T16:04:36.759883Z","caller":"traceutil/trace.go:171","msg":"trace[296501798] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:2252; }","duration":"184.476965ms","start":"2026-08-10T16:04:36.575392Z","end":"2026-08-10T16:04:36.759869Z","steps":["trace[296501798] 'agreement among raft nodes before linearized reading' (duration: 184.352033ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T16:04:36.759876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T16:04:36.244566Z","time spent":"515.29742ms","remote":"127.0.0.1:52552","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":31,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-08-10T16:04:36.760038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.259987ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-10T16:04:36.760109Z","caller":"traceutil/trace.go:171","msg":"trace[354017223] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2252; }","duration":"208.403071ms","start":"2026-08-10T16:04:36.551693Z","end":"2026-08-10T16:04:36.760096Z","steps":["trace[354017223] 'agreement among raft nodes before linearized reading' (duration: 208.268438ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T16:04:36.760114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.859064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-08-10T16:04:36.759854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.04677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-10T16:04:36.760202Z","caller":"traceutil/trace.go:171","msg":"trace[1724555337] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:2252; }","duration":"415.49991ms","start":"2026-08-10T16:04:36.344692Z","end":"2026-08-10T16:04:36.760192Z","steps":["trace[1724555337] 'agreement among raft nodes before linearized reading' (duration: 415.041149ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:04:36.760192Z","caller":"traceutil/trace.go:171","msg":"trace[1247876186] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2252; }","duration":"389.966037ms","start":"2026-08-10T16:04:36.370204Z","end":"2026-08-10T16:04:36.76017Z","steps":["trace[1247876186] 'agreement among raft nodes before linearized reading' (duration: 389.737061ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T16:04:36.760234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T16:04:36.344664Z","time spent":"415.558762ms","remote":"127.0.0.1:42338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":31,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-08-10T16:04:36.760262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T16:04:36.37019Z","time spent":"390.051358ms","remote":"127.0.0.1:42182","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-10T16:04:36.760584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.78165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-08-10T16:04:36.760652Z","caller":"traceutil/trace.go:171","msg":"trace[93247507] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2252; }","duration":"386.908103ms","start":"2026-08-10T16:04:36.373727Z","end":"2026-08-10T16:04:36.760635Z","steps":["trace[93247507] 'agreement among raft nodes before linearized reading' (duration: 386.136414ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T16:04:36.760702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T16:04:36.373708Z","time spent":"386.985355ms","remote":"127.0.0.1:52600","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5436,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-08-10T16:05:18.904532Z","caller":"traceutil/trace.go:171","msg":"trace[1383458299] transaction","detail":"{read_only:false; response_revision:2653; number_of_response:1; }","duration":"285.867694ms","start":"2026-08-10T16:05:18.618633Z","end":"2026-08-10T16:05:18.904501Z","steps":["trace[1383458299] 'process raft request' (duration: 285.69781ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:05:18.921296Z","caller":"traceutil/trace.go:171","msg":"trace[1368096365] transaction","detail":"{read_only:false; response_revision:2654; number_of_response:1; }","duration":"182.15385ms","start":"2026-08-10T16:05:18.739098Z","end":"2026-08-10T16:05:18.921252Z","steps":["trace[1368096365] 'process raft request' (duration: 181.891513ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:05:53.233676Z","caller":"traceutil/trace.go:171","msg":"trace[323769319] linearizableReadLoop","detail":"{readStateIndex:2970; appliedIndex:2968; }","duration":"100.173025ms","start":"2026-08-10T16:05:53.133474Z","end":"2026-08-10T16:05:53.233647Z","steps":["trace[323769319] 'read index received' (duration: 99.889948ms)","trace[323769319] 'applied index is now lower than readState.Index' (duration: 282.217µs)"],"step_count":2} {"level":"info","ts":"2026-08-10T16:05:53.23374Z","caller":"traceutil/trace.go:171","msg":"trace[853445587] transaction","detail":"{read_only:false; response_revision:2860; number_of_response:1; }","duration":"199.382257ms","start":"2026-08-10T16:05:53.034311Z","end":"2026-08-10T16:05:53.233693Z","steps":["trace[853445587] 'process raft request' (duration: 199.056369ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T16:05:53.234085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.578894ms","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-08-10T16:05:53.234123Z","caller":"traceutil/trace.go:171","msg":"trace[591136875] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2861; }","duration":"100.689497ms","start":"2026-08-10T16:05:53.133424Z","end":"2026-08-10T16:05:53.234113Z","steps":["trace[591136875] 'agreement among raft nodes before linearized reading' (duration: 100.342558ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:05:53.234393Z","caller":"traceutil/trace.go:171","msg":"trace[1371629148] transaction","detail":"{read_only:false; response_revision:2861; number_of_response:1; }","duration":"171.282679ms","start":"2026-08-10T16:05:53.063089Z","end":"2026-08-10T16:05:53.234372Z","steps":["trace[1371629148] 'process raft request' (duration: 170.522081ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:08:28.234065Z","caller":"traceutil/trace.go:171","msg":"trace[825590946] transaction","detail":"{read_only:false; response_revision:3880; number_of_response:1; }","duration":"138.299411ms","start":"2026-08-10T16:08:28.095737Z","end":"2026-08-10T16:08:28.234036Z","steps":["trace[825590946] 'process raft request' (duration: 138.139967ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:09:53.194644Z","caller":"traceutil/trace.go:171","msg":"trace[706132143] transaction","detail":"{read_only:false; response_revision:4921; number_of_response:1; }","duration":"170.793933ms","start":"2026-08-10T16:09:53.023814Z","end":"2026-08-10T16:09:53.194608Z","steps":["trace[706132143] 'process raft request' (duration: 95.454872ms)","trace[706132143] 'compare' (duration: 74.874471ms)"],"step_count":2} {"level":"info","ts":"2026-08-10T16:09:53.194747Z","caller":"traceutil/trace.go:171","msg":"trace[1603254776] transaction","detail":"{read_only:false; response_revision:4922; number_of_response:1; }","duration":"125.848599ms","start":"2026-08-10T16:09:53.068871Z","end":"2026-08-10T16:09:53.194719Z","steps":["trace[1603254776] 'process raft request' (duration: 125.520611ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:09:53.38705Z","caller":"traceutil/trace.go:171","msg":"trace[454433261] linearizableReadLoop","detail":"{readStateIndex:5114; appliedIndex:5113; }","duration":"122.668454ms","start":"2026-08-10T16:09:53.264341Z","end":"2026-08-10T16:09:53.387009Z","steps":["trace[454433261] 'read index received' (duration: 57.371251ms)","trace[454433261] 'applied index is now lower than readState.Index' (duration: 65.295902ms)"],"step_count":2} {"level":"info","ts":"2026-08-10T16:09:53.387084Z","caller":"traceutil/trace.go:171","msg":"trace[407275382] transaction","detail":"{read_only:false; response_revision:4926; number_of_response:1; }","duration":"123.287748ms","start":"2026-08-10T16:09:53.263734Z","end":"2026-08-10T16:09:53.387022Z","steps":["trace[407275382] 'process raft request' (duration: 58.096888ms)","trace[407275382] 'compare' (duration: 64.912652ms)"],"step_count":2} {"level":"warn","ts":"2026-08-10T16:09:53.387447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.078023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0\" ","response":"range_response_count:1 size:650"} {"level":"info","ts":"2026-08-10T16:09:53.387525Z","caller":"traceutil/trace.go:171","msg":"trace[1743217753] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0; range_end:; response_count:1; response_revision:4926; }","duration":"123.168206ms","start":"2026-08-10T16:09:53.264315Z","end":"2026-08-10T16:09:53.387483Z","steps":["trace[1743217753] 'agreement among raft nodes before linearized reading' (duration: 122.840978ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:09:58.421716Z","caller":"traceutil/trace.go:171","msg":"trace[378575969] linearizableReadLoop","detail":"{readStateIndex:5274; appliedIndex:5272; }","duration":"168.077379ms","start":"2026-08-10T16:09:58.253613Z","end":"2026-08-10T16:09:58.42169Z","steps":["trace[378575969] 'read index received' (duration: 32.948999ms)","trace[378575969] 'applied index is now lower than readState.Index' (duration: 135.12731ms)"],"step_count":2} {"level":"info","ts":"2026-08-10T16:09:58.421774Z","caller":"traceutil/trace.go:171","msg":"trace[549041233] transaction","detail":"{read_only:false; response_revision:5078; number_of_response:1; }","duration":"181.193993ms","start":"2026-08-10T16:09:58.240552Z","end":"2026-08-10T16:09:58.421746Z","steps":["trace[549041233] 'process raft request' (duration: 180.922606ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:09:58.421846Z","caller":"traceutil/trace.go:171","msg":"trace[1672267991] transaction","detail":"{read_only:false; response_revision:5079; number_of_response:1; }","duration":"180.103637ms","start":"2026-08-10T16:09:58.241715Z","end":"2026-08-10T16:09:58.421819Z","steps":["trace[1672267991] 'process raft request' (duration: 179.934013ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T16:09:58.421969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.322625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-10T16:09:58.422483Z","caller":"traceutil/trace.go:171","msg":"trace[779620265] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:5079; }","duration":"168.889978ms","start":"2026-08-10T16:09:58.253575Z","end":"2026-08-10T16:09:58.422465Z","steps":["trace[779620265] 'agreement among raft nodes before linearized reading' (duration: 168.267423ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T16:09:58.422057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.149248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/monitoring\" ","response":"range_response_count:1 size:372"} {"level":"info","ts":"2026-08-10T16:09:58.422582Z","caller":"traceutil/trace.go:171","msg":"trace[643999835] range","detail":"{range_begin:/registry/namespaces/monitoring; range_end:; response_count:1; response_revision:5079; }","duration":"134.695891ms","start":"2026-08-10T16:09:58.287859Z","end":"2026-08-10T16:09:58.422554Z","steps":["trace[643999835] 'agreement among raft nodes before linearized reading' (duration: 134.050986ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:09:58.836494Z","caller":"traceutil/trace.go:171","msg":"trace[1919589972] linearizableReadLoop","detail":"{readStateIndex:5286; appliedIndex:5285; }","duration":"132.426066ms","start":"2026-08-10T16:09:58.704035Z","end":"2026-08-10T16:09:58.836461Z","steps":["trace[1919589972] 'read index received' (duration: 126.765351ms)","trace[1919589972] 'applied index is now lower than readState.Index' (duration: 5.659525ms)"],"step_count":2} {"level":"info","ts":"2026-08-10T16:09:58.836619Z","caller":"traceutil/trace.go:171","msg":"trace[2141989486] transaction","detail":"{read_only:false; response_revision:5091; number_of_response:1; }","duration":"198.673071ms","start":"2026-08-10T16:09:58.637909Z","end":"2026-08-10T16:09:58.836582Z","steps":["trace[2141989486] 'process raft request' (duration: 192.907473ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T16:09:58.836727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.664341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-08-10T16:09:58.836772Z","caller":"traceutil/trace.go:171","msg":"trace[258182686] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5091; }","duration":"132.782565ms","start":"2026-08-10T16:09:58.703978Z","end":"2026-08-10T16:09:58.836761Z","steps":["trace[258182686] 'agreement among raft nodes before linearized reading' (duration: 132.603801ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:09:58.861853Z","caller":"traceutil/trace.go:171","msg":"trace[600468053] transaction","detail":"{read_only:false; response_revision:5092; number_of_response:1; }","duration":"145.452298ms","start":"2026-08-10T16:09:58.716363Z","end":"2026-08-10T16:09:58.861816Z","steps":["trace[600468053] 'process raft request' (duration: 145.259364ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:10:09.180437Z","caller":"traceutil/trace.go:171","msg":"trace[222520128] transaction","detail":"{read_only:false; response_revision:5292; number_of_response:1; }","duration":"123.571245ms","start":"2026-08-10T16:10:09.056828Z","end":"2026-08-10T16:10:09.1804Z","steps":["trace[222520128] 'process raft request' (duration: 123.074333ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:10:12.741754Z","caller":"traceutil/trace.go:171","msg":"trace[800956989] transaction","detail":"{read_only:false; response_revision:5362; number_of_response:1; }","duration":"256.108014ms","start":"2026-08-10T16:10:12.48562Z","end":"2026-08-10T16:10:12.741728Z","steps":["trace[800956989] 'process raft request' (duration: 255.931869ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:10:12.752038Z","caller":"traceutil/trace.go:171","msg":"trace[533080222] transaction","detail":"{read_only:false; response_revision:5364; number_of_response:1; }","duration":"209.027497ms","start":"2026-08-10T16:10:12.542989Z","end":"2026-08-10T16:10:12.752016Z","steps":["trace[533080222] 'process raft request' (duration: 208.990166ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:10:12.752216Z","caller":"traceutil/trace.go:171","msg":"trace[1825776477] transaction","detail":"{read_only:false; response_revision:5363; number_of_response:1; }","duration":"258.47237ms","start":"2026-08-10T16:10:12.493713Z","end":"2026-08-10T16:10:12.752185Z","steps":["trace[1825776477] 'process raft request' (duration: 258.160923ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:11:18.421352Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3003} {"level":"info","ts":"2026-08-10T16:11:18.508058Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3003,"took":"84.534781ms","hash":3180821698,"current-db-size-bytes":58105856,"current-db-size":"58 MB","current-db-size-in-use-bytes":31825920,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-08-10T16:11:18.508239Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3180821698,"revision":3003,"compact-revision":-1} {"level":"info","ts":"2026-08-10T16:16:18.428602Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6075} {"level":"info","ts":"2026-08-10T16:16:18.524715Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6075,"took":"94.095422ms","hash":1109125238,"current-db-size-bytes":58105856,"current-db-size":"58 MB","current-db-size-in-use-bytes":21917696,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-08-10T16:16:18.524819Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1109125238,"revision":6075,"compact-revision":3003} {"level":"info","ts":"2026-08-10T16:16:39.191733Z","caller":"traceutil/trace.go:171","msg":"trace[274021276] linearizableReadLoop","detail":"{readStateIndex:8704; appliedIndex:8703; }","duration":"121.223435ms","start":"2026-08-10T16:16:39.070453Z","end":"2026-08-10T16:16:39.191676Z","steps":["trace[274021276] 'read index received' (duration: 119.916773ms)","trace[274021276] 'applied index is now lower than readState.Index' (duration: 1.305212ms)"],"step_count":2} {"level":"warn","ts":"2026-08-10T16:16:39.191949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.477672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/vhosts/\" range_end:\"/registry/rabbitmq.com/vhosts0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-10T16:16:39.19191Z","caller":"traceutil/trace.go:171","msg":"trace[2033967425] transaction","detail":"{read_only:false; response_revision:8405; number_of_response:1; }","duration":"124.147745ms","start":"2026-08-10T16:16:39.067711Z","end":"2026-08-10T16:16:39.191859Z","steps":["trace[2033967425] 'process raft request' (duration: 122.640589ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:16:39.192019Z","caller":"traceutil/trace.go:171","msg":"trace[1321227758] range","detail":"{range_begin:/registry/rabbitmq.com/vhosts/; range_end:/registry/rabbitmq.com/vhosts0; response_count:0; response_revision:8405; }","duration":"121.613145ms","start":"2026-08-10T16:16:39.070386Z","end":"2026-08-10T16:16:39.191999Z","steps":["trace[1321227758] 'agreement among raft nodes before linearized reading' (duration: 121.489382ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:16:50.576566Z","caller":"traceutil/trace.go:171","msg":"trace[842997620] transaction","detail":"{read_only:false; response_revision:8464; number_of_response:1; }","duration":"180.254176ms","start":"2026-08-10T16:16:50.396288Z","end":"2026-08-10T16:16:50.576542Z","steps":["trace[842997620] 'process raft request' (duration: 180.097262ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T16:16:50.78754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.212558ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-10T16:16:50.787731Z","caller":"traceutil/trace.go:171","msg":"trace[1450758851] transaction","detail":"{read_only:false; response_revision:8466; number_of_response:1; }","duration":"354.358441ms","start":"2026-08-10T16:16:50.433357Z","end":"2026-08-10T16:16:50.787716Z","steps":["trace[1450758851] 'process raft request' (duration: 354.29932ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T16:16:50.787788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T16:16:50.433345Z","time spent":"354.415793ms","remote":"127.0.0.1:42182","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-10T16:16:50.787909Z","caller":"traceutil/trace.go:171","msg":"trace[939958374] transaction","detail":"{read_only:false; response_revision:8465; number_of_response:1; }","duration":"360.374926ms","start":"2026-08-10T16:16:50.427525Z","end":"2026-08-10T16:16:50.7879Z","steps":["trace[939958374] 'process raft request' (duration: 225.731219ms)","trace[939958374] 'compare' (duration: 134.074014ms)"],"step_count":2} {"level":"warn","ts":"2026-08-10T16:16:50.787954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T16:16:50.427499Z","time spent":"360.431257ms","remote":"127.0.0.1:42182","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-10T16:16:51.644192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.007831ms","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-08-10T16:16:51.644275Z","caller":"traceutil/trace.go:171","msg":"trace[1938842214] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8469; }","duration":"257.133393ms","start":"2026-08-10T16:16:51.387125Z","end":"2026-08-10T16:16:51.644258Z","steps":["trace[1938842214] 'range keys from in-memory index tree' (duration: 256.832576ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:17:16.135457Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000022f6.wal"} {"level":"info","ts":"2026-08-10T16:17:20.811777Z","caller":"traceutil/trace.go:171","msg":"trace[1562734733] transaction","detail":"{read_only:false; response_revision:8681; number_of_response:1; }","duration":"120.753645ms","start":"2026-08-10T16:17:20.690991Z","end":"2026-08-10T16:17:20.811745Z","steps":["trace[1562734733] 'process raft request' (duration: 120.481887ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T16:17:33.528209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.837849ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:4702"} {"level":"info","ts":"2026-08-10T16:17:33.528308Z","caller":"traceutil/trace.go:171","msg":"trace[24678261] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8788; }","duration":"360.042828ms","start":"2026-08-10T16:17:33.168252Z","end":"2026-08-10T16:17:33.528295Z","steps":["trace[24678261] 'process raft request' (duration: 253.043565ms)","trace[24678261] 'compare' (duration: 106.793238ms)"],"step_count":2} {"level":"warn","ts":"2026-08-10T16:17:33.528346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T16:17:33.168237Z","time spent":"360.091489ms","remote":"127.0.0.1:42084","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":59,"response count":0,"response size":4726,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-10T16:17:33.536274Z","caller":"traceutil/trace.go:171","msg":"trace[1671151111] linearizableReadLoop","detail":"{readStateIndex:9105; appliedIndex:9103; }","duration":"145.889398ms","start":"2026-08-10T16:17:33.390374Z","end":"2026-08-10T16:17:33.536264Z","steps":["trace[1671151111] 'read index received' (duration: 30.910073ms)","trace[1671151111] 'applied index is now lower than readState.Index' (duration: 114.978735ms)"],"step_count":2} {"level":"info","ts":"2026-08-10T16:17:33.536362Z","caller":"traceutil/trace.go:171","msg":"trace[153946434] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8789; }","duration":"298.56317ms","start":"2026-08-10T16:17:33.237775Z","end":"2026-08-10T16:17:33.536338Z","steps":["trace[153946434] 'process raft request' (duration: 298.397966ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T16:17:33.536416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.040961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-08-10T16:17:33.536435Z","caller":"traceutil/trace.go:171","msg":"trace[1423048475] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8789; }","duration":"146.092413ms","start":"2026-08-10T16:17:33.390336Z","end":"2026-08-10T16:17:33.536429Z","steps":["trace[1423048475] 'agreement among raft nodes before linearized reading' (duration: 145.995931ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:17:33.703452Z","caller":"traceutil/trace.go:171","msg":"trace[922817464] transaction","detail":"{read_only:false; response_revision:8790; number_of_response:1; }","duration":"161.35035ms","start":"2026-08-10T16:17:33.54207Z","end":"2026-08-10T16:17:33.70342Z","steps":["trace[922817464] 'process raft request' (duration: 135.960449ms)","trace[922817464] 'compare' (duration: 25.252677ms)"],"step_count":2} {"level":"info","ts":"2026-08-10T16:17:33.734328Z","caller":"traceutil/trace.go:171","msg":"trace[525123987] linearizableReadLoop","detail":"{readStateIndex:9108; appliedIndex:9105; }","duration":"189.570478ms","start":"2026-08-10T16:17:33.544728Z","end":"2026-08-10T16:17:33.734299Z","steps":["trace[525123987] 'read index received' (duration: 133.330636ms)","trace[525123987] 'applied index is now lower than readState.Index' (duration: 56.238602ms)"],"step_count":2} {"level":"warn","ts":"2026-08-10T16:17:33.734569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.811065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-dnj7l\" ","response":"range_response_count:1 size:4691"} {"level":"info","ts":"2026-08-10T16:17:33.734633Z","caller":"traceutil/trace.go:171","msg":"trace[1933761053] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-dnj7l; range_end:; response_count:1; response_revision:8792; }","duration":"189.904377ms","start":"2026-08-10T16:17:33.544712Z","end":"2026-08-10T16:17:33.734616Z","steps":["trace[1933761053] 'agreement among raft nodes before linearized reading' (duration: 189.704952ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:17:33.734661Z","caller":"traceutil/trace.go:171","msg":"trace[340373909] transaction","detail":"{read_only:false; response_revision:8791; number_of_response:1; }","duration":"190.817219ms","start":"2026-08-10T16:17:33.543822Z","end":"2026-08-10T16:17:33.73464Z","steps":["trace[340373909] 'process raft request' (duration: 190.219664ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:17:33.734927Z","caller":"traceutil/trace.go:171","msg":"trace[1941178723] transaction","detail":"{read_only:false; response_revision:8792; number_of_response:1; }","duration":"190.755927ms","start":"2026-08-10T16:17:33.544154Z","end":"2026-08-10T16:17:33.73491Z","steps":["trace[1941178723] 'process raft request' (duration: 190.08123ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:17:34.80036Z","caller":"traceutil/trace.go:171","msg":"trace[1894652516] transaction","detail":"{read_only:false; response_revision:8802; number_of_response:1; }","duration":"113.226443ms","start":"2026-08-10T16:17:34.687113Z","end":"2026-08-10T16:17:34.800339Z","steps":["trace[1894652516] 'process raft request' (duration: 113.085129ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:19:03.380062Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"837e89131cc6bd81","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-08-10T16:19:03.387795Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-08-10T16:19:03.387973Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-08-10T16:21:18.435492Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8128} {"level":"info","ts":"2026-08-10T16:21:18.499892Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8128,"took":"61.802076ms","hash":2742650946,"current-db-size-bytes":58105856,"current-db-size":"58 MB","current-db-size-in-use-bytes":28020736,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-08-10T16:21:18.499958Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2742650946,"revision":8128,"compact-revision":6075} {"level":"info","ts":"2026-08-10T16:24:24.119038Z","caller":"traceutil/trace.go:171","msg":"trace[1962701511] linearizableReadLoop","detail":"{readStateIndex:12364; appliedIndex:12363; }","duration":"188.76714ms","start":"2026-08-10T16:24:23.930245Z","end":"2026-08-10T16:24:24.119012Z","steps":["trace[1962701511] 'read index received' (duration: 188.481014ms)","trace[1962701511] 'applied index is now lower than readState.Index' (duration: 284.876µs)"],"step_count":2} {"level":"info","ts":"2026-08-10T16:24:24.11914Z","caller":"traceutil/trace.go:171","msg":"trace[201779684] transaction","detail":"{read_only:false; response_revision:11950; number_of_response:1; }","duration":"190.80409ms","start":"2026-08-10T16:24:23.928306Z","end":"2026-08-10T16:24:24.11911Z","steps":["trace[201779684] 'process raft request' (duration: 190.500982ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T16:24:24.119443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.83557ms","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-08-10T16:24:24.119515Z","caller":"traceutil/trace.go:171","msg":"trace[250628480] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:11950; }","duration":"185.929123ms","start":"2026-08-10T16:24:23.933568Z","end":"2026-08-10T16:24:24.119497Z","steps":["trace[250628480] 'agreement among raft nodes before linearized reading' (duration: 185.676037ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T16:24:24.119723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.085858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-08-10T16:24:24.11978Z","caller":"traceutil/trace.go:171","msg":"trace[1637790457] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:11950; }","duration":"189.57228ms","start":"2026-08-10T16:24:23.930192Z","end":"2026-08-10T16:24:24.119764Z","steps":["trace[1637790457] 'agreement among raft nodes before linearized reading' (duration: 188.966225ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:24:24.232948Z","caller":"traceutil/trace.go:171","msg":"trace[833559198] transaction","detail":"{read_only:false; response_revision:11951; number_of_response:1; }","duration":"109.084134ms","start":"2026-08-10T16:24:24.12381Z","end":"2026-08-10T16:24:24.232895Z","steps":["trace[833559198] 'process raft request' (duration: 24.057789ms)","trace[833559198] 'compare' (duration: 84.767499ms)"],"step_count":2} {"level":"info","ts":"2026-08-10T16:24:24.23328Z","caller":"traceutil/trace.go:171","msg":"trace[1290117695] transaction","detail":"{read_only:false; response_revision:11952; number_of_response:1; }","duration":"109.154846ms","start":"2026-08-10T16:24:24.124078Z","end":"2026-08-10T16:24:24.233233Z","steps":["trace[1290117695] 'process raft request' (duration: 108.762877ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:24:24.233723Z","caller":"traceutil/trace.go:171","msg":"trace[1393381072] transaction","detail":"{read_only:false; response_revision:11954; number_of_response:1; }","duration":"109.210797ms","start":"2026-08-10T16:24:24.124218Z","end":"2026-08-10T16:24:24.233429Z","steps":["trace[1393381072] 'process raft request' (duration: 109.142515ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:24:24.233717Z","caller":"traceutil/trace.go:171","msg":"trace[349615183] transaction","detail":"{read_only:false; response_revision:11953; number_of_response:1; }","duration":"109.533255ms","start":"2026-08-10T16:24:24.124156Z","end":"2026-08-10T16:24:24.233689Z","steps":["trace[349615183] 'process raft request' (duration: 108.935551ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:26:18.442623Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10526} {"level":"info","ts":"2026-08-10T16:26:18.526039Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10526,"took":"80.907048ms","hash":19492484,"current-db-size-bytes":58105856,"current-db-size":"58 MB","current-db-size-in-use-bytes":26603520,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-08-10T16:26:18.526088Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":19492484,"revision":10526,"compact-revision":8128} {"level":"warn","ts":"2026-08-10T16:30:32.088719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.548744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-08-10T16:30:32.088819Z","caller":"traceutil/trace.go:171","msg":"trace[195173858] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:14433; }","duration":"133.700848ms","start":"2026-08-10T16:30:31.955099Z","end":"2026-08-10T16:30:32.0888Z","steps":["trace[195173858] 'range keys from in-memory index tree' (duration: 133.36692ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:30:55.08923Z","caller":"traceutil/trace.go:171","msg":"trace[1198697144] transaction","detail":"{read_only:false; response_revision:14557; number_of_response:1; }","duration":"127.235421ms","start":"2026-08-10T16:30:54.961972Z","end":"2026-08-10T16:30:55.089207Z","steps":["trace[1198697144] 'process raft request' (duration: 127.097468ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T16:31:12.010343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.136418ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-10T16:31:12.010494Z","caller":"traceutil/trace.go:171","msg":"trace[1207513153] transaction","detail":"{read_only:false; response_revision:14656; number_of_response:1; }","duration":"277.262392ms","start":"2026-08-10T16:31:11.733207Z","end":"2026-08-10T16:31:12.010469Z","steps":["trace[1207513153] 'process raft request' (duration: 174.893519ms)","trace[1207513153] 'compare' (duration: 101.905622ms)"],"step_count":2} {"level":"info","ts":"2026-08-10T16:31:12.062798Z","caller":"traceutil/trace.go:171","msg":"trace[955738695] transaction","detail":"{read_only:false; response_revision:14658; number_of_response:1; }","duration":"164.271844ms","start":"2026-08-10T16:31:11.898505Z","end":"2026-08-10T16:31:12.062777Z","steps":["trace[955738695] 'process raft request' (duration: 164.221033ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:31:12.063194Z","caller":"traceutil/trace.go:171","msg":"trace[1117534757] transaction","detail":"{read_only:false; response_revision:14657; number_of_response:1; }","duration":"246.279597ms","start":"2026-08-10T16:31:11.816902Z","end":"2026-08-10T16:31:12.063181Z","steps":["trace[1117534757] 'process raft request' (duration: 245.712413ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:31:18.448454Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12715} {"level":"info","ts":"2026-08-10T16:31:18.522963Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12715,"took":"71.89497ms","hash":2533651659,"current-db-size-bytes":58105856,"current-db-size":"58 MB","current-db-size-in-use-bytes":27439104,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-08-10T16:31:18.523036Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2533651659,"revision":12715,"compact-revision":10526} {"level":"info","ts":"2026-08-10T16:31:21.872989Z","caller":"traceutil/trace.go:171","msg":"trace[659501310] linearizableReadLoop","detail":"{readStateIndex:15347; appliedIndex:15346; }","duration":"181.023808ms","start":"2026-08-10T16:31:21.691942Z","end":"2026-08-10T16:31:21.872966Z","steps":["trace[659501310] 'read index received' (duration: 180.816333ms)","trace[659501310] 'applied index is now lower than readState.Index' (duration: 206.875µs)"],"step_count":2} {"level":"warn","ts":"2026-08-10T16:31:21.873196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.246552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-08-10T16:31:21.873228Z","caller":"traceutil/trace.go:171","msg":"trace[1747422877] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:14831; }","duration":"181.324365ms","start":"2026-08-10T16:31:21.691894Z","end":"2026-08-10T16:31:21.873219Z","steps":["trace[1747422877] 'agreement among raft nodes before linearized reading' (duration: 181.167321ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:31:21.873489Z","caller":"traceutil/trace.go:171","msg":"trace[893677225] transaction","detail":"{read_only:false; response_revision:14831; number_of_response:1; }","duration":"191.95064ms","start":"2026-08-10T16:31:21.68153Z","end":"2026-08-10T16:31:21.873481Z","steps":["trace[893677225] 'process raft request' (duration: 191.302214ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T16:31:22.078249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.608141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5651"} {"level":"info","ts":"2026-08-10T16:31:22.078359Z","caller":"traceutil/trace.go:171","msg":"trace[579876344] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:14831; }","duration":"122.767565ms","start":"2026-08-10T16:31:21.95557Z","end":"2026-08-10T16:31:22.078338Z","steps":["trace[579876344] 'range keys from in-memory index tree' (duration: 122.408957ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:33:02.652052Z","caller":"traceutil/trace.go:171","msg":"trace[1634031966] transaction","detail":"{read_only:false; response_revision:15918; number_of_response:1; }","duration":"120.612742ms","start":"2026-08-10T16:33:02.531412Z","end":"2026-08-10T16:33:02.652025Z","steps":["trace[1634031966] 'process raft request' (duration: 120.436078ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T16:33:02.856342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.286547ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-10T16:33:02.856557Z","caller":"traceutil/trace.go:171","msg":"trace[897266937] transaction","detail":"{read_only:false; response_revision:15919; number_of_response:1; }","duration":"318.859614ms","start":"2026-08-10T16:33:02.537672Z","end":"2026-08-10T16:33:02.856531Z","steps":["trace[897266937] 'process raft request' (duration: 190.272099ms)","trace[897266937] 'compare' (duration: 128.153444ms)"],"step_count":2} {"level":"info","ts":"2026-08-10T16:33:02.85661Z","caller":"traceutil/trace.go:171","msg":"trace[1738393466] transaction","detail":"{read_only:false; response_revision:15920; number_of_response:1; }","duration":"317.83286ms","start":"2026-08-10T16:33:02.538738Z","end":"2026-08-10T16:33:02.856571Z","steps":["trace[1738393466] 'process raft request' (duration: 317.721487ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:33:02.85662Z","caller":"traceutil/trace.go:171","msg":"trace[2070874068] linearizableReadLoop","detail":"{readStateIndex:16471; appliedIndex:16468; }","duration":"305.611515ms","start":"2026-08-10T16:33:02.550933Z","end":"2026-08-10T16:33:02.856545Z","steps":["trace[2070874068] 'read index received' (duration: 101.015651ms)","trace[2070874068] 'applied index is now lower than readState.Index' (duration: 204.594674ms)"],"step_count":2} {"level":"warn","ts":"2026-08-10T16:33:02.856698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T16:33:02.537616Z","time spent":"319.010818ms","remote":"127.0.0.1:42182","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-10T16:33:02.856741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T16:33:02.538712Z","time spent":"317.963133ms","remote":"127.0.0.1:42182","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-10T16:33:02.856727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.784179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-10T16:33:02.856803Z","caller":"traceutil/trace.go:171","msg":"trace[795874717] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:15920; }","duration":"305.930573ms","start":"2026-08-10T16:33:02.550856Z","end":"2026-08-10T16:33:02.856787Z","steps":["trace[795874717] 'agreement among raft nodes before linearized reading' (duration: 305.791239ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T16:33:02.856863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T16:33:02.550841Z","time spent":"306.004874ms","remote":"127.0.0.1:41888","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-10T16:33:02.857277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.428088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-10T16:33:02.85733Z","caller":"traceutil/trace.go:171","msg":"trace[420839544] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:15920; }","duration":"287.52663ms","start":"2026-08-10T16:33:02.569787Z","end":"2026-08-10T16:33:02.857314Z","steps":["trace[420839544] 'agreement among raft nodes before linearized reading' (duration: 287.418878ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:33:03.084905Z","caller":"traceutil/trace.go:171","msg":"trace[120731639] transaction","detail":"{read_only:false; response_revision:15921; number_of_response:1; }","duration":"222.920505ms","start":"2026-08-10T16:33:02.861948Z","end":"2026-08-10T16:33:03.084868Z","steps":["trace[120731639] 'process raft request' (duration: 219.418431ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:33:03.084942Z","caller":"traceutil/trace.go:171","msg":"trace[149377656] linearizableReadLoop","detail":"{readStateIndex:16474; appliedIndex:16471; }","duration":"222.513615ms","start":"2026-08-10T16:33:02.862416Z","end":"2026-08-10T16:33:03.08493Z","steps":["trace[149377656] 'read index received' (duration: 218.879468ms)","trace[149377656] 'applied index is now lower than readState.Index' (duration: 3.633447ms)"],"step_count":2} {"level":"info","ts":"2026-08-10T16:33:03.084927Z","caller":"traceutil/trace.go:171","msg":"trace[1508440038] transaction","detail":"{read_only:false; response_revision:15922; number_of_response:1; }","duration":"222.903274ms","start":"2026-08-10T16:33:02.861993Z","end":"2026-08-10T16:33:03.084896Z","steps":["trace[1508440038] 'process raft request' (duration: 222.780902ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:33:03.08495Z","caller":"traceutil/trace.go:171","msg":"trace[1749921848] transaction","detail":"{read_only:false; response_revision:15923; number_of_response:1; }","duration":"222.848293ms","start":"2026-08-10T16:33:02.862075Z","end":"2026-08-10T16:33:03.084923Z","steps":["trace[1749921848] 'process raft request' (duration: 222.774281ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:33:03.08504Z","caller":"traceutil/trace.go:171","msg":"trace[213519577] transaction","detail":"{read_only:false; response_revision:15925; number_of_response:1; }","duration":"221.234104ms","start":"2026-08-10T16:33:02.863775Z","end":"2026-08-10T16:33:03.085009Z","steps":["trace[213519577] 'process raft request' (duration: 221.130442ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:33:03.085117Z","caller":"traceutil/trace.go:171","msg":"trace[580333113] transaction","detail":"{read_only:false; response_revision:15924; number_of_response:1; }","duration":"221.637474ms","start":"2026-08-10T16:33:02.863472Z","end":"2026-08-10T16:33:03.085109Z","steps":["trace[580333113] 'process raft request' (duration: 221.409659ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T16:33:03.085141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.896101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"} {"level":"info","ts":"2026-08-10T16:33:03.085162Z","caller":"traceutil/trace.go:171","msg":"trace[1034742036] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15925; }","duration":"155.930013ms","start":"2026-08-10T16:33:02.929223Z","end":"2026-08-10T16:33:03.085153Z","steps":["trace[1034742036] 'agreement among raft nodes before linearized reading' (duration: 155.873211ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T16:33:03.085147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.3344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-user\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-10T16:33:03.085177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.714466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-10T16:33:03.085077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.876947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-10T16:33:03.08522Z","caller":"traceutil/trace.go:171","msg":"trace[1224165154] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:15925; }","duration":"158.438423ms","start":"2026-08-10T16:33:02.926771Z","end":"2026-08-10T16:33:03.085209Z","steps":["trace[1224165154] 'agreement among raft nodes before linearized reading' (duration: 158.342221ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:33:03.085225Z","caller":"traceutil/trace.go:171","msg":"trace[733397512] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15925; }","duration":"157.812008ms","start":"2026-08-10T16:33:02.927401Z","end":"2026-08-10T16:33:03.085213Z","steps":["trace[733397512] 'agreement among raft nodes before linearized reading' (duration: 157.723696ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:33:03.085235Z","caller":"traceutil/trace.go:171","msg":"trace[1350071149] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15925; }","duration":"219.059142ms","start":"2026-08-10T16:33:02.866164Z","end":"2026-08-10T16:33:03.085223Z","steps":["trace[1350071149] 'agreement among raft nodes before linearized reading' (duration: 218.870908ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T16:33:03.085082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.662179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:666"} {"level":"info","ts":"2026-08-10T16:33:03.085321Z","caller":"traceutil/trace.go:171","msg":"trace[797089584] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15925; }","duration":"222.934425ms","start":"2026-08-10T16:33:02.862379Z","end":"2026-08-10T16:33:03.085313Z","steps":["trace[797089584] 'agreement among raft nodes before linearized reading' (duration: 222.618678ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T16:33:03.085373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.308119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-10T16:33:03.08541Z","caller":"traceutil/trace.go:171","msg":"trace[1990554110] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:15925; }","duration":"158.375781ms","start":"2026-08-10T16:33:02.927024Z","end":"2026-08-10T16:33:03.0854Z","steps":["trace[1990554110] 'agreement among raft nodes before linearized reading' (duration: 158.296819ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T16:33:03.085505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.008915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"} {"level":"info","ts":"2026-08-10T16:33:03.085533Z","caller":"traceutil/trace.go:171","msg":"trace[625051311] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15925; }","duration":"210.050305ms","start":"2026-08-10T16:33:02.875476Z","end":"2026-08-10T16:33:03.085527Z","steps":["trace[625051311] 'agreement among raft nodes before linearized reading' (duration: 209.980574ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T16:33:03.0858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.540064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:79 size:769803"} {"level":"info","ts":"2026-08-10T16:33:03.08583Z","caller":"traceutil/trace.go:171","msg":"trace[1389804262] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:79; response_revision:15925; }","duration":"219.604155ms","start":"2026-08-10T16:33:02.86622Z","end":"2026-08-10T16:33:03.085824Z","steps":["trace[1389804262] 'agreement among raft nodes before linearized reading' (duration: 218.99512ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T16:33:03.08584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.607466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:79 size:769803"} {"level":"info","ts":"2026-08-10T16:33:03.085859Z","caller":"traceutil/trace.go:171","msg":"trace[108467715] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:79; response_revision:15925; }","duration":"219.646277ms","start":"2026-08-10T16:33:02.866208Z","end":"2026-08-10T16:33:03.085854Z","steps":["trace[108467715] 'agreement among raft nodes before linearized reading' (duration: 219.051662ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:36:18.459642Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14712} {"level":"info","ts":"2026-08-10T16:36:18.537704Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14712,"took":"75.071168ms","hash":3138146212,"current-db-size-bytes":58105856,"current-db-size":"58 MB","current-db-size-in-use-bytes":34238464,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-08-10T16:36:18.537788Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3138146212,"revision":14712,"compact-revision":12715} {"level":"info","ts":"2026-08-10T16:38:41.788261Z","caller":"traceutil/trace.go:171","msg":"trace[1808384135] linearizableReadLoop","detail":"{readStateIndex:19048; appliedIndex:19047; }","duration":"103.655017ms","start":"2026-08-10T16:38:41.684586Z","end":"2026-08-10T16:38:41.788241Z","steps":["trace[1808384135] 'read index received' (duration: 103.503684ms)","trace[1808384135] 'applied index is now lower than readState.Index' (duration: 150.503µs)"],"step_count":2} {"level":"info","ts":"2026-08-10T16:38:41.788358Z","caller":"traceutil/trace.go:171","msg":"trace[2096229241] transaction","detail":"{read_only:false; response_revision:18415; number_of_response:1; }","duration":"107.273134ms","start":"2026-08-10T16:38:41.68103Z","end":"2026-08-10T16:38:41.788303Z","steps":["trace[2096229241] 'process raft request' (duration: 107.078019ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T16:38:41.788424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.831771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.171\" ","response":"range_response_count:1 size:140"} {"level":"info","ts":"2026-08-10T16:38:41.788454Z","caller":"traceutil/trace.go:171","msg":"trace[1470153876] range","detail":"{range_begin:/registry/masterleases/199.19.213.171; range_end:; response_count:1; response_revision:18415; }","duration":"103.909483ms","start":"2026-08-10T16:38:41.684536Z","end":"2026-08-10T16:38:41.788445Z","steps":["trace[1470153876] 'agreement among raft nodes before linearized reading' (duration: 103.7888ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:38:42.344706Z","caller":"traceutil/trace.go:171","msg":"trace[891235757] transaction","detail":"{read_only:false; response_revision:18418; number_of_response:1; }","duration":"300.434027ms","start":"2026-08-10T16:38:42.044243Z","end":"2026-08-10T16:38:42.344677Z","steps":["trace[891235757] 'process raft request' (duration: 300.290004ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T16:38:42.344865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T16:38:42.044217Z","time spent":"300.564841ms","remote":"127.0.0.1:42182","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-10T16:38:42.379126Z","caller":"traceutil/trace.go:171","msg":"trace[1869823811] transaction","detail":"{read_only:false; response_revision:18419; number_of_response:1; }","duration":"209.822225ms","start":"2026-08-10T16:38:42.169288Z","end":"2026-08-10T16:38:42.37911Z","steps":["trace[1869823811] 'process raft request' (duration: 209.658781ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T16:38:42.660685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.425835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-10T16:38:42.6608Z","caller":"traceutil/trace.go:171","msg":"trace[295730996] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:18420; }","duration":"111.567358ms","start":"2026-08-10T16:38:42.5492Z","end":"2026-08-10T16:38:42.660767Z","steps":["trace[295730996] 'range keys from in-memory index tree' (duration: 111.286152ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:38:53.093978Z","caller":"traceutil/trace.go:171","msg":"trace[740523226] linearizableReadLoop","detail":"{readStateIndex:19275; appliedIndex:19273; }","duration":"141.493468ms","start":"2026-08-10T16:38:52.952458Z","end":"2026-08-10T16:38:53.093951Z","steps":["trace[740523226] 'read index received' (duration: 53.477808ms)","trace[740523226] 'applied index is now lower than readState.Index' (duration: 88.0148ms)"],"step_count":2} {"level":"info","ts":"2026-08-10T16:38:53.094099Z","caller":"traceutil/trace.go:171","msg":"trace[2072747728] transaction","detail":"{read_only:false; response_revision:18632; number_of_response:1; }","duration":"148.039007ms","start":"2026-08-10T16:38:52.946025Z","end":"2026-08-10T16:38:53.094064Z","steps":["trace[2072747728] 'process raft request' (duration: 59.899334ms)","trace[2072747728] 'compare' (duration: 87.816395ms)"],"step_count":2} {"level":"info","ts":"2026-08-10T16:38:53.094134Z","caller":"traceutil/trace.go:171","msg":"trace[1620078162] transaction","detail":"{read_only:false; response_revision:18633; number_of_response:1; }","duration":"147.460262ms","start":"2026-08-10T16:38:52.946651Z","end":"2026-08-10T16:38:53.094112Z","steps":["trace[1620078162] 'process raft request' (duration: 147.240297ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T16:38:53.094192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.702883ms","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-08-10T16:38:53.09425Z","caller":"traceutil/trace.go:171","msg":"trace[369361711] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:18633; }","duration":"141.795465ms","start":"2026-08-10T16:38:52.952439Z","end":"2026-08-10T16:38:53.094234Z","steps":["trace[369361711] 'agreement among raft nodes before linearized reading' (duration: 141.61566ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:40:03.442284Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"837e89131cc6bd81","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-08-10T16:40:03.447154Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-08-10T16:40:03.447261Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-08-10T16:40:45.028575Z","caller":"traceutil/trace.go:171","msg":"trace[727207442] transaction","detail":"{read_only:false; response_revision:19621; number_of_response:1; }","duration":"188.207944ms","start":"2026-08-10T16:40:44.840331Z","end":"2026-08-10T16:40:45.028539Z","steps":["trace[727207442] 'process raft request' (duration: 110.101122ms)","trace[727207442] 'compare' (duration: 77.957148ms)"],"step_count":2} {"level":"info","ts":"2026-08-10T16:41:18.466594Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17468} {"level":"info","ts":"2026-08-10T16:41:18.573102Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17468,"took":"102.96527ms","hash":2020367689,"current-db-size-bytes":58105856,"current-db-size":"58 MB","current-db-size-in-use-bytes":34865152,"current-db-size-in-use":"35 MB"} {"level":"info","ts":"2026-08-10T16:41:18.573167Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2020367689,"revision":17468,"compact-revision":14712} {"level":"warn","ts":"2026-08-10T16:44:58.436012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.233211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-10T16:44:58.436129Z","caller":"traceutil/trace.go:171","msg":"trace[231223725] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:21284; }","duration":"136.386275ms","start":"2026-08-10T16:44:58.299723Z","end":"2026-08-10T16:44:58.436109Z","steps":["trace[231223725] 'range keys from in-memory index tree' (duration: 136.112969ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T16:44:58.675863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.577306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-10T16:44:58.675962Z","caller":"traceutil/trace.go:171","msg":"trace[1788236086] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21285; }","duration":"125.74836ms","start":"2026-08-10T16:44:58.550189Z","end":"2026-08-10T16:44:58.675937Z","steps":["trace[1788236086] 'range keys from in-memory index tree' (duration: 125.444092ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:44:58.907401Z","caller":"traceutil/trace.go:171","msg":"trace[900343724] transaction","detail":"{read_only:false; response_revision:21286; number_of_response:1; }","duration":"135.484265ms","start":"2026-08-10T16:44:58.771883Z","end":"2026-08-10T16:44:58.907367Z","steps":["trace[900343724] 'process raft request' (duration: 135.204367ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:44:58.923855Z","caller":"traceutil/trace.go:171","msg":"trace[1624901456] linearizableReadLoop","detail":"{readStateIndex:22016; appliedIndex:22014; }","duration":"137.742978ms","start":"2026-08-10T16:44:58.786073Z","end":"2026-08-10T16:44:58.923816Z","steps":["trace[1624901456] 'read index received' (duration: 121.120518ms)","trace[1624901456] 'applied index is now lower than readState.Index' (duration: 16.62089ms)"],"step_count":2} {"level":"info","ts":"2026-08-10T16:44:58.924224Z","caller":"traceutil/trace.go:171","msg":"trace[921463033] transaction","detail":"{read_only:false; response_revision:21287; number_of_response:1; }","duration":"147.896033ms","start":"2026-08-10T16:44:58.7763Z","end":"2026-08-10T16:44:58.924196Z","steps":["trace[921463033] 'process raft request' (duration: 147.058492ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T16:44:58.924658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.271172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/operatorpolicies/\" range_end:\"/registry/rabbitmq.com/operatorpolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-10T16:44:58.924759Z","caller":"traceutil/trace.go:171","msg":"trace[515697238] range","detail":"{range_begin:/registry/rabbitmq.com/operatorpolicies/; range_end:/registry/rabbitmq.com/operatorpolicies0; response_count:0; response_revision:21287; }","duration":"138.722663ms","start":"2026-08-10T16:44:58.786013Z","end":"2026-08-10T16:44:58.924735Z","steps":["trace[515697238] 'agreement among raft nodes before linearized reading' (duration: 138.058247ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:44:59.21755Z","caller":"traceutil/trace.go:171","msg":"trace[538097764] transaction","detail":"{read_only:false; response_revision:21288; number_of_response:1; }","duration":"287.743981ms","start":"2026-08-10T16:44:58.929754Z","end":"2026-08-10T16:44:59.217498Z","steps":["trace[538097764] 'process raft request' (duration: 193.789208ms)","trace[538097764] 'compare' (duration: 93.314308ms)"],"step_count":2} {"level":"info","ts":"2026-08-10T16:44:59.217857Z","caller":"traceutil/trace.go:171","msg":"trace[174399470] transaction","detail":"{read_only:false; response_revision:21290; number_of_response:1; }","duration":"287.968977ms","start":"2026-08-10T16:44:58.929782Z","end":"2026-08-10T16:44:59.217751Z","steps":["trace[174399470] 'process raft request' (duration: 287.839414ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:44:59.218285Z","caller":"traceutil/trace.go:171","msg":"trace[1185496304] transaction","detail":"{read_only:false; response_revision:21289; number_of_response:1; }","duration":"288.188052ms","start":"2026-08-10T16:44:58.929768Z","end":"2026-08-10T16:44:59.217956Z","steps":["trace[1185496304] 'process raft request' (duration: 287.577207ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:44:59.650305Z","caller":"traceutil/trace.go:171","msg":"trace[1807582306] transaction","detail":"{read_only:false; response_revision:21292; number_of_response:1; }","duration":"107.09183ms","start":"2026-08-10T16:44:59.54313Z","end":"2026-08-10T16:44:59.650222Z","steps":["trace[1807582306] 'process raft request' (duration: 106.702041ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T16:45:00.076392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.312638ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-10T16:45:00.0769Z","caller":"traceutil/trace.go:171","msg":"trace[1365004958] transaction","detail":"{read_only:false; response_revision:21293; number_of_response:1; }","duration":"394.151456ms","start":"2026-08-10T16:44:59.682712Z","end":"2026-08-10T16:45:00.076864Z","steps":["trace[1365004958] 'process raft request' (duration: 118.28287ms)","trace[1365004958] 'compare' (duration: 274.054952ms)"],"step_count":2} {"level":"info","ts":"2026-08-10T16:45:00.07696Z","caller":"traceutil/trace.go:171","msg":"trace[1416836544] linearizableReadLoop","detail":"{readStateIndex:22023; appliedIndex:22021; }","duration":"104.711693ms","start":"2026-08-10T16:44:59.972184Z","end":"2026-08-10T16:45:00.076896Z","steps":["trace[1416836544] 'read index received' (duration: 101.509806ms)","trace[1416836544] 'applied index is now lower than readState.Index' (duration: 3.199887ms)"],"step_count":2} {"level":"warn","ts":"2026-08-10T16:45:00.077152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.964658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-08-10T16:45:00.077143Z","caller":"traceutil/trace.go:171","msg":"trace[1500822682] transaction","detail":"{read_only:false; response_revision:21294; number_of_response:1; }","duration":"180.831125ms","start":"2026-08-10T16:44:59.896256Z","end":"2026-08-10T16:45:00.077087Z","steps":["trace[1500822682] 'process raft request' (duration: 180.422566ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T16:45:00.077231Z","caller":"traceutil/trace.go:171","msg":"trace[2118963521] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:21294; }","duration":"105.058061ms","start":"2026-08-10T16:44:59.972129Z","end":"2026-08-10T16:45:00.077187Z","steps":["trace[2118963521] 'agreement among raft nodes before linearized reading' (duration: 104.917087ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T16:45:00.077371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T16:44:59.682689Z","time spent":"394.29415ms","remote":"127.0.0.1:42182","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-10T16:46:18.473329Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19815} {"level":"info","ts":"2026-08-10T16:46:18.581412Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19815,"took":"104.664962ms","hash":4215806244,"current-db-size-bytes":58105856,"current-db-size":"58 MB","current-db-size-in-use-bytes":30363648,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-08-10T16:46:18.581506Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4215806244,"revision":19815,"compact-revision":17468} {"level":"info","ts":"2026-08-10T16:51:18.480281Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":22046} {"level":"info","ts":"2026-08-10T16:51:18.591146Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":22046,"took":"106.556221ms","hash":2461072956,"current-db-size-bytes":58105856,"current-db-size":"58 MB","current-db-size-in-use-bytes":44433408,"current-db-size-in-use":"44 MB"} {"level":"info","ts":"2026-08-10T16:51:18.591219Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2461072956,"revision":22046,"compact-revision":19815} {"level":"info","ts":"2026-08-10T16:56:18.488126Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25130} {"level":"info","ts":"2026-08-10T16:56:18.628954Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25130,"took":"137.517843ms","hash":2458494039,"current-db-size-bytes":58105856,"current-db-size":"58 MB","current-db-size-in-use-bytes":31178752,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-08-10T16:56:18.629016Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2458494039,"revision":25130,"compact-revision":22046} {"level":"info","ts":"2026-08-10T16:56:32.429036Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006ed4.wal"}