{"level":"warn","ts":"2026-08-06T00:57:54.250144Z","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-06T00:57:54.250234Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.205: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.205:2380","--initial-cluster=instance=https://199.19.213.205:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.205:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.205: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-06T00:57:54.250411Z","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-06T00:57:54.250448Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.205:2380"]}
{"level":"info","ts":"2026-08-06T00:57:54.250521Z","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-06T00:57:54.251306Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.205:2379"]}
{"level":"info","ts":"2026-08-06T00:57:54.251997Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.205:2380"],"listen-peer-urls":["https://199.19.213.205:2380"],"advertise-client-urls":["https://199.19.213.205:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.205:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.205: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-06T00:57:54.256434Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.17964ms"}
{"level":"info","ts":"2026-08-06T00:57:54.26514Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f69f598a0f963672","cluster-id":"740466542a91995c"}
{"level":"info","ts":"2026-08-06T00:57:54.265213Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f69f598a0f963672 switched to configuration voters=()"}
{"level":"info","ts":"2026-08-06T00:57:54.265235Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f69f598a0f963672 became follower at term 0"}
{"level":"info","ts":"2026-08-06T00:57:54.265248Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f69f598a0f963672 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-08-06T00:57:54.265257Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f69f598a0f963672 became follower at term 1"}
{"level":"info","ts":"2026-08-06T00:57:54.265323Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f69f598a0f963672 switched to configuration voters=(17771021104129128050)"}
{"level":"warn","ts":"2026-08-06T00:57:54.277401Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-08-06T00:57:54.278857Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-08-06T00:57:54.280273Z","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-06T00:57:54.282177Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f69f598a0f963672","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-08-06T00:57:54.282971Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f69f598a0f963672","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-08-06T00:57:54.283248Z","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-06T00:57:54.283286Z","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-06T00:57:54.283298Z","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-06T00:57:54.285361Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f69f598a0f963672 switched to configuration voters=(17771021104129128050)"}
{"level":"info","ts":"2026-08-06T00:57:54.285463Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"740466542a91995c","local-member-id":"f69f598a0f963672","added-peer-id":"f69f598a0f963672","added-peer-peer-urls":["https://199.19.213.205:2380"]}
{"level":"info","ts":"2026-08-06T00:57:54.287668Z","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-06T00:57:54.287917Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f69f598a0f963672","initial-advertise-peer-urls":["https://199.19.213.205:2380"],"listen-peer-urls":["https://199.19.213.205:2380"],"advertise-client-urls":["https://199.19.213.205:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.205:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-08-06T00:57:54.287962Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-08-06T00:57:54.288117Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.205:2380"}
{"level":"info","ts":"2026-08-06T00:57:54.288133Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.205:2380"}
{"level":"info","ts":"2026-08-06T00:57:54.766114Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f69f598a0f963672 is starting a new election at term 1"}
{"level":"info","ts":"2026-08-06T00:57:54.766173Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f69f598a0f963672 became pre-candidate at term 1"}
{"level":"info","ts":"2026-08-06T00:57:54.76621Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f69f598a0f963672 received MsgPreVoteResp from f69f598a0f963672 at term 1"}
{"level":"info","ts":"2026-08-06T00:57:54.766234Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f69f598a0f963672 became candidate at term 2"}
{"level":"info","ts":"2026-08-06T00:57:54.76625Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f69f598a0f963672 received MsgVoteResp from f69f598a0f963672 at term 2"}
{"level":"info","ts":"2026-08-06T00:57:54.766277Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f69f598a0f963672 became leader at term 2"}
{"level":"info","ts":"2026-08-06T00:57:54.766296Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f69f598a0f963672 elected leader f69f598a0f963672 at term 2"}
{"level":"info","ts":"2026-08-06T00:57:54.767399Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f69f598a0f963672","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.205:2379]}","request-path":"/0/members/f69f598a0f963672/attributes","cluster-id":"740466542a91995c","publish-timeout":"7s"}
{"level":"info","ts":"2026-08-06T00:57:54.767414Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-08-06T00:57:54.76745Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-06T00:57:54.767673Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-08-06T00:57:54.768072Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-08-06T00:57:54.768124Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-08-06T00:57:54.768527Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"740466542a91995c","local-member-id":"f69f598a0f963672","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-06T00:57:54.768715Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-06T00:57:54.768786Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-06T00:57:54.771496Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-08-06T00:57:54.771848Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.205:2379"}
{"level":"info","ts":"2026-08-06T00:58:30.171459Z","caller":"traceutil/trace.go:171","msg":"trace[114522092] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"108.425679ms","start":"2026-08-06T00:58:30.062448Z","end":"2026-08-06T00:58:30.170874Z","steps":["trace[114522092] 'process raft request'  (duration: 67.596934ms)","trace[114522092] 'compare'  (duration: 40.632968ms)"],"step_count":2}
{"level":"info","ts":"2026-08-06T00:58:30.198551Z","caller":"traceutil/trace.go:171","msg":"trace[876763674] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"124.09676ms","start":"2026-08-06T00:58:30.074425Z","end":"2026-08-06T00:58:30.198522Z","steps":["trace[876763674] 'process raft request'  (duration: 122.988904ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T00:58:30.198789Z","caller":"traceutil/trace.go:171","msg":"trace[464429307] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"105.159101ms","start":"2026-08-06T00:58:30.093569Z","end":"2026-08-06T00:58:30.198728Z","steps":["trace[464429307] 'process raft request'  (duration: 104.090436ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T00:58:37.777538Z","caller":"traceutil/trace.go:171","msg":"trace[1328048244] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"167.629898ms","start":"2026-08-06T00:58:37.609885Z","end":"2026-08-06T00:58:37.777515Z","steps":["trace[1328048244] 'process raft request'  (duration: 167.164493ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T00:58:37.945744Z","caller":"traceutil/trace.go:171","msg":"trace[1826354094] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"111.366933ms","start":"2026-08-06T00:58:37.834318Z","end":"2026-08-06T00:58:37.945685Z","steps":["trace[1826354094] 'process raft request'  (duration: 104.821608ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T00:58:38.737445Z","caller":"traceutil/trace.go:171","msg":"trace[553382651] linearizableReadLoop","detail":"{readStateIndex:662; appliedIndex:661; }","duration":"250.746532ms","start":"2026-08-06T00:58:38.486675Z","end":"2026-08-06T00:58:38.737422Z","steps":["trace[553382651] 'read index received'  (duration: 250.099423ms)","trace[553382651] 'applied index is now lower than readState.Index'  (duration: 646.389µs)"],"step_count":2}
{"level":"warn","ts":"2026-08-06T00:58:38.737673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.929848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-06T00:58:38.737769Z","caller":"traceutil/trace.go:171","msg":"trace[1043467068] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:635; }","duration":"251.137274ms","start":"2026-08-06T00:58:38.486612Z","end":"2026-08-06T00:58:38.737749Z","steps":["trace[1043467068] 'agreement among raft nodes before linearized reading'  (duration: 250.920068ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T00:58:38.738218Z","caller":"traceutil/trace.go:171","msg":"trace[1321062912] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"323.42743ms","start":"2026-08-06T00:58:38.414776Z","end":"2026-08-06T00:58:38.738204Z","steps":["trace[1321062912] 'process raft request'  (duration: 322.225592ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-06T00:58:38.738891Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T00:58:38.414694Z","time spent":"323.549404ms","remote":"127.0.0.1:58234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" mod_revision:629 > success:<request_put:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" value_size:1036201 >> failure:<request_range:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" > >"}
{"level":"warn","ts":"2026-08-06T00:58:54.279324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.471989ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3923373960752226225 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:787 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-06T00:58:54.279453Z","caller":"traceutil/trace.go:171","msg":"trace[1748865976] transaction","detail":"{read_only:false; response_revision:801; number_of_response:1; }","duration":"249.069287ms","start":"2026-08-06T00:58:54.030362Z","end":"2026-08-06T00:58:54.279431Z","steps":["trace[1748865976] 'process raft request'  (duration: 104.149065ms)","trace[1748865976] 'compare'  (duration: 144.283565ms)"],"step_count":2}
{"level":"info","ts":"2026-08-06T01:00:28.862063Z","caller":"traceutil/trace.go:171","msg":"trace[751230780] transaction","detail":"{read_only:false; response_revision:2004; number_of_response:1; }","duration":"229.087783ms","start":"2026-08-06T01:00:28.632947Z","end":"2026-08-06T01:00:28.862035Z","steps":["trace[751230780] 'process raft request'  (duration: 160.725768ms)","trace[751230780] 'compare'  (duration: 68.205642ms)"],"step_count":2}
{"level":"info","ts":"2026-08-06T01:00:55.365793Z","caller":"traceutil/trace.go:171","msg":"trace[1163705768] transaction","detail":"{read_only:false; response_revision:2160; number_of_response:1; }","duration":"341.295604ms","start":"2026-08-06T01:00:55.024454Z","end":"2026-08-06T01:00:55.365749Z","steps":["trace[1163705768] 'process raft request'  (duration: 340.917498ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-06T01:00:55.366063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:00:55.024426Z","time spent":"341.511156ms","remote":"127.0.0.1:58400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:2149 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-08-06T01:00:55.520063Z","caller":"traceutil/trace.go:171","msg":"trace[1225294269] transaction","detail":"{read_only:false; response_revision:2161; number_of_response:1; }","duration":"356.145109ms","start":"2026-08-06T01:00:55.163873Z","end":"2026-08-06T01:00:55.520018Z","steps":["trace[1225294269] 'process raft request'  (duration: 280.848244ms)","trace[1225294269] 'compare'  (duration: 74.916459ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-06T01:00:55.520263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:00:55.16385Z","time spent":"356.306302ms","remote":"127.0.0.1:58400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:2151 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-08-06T01:00:55.520703Z","caller":"traceutil/trace.go:171","msg":"trace[290780260] linearizableReadLoop","detail":"{readStateIndex:2244; appliedIndex:2241; }","duration":"314.587921ms","start":"2026-08-06T01:00:55.206094Z","end":"2026-08-06T01:00:55.520682Z","steps":["trace[290780260] 'read index received'  (duration: 159.319587ms)","trace[290780260] 'applied index is now lower than readState.Index'  (duration: 155.266264ms)"],"step_count":2}
{"level":"info","ts":"2026-08-06T01:00:55.520677Z","caller":"traceutil/trace.go:171","msg":"trace[1507166767] transaction","detail":"{read_only:false; response_revision:2162; number_of_response:1; }","duration":"345.139185ms","start":"2026-08-06T01:00:55.175509Z","end":"2026-08-06T01:00:55.520648Z","steps":["trace[1507166767] 'process raft request'  (duration: 344.431623ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-06T01:00:55.520868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:00:55.175496Z","time spent":"345.326648ms","remote":"127.0.0.1:58224","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":820,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/openstack/percona-xtradb-pxc-0.18c911942334c549\" mod_revision:0 > success:<request_put:<key:\"/registry/events/openstack/percona-xtradb-pxc-0.18c911942334c549\" value_size:738 lease:3923373960752227833 >> failure:<>"}
{"level":"warn","ts":"2026-08-06T01:00:55.520892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.796904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"}
{"level":"info","ts":"2026-08-06T01:00:55.520944Z","caller":"traceutil/trace.go:171","msg":"trace[1576683775] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2163; }","duration":"314.885275ms","start":"2026-08-06T01:00:55.206041Z","end":"2026-08-06T01:00:55.520927Z","steps":["trace[1576683775] 'agreement among raft nodes before linearized reading'  (duration: 314.701492ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-06T01:00:55.520993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:00:55.206026Z","time spent":"314.954357ms","remote":"127.0.0.1:58400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":577,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"info","ts":"2026-08-06T01:00:55.706214Z","caller":"traceutil/trace.go:171","msg":"trace[377326993] linearizableReadLoop","detail":"{readStateIndex:2246; appliedIndex:2245; }","duration":"150.433286ms","start":"2026-08-06T01:00:55.555742Z","end":"2026-08-06T01:00:55.706176Z","steps":["trace[377326993] 'read index received'  (duration: 132.690865ms)","trace[377326993] 'applied index is now lower than readState.Index'  (duration: 17.740991ms)"],"step_count":2}
{"level":"info","ts":"2026-08-06T01:00:55.706359Z","caller":"traceutil/trace.go:171","msg":"trace[902755145] transaction","detail":"{read_only:false; response_revision:2164; number_of_response:1; }","duration":"175.542914ms","start":"2026-08-06T01:00:55.530752Z","end":"2026-08-06T01:00:55.706295Z","steps":["trace[902755145] 'process raft request'  (duration: 157.721761ms)","trace[902755145] 'compare'  (duration: 17.57896ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-06T01:00:55.706564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.041876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"warn","ts":"2026-08-06T01:00:55.706603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.817952ms","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-06T01:00:55.706691Z","caller":"traceutil/trace.go:171","msg":"trace[916915501] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2164; }","duration":"117.229549ms","start":"2026-08-06T01:00:55.589442Z","end":"2026-08-06T01:00:55.706672Z","steps":["trace[916915501] 'agreement among raft nodes before linearized reading'  (duration: 116.932515ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:00:55.706792Z","caller":"traceutil/trace.go:171","msg":"trace[1118966723] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2164; }","duration":"151.068876ms","start":"2026-08-06T01:00:55.555694Z","end":"2026-08-06T01:00:55.706763Z","steps":["trace[1118966723] 'agreement among raft nodes before linearized reading'  (duration: 150.625389ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-06T01:00:55.706687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.745318ms","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-06T01:00:55.706914Z","caller":"traceutil/trace.go:171","msg":"trace[1804754986] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2164; }","duration":"101.025502ms","start":"2026-08-06T01:00:55.605876Z","end":"2026-08-06T01:00:55.706901Z","steps":["trace[1804754986] 'agreement among raft nodes before linearized reading'  (duration: 100.554344ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:01:59.861659Z","caller":"traceutil/trace.go:171","msg":"trace[919756893] transaction","detail":"{read_only:false; response_revision:2609; number_of_response:1; }","duration":"176.315006ms","start":"2026-08-06T01:01:59.685305Z","end":"2026-08-06T01:01:59.86162Z","steps":["trace[919756893] 'process raft request'  (duration: 176.102793ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:01:59.893674Z","caller":"traceutil/trace.go:171","msg":"trace[60361659] transaction","detail":"{read_only:false; response_revision:2610; number_of_response:1; }","duration":"121.705809ms","start":"2026-08-06T01:01:59.771929Z","end":"2026-08-06T01:01:59.893635Z","steps":["trace[60361659] 'process raft request'  (duration: 121.427165ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:01:59.893997Z","caller":"traceutil/trace.go:171","msg":"trace[1364970753] transaction","detail":"{read_only:false; response_revision:2611; number_of_response:1; }","duration":"121.80922ms","start":"2026-08-06T01:01:59.772141Z","end":"2026-08-06T01:01:59.893951Z","steps":["trace[1364970753] 'process raft request'  (duration: 121.435745ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:05:08.416422Z","caller":"traceutil/trace.go:171","msg":"trace[1693106669] transaction","detail":"{read_only:false; response_revision:3700; number_of_response:1; }","duration":"155.306624ms","start":"2026-08-06T01:05:08.261088Z","end":"2026-08-06T01:05:08.416394Z","steps":["trace[1693106669] 'process raft request'  (duration: 86.950212ms)","trace[1693106669] 'compare'  (duration: 68.217639ms)"],"step_count":2}
{"level":"info","ts":"2026-08-06T01:05:08.690016Z","caller":"traceutil/trace.go:171","msg":"trace[891995816] transaction","detail":"{read_only:false; response_revision:3701; number_of_response:1; }","duration":"146.187473ms","start":"2026-08-06T01:05:08.543792Z","end":"2026-08-06T01:05:08.68998Z","steps":["trace[891995816] 'process raft request'  (duration: 143.721234ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:05:08.690072Z","caller":"traceutil/trace.go:171","msg":"trace[147161820] transaction","detail":"{read_only:false; response_revision:3702; number_of_response:1; }","duration":"114.242616ms","start":"2026-08-06T01:05:08.575803Z","end":"2026-08-06T01:05:08.690046Z","steps":["trace[147161820] 'process raft request'  (duration: 114.098944ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-06T01:05:27.37944Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3923373960752233294,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-08-06T01:05:27.547177Z","caller":"traceutil/trace.go:171","msg":"trace[923781197] transaction","detail":"{read_only:false; response_revision:3799; number_of_response:1; }","duration":"791.16242ms","start":"2026-08-06T01:05:26.75597Z","end":"2026-08-06T01:05:27.547132Z","steps":["trace[923781197] 'process raft request'  (duration: 789.439897ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:05:27.547314Z","caller":"traceutil/trace.go:171","msg":"trace[1175280071] transaction","detail":"{read_only:false; response_revision:3800; number_of_response:1; }","duration":"197.464956ms","start":"2026-08-06T01:05:27.349792Z","end":"2026-08-06T01:05:27.547257Z","steps":["trace[1175280071] 'process raft request'  (duration: 197.256482ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-06T01:05:27.547376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:05:26.755913Z","time spent":"791.364274ms","remote":"127.0.0.1:58400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:3788 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-08-06T01:05:27.547202Z","caller":"traceutil/trace.go:171","msg":"trace[87982650] linearizableReadLoop","detail":"{readStateIndex:3944; appliedIndex:3942; }","duration":"668.674102ms","start":"2026-08-06T01:05:26.878502Z","end":"2026-08-06T01:05:27.547176Z","steps":["trace[87982650] 'read index received'  (duration: 666.923788ms)","trace[87982650] 'applied index is now lower than readState.Index'  (duration: 1.749124ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-06T01:05:27.547407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"668.881396ms","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-06T01:05:27.547485Z","caller":"traceutil/trace.go:171","msg":"trace[437126423] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3800; }","duration":"669.017898ms","start":"2026-08-06T01:05:26.87845Z","end":"2026-08-06T01:05:27.547468Z","steps":["trace[437126423] 'agreement among raft nodes before linearized reading'  (duration: 668.806424ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-06T01:05:27.547548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:05:26.878419Z","time spent":"669.115181ms","remote":"127.0.0.1:58400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-08-06T01:05:27.547835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.468805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"warn","ts":"2026-08-06T01:05:27.547769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.217338ms","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-06T01:05:27.547889Z","caller":"traceutil/trace.go:171","msg":"trace[1546819578] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3800; }","duration":"361.532516ms","start":"2026-08-06T01:05:27.18634Z","end":"2026-08-06T01:05:27.547873Z","steps":["trace[1546819578] 'agreement among raft nodes before linearized reading'  (duration: 361.358853ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-06T01:05:27.547883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.514804ms","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-06T01:05:27.547925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:05:27.186331Z","time spent":"361.586888ms","remote":"127.0.0.1:58400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-08-06T01:05:27.547936Z","caller":"traceutil/trace.go:171","msg":"trace[1427286557] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:3800; }","duration":"430.636136ms","start":"2026-08-06T01:05:27.117287Z","end":"2026-08-06T01:05:27.547923Z","steps":["trace[1427286557] 'agreement among raft nodes before linearized reading'  (duration: 430.498483ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-06T01:05:27.547934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.957535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"}
{"level":"warn","ts":"2026-08-06T01:05:27.547956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.620285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"warn","ts":"2026-08-06T01:05:27.547974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:05:27.117266Z","time spent":"430.700148ms","remote":"127.0.0.1:58400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-08-06T01:05:27.547992Z","caller":"traceutil/trace.go:171","msg":"trace[643906778] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:3800; }","duration":"429.054536ms","start":"2026-08-06T01:05:27.11892Z","end":"2026-08-06T01:05:27.547975Z","steps":["trace[643906778] 'agreement among raft nodes before linearized reading'  (duration: 428.852852ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:05:27.548014Z","caller":"traceutil/trace.go:171","msg":"trace[1460179548] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3800; }","duration":"432.725967ms","start":"2026-08-06T01:05:27.115268Z","end":"2026-08-06T01:05:27.547993Z","steps":["trace[1460179548] 'agreement among raft nodes before linearized reading'  (duration: 432.597195ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-06T01:05:27.548034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:05:27.118904Z","time spent":"429.121097ms","remote":"127.0.0.1:58400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":578,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"warn","ts":"2026-08-06T01:05:27.548058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:05:27.115238Z","time spent":"432.811948ms","remote":"127.0.0.1:58400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-08-06T01:05:27.548091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.929365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-08-06T01:05:27.548133Z","caller":"traceutil/trace.go:171","msg":"trace[2028455275] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:3800; }","duration":"199.979557ms","start":"2026-08-06T01:05:27.348138Z","end":"2026-08-06T01:05:27.548118Z","steps":["trace[2028455275] 'agreement among raft nodes before linearized reading'  (duration: 199.922146ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:05:27.547904Z","caller":"traceutil/trace.go:171","msg":"trace[917943006] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:3800; }","duration":"479.397012ms","start":"2026-08-06T01:05:27.068487Z","end":"2026-08-06T01:05:27.547884Z","steps":["trace[917943006] 'agreement among raft nodes before linearized reading'  (duration: 479.204079ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-06T01:05:27.548152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.319373ms","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-06T01:05:27.548291Z","caller":"traceutil/trace.go:171","msg":"trace[1246052438] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3800; }","duration":"362.471425ms","start":"2026-08-06T01:05:27.185773Z","end":"2026-08-06T01:05:27.548244Z","steps":["trace[1246052438] 'agreement among raft nodes before linearized reading'  (duration: 362.108288ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-06T01:05:27.548331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.335426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/passwords/monitoring/kube-prometheus-stack-prometheus-cookie-secret\" ","response":"range_response_count:1 size:1225"}
{"level":"warn","ts":"2026-08-06T01:05:27.548377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:05:27.185755Z","time spent":"362.577158ms","remote":"127.0.0.1:58400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-08-06T01:05:27.548206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:05:27.06847Z","time spent":"479.718568ms","remote":"127.0.0.1:45202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true "}
{"level":"info","ts":"2026-08-06T01:05:27.548406Z","caller":"traceutil/trace.go:171","msg":"trace[213014355] range","detail":"{range_begin:/registry/secretgen.k14s.io/passwords/monitoring/kube-prometheus-stack-prometheus-cookie-secret; range_end:; response_count:1; response_revision:3800; }","duration":"260.466848ms","start":"2026-08-06T01:05:27.287917Z","end":"2026-08-06T01:05:27.548384Z","steps":["trace[213014355] 'agreement among raft nodes before linearized reading'  (duration: 260.279874ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-06T01:06:42.57106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.546685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1451"}
{"level":"info","ts":"2026-08-06T01:06:42.571169Z","caller":"traceutil/trace.go:171","msg":"trace[1653677935] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4874; }","duration":"237.707188ms","start":"2026-08-06T01:06:42.333431Z","end":"2026-08-06T01:06:42.571138Z","steps":["trace[1653677935] 'range keys from in-memory index tree'  (duration: 237.395552ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:06:42.571555Z","caller":"traceutil/trace.go:171","msg":"trace[1307873003] linearizableReadLoop","detail":"{readStateIndex:5061; appliedIndex:5060; }","duration":"235.122802ms","start":"2026-08-06T01:06:42.336387Z","end":"2026-08-06T01:06:42.57151Z","steps":["trace[1307873003] 'read index received'  (duration: 148.579485ms)","trace[1307873003] 'applied index is now lower than readState.Index'  (duration: 86.541197ms)"],"step_count":2}
{"level":"info","ts":"2026-08-06T01:06:42.571608Z","caller":"traceutil/trace.go:171","msg":"trace[263065074] transaction","detail":"{read_only:false; response_revision:4875; number_of_response:1; }","duration":"236.851813ms","start":"2026-08-06T01:06:42.334717Z","end":"2026-08-06T01:06:42.571569Z","steps":["trace[263065074] 'process raft request'  (duration: 150.290876ms)","trace[263065074] 'compare'  (duration: 85.813523ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-06T01:06:42.571844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.347402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:4849"}
{"level":"info","ts":"2026-08-06T01:06:42.57189Z","caller":"traceutil/trace.go:171","msg":"trace[798964949] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4875; }","duration":"232.437053ms","start":"2026-08-06T01:06:42.339439Z","end":"2026-08-06T01:06:42.571876Z","steps":["trace[798964949] 'agreement among raft nodes before linearized reading'  (duration: 232.24747ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-06T01:06:42.572846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.445035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0\" ","response":"range_response_count:1 size:1342"}
{"level":"info","ts":"2026-08-06T01:06:42.572907Z","caller":"traceutil/trace.go:171","msg":"trace[540411998] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0; range_end:; response_count:1; response_revision:4875; }","duration":"236.509986ms","start":"2026-08-06T01:06:42.336383Z","end":"2026-08-06T01:06:42.572893Z","steps":["trace[540411998] 'agreement among raft nodes before linearized reading'  (duration: 235.244184ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:06:42.911077Z","caller":"traceutil/trace.go:171","msg":"trace[452263570] transaction","detail":"{read_only:false; response_revision:4885; number_of_response:1; }","duration":"126.051713ms","start":"2026-08-06T01:06:42.784992Z","end":"2026-08-06T01:06:42.911044Z","steps":["trace[452263570] 'process raft request'  (duration: 68.468113ms)","trace[452263570] 'compare'  (duration: 57.305355ms)"],"step_count":2}
{"level":"info","ts":"2026-08-06T01:06:55.3731Z","caller":"traceutil/trace.go:171","msg":"trace[1570328054] linearizableReadLoop","detail":"{readStateIndex:5249; appliedIndex:5248; }","duration":"109.12239ms","start":"2026-08-06T01:06:55.263959Z","end":"2026-08-06T01:06:55.373081Z","steps":["trace[1570328054] 'read index received'  (duration: 108.967416ms)","trace[1570328054] 'applied index is now lower than readState.Index'  (duration: 154.064µs)"],"step_count":2}
{"level":"warn","ts":"2026-08-06T01:06:55.373259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.289043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"}
{"level":"info","ts":"2026-08-06T01:06:55.373294Z","caller":"traceutil/trace.go:171","msg":"trace[1804501603] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5057; }","duration":"109.381554ms","start":"2026-08-06T01:06:55.2639Z","end":"2026-08-06T01:06:55.373281Z","steps":["trace[1804501603] 'agreement among raft nodes before linearized reading'  (duration: 109.255942ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:06:55.373453Z","caller":"traceutil/trace.go:171","msg":"trace[849057064] transaction","detail":"{read_only:false; response_revision:5057; number_of_response:1; }","duration":"115.478244ms","start":"2026-08-06T01:06:55.257951Z","end":"2026-08-06T01:06:55.373429Z","steps":["trace[849057064] 'process raft request'  (duration: 115.030075ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:07:55.071247Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2914}
{"level":"info","ts":"2026-08-06T01:07:55.161669Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2914,"took":"89.217421ms","hash":3442977314,"current-db-size-bytes":51597312,"current-db-size":"52 MB","current-db-size-in-use-bytes":28921856,"current-db-size-in-use":"29 MB"}
{"level":"info","ts":"2026-08-06T01:07:55.161752Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3442977314,"revision":2914,"compact-revision":-1}
{"level":"info","ts":"2026-08-06T01:12:55.078108Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5557}
{"level":"info","ts":"2026-08-06T01:12:55.163796Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5557,"took":"83.389208ms","hash":1339343621,"current-db-size-bytes":51597312,"current-db-size":"52 MB","current-db-size-in-use-bytes":18329600,"current-db-size-in-use":"18 MB"}
{"level":"info","ts":"2026-08-06T01:12:55.163913Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1339343621,"revision":5557,"compact-revision":2914}