{"level":"warn","ts":"2026-08-19T09:06:10.435241Z","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-19T09:06:10.435412Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.44: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.204.45.44:2380","--initial-cluster=instance=https://199.204.45.44:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.44:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.44: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-19T09:06:10.435679Z","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-19T09:06:10.435714Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.44:2380"]}
{"level":"info","ts":"2026-08-19T09:06:10.435756Z","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-19T09:06:10.43723Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.44:2379"]}
{"level":"info","ts":"2026-08-19T09:06:10.437401Z","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.204.45.44:2380"],"listen-peer-urls":["https://199.204.45.44:2380"],"advertise-client-urls":["https://199.204.45.44:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.44:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.44: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-19T09:06:10.441651Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.828057ms"}
{"level":"info","ts":"2026-08-19T09:06:10.451175Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a0a01fc7fbf6be45","cluster-id":"92fa3fee501eaaec"}
{"level":"info","ts":"2026-08-19T09:06:10.451331Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0a01fc7fbf6be45 switched to configuration voters=()"}
{"level":"info","ts":"2026-08-19T09:06:10.451363Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0a01fc7fbf6be45 became follower at term 0"}
{"level":"info","ts":"2026-08-19T09:06:10.451378Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a0a01fc7fbf6be45 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-08-19T09:06:10.451396Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0a01fc7fbf6be45 became follower at term 1"}
{"level":"info","ts":"2026-08-19T09:06:10.451452Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0a01fc7fbf6be45 switched to configuration voters=(11574285986128379461)"}
{"level":"warn","ts":"2026-08-19T09:06:10.458425Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-08-19T09:06:10.46004Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-08-19T09:06:10.461396Z","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-19T09:06:10.464382Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a0a01fc7fbf6be45","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-08-19T09:06:10.464601Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a0a01fc7fbf6be45","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-08-19T09:06:10.464708Z","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-19T09:06:10.464938Z","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-19T09:06:10.464961Z","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-19T09:06:10.466049Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0a01fc7fbf6be45 switched to configuration voters=(11574285986128379461)"}
{"level":"info","ts":"2026-08-19T09:06:10.466385Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"92fa3fee501eaaec","local-member-id":"a0a01fc7fbf6be45","added-peer-id":"a0a01fc7fbf6be45","added-peer-peer-urls":["https://199.204.45.44:2380"]}
{"level":"info","ts":"2026-08-19T09:06:10.468446Z","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-19T09:06:10.468661Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a0a01fc7fbf6be45","initial-advertise-peer-urls":["https://199.204.45.44:2380"],"listen-peer-urls":["https://199.204.45.44:2380"],"advertise-client-urls":["https://199.204.45.44:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.44:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-08-19T09:06:10.468707Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-08-19T09:06:10.469226Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.44:2380"}
{"level":"info","ts":"2026-08-19T09:06:10.46926Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.44:2380"}
{"level":"info","ts":"2026-08-19T09:06:10.65248Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0a01fc7fbf6be45 is starting a new election at term 1"}
{"level":"info","ts":"2026-08-19T09:06:10.652552Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0a01fc7fbf6be45 became pre-candidate at term 1"}
{"level":"info","ts":"2026-08-19T09:06:10.652595Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0a01fc7fbf6be45 received MsgPreVoteResp from a0a01fc7fbf6be45 at term 1"}
{"level":"info","ts":"2026-08-19T09:06:10.652631Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0a01fc7fbf6be45 became candidate at term 2"}
{"level":"info","ts":"2026-08-19T09:06:10.652651Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0a01fc7fbf6be45 received MsgVoteResp from a0a01fc7fbf6be45 at term 2"}
{"level":"info","ts":"2026-08-19T09:06:10.652669Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0a01fc7fbf6be45 became leader at term 2"}
{"level":"info","ts":"2026-08-19T09:06:10.652691Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a0a01fc7fbf6be45 elected leader a0a01fc7fbf6be45 at term 2"}
{"level":"info","ts":"2026-08-19T09:06:10.653671Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a0a01fc7fbf6be45","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.44:2379]}","request-path":"/0/members/a0a01fc7fbf6be45/attributes","cluster-id":"92fa3fee501eaaec","publish-timeout":"7s"}
{"level":"info","ts":"2026-08-19T09:06:10.653695Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-08-19T09:06:10.654335Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-19T09:06:10.654537Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-08-19T09:06:10.654928Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-08-19T09:06:10.655022Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-08-19T09:06:10.65766Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.44:2379"}
{"level":"info","ts":"2026-08-19T09:06:10.657936Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-08-19T09:06:10.66476Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"92fa3fee501eaaec","local-member-id":"a0a01fc7fbf6be45","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-19T09:06:10.664932Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-19T09:06:10.665063Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-19T09:06:54.918374Z","caller":"traceutil/trace.go:171","msg":"trace[662674127] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"172.129857ms","start":"2026-08-19T09:06:54.746217Z","end":"2026-08-19T09:06:54.918347Z","steps":["trace[662674127] 'process raft request'  (duration: 171.862882ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:07:10.124784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.688835ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13710540670997469565 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:743 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-19T09:07:10.12501Z","caller":"traceutil/trace.go:171","msg":"trace[458184289] linearizableReadLoop","detail":"{readStateIndex:785; appliedIndex:784; }","duration":"104.02307ms","start":"2026-08-19T09:07:10.02097Z","end":"2026-08-19T09:07:10.124993Z","steps":["trace[458184289] 'read index received'  (duration: 54.371µs)","trace[458184289] 'applied index is now lower than readState.Index'  (duration: 103.966739ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:07:10.125108Z","caller":"traceutil/trace.go:171","msg":"trace[1948654048] transaction","detail":"{read_only:false; response_revision:757; number_of_response:1; }","duration":"232.235675ms","start":"2026-08-19T09:07:09.892821Z","end":"2026-08-19T09:07:10.125056Z","steps":["trace[1948654048] 'process raft request'  (duration: 82.35252ms)","trace[1948654048] 'compare'  (duration: 148.37024ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T09:07:10.125299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.331897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-08-19T09:07:10.125383Z","caller":"traceutil/trace.go:171","msg":"trace[742528595] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:757; }","duration":"104.402918ms","start":"2026-08-19T09:07:10.020927Z","end":"2026-08-19T09:07:10.125329Z","steps":["trace[742528595] 'agreement among raft nodes before linearized reading'  (duration: 104.174273ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:08:01.246404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.283486ms","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-19T09:08:01.246535Z","caller":"traceutil/trace.go:171","msg":"trace[1159733350] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1412; }","duration":"107.48513ms","start":"2026-08-19T09:08:01.139025Z","end":"2026-08-19T09:08:01.24651Z","steps":["trace[1159733350] 'count revisions from in-memory index tree'  (duration: 107.159334ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:08:23.43561Z","caller":"traceutil/trace.go:171","msg":"trace[1327354272] linearizableReadLoop","detail":"{readStateIndex:1874; appliedIndex:1873; }","duration":"267.440532ms","start":"2026-08-19T09:08:23.168141Z","end":"2026-08-19T09:08:23.435581Z","steps":["trace[1327354272] 'read index received'  (duration: 240.843115ms)","trace[1327354272] 'applied index is now lower than readState.Index'  (duration: 26.595927ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:08:23.435765Z","caller":"traceutil/trace.go:171","msg":"trace[2067634807] transaction","detail":"{read_only:false; response_revision:1804; number_of_response:1; }","duration":"296.435962ms","start":"2026-08-19T09:08:23.139313Z","end":"2026-08-19T09:08:23.435749Z","steps":["trace[2067634807] 'process raft request'  (duration: 269.728903ms)","trace[2067634807] 'compare'  (duration: 26.265172ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T09:08:23.43619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.033882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f3958a16-e60a-4bb0-8491-b3bbf4f0db45\" ","response":"range_response_count:1 size:3626"}
{"level":"info","ts":"2026-08-19T09:08:23.436252Z","caller":"traceutil/trace.go:171","msg":"trace[670196541] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f3958a16-e60a-4bb0-8491-b3bbf4f0db45; range_end:; response_count:1; response_revision:1804; }","duration":"268.138044ms","start":"2026-08-19T09:08:23.168096Z","end":"2026-08-19T09:08:23.436234Z","steps":["trace[670196541] 'agreement among raft nodes before linearized reading'  (duration: 267.940011ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:08:23.61217Z","caller":"traceutil/trace.go:171","msg":"trace[967646983] linearizableReadLoop","detail":"{readStateIndex:1876; appliedIndex:1874; }","duration":"110.433201ms","start":"2026-08-19T09:08:23.501698Z","end":"2026-08-19T09:08:23.612131Z","steps":["trace[967646983] 'read index received'  (duration: 31.695566ms)","trace[967646983] 'applied index is now lower than readState.Index'  (duration: 78.736795ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:08:23.612408Z","caller":"traceutil/trace.go:171","msg":"trace[57590723] transaction","detail":"{read_only:false; response_revision:1806; number_of_response:1; }","duration":"170.179489ms","start":"2026-08-19T09:08:23.442221Z","end":"2026-08-19T09:08:23.6124Z","steps":["trace[57590723] 'process raft request'  (duration: 169.789113ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:08:23.612561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.846388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f3958a16-e60a-4bb0-8491-b3bbf4f0db45\" ","response":"range_response_count:1 size:3746"}
{"level":"info","ts":"2026-08-19T09:08:23.612584Z","caller":"traceutil/trace.go:171","msg":"trace[67512526] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f3958a16-e60a-4bb0-8491-b3bbf4f0db45; range_end:; response_count:1; response_revision:1806; }","duration":"110.906468ms","start":"2026-08-19T09:08:23.50167Z","end":"2026-08-19T09:08:23.612576Z","steps":["trace[67512526] 'agreement among raft nodes before linearized reading'  (duration: 110.850167ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:10:02.16629Z","caller":"traceutil/trace.go:171","msg":"trace[1792468558] transaction","detail":"{read_only:false; response_revision:2569; number_of_response:1; }","duration":"140.619754ms","start":"2026-08-19T09:10:02.02564Z","end":"2026-08-19T09:10:02.16626Z","steps":["trace[1792468558] 'process raft request'  (duration: 140.478401ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:14:21.901746Z","caller":"traceutil/trace.go:171","msg":"trace[209054840] transaction","detail":"{read_only:false; response_revision:4880; number_of_response:1; }","duration":"121.362532ms","start":"2026-08-19T09:14:21.78036Z","end":"2026-08-19T09:14:21.901723Z","steps":["trace[209054840] 'process raft request'  (duration: 121.209478ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:14:21.987073Z","caller":"traceutil/trace.go:171","msg":"trace[1600472223] transaction","detail":"{read_only:false; response_revision:4881; number_of_response:1; }","duration":"159.228221ms","start":"2026-08-19T09:14:21.827808Z","end":"2026-08-19T09:14:21.987036Z","steps":["trace[1600472223] 'process raft request'  (duration: 158.989607ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:14:24.179406Z","caller":"traceutil/trace.go:171","msg":"trace[965163000] transaction","detail":"{read_only:false; response_revision:4933; number_of_response:1; }","duration":"110.082954ms","start":"2026-08-19T09:14:24.069277Z","end":"2026-08-19T09:14:24.17936Z","steps":["trace[965163000] 'process raft request'  (duration: 106.462837ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:14:24.179463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.240951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-19T09:14:24.179538Z","caller":"traceutil/trace.go:171","msg":"trace[1621488007] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4932; }","duration":"120.358953ms","start":"2026-08-19T09:14:24.05916Z","end":"2026-08-19T09:14:24.179519Z","steps":["trace[1621488007] 'range keys from in-memory index tree'  (duration: 119.67741ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:14:29.912903Z","caller":"traceutil/trace.go:171","msg":"trace[101182950] transaction","detail":"{read_only:false; response_revision:5063; number_of_response:1; }","duration":"148.950031ms","start":"2026-08-19T09:14:29.763928Z","end":"2026-08-19T09:14:29.912878Z","steps":["trace[101182950] 'process raft request'  (duration: 127.940124ms)","trace[101182950] 'compare'  (duration: 20.818893ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T09:14:29.91303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.949839ms","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-19T09:14:29.913166Z","caller":"traceutil/trace.go:171","msg":"trace[1381817470] linearizableReadLoop","detail":"{readStateIndex:5252; appliedIndex:5251; }","duration":"113.219291ms","start":"2026-08-19T09:14:29.799659Z","end":"2026-08-19T09:14:29.912878Z","steps":["trace[1381817470] 'read index received'  (duration: 92.205914ms)","trace[1381817470] 'applied index is now lower than readState.Index'  (duration: 21.012557ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:14:29.913289Z","caller":"traceutil/trace.go:171","msg":"trace[2062283169] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5063; }","duration":"124.252984ms","start":"2026-08-19T09:14:29.789017Z","end":"2026-08-19T09:14:29.91327Z","steps":["trace[2062283169] 'agreement among raft nodes before linearized reading'  (duration: 123.864687ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:14:35.267975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.544678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-19T09:14:35.268071Z","caller":"traceutil/trace.go:171","msg":"trace[580718599] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:5163; }","duration":"230.70054ms","start":"2026-08-19T09:14:35.037348Z","end":"2026-08-19T09:14:35.268048Z","steps":["trace[580718599] 'count revisions from in-memory index tree'  (duration: 230.457686ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:14:35.268096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.459152ms","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-19T09:14:35.268213Z","caller":"traceutil/trace.go:171","msg":"trace[1520525804] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5163; }","duration":"187.639316ms","start":"2026-08-19T09:14:35.080549Z","end":"2026-08-19T09:14:35.268189Z","steps":["trace[1520525804] 'range keys from in-memory index tree'  (duration: 187.188748ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:14:35.2694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.105236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/goldpinger-gfk7k\" ","response":"range_response_count:1 size:4991"}
{"level":"info","ts":"2026-08-19T09:14:35.269462Z","caller":"traceutil/trace.go:171","msg":"trace[1024834439] range","detail":"{range_begin:/registry/pods/monitoring/goldpinger-gfk7k; range_end:; response_count:1; response_revision:5163; }","duration":"200.199268ms","start":"2026-08-19T09:14:35.069248Z","end":"2026-08-19T09:14:35.269447Z","steps":["trace[1024834439] 'range keys from in-memory index tree'  (duration: 199.946993ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:14:42.692915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.37671ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13710540670997480053 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:5245 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-19T09:14:42.693024Z","caller":"traceutil/trace.go:171","msg":"trace[653180060] linearizableReadLoop","detail":"{readStateIndex:5518; appliedIndex:5517; }","duration":"252.077026ms","start":"2026-08-19T09:14:42.440929Z","end":"2026-08-19T09:14:42.693006Z","steps":["trace[653180060] 'read index received'  (duration: 50.499863ms)","trace[653180060] 'applied index is now lower than readState.Index'  (duration: 201.575573ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:14:42.693188Z","caller":"traceutil/trace.go:171","msg":"trace[1350574929] transaction","detail":"{read_only:false; response_revision:5325; number_of_response:1; }","duration":"322.972735ms","start":"2026-08-19T09:14:42.370136Z","end":"2026-08-19T09:14:42.693108Z","steps":["trace[1350574929] 'process raft request'  (duration: 121.3077ms)","trace[1350574929] 'compare'  (duration: 201.131966ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T09:14:42.693388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.195128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-77fqs\" ","response":"range_response_count:1 size:6520"}
{"level":"warn","ts":"2026-08-19T09:14:42.693396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:14:42.370116Z","time spent":"323.176269ms","remote":"127.0.0.1:36292","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:5245 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-08-19T09:14:42.693449Z","caller":"traceutil/trace.go:171","msg":"trace[44186366] range","detail":"{range_begin:/registry/pods/openstack/keepalived-77fqs; range_end:; response_count:1; response_revision:5325; }","duration":"200.30041ms","start":"2026-08-19T09:14:42.493137Z","end":"2026-08-19T09:14:42.693437Z","steps":["trace[44186366] 'agreement among raft nodes before linearized reading'  (duration: 200.136016ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:14:42.693989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.063775ms","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-19T09:14:42.694035Z","caller":"traceutil/trace.go:171","msg":"trace[1114132525] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5325; }","duration":"253.110366ms","start":"2026-08-19T09:14:42.440913Z","end":"2026-08-19T09:14:42.694024Z","steps":["trace[1114132525] 'agreement among raft nodes before linearized reading'  (duration: 252.182608ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:14:42.693457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.287205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-19T09:14:42.694663Z","caller":"traceutil/trace.go:171","msg":"trace[1273220829] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5325; }","duration":"172.555358ms","start":"2026-08-19T09:14:42.522084Z","end":"2026-08-19T09:14:42.694639Z","steps":["trace[1273220829] 'agreement among raft nodes before linearized reading'  (duration: 171.271255ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:16:10.887156Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2962}
{"level":"info","ts":"2026-08-19T09:16:10.955868Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2962,"took":"66.73901ms","hash":946803064,"current-db-size-bytes":57520128,"current-db-size":"58 MB","current-db-size-in-use-bytes":34672640,"current-db-size-in-use":"35 MB"}
{"level":"info","ts":"2026-08-19T09:16:10.955944Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":946803064,"revision":2962,"compact-revision":-1}
{"level":"info","ts":"2026-08-19T09:20:39.821611Z","caller":"traceutil/trace.go:171","msg":"trace[1515829727] transaction","detail":"{read_only:false; response_revision:8107; number_of_response:1; }","duration":"195.947946ms","start":"2026-08-19T09:20:39.625646Z","end":"2026-08-19T09:20:39.821594Z","steps":["trace[1515829727] 'process raft request'  (duration: 195.826614ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:20:40.010177Z","caller":"traceutil/trace.go:171","msg":"trace[1346808606] transaction","detail":"{read_only:false; response_revision:8108; number_of_response:1; }","duration":"116.972763ms","start":"2026-08-19T09:20:39.893161Z","end":"2026-08-19T09:20:40.010134Z","steps":["trace[1346808606] 'process raft request'  (duration: 103.163392ms)","trace[1346808606] 'compare'  (duration: 13.666188ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:20:40.555193Z","caller":"traceutil/trace.go:171","msg":"trace[522971901] transaction","detail":"{read_only:false; response_revision:8111; number_of_response:1; }","duration":"116.236198ms","start":"2026-08-19T09:20:40.438929Z","end":"2026-08-19T09:20:40.555165Z","steps":["trace[522971901] 'process raft request'  (duration: 36.795966ms)","trace[522971901] 'compare'  (duration: 79.221068ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T09:20:40.886913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.870642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"}
{"level":"info","ts":"2026-08-19T09:20:40.887013Z","caller":"traceutil/trace.go:171","msg":"trace[360515557] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8112; }","duration":"171.024765ms","start":"2026-08-19T09:20:40.715965Z","end":"2026-08-19T09:20:40.88699Z","steps":["trace[360515557] 'range keys from in-memory index tree'  (duration: 170.658678ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:20:40.887037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.014726ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-77fqs\" ","response":"range_response_count:1 size:6520"}
{"level":"info","ts":"2026-08-19T09:20:40.88714Z","caller":"traceutil/trace.go:171","msg":"trace[1990417796] range","detail":"{range_begin:/registry/pods/openstack/keepalived-77fqs; range_end:; response_count:1; response_revision:8112; }","duration":"123.176529ms","start":"2026-08-19T09:20:40.763939Z","end":"2026-08-19T09:20:40.887115Z","steps":["trace[1990417796] 'range keys from in-memory index tree'  (duration: 122.784242ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:20:41.528189Z","caller":"traceutil/trace.go:171","msg":"trace[1117799469] transaction","detail":"{read_only:false; response_revision:8115; number_of_response:1; }","duration":"195.506348ms","start":"2026-08-19T09:20:41.33264Z","end":"2026-08-19T09:20:41.528147Z","steps":["trace[1117799469] 'process raft request'  (duration: 195.208741ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:20:41.528344Z","caller":"traceutil/trace.go:171","msg":"trace[1905599443] linearizableReadLoop","detail":"{readStateIndex:8397; appliedIndex:8396; }","duration":"181.303378ms","start":"2026-08-19T09:20:41.346774Z","end":"2026-08-19T09:20:41.528078Z","steps":["trace[1905599443] 'read index received'  (duration: 181.137405ms)","trace[1905599443] 'applied index is now lower than readState.Index'  (duration: 164.303µs)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T09:20:41.52851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.723167ms","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-19T09:20:41.528584Z","caller":"traceutil/trace.go:171","msg":"trace[1699214330] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8115; }","duration":"181.836399ms","start":"2026-08-19T09:20:41.34673Z","end":"2026-08-19T09:20:41.528566Z","steps":["trace[1699214330] 'agreement among raft nodes before linearized reading'  (duration: 181.650076ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:21:07.730652Z","caller":"traceutil/trace.go:171","msg":"trace[1406736432] transaction","detail":"{read_only:false; response_revision:8311; number_of_response:1; }","duration":"115.673417ms","start":"2026-08-19T09:21:07.614942Z","end":"2026-08-19T09:21:07.730615Z","steps":["trace[1406736432] 'process raft request'  (duration: 115.422973ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:21:07.894732Z","caller":"traceutil/trace.go:171","msg":"trace[1310166612] transaction","detail":"{read_only:false; response_revision:8312; number_of_response:1; }","duration":"159.321724ms","start":"2026-08-19T09:21:07.735381Z","end":"2026-08-19T09:21:07.894703Z","steps":["trace[1310166612] 'process raft request'  (duration: 79.715457ms)","trace[1310166612] 'compare'  (duration: 78.351872ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:21:10.893726Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6108}
{"level":"info","ts":"2026-08-19T09:21:10.991112Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6108,"took":"95.997095ms","hash":3705223536,"current-db-size-bytes":57520128,"current-db-size":"58 MB","current-db-size-in-use-bytes":23216128,"current-db-size-in-use":"23 MB"}
{"level":"info","ts":"2026-08-19T09:21:10.991175Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3705223536,"revision":6108,"compact-revision":2962}
{"level":"info","ts":"2026-08-19T09:21:20.476145Z","caller":"traceutil/trace.go:171","msg":"trace[626273129] transaction","detail":"{read_only:false; response_revision:8419; number_of_response:1; }","duration":"248.368649ms","start":"2026-08-19T09:21:20.227751Z","end":"2026-08-19T09:21:20.47612Z","steps":["trace[626273129] 'process raft request'  (duration: 248.116004ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:21:20.669203Z","caller":"traceutil/trace.go:171","msg":"trace[1135052897] transaction","detail":"{read_only:false; response_revision:8420; number_of_response:1; }","duration":"214.798703ms","start":"2026-08-19T09:21:20.454375Z","end":"2026-08-19T09:21:20.669173Z","steps":["trace[1135052897] 'process raft request'  (duration: 214.546459ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:21:20.669191Z","caller":"traceutil/trace.go:171","msg":"trace[1509018993] linearizableReadLoop","detail":"{readStateIndex:8718; appliedIndex:8716; }","duration":"189.828341ms","start":"2026-08-19T09:21:20.479338Z","end":"2026-08-19T09:21:20.669166Z","steps":["trace[1509018993] 'read index received'  (duration: 189.643248ms)","trace[1509018993] 'applied index is now lower than readState.Index'  (duration: 183.773µs)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:21:20.669363Z","caller":"traceutil/trace.go:171","msg":"trace[1463149552] transaction","detail":"{read_only:false; response_revision:8421; number_of_response:1; }","duration":"214.792554ms","start":"2026-08-19T09:21:20.45456Z","end":"2026-08-19T09:21:20.669353Z","steps":["trace[1463149552] 'process raft request'  (duration: 214.537989ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:21:20.669381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.037615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-lcqvb\" ","response":"range_response_count:1 size:4647"}
{"level":"info","ts":"2026-08-19T09:21:20.669429Z","caller":"traceutil/trace.go:171","msg":"trace[911506480] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-lcqvb; range_end:; response_count:1; response_revision:8421; }","duration":"190.127907ms","start":"2026-08-19T09:21:20.479287Z","end":"2026-08-19T09:21:20.669415Z","steps":["trace[911506480] 'agreement among raft nodes before linearized reading'  (duration: 189.970774ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:21:20.702521Z","caller":"traceutil/trace.go:171","msg":"trace[204543910] transaction","detail":"{read_only:false; response_revision:8422; number_of_response:1; }","duration":"220.410319ms","start":"2026-08-19T09:21:20.482079Z","end":"2026-08-19T09:21:20.70249Z","steps":["trace[204543910] 'process raft request'  (duration: 220.089913ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:21:20.702662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.957272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-19T09:21:20.702768Z","caller":"traceutil/trace.go:171","msg":"trace[802167142] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8422; }","duration":"182.118304ms","start":"2026-08-19T09:21:20.520628Z","end":"2026-08-19T09:21:20.702746Z","steps":["trace[802167142] 'agreement among raft nodes before linearized reading'  (duration: 181.89097ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:21:21.307844Z","caller":"traceutil/trace.go:171","msg":"trace[1933984474] linearizableReadLoop","detail":"{readStateIndex:8723; appliedIndex:8722; }","duration":"134.758369ms","start":"2026-08-19T09:21:21.173068Z","end":"2026-08-19T09:21:21.307827Z","steps":["trace[1933984474] 'read index received'  (duration: 134.676538ms)","trace[1933984474] 'applied index is now lower than readState.Index'  (duration: 80.671µs)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:21:21.307951Z","caller":"traceutil/trace.go:171","msg":"trace[1803555246] transaction","detail":"{read_only:false; response_revision:8426; number_of_response:1; }","duration":"158.734343ms","start":"2026-08-19T09:21:21.149185Z","end":"2026-08-19T09:21:21.30792Z","steps":["trace[1803555246] 'process raft request'  (duration: 158.529019ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:21:21.308014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.928512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-77fqs\" ","response":"range_response_count:1 size:6520"}
{"level":"info","ts":"2026-08-19T09:21:21.308045Z","caller":"traceutil/trace.go:171","msg":"trace[2006409630] range","detail":"{range_begin:/registry/pods/openstack/keepalived-77fqs; range_end:; response_count:1; response_revision:8426; }","duration":"134.982953ms","start":"2026-08-19T09:21:21.173053Z","end":"2026-08-19T09:21:21.308036Z","steps":["trace[2006409630] 'agreement among raft nodes before linearized reading'  (duration: 134.863741ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:21:21.502707Z","caller":"traceutil/trace.go:171","msg":"trace[214394789] linearizableReadLoop","detail":"{readStateIndex:8724; appliedIndex:8723; }","duration":"194.785744ms","start":"2026-08-19T09:21:21.307896Z","end":"2026-08-19T09:21:21.502682Z","steps":["trace[214394789] 'read index received'  (duration: 152.134478ms)","trace[214394789] 'applied index is now lower than readState.Index'  (duration: 42.650126ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:21:21.503053Z","caller":"traceutil/trace.go:171","msg":"trace[1300659434] transaction","detail":"{read_only:false; response_revision:8427; number_of_response:1; }","duration":"295.823924ms","start":"2026-08-19T09:21:21.20719Z","end":"2026-08-19T09:21:21.503014Z","steps":["trace[1300659434] 'process raft request'  (duration: 252.923063ms)","trace[1300659434] 'compare'  (duration: 41.915583ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T09:21:21.503176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.942106ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/servicemonitors/\" range_end:\"/registry/monitoring.coreos.com/servicemonitors0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-08-19T09:21:21.503311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.598583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:26 size:228443"}
{"level":"info","ts":"2026-08-19T09:21:21.503375Z","caller":"traceutil/trace.go:171","msg":"trace[282918618] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:26; response_revision:8427; }","duration":"191.702586ms","start":"2026-08-19T09:21:21.311659Z","end":"2026-08-19T09:21:21.503362Z","steps":["trace[282918618] 'agreement among raft nodes before linearized reading'  (duration: 191.321499ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:21:21.503318Z","caller":"traceutil/trace.go:171","msg":"trace[2123358918] range","detail":"{range_begin:/registry/monitoring.coreos.com/servicemonitors/; range_end:/registry/monitoring.coreos.com/servicemonitors0; response_count:0; response_revision:8427; }","duration":"196.196181ms","start":"2026-08-19T09:21:21.307101Z","end":"2026-08-19T09:21:21.503297Z","steps":["trace[2123358918] 'agreement among raft nodes before linearized reading'  (duration: 195.872845ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:21:22.1048Z","caller":"traceutil/trace.go:171","msg":"trace[1625413462] transaction","detail":"{read_only:false; response_revision:8429; number_of_response:1; }","duration":"146.252476ms","start":"2026-08-19T09:21:21.958519Z","end":"2026-08-19T09:21:22.104771Z","steps":["trace[1625413462] 'process raft request'  (duration: 146.061792ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:21:22.126713Z","caller":"traceutil/trace.go:171","msg":"trace[1117106422] linearizableReadLoop","detail":"{readStateIndex:8727; appliedIndex:8725; }","duration":"137.284447ms","start":"2026-08-19T09:21:21.989409Z","end":"2026-08-19T09:21:22.126693Z","steps":["trace[1117106422] 'read index received'  (duration: 115.157928ms)","trace[1117106422] 'applied index is now lower than readState.Index'  (duration: 22.125709ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:21:22.126774Z","caller":"traceutil/trace.go:171","msg":"trace[455527440] transaction","detail":"{read_only:false; response_revision:8430; number_of_response:1; }","duration":"140.286683ms","start":"2026-08-19T09:21:21.986453Z","end":"2026-08-19T09:21:22.12674Z","steps":["trace[455527440] 'process raft request'  (duration: 140.12214ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:21:22.126923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.48915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" ","response":"range_response_count:1 size:5146"}
{"level":"info","ts":"2026-08-19T09:21:22.12699Z","caller":"traceutil/trace.go:171","msg":"trace[439542013] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/openstack/ceph; range_end:; response_count:1; response_revision:8430; }","duration":"137.599713ms","start":"2026-08-19T09:21:21.989375Z","end":"2026-08-19T09:21:22.126975Z","steps":["trace[439542013] 'agreement among raft nodes before linearized reading'  (duration: 137.392969ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:21:22.27662Z","caller":"traceutil/trace.go:171","msg":"trace[1604996687] transaction","detail":"{read_only:false; response_revision:8431; number_of_response:1; }","duration":"134.707387ms","start":"2026-08-19T09:21:22.141882Z","end":"2026-08-19T09:21:22.276589Z","steps":["trace[1604996687] 'process raft request'  (duration: 134.364481ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:21:22.434578Z","caller":"traceutil/trace.go:171","msg":"trace[1107912249] linearizableReadLoop","detail":"{readStateIndex:8730; appliedIndex:8728; }","duration":"150.62449ms","start":"2026-08-19T09:21:22.283928Z","end":"2026-08-19T09:21:22.434552Z","steps":["trace[1107912249] 'read index received'  (duration: 18.112684ms)","trace[1107912249] 'applied index is now lower than readState.Index'  (duration: 132.510606ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:21:22.434751Z","caller":"traceutil/trace.go:171","msg":"trace[2043695787] transaction","detail":"{read_only:false; response_revision:8433; number_of_response:1; }","duration":"151.611447ms","start":"2026-08-19T09:21:22.283082Z","end":"2026-08-19T09:21:22.434693Z","steps":["trace[2043695787] 'process raft request'  (duration: 151.309352ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:21:22.43503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.082418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-config-override\" ","response":"range_response_count:1 size:1097"}
{"level":"info","ts":"2026-08-19T09:21:22.435126Z","caller":"traceutil/trace.go:171","msg":"trace[488622194] range","detail":"{range_begin:/registry/configmaps/openstack/rook-config-override; range_end:; response_count:1; response_revision:8433; }","duration":"151.22331ms","start":"2026-08-19T09:21:22.283882Z","end":"2026-08-19T09:21:22.435105Z","steps":["trace[488622194] 'agreement among raft nodes before linearized reading'  (duration: 150.881934ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:22:09.00611Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002407.wal"}
{"level":"info","ts":"2026-08-19T09:23:41.87285Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"a0a01fc7fbf6be45","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-08-19T09:23:41.878377Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-08-19T09:23:41.878482Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-08-19T09:26:10.899376Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8328}
{"level":"info","ts":"2026-08-19T09:26:10.973057Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8328,"took":"71.169995ms","hash":1067171609,"current-db-size-bytes":57520128,"current-db-size":"58 MB","current-db-size-in-use-bytes":26542080,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-08-19T09:26:10.97312Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1067171609,"revision":8328,"compact-revision":6108}
{"level":"info","ts":"2026-08-19T09:31:10.91256Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10992}
{"level":"info","ts":"2026-08-19T09:31:10.994461Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10992,"took":"78.946066ms","hash":2414238306,"current-db-size-bytes":57520128,"current-db-size":"58 MB","current-db-size-in-use-bytes":27705344,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-08-19T09:31:10.994537Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2414238306,"revision":10992,"compact-revision":8328}
{"level":"info","ts":"2026-08-19T09:32:04.297377Z","caller":"traceutil/trace.go:171","msg":"trace[1015771477] transaction","detail":"{read_only:false; response_revision:13411; number_of_response:1; }","duration":"120.32253ms","start":"2026-08-19T09:32:04.177015Z","end":"2026-08-19T09:32:04.297337Z","steps":["trace[1015771477] 'process raft request'  (duration: 119.682668ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:32:40.998652Z","caller":"traceutil/trace.go:171","msg":"trace[294613313] transaction","detail":"{read_only:false; response_revision:13620; number_of_response:1; }","duration":"214.261368ms","start":"2026-08-19T09:32:40.784376Z","end":"2026-08-19T09:32:40.998637Z","steps":["trace[294613313] 'process raft request'  (duration: 214.099855ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:32:40.998796Z","caller":"traceutil/trace.go:171","msg":"trace[2069630084] linearizableReadLoop","detail":"{readStateIndex:14084; appliedIndex:14083; }","duration":"176.833496ms","start":"2026-08-19T09:32:40.821761Z","end":"2026-08-19T09:32:40.998595Z","steps":["trace[2069630084] 'read index received'  (duration: 176.599682ms)","trace[2069630084] 'applied index is now lower than readState.Index'  (duration: 233.204µs)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T09:32:40.998887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.107811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/openvswitch-2cb2w\" ","response":"range_response_count:1 size:12360"}
{"level":"warn","ts":"2026-08-19T09:32:40.998946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.7317ms","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-19T09:32:40.998953Z","caller":"traceutil/trace.go:171","msg":"trace[723031411] range","detail":"{range_begin:/registry/pods/openstack/openvswitch-2cb2w; range_end:; response_count:1; response_revision:13620; }","duration":"177.222064ms","start":"2026-08-19T09:32:40.821718Z","end":"2026-08-19T09:32:40.99894Z","steps":["trace[723031411] 'agreement among raft nodes before linearized reading'  (duration: 177.0131ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:32:40.998973Z","caller":"traceutil/trace.go:171","msg":"trace[883730561] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:13620; }","duration":"170.780971ms","start":"2026-08-19T09:32:40.828183Z","end":"2026-08-19T09:32:40.998964Z","steps":["trace[883730561] 'agreement among raft nodes before linearized reading'  (duration: 170.665739ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:32:50.109295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.777759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/ovn-northd-6c6687ddd6-btbbj\" ","response":"range_response_count:1 size:7041"}
{"level":"info","ts":"2026-08-19T09:32:50.109426Z","caller":"traceutil/trace.go:171","msg":"trace[1954264065] range","detail":"{range_begin:/registry/pods/openstack/ovn-northd-6c6687ddd6-btbbj; range_end:; response_count:1; response_revision:13781; }","duration":"162.956663ms","start":"2026-08-19T09:32:49.946442Z","end":"2026-08-19T09:32:50.109399Z","steps":["trace[1954264065] 'range keys from in-memory index tree'  (duration: 162.542914ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:32:50.324533Z","caller":"traceutil/trace.go:171","msg":"trace[1605697936] transaction","detail":"{read_only:false; response_revision:13783; number_of_response:1; }","duration":"211.314942ms","start":"2026-08-19T09:32:50.113169Z","end":"2026-08-19T09:32:50.324484Z","steps":["trace[1605697936] 'process raft request'  (duration: 205.774027ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:32:50.324564Z","caller":"traceutil/trace.go:171","msg":"trace[1820041523] transaction","detail":"{read_only:false; response_revision:13784; number_of_response:1; }","duration":"211.354353ms","start":"2026-08-19T09:32:50.113179Z","end":"2026-08-19T09:32:50.324533Z","steps":["trace[1820041523] 'process raft request'  (duration: 211.220351ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:32:50.324688Z","caller":"traceutil/trace.go:171","msg":"trace[909052432] transaction","detail":"{read_only:false; response_revision:13785; number_of_response:1; }","duration":"204.93317ms","start":"2026-08-19T09:32:50.119726Z","end":"2026-08-19T09:32:50.324659Z","steps":["trace[909052432] 'process raft request'  (duration: 204.761337ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:34:26.916034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-9kkcw\" ","response":"range_response_count:1 size:22121"}
{"level":"info","ts":"2026-08-19T09:34:26.916123Z","caller":"traceutil/trace.go:171","msg":"trace[84656327] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-9kkcw; range_end:; response_count:1; response_revision:14852; }","duration":"101.506623ms","start":"2026-08-19T09:34:26.814598Z","end":"2026-08-19T09:34:26.916104Z","steps":["trace[84656327] 'range keys from in-memory index tree'  (duration: 100.727337ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:36:10.91957Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":13030}
{"level":"info","ts":"2026-08-19T09:36:11.005196Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":13030,"took":"81.947147ms","hash":1300554796,"current-db-size-bytes":57520128,"current-db-size":"58 MB","current-db-size-in-use-bytes":31469568,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-08-19T09:36:11.005261Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1300554796,"revision":13030,"compact-revision":10992}
{"level":"warn","ts":"2026-08-19T09:38:10.471337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.735225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/neutron-ks-endpoints\" ","response":"range_response_count:1 size:12632"}
{"level":"info","ts":"2026-08-19T09:38:10.471421Z","caller":"traceutil/trace.go:171","msg":"trace[623069329] range","detail":"{range_begin:/registry/jobs/openstack/neutron-ks-endpoints; range_end:; response_count:1; response_revision:16619; }","duration":"273.860297ms","start":"2026-08-19T09:38:10.197547Z","end":"2026-08-19T09:38:10.471407Z","steps":["trace[623069329] 'range keys from in-memory index tree'  (duration: 273.546241ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:38:10.473424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.393977ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13710540670997513503 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:16598 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-19T09:38:10.473573Z","caller":"traceutil/trace.go:171","msg":"trace[123895920] linearizableReadLoop","detail":"{readStateIndex:17176; appliedIndex:17175; }","duration":"275.921606ms","start":"2026-08-19T09:38:10.197628Z","end":"2026-08-19T09:38:10.47355Z","steps":["trace[123895920] 'read index received'  (duration: 112.995199ms)","trace[123895920] 'applied index is now lower than readState.Index'  (duration: 162.924987ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:38:10.473631Z","caller":"traceutil/trace.go:171","msg":"trace[668119685] transaction","detail":"{read_only:false; response_revision:16620; number_of_response:1; }","duration":"275.998877ms","start":"2026-08-19T09:38:10.197582Z","end":"2026-08-19T09:38:10.47358Z","steps":["trace[668119685] 'process raft request'  (duration: 113.092711ms)","trace[668119685] 'compare'  (duration: 161.300836ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T09:38:10.473653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.038608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/neutron-ks-user\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-19T09:38:10.47368Z","caller":"traceutil/trace.go:171","msg":"trace[227658404] range","detail":"{range_begin:/registry/jobs/openstack/neutron-ks-user; range_end:; response_count:0; response_revision:16620; }","duration":"276.111419ms","start":"2026-08-19T09:38:10.19756Z","end":"2026-08-19T09:38:10.473671Z","steps":["trace[227658404] 'agreement among raft nodes before linearized reading'  (duration: 276.050348ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:40:51.364562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.39333ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13710540670997517778 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/openstack/heat-ks-endpoints-9rmjj.18cd2b7ee56cbefb\" mod_revision:0 > success:<request_put:<key:\"/registry/events/openstack/heat-ks-endpoints-9rmjj.18cd2b7ee56cbefb\" value_size:685 lease:4487168634142740746 >> failure:<>>","response":"size:18"}
{"level":"info","ts":"2026-08-19T09:40:51.364666Z","caller":"traceutil/trace.go:171","msg":"trace[805428416] linearizableReadLoop","detail":"{readStateIndex:18664; appliedIndex:18663; }","duration":"201.09995ms","start":"2026-08-19T09:40:51.163551Z","end":"2026-08-19T09:40:51.36465Z","steps":["trace[805428416] 'read index received'  (duration: 23.513977ms)","trace[805428416] 'applied index is now lower than readState.Index'  (duration: 177.584413ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:40:51.364952Z","caller":"traceutil/trace.go:171","msg":"trace[2063476367] transaction","detail":"{read_only:false; response_revision:18065; number_of_response:1; }","duration":"212.287442ms","start":"2026-08-19T09:40:51.15265Z","end":"2026-08-19T09:40:51.364938Z","steps":["trace[2063476367] 'process raft request'  (duration: 34.450504ms)","trace[2063476367] 'compare'  (duration: 177.121515ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T09:40:51.365096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.09161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/heat-ks-user\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-19T09:40:51.365178Z","caller":"traceutil/trace.go:171","msg":"trace[1161544619] range","detail":"{range_begin:/registry/jobs/openstack/heat-ks-user; range_end:; response_count:0; response_revision:18065; }","duration":"201.182941ms","start":"2026-08-19T09:40:51.163978Z","end":"2026-08-19T09:40:51.365161Z","steps":["trace[1161544619] 'agreement among raft nodes before linearized reading'  (duration: 201.007808ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:40:51.365285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.656118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectrealms/\" range_end:\"/registry/ceph.rook.io/cephobjectrealms0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-19T09:40:51.365361Z","caller":"traceutil/trace.go:171","msg":"trace[160867004] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectrealms/; range_end:/registry/ceph.rook.io/cephobjectrealms0; response_count:0; response_revision:18065; }","duration":"123.74246ms","start":"2026-08-19T09:40:51.241576Z","end":"2026-08-19T09:40:51.365318Z","steps":["trace[160867004] 'agreement among raft nodes before linearized reading'  (duration: 123.654839ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:40:51.365412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.721748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/heat-ks-endpoints\" ","response":"range_response_count:1 size:21462"}
{"level":"info","ts":"2026-08-19T09:40:51.365479Z","caller":"traceutil/trace.go:171","msg":"trace[2002973352] range","detail":"{range_begin:/registry/jobs/openstack/heat-ks-endpoints; range_end:; response_count:1; response_revision:18065; }","duration":"195.796439ms","start":"2026-08-19T09:40:51.169668Z","end":"2026-08-19T09:40:51.365465Z","steps":["trace[2002973352] 'agreement among raft nodes before linearized reading'  (duration: 195.608306ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:40:51.365512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.946146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/heat-domain-ks-user\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-19T09:40:51.365598Z","caller":"traceutil/trace.go:171","msg":"trace[1219421705] range","detail":"{range_begin:/registry/jobs/openstack/heat-domain-ks-user; range_end:; response_count:0; response_revision:18065; }","duration":"202.066877ms","start":"2026-08-19T09:40:51.163511Z","end":"2026-08-19T09:40:51.365578Z","steps":["trace[1219421705] 'agreement among raft nodes before linearized reading'  (duration: 201.954785ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:41:10.925588Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15595}
{"level":"info","ts":"2026-08-19T09:41:11.024738Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15595,"took":"95.713948ms","hash":3971786109,"current-db-size-bytes":57520128,"current-db-size":"58 MB","current-db-size-in-use-bytes":34717696,"current-db-size-in-use":"35 MB"}
{"level":"info","ts":"2026-08-19T09:41:11.025004Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3971786109,"revision":15595,"compact-revision":13030}
{"level":"info","ts":"2026-08-19T09:43:49.455815Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"a0a01fc7fbf6be45","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-08-19T09:43:49.460401Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-08-19T09:43:49.460581Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-08-19T09:44:30.875019Z","caller":"traceutil/trace.go:171","msg":"trace[1985403570] transaction","detail":"{read_only:false; response_revision:19568; number_of_response:1; }","duration":"237.531598ms","start":"2026-08-19T09:44:30.637467Z","end":"2026-08-19T09:44:30.874998Z","steps":["trace[1985403570] 'process raft request'  (duration: 237.375495ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:44:31.170864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.006852ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13710540670997522150 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:19557 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-19T09:44:31.170984Z","caller":"traceutil/trace.go:171","msg":"trace[493053341] linearizableReadLoop","detail":"{readStateIndex:20223; appliedIndex:20221; }","duration":"500.649323ms","start":"2026-08-19T09:44:30.670317Z","end":"2026-08-19T09:44:31.170967Z","steps":["trace[493053341] 'read index received'  (duration: 204.547451ms)","trace[493053341] 'applied index is now lower than readState.Index'  (duration: 296.100402ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:44:31.171016Z","caller":"traceutil/trace.go:171","msg":"trace[1383414554] transaction","detail":"{read_only:false; response_revision:19569; number_of_response:1; }","duration":"532.072921ms","start":"2026-08-19T09:44:30.638912Z","end":"2026-08-19T09:44:31.170985Z","steps":["trace[1383414554] 'process raft request'  (duration: 380.839754ms)","trace[1383414554] 'compare'  (duration: 150.546004ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T09:44:31.171277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"500.943598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-cinder-server-0\" ","response":"range_response_count:1 size:1858"}
{"level":"warn","ts":"2026-08-19T09:44:31.171319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:44:30.638893Z","time spent":"532.244233ms","remote":"127.0.0.1:36292","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:19557 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-08-19T09:44:31.171361Z","caller":"traceutil/trace.go:171","msg":"trace[1482279264] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-cinder-server-0; range_end:; response_count:1; response_revision:19569; }","duration":"501.07239ms","start":"2026-08-19T09:44:30.670267Z","end":"2026-08-19T09:44:31.171339Z","steps":["trace[1482279264] 'agreement among raft nodes before linearized reading'  (duration: 500.848356ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:44:31.171407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:44:30.670248Z","time spent":"501.150132ms","remote":"127.0.0.1:36168","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":1,"response size":1882,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-cinder-server-0\" "}
{"level":"info","ts":"2026-08-19T09:44:31.177702Z","caller":"traceutil/trace.go:171","msg":"trace[1555545197] transaction","detail":"{read_only:false; response_revision:19570; number_of_response:1; }","duration":"230.055256ms","start":"2026-08-19T09:44:30.947627Z","end":"2026-08-19T09:44:31.177682Z","steps":["trace[1555545197] 'process raft request'  (duration: 229.806171ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:44:31.177788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.818323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbucketnotifications/\" range_end:\"/registry/ceph.rook.io/cephbucketnotifications0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-19T09:44:31.177832Z","caller":"traceutil/trace.go:171","msg":"trace[343753638] range","detail":"{range_begin:/registry/ceph.rook.io/cephbucketnotifications/; range_end:/registry/ceph.rook.io/cephbucketnotifications0; response_count:0; response_revision:19571; }","duration":"359.917825ms","start":"2026-08-19T09:44:30.817904Z","end":"2026-08-19T09:44:31.177822Z","steps":["trace[343753638] 'agreement among raft nodes before linearized reading'  (duration: 359.831254ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:44:31.177855Z","caller":"traceutil/trace.go:171","msg":"trace[574133679] transaction","detail":"{read_only:false; response_revision:19571; number_of_response:1; }","duration":"196.991417ms","start":"2026-08-19T09:44:30.980815Z","end":"2026-08-19T09:44:31.177806Z","steps":["trace[574133679] 'process raft request'  (duration: 196.760483ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:44:31.177888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:44:30.817882Z","time spent":"359.995086ms","remote":"127.0.0.1:38854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":30,"request content":"key:\"/registry/ceph.rook.io/cephbucketnotifications/\" range_end:\"/registry/ceph.rook.io/cephbucketnotifications0\" count_only:true "}
{"level":"info","ts":"2026-08-19T09:44:31.342671Z","caller":"traceutil/trace.go:171","msg":"trace[1389569212] transaction","detail":"{read_only:false; response_revision:19572; number_of_response:1; }","duration":"160.256548ms","start":"2026-08-19T09:44:31.182383Z","end":"2026-08-19T09:44:31.34264Z","steps":["trace[1389569212] 'process raft request'  (duration: 133.901227ms)","trace[1389569212] 'compare'  (duration: 26.220019ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:44:31.738944Z","caller":"traceutil/trace.go:171","msg":"trace[669100361] linearizableReadLoop","detail":"{readStateIndex:20227; appliedIndex:20226; }","duration":"100.621984ms","start":"2026-08-19T09:44:31.638298Z","end":"2026-08-19T09:44:31.73892Z","steps":["trace[669100361] 'read index received'  (duration: 100.41115ms)","trace[669100361] 'applied index is now lower than readState.Index'  (duration: 210.004µs)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:44:31.739064Z","caller":"traceutil/trace.go:171","msg":"trace[223306446] transaction","detail":"{read_only:false; response_revision:19573; number_of_response:1; }","duration":"130.994402ms","start":"2026-08-19T09:44:31.608037Z","end":"2026-08-19T09:44:31.739031Z","steps":["trace[223306446] 'process raft request'  (duration: 130.727277ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:44:31.739452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.109773ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"info","ts":"2026-08-19T09:44:31.739498Z","caller":"traceutil/trace.go:171","msg":"trace[1071025882] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:19573; }","duration":"101.224636ms","start":"2026-08-19T09:44:31.638252Z","end":"2026-08-19T09:44:31.739477Z","steps":["trace[1071025882] 'agreement among raft nodes before linearized reading'  (duration: 100.782617ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:44:31.979111Z","caller":"traceutil/trace.go:171","msg":"trace[1589146938] transaction","detail":"{read_only:false; response_revision:19574; number_of_response:1; }","duration":"235.940967ms","start":"2026-08-19T09:44:31.743134Z","end":"2026-08-19T09:44:31.979075Z","steps":["trace[1589146938] 'process raft request'  (duration: 160.443171ms)","trace[1589146938] 'compare'  (duration: 75.13329ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:44:31.97913Z","caller":"traceutil/trace.go:171","msg":"trace[46816593] transaction","detail":"{read_only:false; response_revision:19575; number_of_response:1; }","duration":"235.141462ms","start":"2026-08-19T09:44:31.743962Z","end":"2026-08-19T09:44:31.979104Z","steps":["trace[46816593] 'process raft request'  (duration: 234.972119ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:44:31.97954Z","caller":"traceutil/trace.go:171","msg":"trace[408071852] linearizableReadLoop","detail":"{readStateIndex:20229; appliedIndex:20227; }","duration":"168.548817ms","start":"2026-08-19T09:44:31.810964Z","end":"2026-08-19T09:44:31.979512Z","steps":["trace[408071852] 'read index received'  (duration: 92.642922ms)","trace[408071852] 'applied index is now lower than readState.Index'  (duration: 75.904775ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T09:44:31.979747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.74243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-08-19T09:44:31.97979Z","caller":"traceutil/trace.go:171","msg":"trace[754185103] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:19576; }","duration":"168.854882ms","start":"2026-08-19T09:44:31.810922Z","end":"2026-08-19T09:44:31.979777Z","steps":["trace[754185103] 'agreement among raft nodes before linearized reading'  (duration: 168.693669ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:44:31.979818Z","caller":"traceutil/trace.go:171","msg":"trace[1195151834] transaction","detail":"{read_only:false; response_revision:19576; number_of_response:1; }","duration":"125.069649ms","start":"2026-08-19T09:44:31.854695Z","end":"2026-08-19T09:44:31.979765Z","steps":["trace[1195151834] 'process raft request'  (duration: 124.364835ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:44:32.464565Z","caller":"traceutil/trace.go:171","msg":"trace[19012686] transaction","detail":"{read_only:false; response_revision:19578; number_of_response:1; }","duration":"265.158474ms","start":"2026-08-19T09:44:32.199375Z","end":"2026-08-19T09:44:32.464533Z","steps":["trace[19012686] 'process raft request'  (duration: 177.872483ms)","trace[19012686] 'compare'  (duration: 87.156098ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:46:10.931698Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":18214}
{"level":"info","ts":"2026-08-19T09:46:11.042227Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":18214,"took":"106.663579ms","hash":4170797000,"current-db-size-bytes":57520128,"current-db-size":"58 MB","current-db-size-in-use-bytes":30302208,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-08-19T09:46:11.042317Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4170797000,"revision":18214,"compact-revision":15595}
{"level":"info","ts":"2026-08-19T09:48:06.963982Z","caller":"traceutil/trace.go:171","msg":"trace[338151957] transaction","detail":"{read_only:false; response_revision:21921; number_of_response:1; }","duration":"110.026492ms","start":"2026-08-19T09:48:06.85392Z","end":"2026-08-19T09:48:06.963947Z","steps":["trace[338151957] 'process raft request'  (duration: 109.468892ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:48:07.300424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.315859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-08-19T09:48:07.30051Z","caller":"traceutil/trace.go:171","msg":"trace[1742035081] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:21923; }","duration":"191.460652ms","start":"2026-08-19T09:48:07.10903Z","end":"2026-08-19T09:48:07.300491Z","steps":["trace[1742035081] 'count revisions from in-memory index tree'  (duration: 191.217476ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:51:10.940626Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20459}
{"level":"info","ts":"2026-08-19T09:51:11.049584Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20459,"took":"105.085948ms","hash":813532059,"current-db-size-bytes":58363904,"current-db-size":"58 MB","current-db-size-in-use-bytes":43245568,"current-db-size-in-use":"43 MB"}
{"level":"info","ts":"2026-08-19T09:51:11.049647Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":813532059,"revision":20459,"compact-revision":18214}
{"level":"info","ts":"2026-08-19T09:56:10.946627Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23601}
{"level":"info","ts":"2026-08-19T09:56:11.080731Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23601,"took":"130.60095ms","hash":2058731483,"current-db-size-bytes":58363904,"current-db-size":"58 MB","current-db-size-in-use-bytes":29974528,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-08-19T09:56:11.080797Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2058731483,"revision":23601,"compact-revision":20459}