{"level":"warn","ts":"2026-08-18T18:57:18.983501Z","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-18T18:57:18.983665Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.186:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.186:2380","--initial-cluster=instance=https://162.253.55.186:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.186:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.186: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-18T18:57:18.983786Z","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-18T18:57:18.983809Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.186:2380"]}
{"level":"info","ts":"2026-08-18T18:57:18.983839Z","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-18T18:57:18.984622Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.186:2379"]}
{"level":"info","ts":"2026-08-18T18:57:18.984732Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.186:2380"],"listen-peer-urls":["https://162.253.55.186:2380"],"advertise-client-urls":["https://162.253.55.186:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.186:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.186: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-18T18:57:18.987184Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.141014ms"}
{"level":"info","ts":"2026-08-18T18:57:18.992402Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"612d5169b08bb96b","cluster-id":"20ec8eafba602517"}
{"level":"info","ts":"2026-08-18T18:57:18.992484Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b switched to configuration voters=()"}
{"level":"info","ts":"2026-08-18T18:57:18.99251Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b became follower at term 0"}
{"level":"info","ts":"2026-08-18T18:57:18.992527Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 612d5169b08bb96b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-08-18T18:57:18.992536Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b became follower at term 1"}
{"level":"info","ts":"2026-08-18T18:57:18.992575Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b switched to configuration voters=(7002342510006352235)"}
{"level":"warn","ts":"2026-08-18T18:57:19.002834Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-08-18T18:57:19.004604Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-08-18T18:57:19.006011Z","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-18T18:57:19.00885Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"612d5169b08bb96b","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-08-18T18:57:19.009135Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"612d5169b08bb96b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-08-18T18:57:19.009258Z","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-18T18:57:19.009365Z","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-18T18:57:19.00938Z","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-18T18:57:19.01015Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b switched to configuration voters=(7002342510006352235)"}
{"level":"info","ts":"2026-08-18T18:57:19.010354Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"20ec8eafba602517","local-member-id":"612d5169b08bb96b","added-peer-id":"612d5169b08bb96b","added-peer-peer-urls":["https://162.253.55.186:2380"]}
{"level":"info","ts":"2026-08-18T18:57:19.017916Z","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-18T18:57:19.018161Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.186:2380"}
{"level":"info","ts":"2026-08-18T18:57:19.018245Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.186:2380"}
{"level":"info","ts":"2026-08-18T18:57:19.018369Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"612d5169b08bb96b","initial-advertise-peer-urls":["https://162.253.55.186:2380"],"listen-peer-urls":["https://162.253.55.186:2380"],"advertise-client-urls":["https://162.253.55.186:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.186:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-08-18T18:57:19.018427Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-08-18T18:57:19.992823Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b is starting a new election at term 1"}
{"level":"info","ts":"2026-08-18T18:57:19.992931Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b became pre-candidate at term 1"}
{"level":"info","ts":"2026-08-18T18:57:19.992963Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b received MsgPreVoteResp from 612d5169b08bb96b at term 1"}
{"level":"info","ts":"2026-08-18T18:57:19.992989Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b became candidate at term 2"}
{"level":"info","ts":"2026-08-18T18:57:19.993002Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b received MsgVoteResp from 612d5169b08bb96b at term 2"}
{"level":"info","ts":"2026-08-18T18:57:19.993021Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b became leader at term 2"}
{"level":"info","ts":"2026-08-18T18:57:19.993037Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 612d5169b08bb96b elected leader 612d5169b08bb96b at term 2"}
{"level":"info","ts":"2026-08-18T18:57:19.994583Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"612d5169b08bb96b","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.186:2379]}","request-path":"/0/members/612d5169b08bb96b/attributes","cluster-id":"20ec8eafba602517","publish-timeout":"7s"}
{"level":"info","ts":"2026-08-18T18:57:19.994682Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-08-18T18:57:19.99465Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-18T18:57:19.994597Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-08-18T18:57:19.994915Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-08-18T18:57:19.995041Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-08-18T18:57:19.995749Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"20ec8eafba602517","local-member-id":"612d5169b08bb96b","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-18T18:57:19.995893Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-18T18:57:19.99595Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-18T18:57:19.998561Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-08-18T18:57:19.99857Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.186:2379"}
{"level":"info","ts":"2026-08-18T18:58:01.816412Z","caller":"traceutil/trace.go:171","msg":"trace[1972087579] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"135.781111ms","start":"2026-08-18T18:58:01.680594Z","end":"2026-08-18T18:58:01.816375Z","steps":["trace[1972087579] 'process raft request'  (duration: 135.036242ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T18:58:02.202162Z","caller":"traceutil/trace.go:171","msg":"trace[155377129] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"221.797148ms","start":"2026-08-18T18:58:01.980319Z","end":"2026-08-18T18:58:02.202116Z","steps":["trace[155377129] 'process raft request'  (duration: 136.11805ms)","trace[155377129] 'compare'  (duration: 85.39577ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T18:58:02.767651Z","caller":"traceutil/trace.go:171","msg":"trace[1395836371] linearizableReadLoop","detail":"{readStateIndex:656; appliedIndex:655; }","duration":"245.596891ms","start":"2026-08-18T18:58:02.522031Z","end":"2026-08-18T18:58:02.767628Z","steps":["trace[1395836371] 'read index received'  (duration: 244.825131ms)","trace[1395836371] 'applied index is now lower than readState.Index'  (duration: 771.02µs)"],"step_count":2}
{"level":"warn","ts":"2026-08-18T18:58:02.767792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.724045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-18T18:58:02.767772Z","caller":"traceutil/trace.go:171","msg":"trace[1952665787] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"441.686745ms","start":"2026-08-18T18:58:02.326026Z","end":"2026-08-18T18:58:02.767713Z","steps":["trace[1952665787] 'process raft request'  (duration: 440.970436ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T18:58:02.767856Z","caller":"traceutil/trace.go:171","msg":"trace[1682083090] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:635; }","duration":"245.879618ms","start":"2026-08-18T18:58:02.52196Z","end":"2026-08-18T18:58:02.76784Z","steps":["trace[1682083090] 'agreement among raft nodes before linearized reading'  (duration: 245.748435ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T18:58:02.768713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T18:58:02.325995Z","time spent":"441.88348ms","remote":"127.0.0.1:41162","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036269,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" mod_revision:631 > success:<request_put:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" value_size:1036185 >> failure:<request_range:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" > >"}
{"level":"info","ts":"2026-08-18T19:00:11.361706Z","caller":"traceutil/trace.go:171","msg":"trace[1130242645] transaction","detail":"{read_only:false; response_revision:2140; number_of_response:1; }","duration":"136.4026ms","start":"2026-08-18T19:00:11.225274Z","end":"2026-08-18T19:00:11.361676Z","steps":["trace[1130242645] 'process raft request'  (duration: 136.238986ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:01:34.35827Z","caller":"traceutil/trace.go:171","msg":"trace[859574083] transaction","detail":"{read_only:false; response_revision:2638; number_of_response:1; }","duration":"115.172803ms","start":"2026-08-18T19:01:34.243069Z","end":"2026-08-18T19:01:34.358242Z","steps":["trace[859574083] 'process raft request'  (duration: 115.005259ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:05:38.921949Z","caller":"traceutil/trace.go:171","msg":"trace[573331376] linearizableReadLoop","detail":"{readStateIndex:5026; appliedIndex:5024; }","duration":"137.0448ms","start":"2026-08-18T19:05:38.784881Z","end":"2026-08-18T19:05:38.921926Z","steps":["trace[573331376] 'read index received'  (duration: 18.428713ms)","trace[573331376] 'applied index is now lower than readState.Index'  (duration: 118.615237ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T19:05:38.922039Z","caller":"traceutil/trace.go:171","msg":"trace[419255112] transaction","detail":"{read_only:false; response_revision:4847; number_of_response:1; }","duration":"190.548782ms","start":"2026-08-18T19:05:38.73144Z","end":"2026-08-18T19:05:38.921989Z","steps":["trace[419255112] 'process raft request'  (duration: 190.344476ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:05:38.922181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.234851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/monitoring\" ","response":"range_response_count:1 size:372"}
{"level":"info","ts":"2026-08-18T19:05:38.922218Z","caller":"traceutil/trace.go:171","msg":"trace[1547013510] range","detail":"{range_begin:/registry/namespaces/monitoring; range_end:; response_count:1; response_revision:4847; }","duration":"117.332753ms","start":"2026-08-18T19:05:38.804875Z","end":"2026-08-18T19:05:38.922207Z","steps":["trace[1547013510] 'agreement among raft nodes before linearized reading'  (duration: 117.180569ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:05:38.92234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.410349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2e06c928-20b6-4bf0-8b7d-cb3ca865ce52\" ","response":"range_response_count:1 size:3601"}
{"level":"info","ts":"2026-08-18T19:05:38.922479Z","caller":"traceutil/trace.go:171","msg":"trace[839659318] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2e06c928-20b6-4bf0-8b7d-cb3ca865ce52; range_end:; response_count:1; response_revision:4847; }","duration":"137.578834ms","start":"2026-08-18T19:05:38.784867Z","end":"2026-08-18T19:05:38.922446Z","steps":["trace[839659318] 'agreement among raft nodes before linearized reading'  (duration: 137.167883ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:05:39.257986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.989145ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13360948736884391022 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/secrets/monitoring/sh.helm.release.v1.vector.v1\" mod_revision:4848 > success:<request_put:<key:\"/registry/secrets/monitoring/sh.helm.release.v1.vector.v1\" value_size:57730 >> failure:<request_range:<key:\"/registry/secrets/monitoring/sh.helm.release.v1.vector.v1\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-18T19:05:39.258221Z","caller":"traceutil/trace.go:171","msg":"trace[1525991762] transaction","detail":"{read_only:false; response_revision:4858; number_of_response:1; }","duration":"166.941773ms","start":"2026-08-18T19:05:39.091248Z","end":"2026-08-18T19:05:39.25819Z","steps":["trace[1525991762] 'process raft request'  (duration: 49.358503ms)","trace[1525991762] 'compare'  (duration: 116.759898ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T19:05:39.258252Z","caller":"traceutil/trace.go:171","msg":"trace[890371011] transaction","detail":"{read_only:false; response_revision:4859; number_of_response:1; }","duration":"154.398614ms","start":"2026-08-18T19:05:39.103809Z","end":"2026-08-18T19:05:39.258208Z","steps":["trace[890371011] 'process raft request'  (duration: 154.299582ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:05:40.685277Z","caller":"traceutil/trace.go:171","msg":"trace[1832525760] linearizableReadLoop","detail":"{readStateIndex:5063; appliedIndex:5061; }","duration":"162.645951ms","start":"2026-08-18T19:05:40.52259Z","end":"2026-08-18T19:05:40.685236Z","steps":["trace[1832525760] 'read index received'  (duration: 13.509174ms)","trace[1832525760] 'applied index is now lower than readState.Index'  (duration: 149.134887ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T19:05:40.685422Z","caller":"traceutil/trace.go:171","msg":"trace[1856136860] transaction","detail":"{read_only:false; response_revision:4883; number_of_response:1; }","duration":"164.957451ms","start":"2026-08-18T19:05:40.520406Z","end":"2026-08-18T19:05:40.685363Z","steps":["trace[1856136860] 'process raft request'  (duration: 124.556903ms)","trace[1856136860] 'compare'  (duration: 40.08773ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-18T19:05:40.685515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.895518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-18T19:05:40.685566Z","caller":"traceutil/trace.go:171","msg":"trace[873178705] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4883; }","duration":"162.969219ms","start":"2026-08-18T19:05:40.522585Z","end":"2026-08-18T19:05:40.685555Z","steps":["trace[873178705] 'agreement among raft nodes before linearized reading'  (duration: 162.845766ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:05:59.915335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.752635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-z5vjf\" ","response":"range_response_count:1 size:6531"}
{"level":"info","ts":"2026-08-18T19:05:59.915417Z","caller":"traceutil/trace.go:171","msg":"trace[679387259] range","detail":"{range_begin:/registry/pods/openstack/keepalived-z5vjf; range_end:; response_count:1; response_revision:5271; }","duration":"108.899939ms","start":"2026-08-18T19:05:59.806498Z","end":"2026-08-18T19:05:59.915398Z","steps":["trace[679387259] 'range keys from in-memory index tree'  (duration: 108.55833ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:05:59.915927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.041507ms","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-18T19:05:59.916064Z","caller":"traceutil/trace.go:171","msg":"trace[1142418262] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5271; }","duration":"103.246742ms","start":"2026-08-18T19:05:59.812784Z","end":"2026-08-18T19:05:59.916031Z","steps":["trace[1142418262] 'range keys from in-memory index tree'  (duration: 102.03775ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:06:00.133947Z","caller":"traceutil/trace.go:171","msg":"trace[1514377774] transaction","detail":"{read_only:false; response_revision:5273; number_of_response:1; }","duration":"142.073981ms","start":"2026-08-18T19:05:59.991823Z","end":"2026-08-18T19:06:00.133897Z","steps":["trace[1514377774] 'process raft request'  (duration: 118.146609ms)","trace[1514377774] 'compare'  (duration: 23.734547ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T19:06:10.271124Z","caller":"traceutil/trace.go:171","msg":"trace[1924011932] transaction","detail":"{read_only:false; response_revision:5421; number_of_response:1; }","duration":"100.915242ms","start":"2026-08-18T19:06:10.170174Z","end":"2026-08-18T19:06:10.27109Z","steps":["trace[1924011932] 'process raft request'  (duration: 100.682186ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:07:20.020517Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2880}
{"level":"info","ts":"2026-08-18T19:07:20.091774Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2880,"took":"69.103845ms","hash":118003101,"current-db-size-bytes":58216448,"current-db-size":"58 MB","current-db-size-in-use-bytes":33595392,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-08-18T19:07:20.091889Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":118003101,"revision":2880,"compact-revision":-1}
{"level":"info","ts":"2026-08-18T19:11:53.398118Z","caller":"traceutil/trace.go:171","msg":"trace[273386804] transaction","detail":"{read_only:false; response_revision:8046; number_of_response:1; }","duration":"154.556583ms","start":"2026-08-18T19:11:53.243515Z","end":"2026-08-18T19:11:53.398071Z","steps":["trace[273386804] 'process raft request'  (duration: 102.276915ms)","trace[273386804] 'compare'  (duration: 52.056862ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T19:12:04.656667Z","caller":"traceutil/trace.go:171","msg":"trace[465924392] transaction","detail":"{read_only:false; response_revision:8103; number_of_response:1; }","duration":"149.282676ms","start":"2026-08-18T19:12:04.507352Z","end":"2026-08-18T19:12:04.656635Z","steps":["trace[465924392] 'process raft request'  (duration: 65.281958ms)","trace[465924392] 'compare'  (duration: 83.797233ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T19:12:04.656916Z","caller":"traceutil/trace.go:171","msg":"trace[332415776] transaction","detail":"{read_only:false; response_revision:8104; number_of_response:1; }","duration":"146.146033ms","start":"2026-08-18T19:12:04.510738Z","end":"2026-08-18T19:12:04.656884Z","steps":["trace[332415776] 'process raft request'  (duration: 145.851366ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:12:05.103465Z","caller":"traceutil/trace.go:171","msg":"trace[830779273] linearizableReadLoop","detail":"{readStateIndex:8383; appliedIndex:8382; }","duration":"390.6142ms","start":"2026-08-18T19:12:04.71281Z","end":"2026-08-18T19:12:05.103424Z","steps":["trace[830779273] 'read index received'  (duration: 390.398244ms)","trace[830779273] 'applied index is now lower than readState.Index'  (duration: 214.476µs)"],"step_count":2}
{"level":"info","ts":"2026-08-18T19:12:05.103546Z","caller":"traceutil/trace.go:171","msg":"trace[242227503] transaction","detail":"{read_only:false; response_revision:8105; number_of_response:1; }","duration":"391.422131ms","start":"2026-08-18T19:12:04.712095Z","end":"2026-08-18T19:12:05.103518Z","steps":["trace[242227503] 'process raft request'  (duration: 391.105033ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:12:05.103734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T19:12:04.71207Z","time spent":"391.543255ms","remote":"127.0.0.1:41302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:8095 > 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":"warn","ts":"2026-08-18T19:12:05.103832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.99685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/openstack/key-manager\" ","response":"range_response_count:1 size:710"}
{"level":"warn","ts":"2026-08-18T19:12:05.103893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.599509ms","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-18T19:12:05.103925Z","caller":"traceutil/trace.go:171","msg":"trace[1318345812] range","detail":"{range_begin:/registry/ingress/openstack/key-manager; range_end:; response_count:1; response_revision:8105; }","duration":"391.150365ms","start":"2026-08-18T19:12:04.712755Z","end":"2026-08-18T19:12:05.103905Z","steps":["trace[1318345812] 'agreement among raft nodes before linearized reading'  (duration: 390.837556ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:12:05.103983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T19:12:04.712735Z","time spent":"391.239416ms","remote":"127.0.0.1:41336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":732,"request content":"key:\"/registry/ingress/openstack/key-manager\" "}
{"level":"info","ts":"2026-08-18T19:12:05.10398Z","caller":"traceutil/trace.go:171","msg":"trace[1348387008] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8105; }","duration":"265.787694ms","start":"2026-08-18T19:12:04.838174Z","end":"2026-08-18T19:12:05.103961Z","steps":["trace[1348387008] 'agreement among raft nodes before linearized reading'  (duration: 265.479846ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:12:05.272237Z","caller":"traceutil/trace.go:171","msg":"trace[1702361032] transaction","detail":"{read_only:false; response_revision:8110; number_of_response:1; }","duration":"111.58209ms","start":"2026-08-18T19:12:05.16061Z","end":"2026-08-18T19:12:05.272192Z","steps":["trace[1702361032] 'process raft request'  (duration: 111.484677ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:12:05.272393Z","caller":"traceutil/trace.go:171","msg":"trace[909660859] transaction","detail":"{read_only:false; response_revision:8109; number_of_response:1; }","duration":"111.803194ms","start":"2026-08-18T19:12:05.160349Z","end":"2026-08-18T19:12:05.272152Z","steps":["trace[909660859] 'process raft request'  (duration: 37.48512ms)","trace[909660859] 'compare'  (duration: 73.849962ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T19:12:05.721153Z","caller":"traceutil/trace.go:171","msg":"trace[697676847] transaction","detail":"{read_only:false; response_revision:8112; number_of_response:1; }","duration":"107.587826ms","start":"2026-08-18T19:12:05.613532Z","end":"2026-08-18T19:12:05.721119Z","steps":["trace[697676847] 'process raft request'  (duration: 107.37102ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:12:06.082087Z","caller":"traceutil/trace.go:171","msg":"trace[982400138] linearizableReadLoop","detail":"{readStateIndex:8392; appliedIndex:8391; }","duration":"245.932035ms","start":"2026-08-18T19:12:05.836122Z","end":"2026-08-18T19:12:06.082054Z","steps":["trace[982400138] 'read index received'  (duration: 169.370662ms)","trace[982400138] 'applied index is now lower than readState.Index'  (duration: 76.559373ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T19:12:06.082117Z","caller":"traceutil/trace.go:171","msg":"trace[959728465] transaction","detail":"{read_only:false; response_revision:8113; number_of_response:1; }","duration":"330.798325ms","start":"2026-08-18T19:12:05.75127Z","end":"2026-08-18T19:12:06.082068Z","steps":["trace[959728465] 'process raft request'  (duration: 254.235372ms)","trace[959728465] 'compare'  (duration: 76.390429ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-18T19:12:06.082339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.367471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-18T19:12:06.082402Z","caller":"traceutil/trace.go:171","msg":"trace[393553438] range","detail":"{range_begin:/registry/acme.cert-manager.io/challenges/; range_end:/registry/acme.cert-manager.io/challenges0; response_count:0; response_revision:8113; }","duration":"229.521355ms","start":"2026-08-18T19:12:05.852866Z","end":"2026-08-18T19:12:06.082387Z","steps":["trace[393553438] 'agreement among raft nodes before linearized reading'  (duration: 229.392911ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:12:06.082343Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T19:12:05.751233Z","time spent":"330.99326ms","remote":"127.0.0.1:41302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:8099 > 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\" > >"}
{"level":"warn","ts":"2026-08-18T19:12:06.082607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.967478ms","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":"warn","ts":"2026-08-18T19:12:06.082366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.195281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-08-18T19:12:06.082742Z","caller":"traceutil/trace.go:171","msg":"trace[1022838773] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8113; }","duration":"107.166594ms","start":"2026-08-18T19:12:05.975541Z","end":"2026-08-18T19:12:06.082707Z","steps":["trace[1022838773] 'agreement among raft nodes before linearized reading'  (duration: 106.855096ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:12:06.082774Z","caller":"traceutil/trace.go:171","msg":"trace[652863585] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/; range_end:/registry/rabbitmq.com/rabbitmqclusters0; response_count:0; response_revision:8113; }","duration":"246.676954ms","start":"2026-08-18T19:12:05.83607Z","end":"2026-08-18T19:12:06.082747Z","steps":["trace[652863585] 'agreement among raft nodes before linearized reading'  (duration: 246.13397ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:12:06.811772Z","caller":"traceutil/trace.go:171","msg":"trace[648173900] transaction","detail":"{read_only:false; response_revision:8118; number_of_response:1; }","duration":"145.355043ms","start":"2026-08-18T19:12:06.666354Z","end":"2026-08-18T19:12:06.811709Z","steps":["trace[648173900] 'process raft request'  (duration: 145.074895ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:12:06.829087Z","caller":"traceutil/trace.go:171","msg":"trace[1140262524] linearizableReadLoop","detail":"{readStateIndex:8398; appliedIndex:8396; }","duration":"150.541978ms","start":"2026-08-18T19:12:06.678507Z","end":"2026-08-18T19:12:06.829049Z","steps":["trace[1140262524] 'read index received'  (duration: 132.965178ms)","trace[1140262524] 'applied index is now lower than readState.Index'  (duration: 17.57521ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-18T19:12:06.829298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.754775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-18T19:12:06.82937Z","caller":"traceutil/trace.go:171","msg":"trace[134780731] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:8119; }","duration":"150.878227ms","start":"2026-08-18T19:12:06.678474Z","end":"2026-08-18T19:12:06.829352Z","steps":["trace[134780731] 'agreement among raft nodes before linearized reading'  (duration: 150.729603ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:12:06.829402Z","caller":"traceutil/trace.go:171","msg":"trace[60388109] transaction","detail":"{read_only:false; response_revision:8119; number_of_response:1; }","duration":"162.733798ms","start":"2026-08-18T19:12:06.666643Z","end":"2026-08-18T19:12:06.829377Z","steps":["trace[60388109] 'process raft request'  (duration: 162.209894ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:12:20.027532Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6018}
{"level":"info","ts":"2026-08-18T19:12:20.132695Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6018,"took":"102.737304ms","hash":1976242448,"current-db-size-bytes":58216448,"current-db-size":"58 MB","current-db-size-in-use-bytes":22634496,"current-db-size-in-use":"23 MB"}
{"level":"info","ts":"2026-08-18T19:12:20.132776Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1976242448,"revision":6018,"compact-revision":2880}
{"level":"info","ts":"2026-08-18T19:12:33.887652Z","caller":"traceutil/trace.go:171","msg":"trace[1166645887] linearizableReadLoop","detail":"{readStateIndex:8600; appliedIndex:8599; }","duration":"185.864785ms","start":"2026-08-18T19:12:33.701758Z","end":"2026-08-18T19:12:33.887622Z","steps":["trace[1166645887] 'read index received'  (duration: 185.646169ms)","trace[1166645887] 'applied index is now lower than readState.Index'  (duration: 217.266µs)"],"step_count":2}
{"level":"info","ts":"2026-08-18T19:12:33.887788Z","caller":"traceutil/trace.go:171","msg":"trace[1262373339] transaction","detail":"{read_only:false; response_revision:8313; number_of_response:1; }","duration":"254.433033ms","start":"2026-08-18T19:12:33.633311Z","end":"2026-08-18T19:12:33.887745Z","steps":["trace[1262373339] 'process raft request'  (duration: 254.133305ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:12:33.887913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.684827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-08-18T19:12:33.887945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.149272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-08-18T19:12:33.888039Z","caller":"traceutil/trace.go:171","msg":"trace[1812048027] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:8313; }","duration":"186.336207ms","start":"2026-08-18T19:12:33.701685Z","end":"2026-08-18T19:12:33.888022Z","steps":["trace[1812048027] 'agreement among raft nodes before linearized reading'  (duration: 186.094281ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:12:33.887977Z","caller":"traceutil/trace.go:171","msg":"trace[1084150686] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:8313; }","duration":"101.79543ms","start":"2026-08-18T19:12:33.78616Z","end":"2026-08-18T19:12:33.887955Z","steps":["trace[1084150686] 'agreement among raft nodes before linearized reading'  (duration: 101.675907ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:12:47.386666Z","caller":"traceutil/trace.go:171","msg":"trace[1638208742] linearizableReadLoop","detail":"{readStateIndex:8717; appliedIndex:8716; }","duration":"201.395763ms","start":"2026-08-18T19:12:47.185236Z","end":"2026-08-18T19:12:47.386631Z","steps":["trace[1638208742] 'read index received'  (duration: 187.540459ms)","trace[1638208742] 'applied index is now lower than readState.Index'  (duration: 13.853554ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T19:12:47.386721Z","caller":"traceutil/trace.go:171","msg":"trace[732674663] transaction","detail":"{read_only:false; response_revision:8425; number_of_response:1; }","duration":"338.503898ms","start":"2026-08-18T19:12:47.048177Z","end":"2026-08-18T19:12:47.386681Z","steps":["trace[732674663] 'process raft request'  (duration: 324.539722ms)","trace[732674663] 'compare'  (duration: 13.711729ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-18T19:12:47.386915Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T19:12:47.048158Z","time spent":"338.667772ms","remote":"127.0.0.1:41302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:8404 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-08-18T19:12:47.386902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.652519ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-s7tgs\" ","response":"range_response_count:1 size:4648"}
{"level":"info","ts":"2026-08-18T19:12:47.386988Z","caller":"traceutil/trace.go:171","msg":"trace[1070816837] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-s7tgs; range_end:; response_count:1; response_revision:8425; }","duration":"201.803322ms","start":"2026-08-18T19:12:47.185163Z","end":"2026-08-18T19:12:47.386966Z","steps":["trace[1070816837] 'agreement among raft nodes before linearized reading'  (duration: 201.582307ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:12:47.463582Z","caller":"traceutil/trace.go:171","msg":"trace[164642420] transaction","detail":"{read_only:false; response_revision:8426; number_of_response:1; }","duration":"276.980884ms","start":"2026-08-18T19:12:47.186535Z","end":"2026-08-18T19:12:47.463516Z","steps":["trace[164642420] 'process raft request'  (duration: 276.718977ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:12:47.530419Z","caller":"traceutil/trace.go:171","msg":"trace[905064776] transaction","detail":"{read_only:false; response_revision:8427; number_of_response:1; }","duration":"134.57215ms","start":"2026-08-18T19:12:47.395816Z","end":"2026-08-18T19:12:47.530388Z","steps":["trace[905064776] 'process raft request'  (duration: 106.660868ms)","trace[905064776] 'compare'  (duration: 27.519612ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T19:12:47.530792Z","caller":"traceutil/trace.go:171","msg":"trace[724698327] transaction","detail":"{read_only:false; response_revision:8428; number_of_response:1; }","duration":"106.723829ms","start":"2026-08-18T19:12:47.424058Z","end":"2026-08-18T19:12:47.530782Z","steps":["trace[724698327] 'process raft request'  (duration: 106.055522ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:12:48.519436Z","caller":"traceutil/trace.go:171","msg":"trace[630062280] linearizableReadLoop","detail":"{readStateIndex:8724; appliedIndex:8723; }","duration":"175.01319ms","start":"2026-08-18T19:12:48.344383Z","end":"2026-08-18T19:12:48.519397Z","steps":["trace[630062280] 'read index received'  (duration: 174.749213ms)","trace[630062280] 'applied index is now lower than readState.Index'  (duration: 262.207µs)"],"step_count":2}
{"level":"info","ts":"2026-08-18T19:12:48.519507Z","caller":"traceutil/trace.go:171","msg":"trace[2013290272] transaction","detail":"{read_only:false; response_revision:8432; number_of_response:1; }","duration":"266.49417ms","start":"2026-08-18T19:12:48.252978Z","end":"2026-08-18T19:12:48.519472Z","steps":["trace[2013290272] 'process raft request'  (duration: 266.180412ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:12:48.519764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.819444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-08-18T19:12:48.519801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.38967ms","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-18T19:12:48.519882Z","caller":"traceutil/trace.go:171","msg":"trace[1498447227] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:8432; }","duration":"137.987229ms","start":"2026-08-18T19:12:48.381867Z","end":"2026-08-18T19:12:48.519854Z","steps":["trace[1498447227] 'agreement among raft nodes before linearized reading'  (duration: 137.776224ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:12:48.519909Z","caller":"traceutil/trace.go:171","msg":"trace[947801453] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/openstack/ceph; range_end:; response_count:1; response_revision:8432; }","duration":"175.568035ms","start":"2026-08-18T19:12:48.344316Z","end":"2026-08-18T19:12:48.519884Z","steps":["trace[947801453] 'agreement among raft nodes before linearized reading'  (duration: 175.201635ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:13:32.686765Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023f5.wal"}
{"level":"info","ts":"2026-08-18T19:13:54.59027Z","caller":"traceutil/trace.go:171","msg":"trace[1411109514] transaction","detail":"{read_only:false; response_revision:9067; number_of_response:1; }","duration":"114.368419ms","start":"2026-08-18T19:13:54.475842Z","end":"2026-08-18T19:13:54.59021Z","steps":["trace[1411109514] 'process raft request'  (duration: 69.900423ms)","trace[1411109514] 'compare'  (duration: 44.20503ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T19:15:08.691015Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"612d5169b08bb96b","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-08-18T19:15:08.702043Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-08-18T19:15:08.712102Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-08-18T19:17:20.035177Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8189}
{"level":"info","ts":"2026-08-18T19:17:20.114168Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8189,"took":"77.166726ms","hash":989727011,"current-db-size-bytes":58216448,"current-db-size":"58 MB","current-db-size-in-use-bytes":26267648,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-08-18T19:17:20.114268Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":989727011,"revision":8189,"compact-revision":6018}
{"level":"warn","ts":"2026-08-18T19:17:34.134763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.506933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-storage-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-18T19:17:34.134862Z","caller":"traceutil/trace.go:171","msg":"trace[1822123172] range","detail":"{range_begin:/registry/jobs/openstack/cinder-storage-init; range_end:; response_count:0; response_revision:10984; }","duration":"116.648817ms","start":"2026-08-18T19:17:34.018192Z","end":"2026-08-18T19:17:34.134841Z","steps":["trace[1822123172] 'range keys from in-memory index tree'  (duration: 116.443262ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:17:34.135004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.499834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-08-18T19:17:34.135046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.183341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-endpoints\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-08-18T19:17:34.135051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.000617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-user\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-18T19:17:34.135098Z","caller":"traceutil/trace.go:171","msg":"trace[249159371] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-endpoints; range_end:; response_count:0; response_revision:10984; }","duration":"117.273643ms","start":"2026-08-18T19:17:34.017809Z","end":"2026-08-18T19:17:34.135083Z","steps":["trace[249159371] 'range keys from in-memory index tree'  (duration: 117.10698ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:17:34.135093Z","caller":"traceutil/trace.go:171","msg":"trace[267368618] range","detail":"{range_begin:/registry/jobs/openstack/cinder-rabbit-init; range_end:; response_count:0; response_revision:10984; }","duration":"116.604066ms","start":"2026-08-18T19:17:34.018469Z","end":"2026-08-18T19:17:34.135073Z","steps":["trace[267368618] 'range keys from in-memory index tree'  (duration: 116.470383ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:17:34.135142Z","caller":"traceutil/trace.go:171","msg":"trace[878927011] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-user; range_end:; response_count:0; response_revision:10984; }","duration":"117.103489ms","start":"2026-08-18T19:17:34.018017Z","end":"2026-08-18T19:17:34.135121Z","steps":["trace[878927011] 'range keys from in-memory index tree'  (duration: 116.940335ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:17:34.135514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.500296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-db-sync\" ","response":"range_response_count:1 size:5079"}
{"level":"info","ts":"2026-08-18T19:17:34.135608Z","caller":"traceutil/trace.go:171","msg":"trace[275549465] range","detail":"{range_begin:/registry/jobs/openstack/cinder-db-sync; range_end:; response_count:1; response_revision:10984; }","duration":"113.627159ms","start":"2026-08-18T19:17:34.021959Z","end":"2026-08-18T19:17:34.135586Z","steps":["trace[275549465] 'range keys from in-memory index tree'  (duration: 112.91102ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:22:20.042636Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10905}
{"level":"info","ts":"2026-08-18T19:22:20.128745Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10905,"took":"83.226742ms","hash":620780900,"current-db-size-bytes":58216448,"current-db-size":"58 MB","current-db-size-in-use-bytes":27557888,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-08-18T19:22:20.128835Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":620780900,"revision":10905,"compact-revision":8189}
{"level":"info","ts":"2026-08-18T19:23:18.770151Z","caller":"traceutil/trace.go:171","msg":"trace[1414063752] transaction","detail":"{read_only:false; response_revision:13348; number_of_response:1; }","duration":"130.380074ms","start":"2026-08-18T19:23:18.639726Z","end":"2026-08-18T19:23:18.770106Z","steps":["trace[1414063752] 'process raft request'  (duration: 102.27409ms)","trace[1414063752] 'compare'  (duration: 27.907329ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-18T19:23:22.138756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.923239ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13360948736884414837 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:13355 > 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:16"}
{"level":"info","ts":"2026-08-18T19:23:22.138965Z","caller":"traceutil/trace.go:171","msg":"trace[267310853] transaction","detail":"{read_only:false; response_revision:13367; number_of_response:1; }","duration":"143.257209ms","start":"2026-08-18T19:23:21.995653Z","end":"2026-08-18T19:23:22.13891Z","steps":["trace[267310853] 'process raft request'  (duration: 15.072483ms)","trace[267310853] 'compare'  (duration: 127.767825ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T19:24:19.475036Z","caller":"traceutil/trace.go:171","msg":"trace[2070686012] transaction","detail":"{read_only:false; response_revision:13880; number_of_response:1; }","duration":"149.065812ms","start":"2026-08-18T19:24:19.325943Z","end":"2026-08-18T19:24:19.475009Z","steps":["trace[2070686012] 'process raft request'  (duration: 148.789404ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:24:19.476156Z","caller":"traceutil/trace.go:171","msg":"trace[567364724] transaction","detail":"{read_only:false; response_revision:13881; number_of_response:1; }","duration":"130.014014ms","start":"2026-08-18T19:24:19.346111Z","end":"2026-08-18T19:24:19.476125Z","steps":["trace[567364724] 'process raft request'  (duration: 129.816318ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:25:38.635105Z","caller":"traceutil/trace.go:171","msg":"trace[1146153773] linearizableReadLoop","detail":"{readStateIndex:15146; appliedIndex:15145; }","duration":"111.197764ms","start":"2026-08-18T19:25:38.523871Z","end":"2026-08-18T19:25:38.635069Z","steps":["trace[1146153773] 'read index received'  (duration: 27.277223ms)","trace[1146153773] 'applied index is now lower than readState.Index'  (duration: 83.918921ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-18T19:25:38.63542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.488501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-18T19:25:38.635579Z","caller":"traceutil/trace.go:171","msg":"trace[76582754] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14652; }","duration":"111.654196ms","start":"2026-08-18T19:25:38.523823Z","end":"2026-08-18T19:25:38.635477Z","steps":["trace[76582754] 'agreement among raft nodes before linearized reading'  (duration: 111.372458ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:25:39.108121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.690458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:356"}
{"level":"info","ts":"2026-08-18T19:25:39.108236Z","caller":"traceutil/trace.go:171","msg":"trace[1186997796] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:14653; }","duration":"193.827241ms","start":"2026-08-18T19:25:38.914385Z","end":"2026-08-18T19:25:39.108212Z","steps":["trace[1186997796] 'range keys from in-memory index tree'  (duration: 193.461042ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:25:39.108616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.594893ms","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-18T19:25:39.108676Z","caller":"traceutil/trace.go:171","msg":"trace[960226311] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:14653; }","duration":"119.689526ms","start":"2026-08-18T19:25:38.988967Z","end":"2026-08-18T19:25:39.108657Z","steps":["trace[960226311] 'range keys from in-memory index tree'  (duration: 119.430849ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:27:20.049008Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12942}
{"level":"info","ts":"2026-08-18T19:27:20.138063Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12942,"took":"85.119603ms","hash":3753585285,"current-db-size-bytes":58216448,"current-db-size":"58 MB","current-db-size-in-use-bytes":30310400,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-08-18T19:27:20.138131Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3753585285,"revision":12942,"compact-revision":10905}
{"level":"info","ts":"2026-08-18T19:31:06.670326Z","caller":"traceutil/trace.go:171","msg":"trace[1008045597] transaction","detail":"{read_only:false; response_revision:17130; number_of_response:1; }","duration":"135.216506ms","start":"2026-08-18T19:31:06.535069Z","end":"2026-08-18T19:31:06.670285Z","steps":["trace[1008045597] 'process raft request'  (duration: 134.734223ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:31:07.307146Z","caller":"traceutil/trace.go:171","msg":"trace[826386104] transaction","detail":"{read_only:false; response_revision:17131; number_of_response:1; }","duration":"617.949586ms","start":"2026-08-18T19:31:06.689159Z","end":"2026-08-18T19:31:07.307108Z","steps":["trace[826386104] 'process raft request'  (duration: 617.760731ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:31:07.307358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T19:31:06.689126Z","time spent":"618.12671ms","remote":"127.0.0.1:41238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":20877,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/openstack/libvirt-libvirt-default-jb5jj\" mod_revision:17076 > success:<request_put:<key:\"/registry/pods/openstack/libvirt-libvirt-default-jb5jj\" value_size:20813 >> failure:<request_range:<key:\"/registry/pods/openstack/libvirt-libvirt-default-jb5jj\" > >"}
{"level":"info","ts":"2026-08-18T19:31:07.398223Z","caller":"traceutil/trace.go:171","msg":"trace[56188589] linearizableReadLoop","detail":"{readStateIndex:17710; appliedIndex:17706; }","duration":"237.790687ms","start":"2026-08-18T19:31:07.160409Z","end":"2026-08-18T19:31:07.398199Z","steps":["trace[56188589] 'read index received'  (duration: 146.434839ms)","trace[56188589] 'applied index is now lower than readState.Index'  (duration: 91.354238ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T19:31:07.398585Z","caller":"traceutil/trace.go:171","msg":"trace[1729403786] transaction","detail":"{read_only:false; response_revision:17132; number_of_response:1; }","duration":"457.762238ms","start":"2026-08-18T19:31:06.940806Z","end":"2026-08-18T19:31:07.398569Z","steps":["trace[1729403786] 'process raft request'  (duration: 442.737135ms)","trace[1729403786] 'compare'  (duration: 14.413127ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-18T19:31:07.398718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T19:31:06.940772Z","time spent":"457.85409ms","remote":"127.0.0.1:41302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:17075 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:416 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"info","ts":"2026-08-18T19:31:07.398929Z","caller":"traceutil/trace.go:171","msg":"trace[1779160224] transaction","detail":"{read_only:false; response_revision:17133; number_of_response:1; }","duration":"446.904194ms","start":"2026-08-18T19:31:06.952014Z","end":"2026-08-18T19:31:07.398918Z","steps":["trace[1779160224] 'process raft request'  (duration: 446.084523ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:31:07.398996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T19:31:06.95198Z","time spent":"446.979916ms","remote":"127.0.0.1:41302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:17118 > 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\" > >"}
{"level":"info","ts":"2026-08-18T19:31:07.399142Z","caller":"traceutil/trace.go:171","msg":"trace[1296397162] transaction","detail":"{read_only:false; response_revision:17134; number_of_response:1; }","duration":"445.907248ms","start":"2026-08-18T19:31:06.953225Z","end":"2026-08-18T19:31:07.399132Z","steps":["trace[1296397162] 'process raft request'  (duration: 444.923992ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:31:07.399199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T19:31:06.953188Z","time spent":"445.9829ms","remote":"127.0.0.1:41302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:17119 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-08-18T19:31:07.399425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.015309ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"}
{"level":"info","ts":"2026-08-18T19:31:07.399469Z","caller":"traceutil/trace.go:171","msg":"trace[1316393617] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:17134; }","duration":"239.102501ms","start":"2026-08-18T19:31:07.160354Z","end":"2026-08-18T19:31:07.399456Z","steps":["trace[1316393617] 'agreement among raft nodes before linearized reading'  (duration: 238.970488ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:31:07.399651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.248328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-18T19:31:07.39969Z","caller":"traceutil/trace.go:171","msg":"trace[1483850480] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:17134; }","duration":"233.33274ms","start":"2026-08-18T19:31:07.166346Z","end":"2026-08-18T19:31:07.399679Z","steps":["trace[1483850480] 'agreement among raft nodes before linearized reading'  (duration: 233.269828ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:32:20.057305Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15300}
{"level":"info","ts":"2026-08-18T19:32:20.163821Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15300,"took":"102.52062ms","hash":126807820,"current-db-size-bytes":58216448,"current-db-size":"58 MB","current-db-size-in-use-bytes":33292288,"current-db-size-in-use":"33 MB"}
{"level":"info","ts":"2026-08-18T19:32:20.163904Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":126807820,"revision":15300,"compact-revision":12942}
{"level":"info","ts":"2026-08-18T19:32:23.804134Z","caller":"traceutil/trace.go:171","msg":"trace[1461801911] transaction","detail":"{read_only:false; response_revision:17965; number_of_response:1; }","duration":"115.279204ms","start":"2026-08-18T19:32:23.688818Z","end":"2026-08-18T19:32:23.804098Z","steps":["trace[1461801911] 'process raft request'  (duration: 81.642604ms)","trace[1461801911] 'compare'  (duration: 32.705255ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T19:33:18.661721Z","caller":"traceutil/trace.go:171","msg":"trace[1870982040] transaction","detail":"{read_only:false; response_revision:18316; number_of_response:1; }","duration":"105.846658ms","start":"2026-08-18T19:33:18.555837Z","end":"2026-08-18T19:33:18.661684Z","steps":["trace[1870982040] 'process raft request'  (duration: 105.638012ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:33:18.688009Z","caller":"traceutil/trace.go:171","msg":"trace[2142191004] transaction","detail":"{read_only:false; response_revision:18318; number_of_response:1; }","duration":"126.296482ms","start":"2026-08-18T19:33:18.561694Z","end":"2026-08-18T19:33:18.68799Z","steps":["trace[2142191004] 'process raft request'  (duration: 126.159098ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:33:18.688027Z","caller":"traceutil/trace.go:171","msg":"trace[1201405377] transaction","detail":"{read_only:false; response_revision:18317; number_of_response:1; }","duration":"130.724368ms","start":"2026-08-18T19:33:18.55725Z","end":"2026-08-18T19:33:18.687974Z","steps":["trace[1201405377] 'process raft request'  (duration: 130.42094ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:33:18.718456Z","caller":"traceutil/trace.go:171","msg":"trace[609669964] linearizableReadLoop","detail":"{readStateIndex:18929; appliedIndex:18927; }","duration":"157.818616ms","start":"2026-08-18T19:33:18.560587Z","end":"2026-08-18T19:33:18.718406Z","steps":["trace[609669964] 'read index received'  (duration: 100.97492ms)","trace[609669964] 'applied index is now lower than readState.Index'  (duration: 56.837515ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-18T19:33:18.718759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.160125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/senlin-ks-user\" ","response":"range_response_count:1 size:7346"}
{"level":"info","ts":"2026-08-18T19:33:18.718833Z","caller":"traceutil/trace.go:171","msg":"trace[602868420] range","detail":"{range_begin:/registry/jobs/openstack/senlin-ks-user; range_end:; response_count:1; response_revision:18318; }","duration":"158.294968ms","start":"2026-08-18T19:33:18.56052Z","end":"2026-08-18T19:33:18.718815Z","steps":["trace[602868420] 'agreement among raft nodes before linearized reading'  (duration: 158.066522ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:35:02.781215Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"612d5169b08bb96b","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-08-18T19:35:02.787136Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-08-18T19:35:02.787269Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-08-18T19:37:20.063709Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17920}
{"level":"info","ts":"2026-08-18T19:37:20.179364Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17920,"took":"110.757398ms","hash":1948662083,"current-db-size-bytes":58216448,"current-db-size":"58 MB","current-db-size-in-use-bytes":31653888,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-08-18T19:37:20.17946Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1948662083,"revision":17920,"compact-revision":15300}
{"level":"info","ts":"2026-08-18T19:38:46.486968Z","caller":"traceutil/trace.go:171","msg":"trace[1424539652] transaction","detail":"{read_only:false; response_revision:20906; number_of_response:1; }","duration":"189.18185ms","start":"2026-08-18T19:38:46.297484Z","end":"2026-08-18T19:38:46.486666Z","steps":["trace[1424539652] 'process raft request'  (duration: 188.991395ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:38:46.836583Z","caller":"traceutil/trace.go:171","msg":"trace[88990021] transaction","detail":"{read_only:false; response_revision:20907; number_of_response:1; }","duration":"152.897ms","start":"2026-08-18T19:38:46.683653Z","end":"2026-08-18T19:38:46.83655Z","steps":["trace[88990021] 'process raft request'  (duration: 152.714196ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:38:47.104117Z","caller":"traceutil/trace.go:171","msg":"trace[423760116] transaction","detail":"{read_only:false; response_revision:20908; number_of_response:1; }","duration":"420.141663ms","start":"2026-08-18T19:38:46.683948Z","end":"2026-08-18T19:38:47.104089Z","steps":["trace[423760116] 'process raft request'  (duration: 411.270061ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:38:47.104417Z","caller":"traceutil/trace.go:171","msg":"trace[2034002415] transaction","detail":"{read_only:false; response_revision:20909; number_of_response:1; }","duration":"418.832989ms","start":"2026-08-18T19:38:46.685558Z","end":"2026-08-18T19:38:47.104391Z","steps":["trace[2034002415] 'process raft request'  (duration: 418.48244ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:38:47.104599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T19:38:46.685551Z","time spent":"418.945892ms","remote":"127.0.0.1:41302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:20899 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-08-18T19:38:47.104882Z","caller":"traceutil/trace.go:171","msg":"trace[2035742782] linearizableReadLoop","detail":"{readStateIndex:21605; appliedIndex:21602; }","duration":"240.02215ms","start":"2026-08-18T19:38:46.864693Z","end":"2026-08-18T19:38:47.104715Z","steps":["trace[2035742782] 'read index received'  (duration: 230.44735ms)","trace[2035742782] 'applied index is now lower than readState.Index'  (duration: 9.57383ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T19:38:47.104928Z","caller":"traceutil/trace.go:171","msg":"trace[1481473643] transaction","detail":"{read_only:false; response_revision:20910; number_of_response:1; }","duration":"413.323896ms","start":"2026-08-18T19:38:46.691589Z","end":"2026-08-18T19:38:47.104913Z","steps":["trace[1481473643] 'process raft request'  (duration: 412.70905ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:38:47.105036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.491219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/policies/\" range_end:\"/registry/rabbitmq.com/policies0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-08-18T19:38:47.105001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T19:38:46.691582Z","time spent":"413.377487ms","remote":"127.0.0.1:41302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:20859 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"info","ts":"2026-08-18T19:38:47.105082Z","caller":"traceutil/trace.go:171","msg":"trace[411611382] range","detail":"{range_begin:/registry/rabbitmq.com/policies/; range_end:/registry/rabbitmq.com/policies0; response_count:0; response_revision:20910; }","duration":"134.593642ms","start":"2026-08-18T19:38:46.970476Z","end":"2026-08-18T19:38:47.10507Z","steps":["trace[411611382] 'agreement among raft nodes before linearized reading'  (duration: 134.50925ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:38:47.105166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.448161ms","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":"info","ts":"2026-08-18T19:38:47.105304Z","caller":"traceutil/trace.go:171","msg":"trace[1842152117] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-cinder-server-0; range_end:; response_count:1; response_revision:20910; }","duration":"240.641547ms","start":"2026-08-18T19:38:46.864633Z","end":"2026-08-18T19:38:47.105274Z","steps":["trace[1842152117] 'agreement among raft nodes before linearized reading'  (duration: 240.299988ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:38:47.104333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T19:38:46.683941Z","time spent":"420.266737ms","remote":"127.0.0.1:41302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:20897 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-08-18T19:38:47.505599Z","caller":"traceutil/trace.go:171","msg":"trace[826574711] transaction","detail":"{read_only:false; response_revision:20913; number_of_response:1; }","duration":"176.314873ms","start":"2026-08-18T19:38:47.329254Z","end":"2026-08-18T19:38:47.50548Z","steps":["trace[826574711] 'process raft request'  (duration: 176.134398ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:38:47.652889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.655055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-18T19:38:47.653047Z","caller":"traceutil/trace.go:171","msg":"trace[1158203616] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:20913; }","duration":"131.906602ms","start":"2026-08-18T19:38:47.521117Z","end":"2026-08-18T19:38:47.653023Z","steps":["trace[1158203616] 'count revisions from in-memory index tree'  (duration: 131.534481ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:42:20.090249Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20338}
{"level":"info","ts":"2026-08-18T19:42:20.219357Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20338,"took":"124.38911ms","hash":480506772,"current-db-size-bytes":58216448,"current-db-size":"58 MB","current-db-size-in-use-bytes":32927744,"current-db-size-in-use":"33 MB"}
{"level":"info","ts":"2026-08-18T19:42:20.219446Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":480506772,"revision":20338,"compact-revision":17920}
{"level":"info","ts":"2026-08-18T19:42:24.250463Z","caller":"traceutil/trace.go:171","msg":"trace[502247045] transaction","detail":"{read_only:false; response_revision:22832; number_of_response:1; }","duration":"101.762589ms","start":"2026-08-18T19:42:24.148672Z","end":"2026-08-18T19:42:24.250435Z","steps":["trace[502247045] 'process raft request'  (duration: 101.569194ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:42:24.256471Z","caller":"traceutil/trace.go:171","msg":"trace[746586666] transaction","detail":"{read_only:false; response_revision:22833; number_of_response:1; }","duration":"107.745025ms","start":"2026-08-18T19:42:24.14869Z","end":"2026-08-18T19:42:24.256435Z","steps":["trace[746586666] 'process raft request'  (duration: 107.357775ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:42:24.256461Z","caller":"traceutil/trace.go:171","msg":"trace[733000615] transaction","detail":"{read_only:false; response_revision:22834; number_of_response:1; }","duration":"107.654103ms","start":"2026-08-18T19:42:24.148773Z","end":"2026-08-18T19:42:24.256427Z","steps":["trace[733000615] 'process raft request'  (duration: 107.535009ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:42:24.256763Z","caller":"traceutil/trace.go:171","msg":"trace[803100019] transaction","detail":"{read_only:false; response_revision:22836; number_of_response:1; }","duration":"107.854638ms","start":"2026-08-18T19:42:24.148899Z","end":"2026-08-18T19:42:24.256754Z","steps":["trace[803100019] 'process raft request'  (duration: 107.710614ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:42:24.256934Z","caller":"traceutil/trace.go:171","msg":"trace[1543374091] transaction","detail":"{read_only:false; response_revision:22835; number_of_response:1; }","duration":"108.063223ms","start":"2026-08-18T19:42:24.148855Z","end":"2026-08-18T19:42:24.256919Z","steps":["trace[1543374091] 'process raft request'  (duration: 107.53403ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:42:24.257092Z","caller":"traceutil/trace.go:171","msg":"trace[956613897] transaction","detail":"{read_only:false; response_revision:22837; number_of_response:1; }","duration":"108.177517ms","start":"2026-08-18T19:42:24.148905Z","end":"2026-08-18T19:42:24.257082Z","steps":["trace[956613897] 'process raft request'  (duration: 107.789226ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:42:24.257168Z","caller":"traceutil/trace.go:171","msg":"trace[79871368] transaction","detail":"{read_only:false; response_revision:22839; number_of_response:1; }","duration":"108.188037ms","start":"2026-08-18T19:42:24.148972Z","end":"2026-08-18T19:42:24.25716Z","steps":["trace[79871368] 'process raft request'  (duration: 107.779536ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:42:24.257144Z","caller":"traceutil/trace.go:171","msg":"trace[974528339] transaction","detail":"{read_only:false; response_revision:22838; number_of_response:1; }","duration":"108.187057ms","start":"2026-08-18T19:42:24.148929Z","end":"2026-08-18T19:42:24.257116Z","steps":["trace[974528339] 'process raft request'  (duration: 107.794156ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:42:24.257243Z","caller":"traceutil/trace.go:171","msg":"trace[20353477] transaction","detail":"{read_only:false; response_revision:22840; number_of_response:1; }","duration":"104.795169ms","start":"2026-08-18T19:42:24.15244Z","end":"2026-08-18T19:42:24.257235Z","steps":["trace[20353477] 'process raft request'  (duration: 104.4748ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:42:24.257336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.203628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-1\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-18T19:42:24.25738Z","caller":"traceutil/trace.go:171","msg":"trace[1026887859] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-1; range_end:; response_count:0; response_revision:22841; }","duration":"105.306101ms","start":"2026-08-18T19:42:24.152064Z","end":"2026-08-18T19:42:24.25737Z","steps":["trace[1026887859] 'agreement among raft nodes before linearized reading'  (duration: 105.200648ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:42:24.257235Z","caller":"traceutil/trace.go:171","msg":"trace[727795621] linearizableReadLoop","detail":"{readStateIndex:23598; appliedIndex:23590; }","duration":"105.114476ms","start":"2026-08-18T19:42:24.152107Z","end":"2026-08-18T19:42:24.257221Z","steps":["trace[727795621] 'read index received'  (duration: 98.154535ms)","trace[727795621] 'applied index is now lower than readState.Index'  (duration: 6.959351ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T19:42:34.552948Z","caller":"traceutil/trace.go:171","msg":"trace[1783579417] linearizableReadLoop","detail":"{readStateIndex:24103; appliedIndex:24102; }","duration":"232.426173ms","start":"2026-08-18T19:42:34.320493Z","end":"2026-08-18T19:42:34.552919Z","steps":["trace[1783579417] 'read index received'  (duration: 232.339231ms)","trace[1783579417] 'applied index is now lower than readState.Index'  (duration: 85.182µs)"],"step_count":2}
{"level":"info","ts":"2026-08-18T19:42:34.553072Z","caller":"traceutil/trace.go:171","msg":"trace[1162337889] transaction","detail":"{read_only:false; response_revision:23333; number_of_response:1; }","duration":"239.60918ms","start":"2026-08-18T19:42:34.313423Z","end":"2026-08-18T19:42:34.553032Z","steps":["trace[1162337889] 'process raft request'  (duration: 239.326003ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:42:34.553233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.718721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:573"}
{"level":"info","ts":"2026-08-18T19:42:34.553289Z","caller":"traceutil/trace.go:171","msg":"trace[243282900] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:23333; }","duration":"232.834554ms","start":"2026-08-18T19:42:34.320435Z","end":"2026-08-18T19:42:34.553269Z","steps":["trace[243282900] 'agreement among raft nodes before linearized reading'  (duration: 232.644369ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:42:34.571677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.764562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-08-18T19:42:34.571797Z","caller":"traceutil/trace.go:171","msg":"trace[419630176] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:23336; }","duration":"245.944526ms","start":"2026-08-18T19:42:34.325827Z","end":"2026-08-18T19:42:34.571772Z","steps":["trace[419630176] 'agreement among raft nodes before linearized reading'  (duration: 245.618518ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:42:34.572226Z","caller":"traceutil/trace.go:171","msg":"trace[252713417] transaction","detail":"{read_only:false; response_revision:23335; number_of_response:1; }","duration":"155.239376ms","start":"2026-08-18T19:42:34.416971Z","end":"2026-08-18T19:42:34.57221Z","steps":["trace[252713417] 'process raft request'  (duration: 154.362034ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:42:34.572222Z","caller":"traceutil/trace.go:171","msg":"trace[1663459740] transaction","detail":"{read_only:false; response_revision:23334; number_of_response:1; }","duration":"171.259685ms","start":"2026-08-18T19:42:34.400881Z","end":"2026-08-18T19:42:34.572141Z","steps":["trace[1663459740] 'process raft request'  (duration: 170.30822ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:42:34.572453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.380206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-08-18T19:42:34.572536Z","caller":"traceutil/trace.go:171","msg":"trace[2019725821] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:23336; }","duration":"169.55624ms","start":"2026-08-18T19:42:34.40296Z","end":"2026-08-18T19:42:34.572516Z","steps":["trace[2019725821] 'agreement among raft nodes before linearized reading'  (duration: 169.15702ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:45:43.108517Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-00000000000065c1.wal"}
{"level":"info","ts":"2026-08-18T19:46:07.269498Z","caller":"traceutil/trace.go:171","msg":"trace[1081318057] linearizableReadLoop","detail":"{readStateIndex:26356; appliedIndex:26355; }","duration":"167.324532ms","start":"2026-08-18T19:46:07.102146Z","end":"2026-08-18T19:46:07.269471Z","steps":["trace[1081318057] 'read index received'  (duration: 167.131137ms)","trace[1081318057] 'applied index is now lower than readState.Index'  (duration: 191.595µs)"],"step_count":2}
{"level":"warn","ts":"2026-08-18T19:46:07.270103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.244824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-18T19:46:07.270109Z","caller":"traceutil/trace.go:171","msg":"trace[1425788096] transaction","detail":"{read_only:false; response_revision:25529; number_of_response:1; }","duration":"253.788581ms","start":"2026-08-18T19:46:07.016267Z","end":"2026-08-18T19:46:07.270056Z","steps":["trace[1425788096] 'process raft request'  (duration: 253.00278ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:46:07.270153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.974819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"}
{"level":"info","ts":"2026-08-18T19:46:07.270278Z","caller":"traceutil/trace.go:171","msg":"trace[649186036] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25529; }","duration":"168.166764ms","start":"2026-08-18T19:46:07.102081Z","end":"2026-08-18T19:46:07.270248Z","steps":["trace[649186036] 'agreement among raft nodes before linearized reading'  (duration: 167.811025ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:46:07.270207Z","caller":"traceutil/trace.go:171","msg":"trace[1498905112] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:25529; }","duration":"148.423678ms","start":"2026-08-18T19:46:07.121761Z","end":"2026-08-18T19:46:07.270185Z","steps":["trace[1498905112] 'agreement among raft nodes before linearized reading'  (duration: 148.198123ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:46:07.408061Z","caller":"traceutil/trace.go:171","msg":"trace[402935587] transaction","detail":"{read_only:false; response_revision:25533; number_of_response:1; }","duration":"128.920208ms","start":"2026-08-18T19:46:07.279118Z","end":"2026-08-18T19:46:07.408038Z","steps":["trace[402935587] 'process raft request'  (duration: 128.805295ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:46:07.408088Z","caller":"traceutil/trace.go:171","msg":"trace[986017933] transaction","detail":"{read_only:false; response_revision:25532; number_of_response:1; }","duration":"130.020157ms","start":"2026-08-18T19:46:07.278034Z","end":"2026-08-18T19:46:07.408054Z","steps":["trace[986017933] 'process raft request'  (duration: 129.843722ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:46:07.408299Z","caller":"traceutil/trace.go:171","msg":"trace[1965327014] transaction","detail":"{read_only:false; response_revision:25531; number_of_response:1; }","duration":"130.49182ms","start":"2026-08-18T19:46:07.277794Z","end":"2026-08-18T19:46:07.408286Z","steps":["trace[1965327014] 'process raft request'  (duration: 129.941996ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:46:07.408535Z","caller":"traceutil/trace.go:171","msg":"trace[1326610662] transaction","detail":"{read_only:false; response_revision:25534; number_of_response:1; }","duration":"128.902658ms","start":"2026-08-18T19:46:07.279624Z","end":"2026-08-18T19:46:07.408527Z","steps":["trace[1326610662] 'process raft request'  (duration: 128.338983ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:46:07.535628Z","caller":"traceutil/trace.go:171","msg":"trace[891785393] transaction","detail":"{read_only:false; response_revision:25536; number_of_response:1; }","duration":"116.829293ms","start":"2026-08-18T19:46:07.418748Z","end":"2026-08-18T19:46:07.535577Z","steps":["trace[891785393] 'process raft request'  (duration: 116.241077ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:46:17.854046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.9563ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13360948736884453290 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:25596 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-18T19:46:17.854395Z","caller":"traceutil/trace.go:171","msg":"trace[2017724241] transaction","detail":"{read_only:false; response_revision:25610; number_of_response:1; }","duration":"274.852122ms","start":"2026-08-18T19:46:17.57949Z","end":"2026-08-18T19:46:17.854342Z","steps":["trace[2017724241] 'process raft request'  (duration: 140.45333ms)","trace[2017724241] 'compare'  (duration: 133.724314ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T19:46:17.854597Z","caller":"traceutil/trace.go:171","msg":"trace[294535288] transaction","detail":"{read_only:false; response_revision:25611; number_of_response:1; }","duration":"194.137982ms","start":"2026-08-18T19:46:17.660411Z","end":"2026-08-18T19:46:17.854549Z","steps":["trace[294535288] 'process raft request'  (duration: 193.768203ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:46:18.058281Z","caller":"traceutil/trace.go:171","msg":"trace[1718673619] transaction","detail":"{read_only:false; response_revision:25612; number_of_response:1; }","duration":"200.062768ms","start":"2026-08-18T19:46:17.858186Z","end":"2026-08-18T19:46:18.058248Z","steps":["trace[1718673619] 'process raft request'  (duration: 126.826704ms)","trace[1718673619] 'compare'  (duration: 73.054189ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T19:46:18.126766Z","caller":"traceutil/trace.go:171","msg":"trace[1585055195] transaction","detail":"{read_only:false; response_revision:25614; number_of_response:1; }","duration":"266.250527ms","start":"2026-08-18T19:46:17.86048Z","end":"2026-08-18T19:46:18.126731Z","steps":["trace[1585055195] 'process raft request'  (duration: 266.130514ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:46:18.126799Z","caller":"traceutil/trace.go:171","msg":"trace[164241121] transaction","detail":"{read_only:false; response_revision:25613; number_of_response:1; }","duration":"267.50213ms","start":"2026-08-18T19:46:17.859255Z","end":"2026-08-18T19:46:18.126757Z","steps":["trace[164241121] 'process raft request'  (duration: 267.13406ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:46:18.127033Z","caller":"traceutil/trace.go:171","msg":"trace[2038301786] transaction","detail":"{read_only:false; response_revision:25615; number_of_response:1; }","duration":"240.729521ms","start":"2026-08-18T19:46:17.886286Z","end":"2026-08-18T19:46:18.127016Z","steps":["trace[2038301786] 'process raft request'  (duration: 240.374291ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:46:18.127091Z","caller":"traceutil/trace.go:171","msg":"trace[1665328203] linearizableReadLoop","detail":"{readStateIndex:26443; appliedIndex:26440; }","duration":"251.83784ms","start":"2026-08-18T19:46:17.875149Z","end":"2026-08-18T19:46:18.126987Z","steps":["trace[1665328203] 'read index received'  (duration: 109.83816ms)","trace[1665328203] 'applied index is now lower than readState.Index'  (duration: 141.99685ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-18T19:46:18.127282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.121638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:573"}
{"level":"info","ts":"2026-08-18T19:46:18.127326Z","caller":"traceutil/trace.go:171","msg":"trace[1274268882] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:25615; }","duration":"252.23145ms","start":"2026-08-18T19:46:17.87508Z","end":"2026-08-18T19:46:18.127311Z","steps":["trace[1274268882] 'agreement among raft nodes before linearized reading'  (duration: 252.085577ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:46:18.380656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.66088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"}
{"level":"info","ts":"2026-08-18T19:46:18.380798Z","caller":"traceutil/trace.go:171","msg":"trace[539593458] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25617; }","duration":"123.897026ms","start":"2026-08-18T19:46:18.256869Z","end":"2026-08-18T19:46:18.380766Z","steps":["trace[539593458] 'range keys from in-memory index tree'  (duration: 123.302601ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:46:18.863815Z","caller":"traceutil/trace.go:171","msg":"trace[1541594266] transaction","detail":"{read_only:false; response_revision:25618; number_of_response:1; }","duration":"176.744218ms","start":"2026-08-18T19:46:18.687037Z","end":"2026-08-18T19:46:18.863781Z","steps":["trace[1541594266] 'process raft request'  (duration: 176.431579ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:46:18.994506Z","caller":"traceutil/trace.go:171","msg":"trace[429529935] transaction","detail":"{read_only:false; response_revision:25619; number_of_response:1; }","duration":"306.262523ms","start":"2026-08-18T19:46:18.688213Z","end":"2026-08-18T19:46:18.994476Z","steps":["trace[429529935] 'process raft request'  (duration: 288.56086ms)","trace[429529935] 'compare'  (duration: 17.533118ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-18T19:46:18.994684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T19:46:18.688186Z","time spent":"306.399665ms","remote":"127.0.0.1:41302","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:25604 > 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-18T19:46:18.994921Z","caller":"traceutil/trace.go:171","msg":"trace[2054298868] transaction","detail":"{read_only:false; response_revision:25620; number_of_response:1; }","duration":"257.95417ms","start":"2026-08-18T19:46:18.736926Z","end":"2026-08-18T19:46:18.99488Z","steps":["trace[2054298868] 'process raft request'  (duration: 257.506548ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:46:18.99519Z","caller":"traceutil/trace.go:171","msg":"trace[925841703] transaction","detail":"{read_only:false; response_revision:25621; number_of_response:1; }","duration":"156.414757ms","start":"2026-08-18T19:46:18.83869Z","end":"2026-08-18T19:46:18.995105Z","steps":["trace[925841703] 'process raft request'  (duration: 156.076678ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:46:19.474673Z","caller":"traceutil/trace.go:171","msg":"trace[1798318850] transaction","detail":"{read_only:false; response_revision:25622; number_of_response:1; }","duration":"125.027947ms","start":"2026-08-18T19:46:19.349613Z","end":"2026-08-18T19:46:19.474641Z","steps":["trace[1798318850] 'process raft request'  (duration: 124.806861ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:46:19.793601Z","caller":"traceutil/trace.go:171","msg":"trace[2021327892] linearizableReadLoop","detail":"{readStateIndex:26453; appliedIndex:26452; }","duration":"272.089999ms","start":"2026-08-18T19:46:19.521481Z","end":"2026-08-18T19:46:19.793571Z","steps":["trace[2021327892] 'read index received'  (duration: 255.698371ms)","trace[2021327892] 'applied index is now lower than readState.Index'  (duration: 16.390388ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T19:46:19.793733Z","caller":"traceutil/trace.go:171","msg":"trace[952777084] transaction","detail":"{read_only:false; response_revision:25623; number_of_response:1; }","duration":"397.546297ms","start":"2026-08-18T19:46:19.396171Z","end":"2026-08-18T19:46:19.793717Z","steps":["trace[952777084] 'process raft request'  (duration: 380.984954ms)","trace[952777084] 'compare'  (duration: 16.111901ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-18T19:46:19.793853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T19:46:19.396136Z","time spent":"397.623749ms","remote":"127.0.0.1:41302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:25551 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-08-18T19:46:19.79393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.402748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-18T19:46:19.794047Z","caller":"traceutil/trace.go:171","msg":"trace[2038788521] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25623; }","duration":"272.591493ms","start":"2026-08-18T19:46:19.521426Z","end":"2026-08-18T19:46:19.794018Z","steps":["trace[2038788521] 'agreement among raft nodes before linearized reading'  (duration: 272.369117ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:46:19.805408Z","caller":"traceutil/trace.go:171","msg":"trace[1876091447] transaction","detail":"{read_only:false; response_revision:25624; number_of_response:1; }","duration":"198.543348ms","start":"2026-08-18T19:46:19.606841Z","end":"2026-08-18T19:46:19.805384Z","steps":["trace[1876091447] 'process raft request'  (duration: 198.23738ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:46:19.805813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.231497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/octavia-api\" ","response":"range_response_count:1 size:672"}
{"level":"info","ts":"2026-08-18T19:46:19.805851Z","caller":"traceutil/trace.go:171","msg":"trace[44681019] range","detail":"{range_begin:/registry/services/endpoints/openstack/octavia-api; range_end:; response_count:1; response_revision:25624; }","duration":"235.287868ms","start":"2026-08-18T19:46:19.570553Z","end":"2026-08-18T19:46:19.805841Z","steps":["trace[44681019] 'agreement among raft nodes before linearized reading'  (duration: 235.178805ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:46:19.805889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.697178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/octavia-api\" ","response":"range_response_count:1 size:672"}
{"level":"info","ts":"2026-08-18T19:46:19.805925Z","caller":"traceutil/trace.go:171","msg":"trace[1925412322] range","detail":"{range_begin:/registry/services/endpoints/openstack/octavia-api; range_end:; response_count:1; response_revision:25624; }","duration":"243.807661ms","start":"2026-08-18T19:46:19.562108Z","end":"2026-08-18T19:46:19.805916Z","steps":["trace[1925412322] 'agreement among raft nodes before linearized reading'  (duration: 243.625466ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:46:19.806106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.88334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/octavia-api\" ","response":"range_response_count:1 size:672"}
{"level":"info","ts":"2026-08-18T19:46:19.806126Z","caller":"traceutil/trace.go:171","msg":"trace[536741940] range","detail":"{range_begin:/registry/services/endpoints/openstack/octavia-api; range_end:; response_count:1; response_revision:25624; }","duration":"236.922811ms","start":"2026-08-18T19:46:19.569197Z","end":"2026-08-18T19:46:19.80612Z","steps":["trace[536741940] 'agreement among raft nodes before linearized reading'  (duration: 236.8655ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:46:20.218353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.195001ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13360948736884453329 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" mod_revision:25593 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" value_size:518 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-18T19:46:20.21855Z","caller":"traceutil/trace.go:171","msg":"trace[1077340316] transaction","detail":"{read_only:false; response_revision:25626; number_of_response:1; }","duration":"158.170883ms","start":"2026-08-18T19:46:20.06033Z","end":"2026-08-18T19:46:20.218501Z","steps":["trace[1077340316] 'process raft request'  (duration: 50.694545ms)","trace[1077340316] 'compare'  (duration: 106.988296ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T19:46:20.218852Z","caller":"traceutil/trace.go:171","msg":"trace[1935963016] linearizableReadLoop","detail":"{readStateIndex:26456; appliedIndex:26455; }","duration":"155.478523ms","start":"2026-08-18T19:46:20.063354Z","end":"2026-08-18T19:46:20.218832Z","steps":["trace[1935963016] 'read index received'  (duration: 47.608734ms)","trace[1935963016] 'applied index is now lower than readState.Index'  (duration: 107.868699ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-18T19:46:20.219215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.827482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"info","ts":"2026-08-18T19:46:20.219597Z","caller":"traceutil/trace.go:171","msg":"trace[1104025285] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25627; }","duration":"156.275183ms","start":"2026-08-18T19:46:20.063289Z","end":"2026-08-18T19:46:20.219565Z","steps":["trace[1104025285] 'agreement among raft nodes before linearized reading'  (duration: 155.662427ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:46:20.239744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.855855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-08-18T19:46:20.239806Z","caller":"traceutil/trace.go:171","msg":"trace[1119652754] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25628; }","duration":"108.970487ms","start":"2026-08-18T19:46:20.130821Z","end":"2026-08-18T19:46:20.239791Z","steps":["trace[1119652754] 'agreement among raft nodes before linearized reading'  (duration: 108.800693ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:46:20.240063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.799283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-08-18T19:46:20.240171Z","caller":"traceutil/trace.go:171","msg":"trace[495504871] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25628; }","duration":"108.931087ms","start":"2026-08-18T19:46:20.131213Z","end":"2026-08-18T19:46:20.240144Z","steps":["trace[495504871] 'agreement among raft nodes before linearized reading'  (duration: 108.581887ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:46:20.406386Z","caller":"traceutil/trace.go:171","msg":"trace[61324781] transaction","detail":"{read_only:false; response_revision:25630; number_of_response:1; }","duration":"162.603909ms","start":"2026-08-18T19:46:20.243755Z","end":"2026-08-18T19:46:20.406359Z","steps":["trace[61324781] 'process raft request'  (duration: 152.976237ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:46:20.406647Z","caller":"traceutil/trace.go:171","msg":"trace[1961087963] transaction","detail":"{read_only:false; response_revision:25631; number_of_response:1; }","duration":"162.569038ms","start":"2026-08-18T19:46:20.244061Z","end":"2026-08-18T19:46:20.40663Z","steps":["trace[1961087963] 'process raft request'  (duration: 162.241509ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:46:20.406913Z","caller":"traceutil/trace.go:171","msg":"trace[1778343374] transaction","detail":"{read_only:false; response_revision:25632; number_of_response:1; }","duration":"162.349042ms","start":"2026-08-18T19:46:20.244531Z","end":"2026-08-18T19:46:20.40688Z","steps":["trace[1778343374] 'process raft request'  (duration: 161.877979ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:46:21.354975Z","caller":"traceutil/trace.go:171","msg":"trace[210674617] transaction","detail":"{read_only:false; response_revision:25634; number_of_response:1; }","duration":"354.392789ms","start":"2026-08-18T19:46:21.000552Z","end":"2026-08-18T19:46:21.354945Z","steps":["trace[210674617] 'process raft request'  (duration: 354.160363ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:46:21.35522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T19:46:21.000529Z","time spent":"354.598355ms","remote":"127.0.0.1:41302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:25621 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:441 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"info","ts":"2026-08-18T19:46:21.374554Z","caller":"traceutil/trace.go:171","msg":"trace[324539785] transaction","detail":"{read_only:false; response_revision:25635; number_of_response:1; }","duration":"373.358025ms","start":"2026-08-18T19:46:21.001131Z","end":"2026-08-18T19:46:21.374489Z","steps":["trace[324539785] 'process raft request'  (duration: 373.113919ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:46:21.374806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T19:46:21.001097Z","time spent":"373.574701ms","remote":"127.0.0.1:41302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:25620 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:507 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"info","ts":"2026-08-18T19:46:21.374829Z","caller":"traceutil/trace.go:171","msg":"trace[817722882] linearizableReadLoop","detail":"{readStateIndex:26466; appliedIndex:26463; }","duration":"185.848316ms","start":"2026-08-18T19:46:21.188954Z","end":"2026-08-18T19:46:21.374802Z","steps":["trace[817722882] 'read index received'  (duration: 165.865064ms)","trace[817722882] 'applied index is now lower than readState.Index'  (duration: 19.982102ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T19:46:21.374926Z","caller":"traceutil/trace.go:171","msg":"trace[1117846409] transaction","detail":"{read_only:false; response_revision:25636; number_of_response:1; }","duration":"371.836125ms","start":"2026-08-18T19:46:21.003049Z","end":"2026-08-18T19:46:21.374885Z","steps":["trace[1117846409] 'process raft request'  (duration: 371.61213ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:46:21.374999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.019361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstores/\" range_end:\"/registry/ceph.rook.io/cephobjectstores0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-08-18T19:46:21.375047Z","caller":"traceutil/trace.go:171","msg":"trace[720991416] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstores/; range_end:/registry/ceph.rook.io/cephobjectstores0; response_count:0; response_revision:25636; }","duration":"186.141614ms","start":"2026-08-18T19:46:21.188886Z","end":"2026-08-18T19:46:21.375027Z","steps":["trace[720991416] 'agreement among raft nodes before linearized reading'  (duration: 186.044592ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:46:21.37513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T19:46:21.003037Z","time spent":"371.99122ms","remote":"127.0.0.1:41302","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:25619 > 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":"warn","ts":"2026-08-18T19:46:21.631656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.961125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-18T19:46:21.631762Z","caller":"traceutil/trace.go:171","msg":"trace[1509916594] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25636; }","duration":"112.14977ms","start":"2026-08-18T19:46:21.519591Z","end":"2026-08-18T19:46:21.631741Z","steps":["trace[1509916594] 'range keys from in-memory index tree'  (duration: 111.815702ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:46:21.631934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.922282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:559"}
{"level":"info","ts":"2026-08-18T19:46:21.632034Z","caller":"traceutil/trace.go:171","msg":"trace[779558633] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25636; }","duration":"146.103277ms","start":"2026-08-18T19:46:21.485911Z","end":"2026-08-18T19:46:21.632014Z","steps":["trace[779558633] 'range keys from in-memory index tree'  (duration: 145.720757ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:46:21.787775Z","caller":"traceutil/trace.go:171","msg":"trace[18341044] transaction","detail":"{read_only:false; response_revision:25637; number_of_response:1; }","duration":"149.965329ms","start":"2026-08-18T19:46:21.637756Z","end":"2026-08-18T19:46:21.787722Z","steps":["trace[18341044] 'process raft request'  (duration: 149.302691ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:46:22.060171Z","caller":"traceutil/trace.go:171","msg":"trace[1774068116] linearizableReadLoop","detail":"{readStateIndex:26469; appliedIndex:26468; }","duration":"235.298167ms","start":"2026-08-18T19:46:21.824833Z","end":"2026-08-18T19:46:22.060131Z","steps":["trace[1774068116] 'read index received'  (duration: 235.053201ms)","trace[1774068116] 'applied index is now lower than readState.Index'  (duration: 242.686µs)"],"step_count":2}
{"level":"info","ts":"2026-08-18T19:46:22.060289Z","caller":"traceutil/trace.go:171","msg":"trace[71655221] transaction","detail":"{read_only:false; response_revision:25639; number_of_response:1; }","duration":"248.519783ms","start":"2026-08-18T19:46:21.811704Z","end":"2026-08-18T19:46:22.060224Z","steps":["trace[71655221] 'process raft request'  (duration: 248.156963ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:46:22.060577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.658983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/octavia-api\" ","response":"range_response_count:1 size:672"}
{"level":"warn","ts":"2026-08-18T19:46:22.060621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.308549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/octavia-api\" ","response":"range_response_count:1 size:672"}
{"level":"info","ts":"2026-08-18T19:46:22.060689Z","caller":"traceutil/trace.go:171","msg":"trace[1194418506] range","detail":"{range_begin:/registry/services/endpoints/openstack/octavia-api; range_end:; response_count:1; response_revision:25639; }","duration":"249.804266ms","start":"2026-08-18T19:46:21.810857Z","end":"2026-08-18T19:46:22.060661Z","steps":["trace[1194418506] 'agreement among raft nodes before linearized reading'  (duration: 249.421756ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:46:22.060707Z","caller":"traceutil/trace.go:171","msg":"trace[1901154191] range","detail":"{range_begin:/registry/services/endpoints/openstack/octavia-api; range_end:; response_count:1; response_revision:25639; }","duration":"250.445053ms","start":"2026-08-18T19:46:21.81024Z","end":"2026-08-18T19:46:22.060685Z","steps":["trace[1901154191] 'agreement among raft nodes before linearized reading'  (duration: 250.088093ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:46:22.386433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.294558ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13360948736884453355 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:25625 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-18T19:46:22.386642Z","caller":"traceutil/trace.go:171","msg":"trace[505156655] transaction","detail":"{read_only:false; response_revision:25641; number_of_response:1; }","duration":"161.210542ms","start":"2026-08-18T19:46:22.225412Z","end":"2026-08-18T19:46:22.386622Z","steps":["trace[505156655] 'process raft request'  (duration: 161.142311ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:46:22.386872Z","caller":"traceutil/trace.go:171","msg":"trace[1712449911] transaction","detail":"{read_only:false; response_revision:25640; number_of_response:1; }","duration":"424.629036ms","start":"2026-08-18T19:46:21.96223Z","end":"2026-08-18T19:46:22.386859Z","steps":["trace[1712449911] 'process raft request'  (duration: 211.811175ms)","trace[1712449911] 'compare'  (duration: 212.133143ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-18T19:46:22.38693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T19:46:21.962201Z","time spent":"424.695158ms","remote":"127.0.0.1:41302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:25625 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-08-18T19:46:22.387176Z","caller":"traceutil/trace.go:171","msg":"trace[2060652119] linearizableReadLoop","detail":"{readStateIndex:26470; appliedIndex:26469; }","duration":"221.464267ms","start":"2026-08-18T19:46:22.165671Z","end":"2026-08-18T19:46:22.387136Z","steps":["trace[2060652119] 'read index received'  (duration: 8.343758ms)","trace[2060652119] 'applied index is now lower than readState.Index'  (duration: 213.118109ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-18T19:46:22.387455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.770565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-18T19:46:22.387508Z","caller":"traceutil/trace.go:171","msg":"trace[1916250673] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:25641; }","duration":"221.896408ms","start":"2026-08-18T19:46:22.165596Z","end":"2026-08-18T19:46:22.387492Z","steps":["trace[1916250673] 'agreement among raft nodes before linearized reading'  (duration: 221.787775ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:46:22.473212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.857907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-08-18T19:46:22.473266Z","caller":"traceutil/trace.go:171","msg":"trace[628316731] transaction","detail":"{read_only:false; response_revision:25642; number_of_response:1; }","duration":"227.063193ms","start":"2026-08-18T19:46:22.246166Z","end":"2026-08-18T19:46:22.473229Z","steps":["trace[628316731] 'process raft request'  (duration: 226.671833ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:46:22.473289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.472192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclustertemplates/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclustertemplates0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-18T19:46:22.473308Z","caller":"traceutil/trace.go:171","msg":"trace[607246446] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25642; }","duration":"216.99793ms","start":"2026-08-18T19:46:22.256288Z","end":"2026-08-18T19:46:22.473286Z","steps":["trace[607246446] 'agreement among raft nodes before linearized reading'  (duration: 216.748893ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:46:22.47335Z","caller":"traceutil/trace.go:171","msg":"trace[634902752] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclustertemplates/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclustertemplates0; response_count:0; response_revision:25642; }","duration":"230.603345ms","start":"2026-08-18T19:46:22.242728Z","end":"2026-08-18T19:46:22.473331Z","steps":["trace[634902752] 'agreement among raft nodes before linearized reading'  (duration: 230.327798ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:46:22.729873Z","caller":"traceutil/trace.go:171","msg":"trace[1093907514] transaction","detail":"{read_only:false; response_revision:25644; number_of_response:1; }","duration":"249.464758ms","start":"2026-08-18T19:46:22.480373Z","end":"2026-08-18T19:46:22.729838Z","steps":["trace[1093907514] 'process raft request'  (duration: 214.830163ms)","trace[1093907514] 'compare'  (duration: 34.44795ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T19:46:22.730272Z","caller":"traceutil/trace.go:171","msg":"trace[878701211] linearizableReadLoop","detail":"{readStateIndex:26476; appliedIndex:26473; }","duration":"208.57267ms","start":"2026-08-18T19:46:22.521648Z","end":"2026-08-18T19:46:22.730221Z","steps":["trace[878701211] 'read index received'  (duration: 173.473653ms)","trace[878701211] 'applied index is now lower than readState.Index'  (duration: 35.097827ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-18T19:46:22.730478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.801306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-18T19:46:22.730525Z","caller":"traceutil/trace.go:171","msg":"trace[1960475097] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25646; }","duration":"208.917849ms","start":"2026-08-18T19:46:22.521593Z","end":"2026-08-18T19:46:22.730511Z","steps":["trace[1960475097] 'agreement among raft nodes before linearized reading'  (duration: 208.767015ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:46:22.730577Z","caller":"traceutil/trace.go:171","msg":"trace[1285076721] transaction","detail":"{read_only:false; response_revision:25645; number_of_response:1; }","duration":"250.167756ms","start":"2026-08-18T19:46:22.480373Z","end":"2026-08-18T19:46:22.730541Z","steps":["trace[1285076721] 'process raft request'  (duration: 249.417727ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:46:22.730601Z","caller":"traceutil/trace.go:171","msg":"trace[1372494831] transaction","detail":"{read_only:false; response_revision:25646; number_of_response:1; }","duration":"250.063254ms","start":"2026-08-18T19:46:22.480491Z","end":"2026-08-18T19:46:22.730554Z","steps":["trace[1372494831] 'process raft request'  (duration: 249.604222ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:46:23.165174Z","caller":"traceutil/trace.go:171","msg":"trace[1084208371] transaction","detail":"{read_only:false; response_revision:25647; number_of_response:1; }","duration":"143.253113ms","start":"2026-08-18T19:46:23.021884Z","end":"2026-08-18T19:46:23.165138Z","steps":["trace[1084208371] 'process raft request'  (duration: 143.052948ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:46:23.397555Z","caller":"traceutil/trace.go:171","msg":"trace[169773605] linearizableReadLoop","detail":"{readStateIndex:26478; appliedIndex:26477; }","duration":"159.58562ms","start":"2026-08-18T19:46:23.237935Z","end":"2026-08-18T19:46:23.397521Z","steps":["trace[169773605] 'read index received'  (duration: 66.822856ms)","trace[169773605] 'applied index is now lower than readState.Index'  (duration: 92.761114ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T19:46:23.397645Z","caller":"traceutil/trace.go:171","msg":"trace[447977279] transaction","detail":"{read_only:false; response_revision:25648; number_of_response:1; }","duration":"222.049132ms","start":"2026-08-18T19:46:23.175508Z","end":"2026-08-18T19:46:23.397558Z","steps":["trace[447977279] 'process raft request'  (duration: 129.294169ms)","trace[447977279] 'compare'  (duration: 92.531257ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-18T19:46:23.397824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.874057ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.186\" ","response":"range_response_count:1 size:140"}
{"level":"info","ts":"2026-08-18T19:46:23.397908Z","caller":"traceutil/trace.go:171","msg":"trace[1846328879] range","detail":"{range_begin:/registry/masterleases/162.253.55.186; range_end:; response_count:1; response_revision:25648; }","duration":"160.000591ms","start":"2026-08-18T19:46:23.237888Z","end":"2026-08-18T19:46:23.397888Z","steps":["trace[1846328879] 'agreement among raft nodes before linearized reading'  (duration: 159.734134ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:46:23.482683Z","caller":"traceutil/trace.go:171","msg":"trace[283338058] transaction","detail":"{read_only:false; response_revision:25649; number_of_response:1; }","duration":"126.865755ms","start":"2026-08-18T19:46:23.355791Z","end":"2026-08-18T19:46:23.482657Z","steps":["trace[283338058] 'process raft request'  (duration: 126.762952ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:46:23.486749Z","caller":"traceutil/trace.go:171","msg":"trace[1896311142] transaction","detail":"{read_only:false; response_revision:25650; number_of_response:1; }","duration":"125.602362ms","start":"2026-08-18T19:46:23.361129Z","end":"2026-08-18T19:46:23.486731Z","steps":["trace[1896311142] 'process raft request'  (duration: 125.026027ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:46:23.486758Z","caller":"traceutil/trace.go:171","msg":"trace[1341146376] transaction","detail":"{read_only:false; response_revision:25651; number_of_response:1; }","duration":"105.731823ms","start":"2026-08-18T19:46:23.380979Z","end":"2026-08-18T19:46:23.486711Z","steps":["trace[1341146376] 'process raft request'  (duration: 105.360803ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:46:23.486776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.417812ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-08-18T19:46:23.486898Z","caller":"traceutil/trace.go:171","msg":"trace[982564089] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25651; }","duration":"103.590167ms","start":"2026-08-18T19:46:23.383281Z","end":"2026-08-18T19:46:23.486871Z","steps":["trace[982564089] 'agreement among raft nodes before linearized reading'  (duration: 103.31731ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:46:28.670433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.414054ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13360948736884453472 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:25672 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-18T19:46:28.670705Z","caller":"traceutil/trace.go:171","msg":"trace[1980940673] linearizableReadLoop","detail":"{readStateIndex:26517; appliedIndex:26516; }","duration":"147.250057ms","start":"2026-08-18T19:46:28.523432Z","end":"2026-08-18T19:46:28.670682Z","steps":["trace[1980940673] 'read index received'  (duration: 46.455143ms)","trace[1980940673] 'applied index is now lower than readState.Index'  (duration: 100.792944ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T19:46:28.670797Z","caller":"traceutil/trace.go:171","msg":"trace[338361812] transaction","detail":"{read_only:false; response_revision:25686; number_of_response:1; }","duration":"176.712257ms","start":"2026-08-18T19:46:28.494023Z","end":"2026-08-18T19:46:28.670735Z","steps":["trace[338361812] 'process raft request'  (duration: 75.78956ms)","trace[338361812] 'compare'  (duration: 100.115056ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-18T19:46:28.670937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.462463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-18T19:46:28.671073Z","caller":"traceutil/trace.go:171","msg":"trace[1043151573] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25686; }","duration":"147.663349ms","start":"2026-08-18T19:46:28.523385Z","end":"2026-08-18T19:46:28.671048Z","steps":["trace[1043151573] 'agreement among raft nodes before linearized reading'  (duration: 147.410132ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:46:28.685237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.683572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-08-18T19:46:28.685336Z","caller":"traceutil/trace.go:171","msg":"trace[996881620] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25686; }","duration":"118.835885ms","start":"2026-08-18T19:46:28.566478Z","end":"2026-08-18T19:46:28.685314Z","steps":["trace[996881620] 'agreement among raft nodes before linearized reading'  (duration: 118.458576ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:46:35.598075Z","caller":"traceutil/trace.go:171","msg":"trace[1801231671] transaction","detail":"{read_only:false; response_revision:25794; number_of_response:1; }","duration":"182.55681ms","start":"2026-08-18T19:46:35.415479Z","end":"2026-08-18T19:46:35.598036Z","steps":["trace[1801231671] 'process raft request'  (duration: 182.307714ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:46:35.82039Z","caller":"traceutil/trace.go:171","msg":"trace[1652735521] linearizableReadLoop","detail":"{readStateIndex:26630; appliedIndex:26628; }","duration":"222.403062ms","start":"2026-08-18T19:46:35.597957Z","end":"2026-08-18T19:46:35.82036Z","steps":["trace[1652735521] 'read index received'  (duration: 222.158535ms)","trace[1652735521] 'applied index is now lower than readState.Index'  (duration: 243.197µs)"],"step_count":2}
{"level":"info","ts":"2026-08-18T19:46:35.820499Z","caller":"traceutil/trace.go:171","msg":"trace[1711451936] transaction","detail":"{read_only:false; response_revision:25796; number_of_response:1; }","duration":"273.222019ms","start":"2026-08-18T19:46:35.547235Z","end":"2026-08-18T19:46:35.820457Z","steps":["trace[1711451936] 'process raft request'  (duration: 273.066465ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:46:35.820629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.364365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-18T19:46:35.820693Z","caller":"traceutil/trace.go:171","msg":"trace[1638631523] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25796; }","duration":"221.493988ms","start":"2026-08-18T19:46:35.599183Z","end":"2026-08-18T19:46:35.820676Z","steps":["trace[1638631523] 'agreement among raft nodes before linearized reading'  (duration: 221.377525ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:46:35.820738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.277269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/sshkeys/\" range_end:\"/registry/secretgen.k14s.io/sshkeys0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-08-18T19:46:35.820488Z","caller":"traceutil/trace.go:171","msg":"trace[1090153110] transaction","detail":"{read_only:false; response_revision:25795; number_of_response:1; }","duration":"276.971047ms","start":"2026-08-18T19:46:35.543452Z","end":"2026-08-18T19:46:35.820424Z","steps":["trace[1090153110] 'process raft request'  (duration: 276.644759ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:46:35.82079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.596779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-08-18T19:46:35.820793Z","caller":"traceutil/trace.go:171","msg":"trace[474440219] range","detail":"{range_begin:/registry/secretgen.k14s.io/sshkeys/; range_end:/registry/secretgen.k14s.io/sshkeys0; response_count:0; response_revision:25796; }","duration":"134.384671ms","start":"2026-08-18T19:46:35.686395Z","end":"2026-08-18T19:46:35.82078Z","steps":["trace[474440219] 'agreement among raft nodes before linearized reading'  (duration: 134.201617ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:46:35.82089Z","caller":"traceutil/trace.go:171","msg":"trace[1698359817] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25796; }","duration":"273.744563ms","start":"2026-08-18T19:46:35.547123Z","end":"2026-08-18T19:46:35.820867Z","steps":["trace[1698359817] 'agreement among raft nodes before linearized reading'  (duration: 273.395974ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:46:36.038713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.054977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:559"}
{"level":"info","ts":"2026-08-18T19:46:36.038854Z","caller":"traceutil/trace.go:171","msg":"trace[1359725596] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25797; }","duration":"169.269083ms","start":"2026-08-18T19:46:35.869555Z","end":"2026-08-18T19:46:36.038824Z","steps":["trace[1359725596] 'range keys from in-memory index tree'  (duration: 168.815041ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:46:36.038735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.561689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/octavia-api\" ","response":"range_response_count:1 size:672"}
{"level":"info","ts":"2026-08-18T19:46:36.03896Z","caller":"traceutil/trace.go:171","msg":"trace[2048830944] range","detail":"{range_begin:/registry/services/endpoints/openstack/octavia-api; range_end:; response_count:1; response_revision:25797; }","duration":"172.851036ms","start":"2026-08-18T19:46:35.866084Z","end":"2026-08-18T19:46:36.038935Z","steps":["trace[2048830944] 'range keys from in-memory index tree'  (duration: 172.300982ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:46:36.367208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.187767ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13360948736884453792 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:25729 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:457 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-18T19:46:36.367308Z","caller":"traceutil/trace.go:171","msg":"trace[323919666] linearizableReadLoop","detail":"{readStateIndex:26633; appliedIndex:26632; }","duration":"247.552927ms","start":"2026-08-18T19:46:36.119739Z","end":"2026-08-18T19:46:36.367292Z","steps":["trace[323919666] 'read index received'  (duration: 98.160735ms)","trace[323919666] 'applied index is now lower than readState.Index'  (duration: 149.390852ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T19:46:36.367381Z","caller":"traceutil/trace.go:171","msg":"trace[713611632] transaction","detail":"{read_only:false; response_revision:25799; number_of_response:1; }","duration":"258.676257ms","start":"2026-08-18T19:46:36.108695Z","end":"2026-08-18T19:46:36.367372Z","steps":["trace[713611632] 'process raft request'  (duration: 109.245224ms)","trace[713611632] 'compare'  (duration: 148.858658ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-18T19:46:36.368168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.612007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/octavia-api\" ","response":"range_response_count:1 size:672"}
{"level":"info","ts":"2026-08-18T19:46:36.368288Z","caller":"traceutil/trace.go:171","msg":"trace[1138085092] range","detail":"{range_begin:/registry/services/endpoints/openstack/octavia-api; range_end:; response_count:1; response_revision:25799; }","duration":"268.788843ms","start":"2026-08-18T19:46:36.099479Z","end":"2026-08-18T19:46:36.368268Z","steps":["trace[1138085092] 'agreement among raft nodes before linearized reading'  (duration: 268.482405ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:46:36.617915Z","caller":"traceutil/trace.go:171","msg":"trace[1833402248] transaction","detail":"{read_only:false; response_revision:25801; number_of_response:1; }","duration":"163.962214ms","start":"2026-08-18T19:46:36.453926Z","end":"2026-08-18T19:46:36.617888Z","steps":["trace[1833402248] 'process raft request'  (duration: 163.637546ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:46:36.780827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.00221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-18T19:46:36.780933Z","caller":"traceutil/trace.go:171","msg":"trace[543397357] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25801; }","duration":"160.172345ms","start":"2026-08-18T19:46:36.620738Z","end":"2026-08-18T19:46:36.78091Z","steps":["trace[543397357] 'range keys from in-memory index tree'  (duration: 159.890768ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:46:36.906857Z","caller":"traceutil/trace.go:171","msg":"trace[271553586] linearizableReadLoop","detail":"{readStateIndex:26636; appliedIndex:26635; }","duration":"180.869876ms","start":"2026-08-18T19:46:36.725961Z","end":"2026-08-18T19:46:36.906831Z","steps":["trace[271553586] 'read index received'  (duration: 180.672701ms)","trace[271553586] 'applied index is now lower than readState.Index'  (duration: 195.915µs)"],"step_count":2}
{"level":"info","ts":"2026-08-18T19:46:36.906961Z","caller":"traceutil/trace.go:171","msg":"trace[1656080260] transaction","detail":"{read_only:false; response_revision:25802; number_of_response:1; }","duration":"205.254364ms","start":"2026-08-18T19:46:36.701661Z","end":"2026-08-18T19:46:36.906915Z","steps":["trace[1656080260] 'process raft request'  (duration: 204.978356ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:46:36.90716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.189315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" ","response":"range_response_count:1 size:7698"}
{"level":"info","ts":"2026-08-18T19:46:36.907201Z","caller":"traceutil/trace.go:171","msg":"trace[1100033627] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/openstack/ceph; range_end:; response_count:1; response_revision:25802; }","duration":"160.290698ms","start":"2026-08-18T19:46:36.746899Z","end":"2026-08-18T19:46:36.907189Z","steps":["trace[1100033627] 'agreement among raft nodes before linearized reading'  (duration: 160.096203ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:46:36.907177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.686077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-08-18T19:46:36.907276Z","caller":"traceutil/trace.go:171","msg":"trace[1942508962] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25802; }","duration":"181.80187ms","start":"2026-08-18T19:46:36.72545Z","end":"2026-08-18T19:46:36.907252Z","steps":["trace[1942508962] 'agreement among raft nodes before linearized reading'  (duration: 181.503663ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:46:36.907269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.510186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"info","ts":"2026-08-18T19:46:36.907355Z","caller":"traceutil/trace.go:171","msg":"trace[524048261] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25802; }","duration":"100.65611ms","start":"2026-08-18T19:46:36.806677Z","end":"2026-08-18T19:46:36.907333Z","steps":["trace[524048261] 'agreement among raft nodes before linearized reading'  (duration: 100.454205ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:46:36.907542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.23806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-08-18T19:46:36.907597Z","caller":"traceutil/trace.go:171","msg":"trace[1097204547] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:25802; }","duration":"141.326603ms","start":"2026-08-18T19:46:36.766258Z","end":"2026-08-18T19:46:36.907585Z","steps":["trace[1097204547] 'agreement among raft nodes before linearized reading'  (duration: 141.19269ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:46:37.147765Z","caller":"traceutil/trace.go:171","msg":"trace[302383592] transaction","detail":"{read_only:false; response_revision:25804; number_of_response:1; }","duration":"235.671059ms","start":"2026-08-18T19:46:36.912046Z","end":"2026-08-18T19:46:37.147717Z","steps":["trace[302383592] 'process raft request'  (duration: 235.234997ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:46:37.147783Z","caller":"traceutil/trace.go:171","msg":"trace[878910109] transaction","detail":"{read_only:false; response_revision:25805; number_of_response:1; }","duration":"233.573323ms","start":"2026-08-18T19:46:36.914172Z","end":"2026-08-18T19:46:37.147746Z","steps":["trace[878910109] 'process raft request'  (duration: 233.45016ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:46:37.148022Z","caller":"traceutil/trace.go:171","msg":"trace[686946637] transaction","detail":"{read_only:false; response_revision:25806; number_of_response:1; }","duration":"233.280835ms","start":"2026-08-18T19:46:36.914723Z","end":"2026-08-18T19:46:37.148004Z","steps":["trace[686946637] 'process raft request'  (duration: 232.956737ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:46:37.148174Z","caller":"traceutil/trace.go:171","msg":"trace[596547313] linearizableReadLoop","detail":"{readStateIndex:26638; appliedIndex:26636; }","duration":"235.102974ms","start":"2026-08-18T19:46:36.913034Z","end":"2026-08-18T19:46:37.148137Z","steps":["trace[596547313] 'read index received'  (duration: 14.613992ms)","trace[596547313] 'applied index is now lower than readState.Index'  (duration: 220.487132ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T19:46:37.148209Z","caller":"traceutil/trace.go:171","msg":"trace[2079590953] transaction","detail":"{read_only:false; response_revision:25807; number_of_response:1; }","duration":"233.159182ms","start":"2026-08-18T19:46:36.915022Z","end":"2026-08-18T19:46:37.148181Z","steps":["trace[2079590953] 'process raft request'  (duration: 232.905395ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:46:37.148533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.472903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-919c804f-9f5f-42a5-9168-3ca0a25fef29\" ","response":"range_response_count:1 size:1322"}
{"level":"warn","ts":"2026-08-18T19:46:37.148558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.641121ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/cert-manager/cert-manager-cainjector\" ","response":"range_response_count:1 size:987"}
{"level":"info","ts":"2026-08-18T19:46:37.148585Z","caller":"traceutil/trace.go:171","msg":"trace[2011402392] range","detail":"{range_begin:/registry/persistentvolumes/pvc-919c804f-9f5f-42a5-9168-3ca0a25fef29; range_end:; response_count:1; response_revision:25807; }","duration":"235.560685ms","start":"2026-08-18T19:46:36.913006Z","end":"2026-08-18T19:46:37.148567Z","steps":["trace[2011402392] 'agreement among raft nodes before linearized reading'  (duration: 235.3615ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:46:37.148636Z","caller":"traceutil/trace.go:171","msg":"trace[1842964530] range","detail":"{range_begin:/registry/serviceaccounts/cert-manager/cert-manager-cainjector; range_end:; response_count:1; response_revision:25807; }","duration":"154.745354ms","start":"2026-08-18T19:46:36.993849Z","end":"2026-08-18T19:46:37.148594Z","steps":["trace[1842964530] 'agreement among raft nodes before linearized reading'  (duration: 154.566159ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:46:37.432728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.047749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/cert-manager/cert-manager-webhook\" ","response":"range_response_count:1 size:972"}
{"level":"info","ts":"2026-08-18T19:46:37.432873Z","caller":"traceutil/trace.go:171","msg":"trace[1888779483] range","detail":"{range_begin:/registry/serviceaccounts/cert-manager/cert-manager-webhook; range_end:; response_count:1; response_revision:25807; }","duration":"233.165012ms","start":"2026-08-18T19:46:37.19964Z","end":"2026-08-18T19:46:37.432805Z","steps":["trace[1888779483] 'range keys from in-memory index tree'  (duration: 232.815463ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:46:37.433219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.329251ms","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-18T19:46:37.433259Z","caller":"traceutil/trace.go:171","msg":"trace[1083549425] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25807; }","duration":"193.373583ms","start":"2026-08-18T19:46:37.239876Z","end":"2026-08-18T19:46:37.43325Z","steps":["trace[1083549425] 'range keys from in-memory index tree'  (duration: 193.183768ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:46:37.741449Z","caller":"traceutil/trace.go:171","msg":"trace[758322566] transaction","detail":"{read_only:false; response_revision:25809; number_of_response:1; }","duration":"254.671134ms","start":"2026-08-18T19:46:37.486738Z","end":"2026-08-18T19:46:37.741409Z","steps":["trace[758322566] 'process raft request'  (duration: 254.432218ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:46:38.108018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.061976ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13360948736884453821 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:25796 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:441 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-18T19:46:38.10823Z","caller":"traceutil/trace.go:171","msg":"trace[2001455337] linearizableReadLoop","detail":"{readStateIndex:26645; appliedIndex:26643; }","duration":"268.105735ms","start":"2026-08-18T19:46:37.840104Z","end":"2026-08-18T19:46:38.10821Z","steps":["trace[2001455337] 'read index received'  (duration: 77.757412ms)","trace[2001455337] 'applied index is now lower than readState.Index'  (duration: 190.347103ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T19:46:38.108369Z","caller":"traceutil/trace.go:171","msg":"trace[899337855] transaction","detail":"{read_only:false; response_revision:25811; number_of_response:1; }","duration":"279.144784ms","start":"2026-08-18T19:46:37.829169Z","end":"2026-08-18T19:46:38.108314Z","steps":["trace[899337855] 'process raft request'  (duration: 278.97342ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:46:38.108466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.355942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-08-18T19:46:38.108495Z","caller":"traceutil/trace.go:171","msg":"trace[933474773] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25811; }","duration":"268.394273ms","start":"2026-08-18T19:46:37.840091Z","end":"2026-08-18T19:46:38.108486Z","steps":["trace[933474773] 'agreement among raft nodes before linearized reading'  (duration: 268.238449ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:46:38.10867Z","caller":"traceutil/trace.go:171","msg":"trace[2062219303] transaction","detail":"{read_only:false; response_revision:25810; number_of_response:1; }","duration":"281.2918ms","start":"2026-08-18T19:46:37.827338Z","end":"2026-08-18T19:46:38.10863Z","steps":["trace[2062219303] 'process raft request'  (duration: 90.513696ms)","trace[2062219303] 'compare'  (duration: 189.915042ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T19:46:38.121278Z","caller":"traceutil/trace.go:171","msg":"trace[1817194455] transaction","detail":"{read_only:false; response_revision:25812; number_of_response:1; }","duration":"155.188366ms","start":"2026-08-18T19:46:37.966075Z","end":"2026-08-18T19:46:38.121264Z","steps":["trace[1817194455] 'process raft request'  (duration: 155.111374ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:46:38.121449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.25787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheuses/\" range_end:\"/registry/monitoring.coreos.com/prometheuses0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-08-18T19:46:38.121539Z","caller":"traceutil/trace.go:171","msg":"trace[458496795] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheuses/; range_end:/registry/monitoring.coreos.com/prometheuses0; response_count:0; response_revision:25812; }","duration":"113.383783ms","start":"2026-08-18T19:46:38.008131Z","end":"2026-08-18T19:46:38.121514Z","steps":["trace[458496795] 'agreement among raft nodes before linearized reading'  (duration: 113.225569ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:46:38.121533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.686771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:1854"}
{"level":"info","ts":"2026-08-18T19:46:38.121632Z","caller":"traceutil/trace.go:171","msg":"trace[1923129399] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25812; }","duration":"242.828085ms","start":"2026-08-18T19:46:37.878779Z","end":"2026-08-18T19:46:38.121607Z","steps":["trace[1923129399] 'agreement among raft nodes before linearized reading'  (duration: 242.510926ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:46:38.382123Z","caller":"traceutil/trace.go:171","msg":"trace[778889509] linearizableReadLoop","detail":"{readStateIndex:26648; appliedIndex:26647; }","duration":"199.109283ms","start":"2026-08-18T19:46:38.18299Z","end":"2026-08-18T19:46:38.382099Z","steps":["trace[778889509] 'read index received'  (duration: 199.062152ms)","trace[778889509] 'applied index is now lower than readState.Index'  (duration: 46.151µs)"],"step_count":2}
{"level":"info","ts":"2026-08-18T19:46:38.382251Z","caller":"traceutil/trace.go:171","msg":"trace[877821233] transaction","detail":"{read_only:false; response_revision:25814; number_of_response:1; }","duration":"201.583288ms","start":"2026-08-18T19:46:38.180631Z","end":"2026-08-18T19:46:38.382214Z","steps":["trace[877821233] 'process raft request'  (duration: 201.332001ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:46:38.382454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.415421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-c3c2d7a0-9f15-474b-91d3-a26ed5c4ffa0\" ","response":"range_response_count:1 size:1451"}
{"level":"info","ts":"2026-08-18T19:46:38.382507Z","caller":"traceutil/trace.go:171","msg":"trace[86516495] range","detail":"{range_begin:/registry/persistentvolumes/pvc-c3c2d7a0-9f15-474b-91d3-a26ed5c4ffa0; range_end:; response_count:1; response_revision:25814; }","duration":"199.522053ms","start":"2026-08-18T19:46:38.182971Z","end":"2026-08-18T19:46:38.382493Z","steps":["trace[86516495] 'agreement among raft nodes before linearized reading'  (duration: 199.253816ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:46:43.845253Z","caller":"traceutil/trace.go:171","msg":"trace[1416688322] linearizableReadLoop","detail":"{readStateIndex:26711; appliedIndex:26710; }","duration":"200.989232ms","start":"2026-08-18T19:46:43.644234Z","end":"2026-08-18T19:46:43.845223Z","steps":["trace[1416688322] 'read index received'  (duration: 200.704715ms)","trace[1416688322] 'applied index is now lower than readState.Index'  (duration: 282.777µs)"],"step_count":2}
{"level":"info","ts":"2026-08-18T19:46:43.845328Z","caller":"traceutil/trace.go:171","msg":"trace[29357832] transaction","detail":"{read_only:false; response_revision:25874; number_of_response:1; }","duration":"229.179238ms","start":"2026-08-18T19:46:43.616082Z","end":"2026-08-18T19:46:43.845261Z","steps":["trace[29357832] 'process raft request'  (duration: 228.903971ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:46:43.845525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.264581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-18T19:46:43.845591Z","caller":"traceutil/trace.go:171","msg":"trace[1716751148] range","detail":"{range_begin:/registry/rabbitmq.com/federations/; range_end:/registry/rabbitmq.com/federations0; response_count:0; response_revision:25874; }","duration":"185.407924ms","start":"2026-08-18T19:46:43.660162Z","end":"2026-08-18T19:46:43.84557Z","steps":["trace[1716751148] 'agreement among raft nodes before linearized reading'  (duration: 185.277011ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:46:43.846175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.903166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0\" ","response":"range_response_count:1 size:1860"}
{"level":"info","ts":"2026-08-18T19:46:43.846271Z","caller":"traceutil/trace.go:171","msg":"trace[1472493051] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:25874; }","duration":"202.06102ms","start":"2026-08-18T19:46:43.644183Z","end":"2026-08-18T19:46:43.846244Z","steps":["trace[1472493051] 'agreement among raft nodes before linearized reading'  (duration: 201.227308ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:46:44.080839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.842669ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13360948736884453984 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/services/endpoints/openstack/rabbitmq-manila\" mod_revision:25737 > success:<request_put:<key:\"/registry/services/endpoints/openstack/rabbitmq-manila\" value_size:823 >> failure:<request_range:<key:\"/registry/services/endpoints/openstack/rabbitmq-manila\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-18T19:46:44.080964Z","caller":"traceutil/trace.go:171","msg":"trace[880590992] transaction","detail":"{read_only:false; response_revision:25875; number_of_response:1; }","duration":"225.02782ms","start":"2026-08-18T19:46:43.855914Z","end":"2026-08-18T19:46:44.080942Z","steps":["trace[880590992] 'process raft request'  (duration: 75.961525ms)","trace[880590992] 'compare'  (duration: 148.518801ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T19:46:44.081862Z","caller":"traceutil/trace.go:171","msg":"trace[629631986] linearizableReadLoop","detail":"{readStateIndex:26715; appliedIndex:26712; }","duration":"101.343668ms","start":"2026-08-18T19:46:43.98049Z","end":"2026-08-18T19:46:44.081833Z","steps":["trace[629631986] 'read index received'  (duration: 100.887857ms)","trace[629631986] 'applied index is now lower than readState.Index'  (duration: 454.921µs)"],"step_count":2}
{"level":"info","ts":"2026-08-18T19:46:44.082199Z","caller":"traceutil/trace.go:171","msg":"trace[1892522521] transaction","detail":"{read_only:false; response_revision:25878; number_of_response:1; }","duration":"225.829331ms","start":"2026-08-18T19:46:43.856354Z","end":"2026-08-18T19:46:44.082183Z","steps":["trace[1892522521] 'process raft request'  (duration: 225.42478ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:46:44.082196Z","caller":"traceutil/trace.go:171","msg":"trace[755668279] transaction","detail":"{read_only:false; response_revision:25877; number_of_response:1; }","duration":"225.81618ms","start":"2026-08-18T19:46:43.856134Z","end":"2026-08-18T19:46:44.08195Z","steps":["trace[755668279] 'process raft request'  (duration: 225.593875ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:46:44.082629Z","caller":"traceutil/trace.go:171","msg":"trace[623599282] transaction","detail":"{read_only:false; response_revision:25876; number_of_response:1; }","duration":"226.660252ms","start":"2026-08-18T19:46:43.85596Z","end":"2026-08-18T19:46:44.08262Z","steps":["trace[623599282] 'process raft request'  (duration: 225.604464ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:46:44.083148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.642222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"}
{"level":"info","ts":"2026-08-18T19:46:44.083217Z","caller":"traceutil/trace.go:171","msg":"trace[1263830122] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25878; }","duration":"102.771805ms","start":"2026-08-18T19:46:43.980431Z","end":"2026-08-18T19:46:44.083203Z","steps":["trace[1263830122] 'agreement among raft nodes before linearized reading'  (duration: 102.513268ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:46:44.297758Z","caller":"traceutil/trace.go:171","msg":"trace[54561693] linearizableReadLoop","detail":"{readStateIndex:26717; appliedIndex:26715; }","duration":"161.850249ms","start":"2026-08-18T19:46:44.135875Z","end":"2026-08-18T19:46:44.297725Z","steps":["trace[54561693] 'read index received'  (duration: 15.400532ms)","trace[54561693] 'applied index is now lower than readState.Index'  (duration: 146.448567ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T19:46:44.297931Z","caller":"traceutil/trace.go:171","msg":"trace[1654810655] transaction","detail":"{read_only:false; response_revision:25880; number_of_response:1; }","duration":"166.974093ms","start":"2026-08-18T19:46:44.130938Z","end":"2026-08-18T19:46:44.297912Z","steps":["trace[1654810655] 'process raft request'  (duration: 154.317672ms)","trace[1654810655] 'compare'  (duration: 11.784238ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-18T19:46:44.29815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.833006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-18T19:46:44.298253Z","caller":"traceutil/trace.go:171","msg":"trace[179771211] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:25880; }","duration":"142.018531ms","start":"2026-08-18T19:46:44.156212Z","end":"2026-08-18T19:46:44.29823Z","steps":["trace[179771211] 'agreement among raft nodes before linearized reading'  (duration: 141.857187ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:46:44.298485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.562668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/octavia-api\" ","response":"range_response_count:1 size:672"}
{"level":"info","ts":"2026-08-18T19:46:44.298589Z","caller":"traceutil/trace.go:171","msg":"trace[1552327372] range","detail":"{range_begin:/registry/services/endpoints/openstack/octavia-api; range_end:; response_count:1; response_revision:25880; }","duration":"162.715842ms","start":"2026-08-18T19:46:44.135847Z","end":"2026-08-18T19:46:44.298563Z","steps":["trace[1552327372] 'agreement among raft nodes before linearized reading'  (duration: 162.345922ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:46:44.298684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.020745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/octavia-api\" ","response":"range_response_count:1 size:672"}
{"level":"info","ts":"2026-08-18T19:46:44.298796Z","caller":"traceutil/trace.go:171","msg":"trace[1658542514] range","detail":"{range_begin:/registry/services/endpoints/openstack/octavia-api; range_end:; response_count:1; response_revision:25880; }","duration":"110.184139ms","start":"2026-08-18T19:46:44.188589Z","end":"2026-08-18T19:46:44.298773Z","steps":["trace[1658542514] 'agreement among raft nodes before linearized reading'  (duration: 109.8266ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:47:14.860418Z","caller":"traceutil/trace.go:171","msg":"trace[1242096041] transaction","detail":"{read_only:false; response_revision:26127; number_of_response:1; }","duration":"103.315659ms","start":"2026-08-18T19:47:14.757067Z","end":"2026-08-18T19:47:14.860382Z","steps":["trace[1242096041] 'process raft request'  (duration: 103.070343ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:47:16.172697Z","caller":"traceutil/trace.go:171","msg":"trace[148909214] linearizableReadLoop","detail":"{readStateIndex:26979; appliedIndex:26978; }","duration":"128.052216ms","start":"2026-08-18T19:47:16.044611Z","end":"2026-08-18T19:47:16.172663Z","steps":["trace[148909214] 'read index received'  (duration: 127.806309ms)","trace[148909214] 'applied index is now lower than readState.Index'  (duration: 244.937µs)"],"step_count":2}
{"level":"info","ts":"2026-08-18T19:47:16.172839Z","caller":"traceutil/trace.go:171","msg":"trace[1327014736] transaction","detail":"{read_only:false; response_revision:26136; number_of_response:1; }","duration":"136.691981ms","start":"2026-08-18T19:47:16.036097Z","end":"2026-08-18T19:47:16.172789Z","steps":["trace[1327014736] 'process raft request'  (duration: 136.388493ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:47:16.173043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.959008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/ingress-nginx/ingress-nginx-backend\" ","response":"range_response_count:1 size:1042"}
{"level":"warn","ts":"2026-08-18T19:47:16.172978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.322293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/securitygroups/\" range_end:\"/registry/openstack.k-orc.cloud/securitygroups0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-18T19:47:16.173158Z","caller":"traceutil/trace.go:171","msg":"trace[1749061951] range","detail":"{range_begin:/registry/serviceaccounts/ingress-nginx/ingress-nginx-backend; range_end:; response_count:1; response_revision:26136; }","duration":"114.098211ms","start":"2026-08-18T19:47:16.059034Z","end":"2026-08-18T19:47:16.173132Z","steps":["trace[1749061951] 'agreement among raft nodes before linearized reading'  (duration: 113.915056ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:47:16.173187Z","caller":"traceutil/trace.go:171","msg":"trace[1338152649] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/securitygroups/; range_end:/registry/openstack.k-orc.cloud/securitygroups0; response_count:0; response_revision:26136; }","duration":"128.60532ms","start":"2026-08-18T19:47:16.044558Z","end":"2026-08-18T19:47:16.173163Z","steps":["trace[1338152649] 'agreement among raft nodes before linearized reading'  (duration: 128.334273ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:47:16.482842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.920581ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13360948736884454701 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:26121 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:506 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-18T19:47:16.483045Z","caller":"traceutil/trace.go:171","msg":"trace[1292577795] transaction","detail":"{read_only:false; response_revision:26137; number_of_response:1; }","duration":"211.008704ms","start":"2026-08-18T19:47:16.272003Z","end":"2026-08-18T19:47:16.483012Z","steps":["trace[1292577795] 'process raft request'  (duration: 61.767064ms)","trace[1292577795] 'compare'  (duration: 148.762697ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T19:47:16.843972Z","caller":"traceutil/trace.go:171","msg":"trace[171398037] linearizableReadLoop","detail":"{readStateIndex:26982; appliedIndex:26981; }","duration":"322.913167ms","start":"2026-08-18T19:47:16.52101Z","end":"2026-08-18T19:47:16.843923Z","steps":["trace[171398037] 'read index received'  (duration: 310.78504ms)","trace[171398037] 'applied index is now lower than readState.Index'  (duration: 12.126427ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-18T19:47:16.844325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.292707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-18T19:47:16.844412Z","caller":"traceutil/trace.go:171","msg":"trace[1437738447] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26139; }","duration":"323.417631ms","start":"2026-08-18T19:47:16.520974Z","end":"2026-08-18T19:47:16.844391Z","steps":["trace[1437738447] 'agreement among raft nodes before linearized reading'  (duration: 323.250726ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:47:16.844419Z","caller":"traceutil/trace.go:171","msg":"trace[876957958] transaction","detail":"{read_only:false; response_revision:26139; number_of_response:1; }","duration":"326.277076ms","start":"2026-08-18T19:47:16.518107Z","end":"2026-08-18T19:47:16.844384Z","steps":["trace[876957958] 'process raft request'  (duration: 313.671166ms)","trace[876957958] 'compare'  (duration: 11.660325ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-18T19:47:16.844452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T19:47:16.520962Z","time spent":"323.482532ms","remote":"127.0.0.1:41022","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-08-18T19:47:16.844579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T19:47:16.51808Z","time spent":"326.415859ms","remote":"127.0.0.1:41302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:26123 > 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\" > >"}
{"level":"info","ts":"2026-08-18T19:47:16.846455Z","caller":"traceutil/trace.go:171","msg":"trace[1343540962] transaction","detail":"{read_only:false; response_revision:26140; number_of_response:1; }","duration":"193.498776ms","start":"2026-08-18T19:47:16.652936Z","end":"2026-08-18T19:47:16.846435Z","steps":["trace[1343540962] 'process raft request'  (duration: 193.27072ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:47:16.846519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.593279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"warn","ts":"2026-08-18T19:47:16.846531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.767607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:559"}
{"level":"info","ts":"2026-08-18T19:47:16.846566Z","caller":"traceutil/trace.go:171","msg":"trace[1290456642] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26140; }","duration":"273.686381ms","start":"2026-08-18T19:47:16.572867Z","end":"2026-08-18T19:47:16.846554Z","steps":["trace[1290456642] 'agreement among raft nodes before linearized reading'  (duration: 273.529057ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:47:16.84658Z","caller":"traceutil/trace.go:171","msg":"trace[748020169] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:26140; }","duration":"272.857319ms","start":"2026-08-18T19:47:16.573707Z","end":"2026-08-18T19:47:16.846564Z","steps":["trace[748020169] 'agreement among raft nodes before linearized reading'  (duration: 272.664344ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:47:17.156903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.537548ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13360948736884454711 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:26124 > 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:18"}
{"level":"info","ts":"2026-08-18T19:47:17.157144Z","caller":"traceutil/trace.go:171","msg":"trace[726854288] linearizableReadLoop","detail":"{readStateIndex:26986; appliedIndex:26983; }","duration":"275.736565ms","start":"2026-08-18T19:47:16.881387Z","end":"2026-08-18T19:47:17.157123Z","steps":["trace[726854288] 'read index received'  (duration: 108.013843ms)","trace[726854288] 'applied index is now lower than readState.Index'  (duration: 167.721342ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T19:47:17.157238Z","caller":"traceutil/trace.go:171","msg":"trace[1963990342] transaction","detail":"{read_only:false; response_revision:26141; number_of_response:1; }","duration":"305.969824ms","start":"2026-08-18T19:47:16.851244Z","end":"2026-08-18T19:47:17.157214Z","steps":["trace[1963990342] 'process raft request'  (duration: 138.023646ms)","trace[1963990342] 'compare'  (duration: 167.373133ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-18T19:47:17.157309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T19:47:16.851227Z","time spent":"306.040297ms","remote":"127.0.0.1:41302","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:26124 > 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-18T19:47:17.157535Z","caller":"traceutil/trace.go:171","msg":"trace[424451166] transaction","detail":"{read_only:false; response_revision:26142; number_of_response:1; }","duration":"301.893369ms","start":"2026-08-18T19:47:16.855602Z","end":"2026-08-18T19:47:17.157495Z","steps":["trace[424451166] 'process raft request'  (duration: 301.417926ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:47:17.157623Z","caller":"traceutil/trace.go:171","msg":"trace[107475159] transaction","detail":"{read_only:false; response_revision:26143; number_of_response:1; }","duration":"293.037697ms","start":"2026-08-18T19:47:16.864547Z","end":"2026-08-18T19:47:17.157585Z","steps":["trace[107475159] 'process raft request'  (duration: 292.539004ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:47:17.157673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T19:47:16.855572Z","time spent":"302.025581ms","remote":"127.0.0.1:41302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:26125 > 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":"warn","ts":"2026-08-18T19:47:17.157833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.414763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-nova-server-0\" ","response":"range_response_count:1 size:1850"}
{"level":"info","ts":"2026-08-18T19:47:17.157931Z","caller":"traceutil/trace.go:171","msg":"trace[1339862128] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-nova-server-0; range_end:; response_count:1; response_revision:26143; }","duration":"276.546977ms","start":"2026-08-18T19:47:16.881359Z","end":"2026-08-18T19:47:17.157906Z","steps":["trace[1339862128] 'agreement among raft nodes before linearized reading'  (duration: 276.233618ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:47:17.219852Z","caller":"traceutil/trace.go:171","msg":"trace[546138394] transaction","detail":"{read_only:false; response_revision:26144; number_of_response:1; }","duration":"161.815699ms","start":"2026-08-18T19:47:17.057981Z","end":"2026-08-18T19:47:17.219797Z","steps":["trace[546138394] 'process raft request'  (duration: 161.642144ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:47:17.219913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.496981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-18T19:47:17.220008Z","caller":"traceutil/trace.go:171","msg":"trace[1042775535] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:26144; }","duration":"246.651785ms","start":"2026-08-18T19:47:16.973335Z","end":"2026-08-18T19:47:17.219987Z","steps":["trace[1042775535] 'agreement among raft nodes before linearized reading'  (duration: 246.46908ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:47:17.219998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.659251ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-08-18T19:47:17.22006Z","caller":"traceutil/trace.go:171","msg":"trace[198936042] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26144; }","duration":"105.718862ms","start":"2026-08-18T19:47:17.114322Z","end":"2026-08-18T19:47:17.220041Z","steps":["trace[198936042] 'agreement among raft nodes before linearized reading'  (duration: 105.476576ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:47:17.515552Z","caller":"traceutil/trace.go:171","msg":"trace[1030977805] linearizableReadLoop","detail":"{readStateIndex:26988; appliedIndex:26987; }","duration":"142.710029ms","start":"2026-08-18T19:47:17.372816Z","end":"2026-08-18T19:47:17.515526Z","steps":["trace[1030977805] 'read index received'  (duration: 142.593496ms)","trace[1030977805] 'applied index is now lower than readState.Index'  (duration: 115.463µs)"],"step_count":2}
{"level":"warn","ts":"2026-08-18T19:47:17.515761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.935385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-08-18T19:47:17.515785Z","caller":"traceutil/trace.go:171","msg":"trace[694252815] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26145; }","duration":"143.034597ms","start":"2026-08-18T19:47:17.372744Z","end":"2026-08-18T19:47:17.515778Z","steps":["trace[694252815] 'agreement among raft nodes before linearized reading'  (duration: 142.909314ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:47:17.515795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.292723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/projects/\" range_end:\"/registry/openstack.k-orc.cloud/projects0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-18T19:47:17.515735Z","caller":"traceutil/trace.go:171","msg":"trace[1989970786] transaction","detail":"{read_only:false; response_revision:26145; number_of_response:1; }","duration":"290.712376ms","start":"2026-08-18T19:47:17.224888Z","end":"2026-08-18T19:47:17.515601Z","steps":["trace[1989970786] 'process raft request'  (duration: 290.48491ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:47:17.515857Z","caller":"traceutil/trace.go:171","msg":"trace[208655962] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/projects/; range_end:/registry/openstack.k-orc.cloud/projects0; response_count:0; response_revision:26145; }","duration":"115.403866ms","start":"2026-08-18T19:47:17.40044Z","end":"2026-08-18T19:47:17.515844Z","steps":["trace[208655962] 'agreement among raft nodes before linearized reading'  (duration: 115.270343ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:47:17.515878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.832366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"warn","ts":"2026-08-18T19:47:17.515936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.349813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:573"}
{"level":"info","ts":"2026-08-18T19:47:17.515967Z","caller":"traceutil/trace.go:171","msg":"trace[561150133] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26145; }","duration":"141.946109ms","start":"2026-08-18T19:47:17.373999Z","end":"2026-08-18T19:47:17.515945Z","steps":["trace[561150133] 'agreement among raft nodes before linearized reading'  (duration: 141.694112ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:47:17.516034Z","caller":"traceutil/trace.go:171","msg":"trace[2067845384] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:26145; }","duration":"123.511447ms","start":"2026-08-18T19:47:17.392503Z","end":"2026-08-18T19:47:17.516014Z","steps":["trace[2067845384] 'agreement among raft nodes before linearized reading'  (duration: 123.23209ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:47:17.675425Z","caller":"traceutil/trace.go:171","msg":"trace[485217896] transaction","detail":"{read_only:false; response_revision:26146; number_of_response:1; }","duration":"155.211476ms","start":"2026-08-18T19:47:17.520171Z","end":"2026-08-18T19:47:17.675383Z","steps":["trace[485217896] 'process raft request'  (duration: 70.396379ms)","trace[485217896] 'compare'  (duration: 84.57923ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T19:47:17.67551Z","caller":"traceutil/trace.go:171","msg":"trace[1207339777] transaction","detail":"{read_only:false; response_revision:26147; number_of_response:1; }","duration":"154.974499ms","start":"2026-08-18T19:47:17.520478Z","end":"2026-08-18T19:47:17.675452Z","steps":["trace[1207339777] 'process raft request'  (duration: 154.825856ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:47:17.675426Z","caller":"traceutil/trace.go:171","msg":"trace[1574982878] transaction","detail":"{read_only:false; response_revision:26148; number_of_response:1; }","duration":"153.999534ms","start":"2026-08-18T19:47:17.521396Z","end":"2026-08-18T19:47:17.675396Z","steps":["trace[1574982878] 'process raft request'  (duration: 153.958673ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:47:18.080099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.27573ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13360948736884454725 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:26135 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-18T19:47:18.08062Z","caller":"traceutil/trace.go:171","msg":"trace[167225819] transaction","detail":"{read_only:false; response_revision:26149; number_of_response:1; }","duration":"335.225739ms","start":"2026-08-18T19:47:17.745333Z","end":"2026-08-18T19:47:18.080559Z","steps":["trace[167225819] 'process raft request'  (duration: 53.413686ms)","trace[167225819] 'compare'  (duration: 281.109875ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-18T19:47:18.080802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T19:47:17.745308Z","time spent":"335.407824ms","remote":"127.0.0.1:41302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:26135 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-08-18T19:47:18.516769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.274934ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-18T19:47:18.51694Z","caller":"traceutil/trace.go:171","msg":"trace[661004637] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:26149; }","duration":"215.459539ms","start":"2026-08-18T19:47:18.301459Z","end":"2026-08-18T19:47:18.516918Z","steps":["trace[661004637] 'range keys from in-memory index tree'  (duration: 215.252364ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:47:18.766099Z","caller":"traceutil/trace.go:171","msg":"trace[689642961] transaction","detail":"{read_only:false; response_revision:26150; number_of_response:1; }","duration":"276.676659ms","start":"2026-08-18T19:47:18.489391Z","end":"2026-08-18T19:47:18.766068Z","steps":["trace[689642961] 'process raft request'  (duration: 276.464054ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:47:18.810218Z","caller":"traceutil/trace.go:171","msg":"trace[289921074] transaction","detail":"{read_only:false; response_revision:26151; number_of_response:1; }","duration":"319.806477ms","start":"2026-08-18T19:47:18.490367Z","end":"2026-08-18T19:47:18.810173Z","steps":["trace[289921074] 'process raft request'  (duration: 319.488478ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:47:18.810426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T19:47:18.490359Z","time spent":"319.95906ms","remote":"127.0.0.1:41302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:26138 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:441 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"info","ts":"2026-08-18T19:47:18.881962Z","caller":"traceutil/trace.go:171","msg":"trace[1451930995] linearizableReadLoop","detail":"{readStateIndex:26994; appliedIndex:26992; }","duration":"391.297984ms","start":"2026-08-18T19:47:18.49062Z","end":"2026-08-18T19:47:18.881918Z","steps":["trace[1451930995] 'read index received'  (duration: 275.233182ms)","trace[1451930995] 'applied index is now lower than readState.Index'  (duration: 116.061362ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-18T19:47:18.882246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.616262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/octavia-api\" ","response":"range_response_count:1 size:672"}
{"level":"info","ts":"2026-08-18T19:47:18.882288Z","caller":"traceutil/trace.go:171","msg":"trace[516898865] range","detail":"{range_begin:/registry/services/endpoints/openstack/octavia-api; range_end:; response_count:1; response_revision:26152; }","duration":"391.725276ms","start":"2026-08-18T19:47:18.490552Z","end":"2026-08-18T19:47:18.882277Z","steps":["trace[516898865] 'agreement among raft nodes before linearized reading'  (duration: 391.524231ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:47:18.882323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T19:47:18.490523Z","time spent":"391.790147ms","remote":"127.0.0.1:41224","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":694,"request content":"key:\"/registry/services/endpoints/openstack/octavia-api\" "}
{"level":"warn","ts":"2026-08-18T19:47:18.89208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.72173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-18T19:47:18.892135Z","caller":"traceutil/trace.go:171","msg":"trace[491515605] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26153; }","duration":"369.817713ms","start":"2026-08-18T19:47:18.522304Z","end":"2026-08-18T19:47:18.892122Z","steps":["trace[491515605] 'agreement among raft nodes before linearized reading'  (duration: 369.72191ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:47:18.892104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.090504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/octavia-api\" ","response":"range_response_count:1 size:672"}
{"level":"warn","ts":"2026-08-18T19:47:18.892167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T19:47:18.522289Z","time spent":"369.871485ms","remote":"127.0.0.1:41022","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-08-18T19:47:18.892213Z","caller":"traceutil/trace.go:171","msg":"trace[1709083788] range","detail":"{range_begin:/registry/services/endpoints/openstack/octavia-api; range_end:; response_count:1; response_revision:26153; }","duration":"400.229548ms","start":"2026-08-18T19:47:18.491963Z","end":"2026-08-18T19:47:18.892192Z","steps":["trace[1709083788] 'agreement among raft nodes before linearized reading'  (duration: 399.95448ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:47:18.892302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T19:47:18.491953Z","time spent":"400.33823ms","remote":"127.0.0.1:41224","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":694,"request content":"key:\"/registry/services/endpoints/openstack/octavia-api\" "}
{"level":"warn","ts":"2026-08-18T19:47:18.892125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.956506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-18T19:47:18.892412Z","caller":"traceutil/trace.go:171","msg":"trace[84989736] range","detail":"{range_begin:/registry/ipam.cluster.x-k8s.io/ipaddressclaims/; range_end:/registry/ipam.cluster.x-k8s.io/ipaddressclaims0; response_count:0; response_revision:26153; }","duration":"383.284455ms","start":"2026-08-18T19:47:18.509112Z","end":"2026-08-18T19:47:18.892396Z","steps":["trace[84989736] 'agreement among raft nodes before linearized reading'  (duration: 382.928966ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:47:18.89246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T19:47:18.509103Z","time spent":"383.339586ms","remote":"127.0.0.1:51696","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":0,"response size":28,"request content":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims0\" count_only:true "}
{"level":"warn","ts":"2026-08-18T19:47:19.582321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.751964ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13360948736884454741 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:26144 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-18T19:47:19.58261Z","caller":"traceutil/trace.go:171","msg":"trace[1575338107] transaction","detail":"{read_only:false; response_revision:26156; number_of_response:1; }","duration":"357.157293ms","start":"2026-08-18T19:47:19.225417Z","end":"2026-08-18T19:47:19.582574Z","steps":["trace[1575338107] 'process raft request'  (duration: 117.022958ms)","trace[1575338107] 'compare'  (duration: 239.468867ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T19:47:19.582704Z","caller":"traceutil/trace.go:171","msg":"trace[1442519060] transaction","detail":"{read_only:false; response_revision:26158; number_of_response:1; }","duration":"353.391564ms","start":"2026-08-18T19:47:19.229272Z","end":"2026-08-18T19:47:19.582664Z","steps":["trace[1442519060] 'process raft request'  (duration: 353.296301ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:47:19.582796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T19:47:19.225365Z","time spent":"357.323497ms","remote":"127.0.0.1:41302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:26144 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"info","ts":"2026-08-18T19:47:19.582704Z","caller":"traceutil/trace.go:171","msg":"trace[1702901123] transaction","detail":"{read_only:false; response_revision:26157; number_of_response:1; }","duration":"354.80046ms","start":"2026-08-18T19:47:19.227878Z","end":"2026-08-18T19:47:19.582678Z","steps":["trace[1702901123] 'process raft request'  (duration: 354.575184ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:47:19.582883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T19:47:19.229248Z","time spent":"353.537547ms","remote":"127.0.0.1:41302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:26142 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-08-18T19:47:19.58297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T19:47:19.227849Z","time spent":"355.025706ms","remote":"127.0.0.1:41302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:26141 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-08-18T19:47:19.874352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.632023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-08-18T19:47:19.874451Z","caller":"traceutil/trace.go:171","msg":"trace[1750652313] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26159; }","duration":"192.787148ms","start":"2026-08-18T19:47:19.681644Z","end":"2026-08-18T19:47:19.874431Z","steps":["trace[1750652313] 'range keys from in-memory index tree'  (duration: 192.424228ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:47:19.875213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.606166ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13360948736884454750 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:26147 > 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\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-18T19:47:19.875273Z","caller":"traceutil/trace.go:171","msg":"trace[1660403312] transaction","detail":"{read_only:false; response_revision:26160; number_of_response:1; }","duration":"190.429255ms","start":"2026-08-18T19:47:19.684834Z","end":"2026-08-18T19:47:19.875263Z","steps":["trace[1660403312] 'process raft request'  (duration: 34.379678ms)","trace[1660403312] 'compare'  (duration: 155.034901ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-18T19:47:19.875223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.732895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-08-18T19:47:19.875446Z","caller":"traceutil/trace.go:171","msg":"trace[517597291] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26159; }","duration":"193.000282ms","start":"2026-08-18T19:47:19.682424Z","end":"2026-08-18T19:47:19.875425Z","steps":["trace[517597291] 'range keys from in-memory index tree'  (duration: 191.902164ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:47:20.233862Z","caller":"traceutil/trace.go:171","msg":"trace[9326035] transaction","detail":"{read_only:false; response_revision:26161; number_of_response:1; }","duration":"354.967875ms","start":"2026-08-18T19:47:19.878863Z","end":"2026-08-18T19:47:20.233831Z","steps":["trace[9326035] 'process raft request'  (duration: 354.7908ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:47:20.234037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T19:47:19.878832Z","time spent":"355.119469ms","remote":"127.0.0.1:41302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:26146 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-08-18T19:47:20.299644Z","caller":"traceutil/trace.go:171","msg":"trace[1513254598] linearizableReadLoop","detail":"{readStateIndex:27006; appliedIndex:27004; }","duration":"214.821033ms","start":"2026-08-18T19:47:20.0848Z","end":"2026-08-18T19:47:20.299622Z","steps":["trace[1513254598] 'read index received'  (duration: 148.949072ms)","trace[1513254598] 'applied index is now lower than readState.Index'  (duration: 65.870841ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T19:47:20.299717Z","caller":"traceutil/trace.go:171","msg":"trace[92592633] transaction","detail":"{read_only:false; response_revision:26163; number_of_response:1; }","duration":"206.452644ms","start":"2026-08-18T19:47:20.09323Z","end":"2026-08-18T19:47:20.299682Z","steps":["trace[92592633] 'process raft request'  (duration: 206.329071ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:47:20.299672Z","caller":"traceutil/trace.go:171","msg":"trace[370206902] transaction","detail":"{read_only:false; response_revision:26162; number_of_response:1; }","duration":"420.254251ms","start":"2026-08-18T19:47:19.879392Z","end":"2026-08-18T19:47:20.299646Z","steps":["trace[370206902] 'process raft request'  (duration: 420.009865ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:47:20.299976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T19:47:19.879355Z","time spent":"420.471217ms","remote":"127.0.0.1:41302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:26148 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-08-18T19:47:20.299958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.505745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"}
{"level":"info","ts":"2026-08-18T19:47:20.3001Z","caller":"traceutil/trace.go:171","msg":"trace[179373033] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26163; }","duration":"170.69737ms","start":"2026-08-18T19:47:20.129392Z","end":"2026-08-18T19:47:20.300089Z","steps":["trace[179373033] 'agreement among raft nodes before linearized reading'  (duration: 170.397162ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:47:20.300099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.275325ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"}
{"level":"info","ts":"2026-08-18T19:47:20.300198Z","caller":"traceutil/trace.go:171","msg":"trace[859095261] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26163; }","duration":"215.446359ms","start":"2026-08-18T19:47:20.084731Z","end":"2026-08-18T19:47:20.300177Z","steps":["trace[859095261] 'agreement among raft nodes before linearized reading'  (duration: 215.019688ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:47:20.535308Z","caller":"traceutil/trace.go:171","msg":"trace[1059586075] transaction","detail":"{read_only:false; response_revision:26164; number_of_response:1; }","duration":"232.240618ms","start":"2026-08-18T19:47:20.303037Z","end":"2026-08-18T19:47:20.535278Z","steps":["trace[1059586075] 'process raft request'  (duration: 189.979274ms)","trace[1059586075] 'compare'  (duration: 42.056769ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T19:47:20.614678Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":22747}
{"level":"info","ts":"2026-08-18T19:47:20.614742Z","caller":"traceutil/trace.go:171","msg":"trace[85202286] linearizableReadLoop","detail":"{readStateIndex:27009; appliedIndex:27007; }","duration":"310.7438ms","start":"2026-08-18T19:47:20.303976Z","end":"2026-08-18T19:47:20.614719Z","steps":["trace[85202286] 'read index received'  (duration: 189.121882ms)","trace[85202286] 'applied index is now lower than readState.Index'  (duration: 121.620558ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T19:47:20.61487Z","caller":"traceutil/trace.go:171","msg":"trace[1559698652] transaction","detail":"{read_only:false; response_revision:26165; number_of_response:1; }","duration":"309.935909ms","start":"2026-08-18T19:47:20.304892Z","end":"2026-08-18T19:47:20.614828Z","steps":["trace[1559698652] 'process raft request'  (duration: 309.726693ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:47:20.614921Z","caller":"traceutil/trace.go:171","msg":"trace[713411760] compact","detail":"{revision:22747; response_revision:26165; }","duration":"311.674404ms","start":"2026-08-18T19:47:20.303215Z","end":"2026-08-18T19:47:20.614889Z","steps":["trace[713411760] 'process raft request'  (duration: 250.085645ms)","trace[713411760] 'check and update compact revision'  (duration: 61.21919ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-18T19:47:20.614999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T19:47:20.30316Z","time spent":"311.834368ms","remote":"127.0.0.1:41054","response type":"/etcdserverpb.KV/Compact","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-08-18T19:47:20.61507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T19:47:20.30487Z","time spent":"310.090762ms","remote":"127.0.0.1:41302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:26149 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-08-18T19:47:20.615397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.402067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"}
{"level":"info","ts":"2026-08-18T19:47:20.615445Z","caller":"traceutil/trace.go:171","msg":"trace[2070344393] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26165; }","duration":"311.482519ms","start":"2026-08-18T19:47:20.303944Z","end":"2026-08-18T19:47:20.615426Z","steps":["trace[2070344393] 'agreement among raft nodes before linearized reading'  (duration: 310.887744ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:47:20.615469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T19:47:20.30393Z","time spent":"311.53444ms","remote":"127.0.0.1:41238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12236,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"warn","ts":"2026-08-18T19:47:21.027969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.70948ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13360948736884454765 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:26150 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:507 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-18T19:47:21.028069Z","caller":"traceutil/trace.go:171","msg":"trace[913681702] linearizableReadLoop","detail":"{readStateIndex:27011; appliedIndex:27010; }","duration":"255.061335ms","start":"2026-08-18T19:47:20.772992Z","end":"2026-08-18T19:47:21.028053Z","steps":["trace[913681702] 'read index received'  (duration: 120.18269ms)","trace[913681702] 'applied index is now lower than readState.Index'  (duration: 134.877515ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-18T19:47:21.028148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.157507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-18T19:47:21.028171Z","caller":"traceutil/trace.go:171","msg":"trace[1228061945] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:26166; }","duration":"255.198728ms","start":"2026-08-18T19:47:20.772963Z","end":"2026-08-18T19:47:21.028162Z","steps":["trace[1228061945] 'agreement among raft nodes before linearized reading'  (duration: 255.149236ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:47:21.028167Z","caller":"traceutil/trace.go:171","msg":"trace[974699944] transaction","detail":"{read_only:false; response_revision:26166; number_of_response:1; }","duration":"255.27235ms","start":"2026-08-18T19:47:20.772846Z","end":"2026-08-18T19:47:21.028119Z","steps":["trace[974699944] 'process raft request'  (duration: 120.312843ms)","trace[974699944] 'compare'  (duration: 134.495994ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T19:47:21.252761Z","caller":"traceutil/trace.go:171","msg":"trace[1068120572] transaction","detail":"{read_only:false; response_revision:26167; number_of_response:1; }","duration":"438.62027ms","start":"2026-08-18T19:47:20.8141Z","end":"2026-08-18T19:47:21.25272Z","steps":["trace[1068120572] 'process raft request'  (duration: 348.047723ms)","trace[1068120572] 'compare'  (duration: 90.352822ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T19:47:21.252781Z","caller":"traceutil/trace.go:171","msg":"trace[1850185698] linearizableReadLoop","detail":"{readStateIndex:27014; appliedIndex:27011; }","duration":"224.67114ms","start":"2026-08-18T19:47:21.028086Z","end":"2026-08-18T19:47:21.252757Z","steps":["trace[1850185698] 'read index received'  (duration: 134.204256ms)","trace[1850185698] 'applied index is now lower than readState.Index'  (duration: 90.465444ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T19:47:21.252787Z","caller":"traceutil/trace.go:171","msg":"trace[202680391] transaction","detail":"{read_only:false; response_revision:26168; number_of_response:1; }","duration":"364.355631ms","start":"2026-08-18T19:47:20.88839Z","end":"2026-08-18T19:47:21.252746Z","steps":["trace[202680391] 'process raft request'  (duration: 364.259038ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:47:21.252877Z","caller":"traceutil/trace.go:171","msg":"trace[708634952] transaction","detail":"{read_only:false; response_revision:26170; number_of_response:1; }","duration":"199.522394ms","start":"2026-08-18T19:47:21.053321Z","end":"2026-08-18T19:47:21.252844Z","steps":["trace[708634952] 'process raft request'  (duration: 199.39967ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:47:21.252963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T19:47:20.888369Z","time spent":"364.505184ms","remote":"127.0.0.1:41302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:26152 > 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\" > >"}
{"level":"info","ts":"2026-08-18T19:47:21.252981Z","caller":"traceutil/trace.go:171","msg":"trace[1096239595] transaction","detail":"{read_only:false; response_revision:26169; number_of_response:1; }","duration":"355.201501ms","start":"2026-08-18T19:47:20.897765Z","end":"2026-08-18T19:47:21.252967Z","steps":["trace[1096239595] 'process raft request'  (duration: 354.931174ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:47:21.252993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.029799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/octavia-api\" ","response":"range_response_count:1 size:672"}
{"level":"info","ts":"2026-08-18T19:47:21.253022Z","caller":"traceutil/trace.go:171","msg":"trace[1378092566] range","detail":"{range_begin:/registry/services/endpoints/openstack/octavia-api; range_end:; response_count:1; response_revision:26170; }","duration":"357.105371ms","start":"2026-08-18T19:47:20.895908Z","end":"2026-08-18T19:47:21.253013Z","steps":["trace[1378092566] 'agreement among raft nodes before linearized reading'  (duration: 356.964887ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:47:21.253045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T19:47:20.897752Z","time spent":"355.259833ms","remote":"127.0.0.1:41302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:26153 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >"}
{"level":"warn","ts":"2026-08-18T19:47:21.253056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T19:47:20.895896Z","time spent":"357.153012ms","remote":"127.0.0.1:41224","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":694,"request content":"key:\"/registry/services/endpoints/openstack/octavia-api\" "}
{"level":"warn","ts":"2026-08-18T19:47:21.252955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T19:47:20.814073Z","time spent":"438.769024ms","remote":"127.0.0.1:41302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:26151 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:441 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"warn","ts":"2026-08-18T19:47:21.253181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.485139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinehealthchecks/\" range_end:\"/registry/cluster.x-k8s.io/machinehealthchecks0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-08-18T19:47:21.253178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.826279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/octavia-api\" ","response":"range_response_count:1 size:672"}
{"level":"info","ts":"2026-08-18T19:47:21.253213Z","caller":"traceutil/trace.go:171","msg":"trace[994074581] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinehealthchecks/; range_end:/registry/cluster.x-k8s.io/machinehealthchecks0; response_count:0; response_revision:26170; }","duration":"391.577702ms","start":"2026-08-18T19:47:20.861625Z","end":"2026-08-18T19:47:21.253203Z","steps":["trace[994074581] 'agreement among raft nodes before linearized reading'  (duration: 391.52316ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:47:21.253215Z","caller":"traceutil/trace.go:171","msg":"trace[403711429] range","detail":"{range_begin:/registry/services/endpoints/openstack/octavia-api; range_end:; response_count:1; response_revision:26170; }","duration":"365.907021ms","start":"2026-08-18T19:47:20.8873Z","end":"2026-08-18T19:47:21.253207Z","steps":["trace[403711429] 'agreement among raft nodes before linearized reading'  (duration: 365.710136ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:47:21.253236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T19:47:20.861599Z","time spent":"391.631933ms","remote":"127.0.0.1:51604","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/cluster.x-k8s.io/machinehealthchecks/\" range_end:\"/registry/cluster.x-k8s.io/machinehealthchecks0\" count_only:true "}
{"level":"warn","ts":"2026-08-18T19:47:21.25326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T19:47:20.887281Z","time spent":"365.972942ms","remote":"127.0.0.1:41224","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":694,"request content":"key:\"/registry/services/endpoints/openstack/octavia-api\" "}
{"level":"warn","ts":"2026-08-18T19:47:21.539542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.833982ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13360948736884454771 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:26155 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:453 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-18T19:47:21.539641Z","caller":"traceutil/trace.go:171","msg":"trace[2087313292] linearizableReadLoop","detail":"{readStateIndex:27016; appliedIndex:27015; }","duration":"286.783264ms","start":"2026-08-18T19:47:21.252843Z","end":"2026-08-18T19:47:21.539626Z","steps":["trace[2087313292] 'read index received'  (duration: 135.679245ms)","trace[2087313292] 'applied index is now lower than readState.Index'  (duration: 151.102909ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-18T19:47:21.539754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.982713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"}
{"level":"info","ts":"2026-08-18T19:47:21.539777Z","caller":"traceutil/trace.go:171","msg":"trace[1115839811] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26171; }","duration":"508.062796ms","start":"2026-08-18T19:47:21.031708Z","end":"2026-08-18T19:47:21.539771Z","steps":["trace[1115839811] 'agreement among raft nodes before linearized reading'  (duration: 507.956183ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:47:21.539757Z","caller":"traceutil/trace.go:171","msg":"trace[1105657689] transaction","detail":"{read_only:false; response_revision:26171; number_of_response:1; }","duration":"309.604609ms","start":"2026-08-18T19:47:21.230111Z","end":"2026-08-18T19:47:21.539716Z","steps":["trace[1105657689] 'process raft request'  (duration: 158.522571ms)","trace[1105657689] 'compare'  (duration: 150.332319ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-18T19:47:21.539948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T19:47:21.230077Z","time spent":"309.774424ms","remote":"127.0.0.1:41302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:26155 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:453 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-08-18T19:47:21.539804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T19:47:21.031681Z","time spent":"508.117526ms","remote":"127.0.0.1:41238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12236,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"warn","ts":"2026-08-18T19:47:21.813462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.61944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5684"}
{"level":"info","ts":"2026-08-18T19:47:21.813536Z","caller":"traceutil/trace.go:171","msg":"trace[1109999798] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:26171; }","duration":"260.720833ms","start":"2026-08-18T19:47:21.5528Z","end":"2026-08-18T19:47:21.813521Z","steps":["trace[1109999798] 'range keys from in-memory index tree'  (duration: 260.489306ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:47:21.81375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.960052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"warn","ts":"2026-08-18T19:47:21.813931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.964062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"}
{"level":"info","ts":"2026-08-18T19:47:21.813773Z","caller":"traceutil/trace.go:171","msg":"trace[1188013983] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26171; }","duration":"224.017574ms","start":"2026-08-18T19:47:21.58975Z","end":"2026-08-18T19:47:21.813768Z","steps":["trace[1188013983] 'range keys from in-memory index tree'  (duration: 223.88115ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:47:21.813991Z","caller":"traceutil/trace.go:171","msg":"trace[876489238] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:26171; }","duration":"224.032924ms","start":"2026-08-18T19:47:21.589942Z","end":"2026-08-18T19:47:21.813975Z","steps":["trace[876489238] 'range keys from in-memory index tree'  (duration: 223.89276ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:47:21.877991Z","caller":"traceutil/trace.go:171","msg":"trace[1475074292] linearizableReadLoop","detail":"{readStateIndex:27017; appliedIndex:27016; }","duration":"192.401837ms","start":"2026-08-18T19:47:21.685556Z","end":"2026-08-18T19:47:21.877957Z","steps":["trace[1475074292] 'read index received'  (duration: 190.470577ms)","trace[1475074292] 'applied index is now lower than readState.Index'  (duration: 1.92919ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-18T19:47:21.878271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.693785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"info","ts":"2026-08-18T19:47:21.878367Z","caller":"traceutil/trace.go:171","msg":"trace[472849550] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26172; }","duration":"192.846369ms","start":"2026-08-18T19:47:21.685505Z","end":"2026-08-18T19:47:21.878351Z","steps":["trace[472849550] 'agreement among raft nodes before linearized reading'  (duration: 192.597323ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:47:21.878365Z","caller":"traceutil/trace.go:171","msg":"trace[452511781] transaction","detail":"{read_only:false; response_revision:26172; number_of_response:1; }","duration":"281.878985ms","start":"2026-08-18T19:47:21.596462Z","end":"2026-08-18T19:47:21.878341Z","steps":["trace[452511781] 'process raft request'  (duration: 279.602666ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:47:22.264833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.297446ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13360948736884454779 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:26157 > 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:18"}
{"level":"info","ts":"2026-08-18T19:47:22.265076Z","caller":"traceutil/trace.go:171","msg":"trace[993844812] transaction","detail":"{read_only:false; response_revision:26173; number_of_response:1; }","duration":"447.988385ms","start":"2026-08-18T19:47:21.817026Z","end":"2026-08-18T19:47:22.265014Z","steps":["trace[993844812] 'process raft request'  (duration: 72.389261ms)","trace[993844812] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/leases/kube-system/plndr-cp-lock; req_size:416; } (duration: 374.964087ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-18T19:47:22.265192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T19:47:21.817003Z","time spent":"448.15014ms","remote":"127.0.0.1:41302","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:26157 > 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-18T19:47:22.520894Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":22747,"took":"1.900980451s","hash":3114757578,"current-db-size-bytes":59482112,"current-db-size":"60 MB","current-db-size-in-use-bytes":46813184,"current-db-size-in-use":"47 MB"}
{"level":"info","ts":"2026-08-18T19:47:22.520985Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3114757578,"revision":22747,"compact-revision":20338}
{"level":"warn","ts":"2026-08-18T19:47:22.521592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.515673ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13360948736884454780 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:26158 > 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-18T19:47:22.521886Z","caller":"traceutil/trace.go:171","msg":"trace[413649482] linearizableReadLoop","detail":"{readStateIndex:27019; appliedIndex:27017; }","duration":"641.758039ms","start":"2026-08-18T19:47:21.880105Z","end":"2026-08-18T19:47:22.521863Z","steps":["trace[413649482] 'read index received'  (duration: 9.305903ms)","trace[413649482] 'applied index is now lower than readState.Index'  (duration: 632.328823ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T19:47:22.521897Z","caller":"traceutil/trace.go:171","msg":"trace[1412401411] transaction","detail":"{read_only:false; response_revision:26174; number_of_response:1; }","duration":"697.924686ms","start":"2026-08-18T19:47:21.823906Z","end":"2026-08-18T19:47:22.521831Z","steps":["trace[1412401411] 'process raft request'  (duration: 441.089025ms)","trace[1412401411] 'compare'  (duration: 116.931265ms)","trace[1412401411] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; req_size:538; } (duration: 139.150907ms)"],"step_count":3}
{"level":"warn","ts":"2026-08-18T19:47:22.522137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T19:47:21.823889Z","time spent":"698.119822ms","remote":"127.0.0.1:41302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:26158 > 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":"warn","ts":"2026-08-18T19:47:22.592466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.500027ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"warn","ts":"2026-08-18T19:47:22.592514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.109379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:532"}
{"level":"info","ts":"2026-08-18T19:47:22.5925Z","caller":"traceutil/trace.go:171","msg":"trace[983222078] transaction","detail":"{read_only:false; response_revision:26175; number_of_response:1; }","duration":"707.846725ms","start":"2026-08-18T19:47:21.88461Z","end":"2026-08-18T19:47:22.592457Z","steps":["trace[983222078] 'process raft request'  (duration: 637.118597ms)","trace[983222078] 'compare'  (duration: 70.41079ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-18T19:47:22.592577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"510.821727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:9"}
{"level":"warn","ts":"2026-08-18T19:47:22.592614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.449017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-08-18T19:47:22.592547Z","caller":"traceutil/trace.go:171","msg":"trace[1620906153] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26175; }","duration":"353.595029ms","start":"2026-08-18T19:47:22.23893Z","end":"2026-08-18T19:47:22.592525Z","steps":["trace[1620906153] 'agreement among raft nodes before linearized reading'  (duration: 353.399684ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:47:22.59266Z","caller":"traceutil/trace.go:171","msg":"trace[1645514374] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:26175; }","duration":"510.992911ms","start":"2026-08-18T19:47:22.081649Z","end":"2026-08-18T19:47:22.592642Z","steps":["trace[1645514374] 'agreement among raft nodes before linearized reading'  (duration: 510.682453ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:47:22.592699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T19:47:22.2389Z","time spent":"353.789354ms","remote":"127.0.0.1:41302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-08-18T19:47:22.592696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T19:47:21.884576Z","time spent":"708.02109ms","remote":"127.0.0.1:41302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:26159 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-08-18T19:47:22.592709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T19:47:22.081612Z","time spent":"511.085394ms","remote":"127.0.0.1:41380","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":194,"response size":31,"request content":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true "}
{"level":"info","ts":"2026-08-18T19:47:22.592557Z","caller":"traceutil/trace.go:171","msg":"trace[1196269296] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:26175; }","duration":"409.202422ms","start":"2026-08-18T19:47:22.183343Z","end":"2026-08-18T19:47:22.592545Z","steps":["trace[1196269296] 'agreement among raft nodes before linearized reading'  (duration: 408.990686ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:47:22.592661Z","caller":"traceutil/trace.go:171","msg":"trace[2096971626] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26175; }","duration":"288.491918ms","start":"2026-08-18T19:47:22.304158Z","end":"2026-08-18T19:47:22.59265Z","steps":["trace[2096971626] 'agreement among raft nodes before linearized reading'  (duration: 288.400266ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:47:22.592879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"712.792515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:573"}
{"level":"warn","ts":"2026-08-18T19:47:22.592864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T19:47:22.183323Z","time spent":"409.49981ms","remote":"127.0.0.1:41302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":554,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "}
{"level":"warn","ts":"2026-08-18T19:47:22.592465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"642.882098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1866"}
{"level":"info","ts":"2026-08-18T19:47:22.59293Z","caller":"traceutil/trace.go:171","msg":"trace[1574003407] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:26174; }","duration":"712.863706ms","start":"2026-08-18T19:47:21.880052Z","end":"2026-08-18T19:47:22.592916Z","steps":["trace[1574003407] 'agreement among raft nodes before linearized reading'  (duration: 641.914873ms)","trace[1574003407] 'range keys from in-memory index tree'  (duration: 70.148383ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T19:47:22.592945Z","caller":"traceutil/trace.go:171","msg":"trace[1063244864] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:26175; }","duration":"643.409222ms","start":"2026-08-18T19:47:21.949523Z","end":"2026-08-18T19:47:22.592932Z","steps":["trace[1063244864] 'agreement among raft nodes before linearized reading'  (duration: 642.822006ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:47:22.59297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T19:47:21.949505Z","time spent":"643.454593ms","remote":"127.0.0.1:41216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1888,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "}
{"level":"warn","ts":"2026-08-18T19:47:22.593245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T19:47:21.880036Z","time spent":"712.915748ms","remote":"127.0.0.1:41302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":595,"request content":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" "}
{"level":"info","ts":"2026-08-18T19:47:22.744807Z","caller":"traceutil/trace.go:171","msg":"trace[1674400788] transaction","detail":"{read_only:false; response_revision:26176; number_of_response:1; }","duration":"147.872704ms","start":"2026-08-18T19:47:22.596907Z","end":"2026-08-18T19:47:22.744779Z","steps":["trace[1674400788] 'process raft request'  (duration: 135.352157ms)","trace[1674400788] 'compare'  (duration: 12.400534ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T19:47:22.817712Z","caller":"traceutil/trace.go:171","msg":"trace[1136736687] linearizableReadLoop","detail":"{readStateIndex:27024; appliedIndex:27020; }","duration":"198.414924ms","start":"2026-08-18T19:47:22.619285Z","end":"2026-08-18T19:47:22.8177Z","steps":["trace[1136736687] 'read index received'  (duration: 113.020893ms)","trace[1136736687] 'applied index is now lower than readState.Index'  (duration: 85.392931ms)"],"step_count":2}
{"level":"info","ts":"2026-08-18T19:47:22.817732Z","caller":"traceutil/trace.go:171","msg":"trace[1094986771] transaction","detail":"{read_only:false; response_revision:26177; number_of_response:1; }","duration":"220.067769ms","start":"2026-08-18T19:47:22.597649Z","end":"2026-08-18T19:47:22.817717Z","steps":["trace[1094986771] 'process raft request'  (duration: 219.939556ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:47:22.817778Z","caller":"traceutil/trace.go:171","msg":"trace[1744897688] transaction","detail":"{read_only:false; response_revision:26179; number_of_response:1; }","duration":"220.038589ms","start":"2026-08-18T19:47:22.597732Z","end":"2026-08-18T19:47:22.817771Z","steps":["trace[1744897688] 'process raft request'  (duration: 219.943976ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:47:22.817801Z","caller":"traceutil/trace.go:171","msg":"trace[1424234306] transaction","detail":"{read_only:false; response_revision:26178; number_of_response:1; }","duration":"220.08158ms","start":"2026-08-18T19:47:22.597696Z","end":"2026-08-18T19:47:22.817777Z","steps":["trace[1424234306] 'process raft request'  (duration: 219.956326ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:47:22.817971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.66474ms","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-18T19:47:22.817991Z","caller":"traceutil/trace.go:171","msg":"trace[1612008194] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26179; }","duration":"198.745212ms","start":"2026-08-18T19:47:22.619241Z","end":"2026-08-18T19:47:22.817986Z","steps":["trace[1612008194] 'agreement among raft nodes before linearized reading'  (duration: 198.589778ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:47:22.81798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.568061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/octavia-api\" ","response":"range_response_count:1 size:672"}
{"level":"info","ts":"2026-08-18T19:47:22.81805Z","caller":"traceutil/trace.go:171","msg":"trace[1166549249] range","detail":"{range_begin:/registry/services/endpoints/openstack/octavia-api; range_end:; response_count:1; response_revision:26179; }","duration":"197.656723ms","start":"2026-08-18T19:47:22.620374Z","end":"2026-08-18T19:47:22.818031Z","steps":["trace[1166549249] 'agreement among raft nodes before linearized reading'  (duration: 197.437928ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:47:23.376854Z","caller":"traceutil/trace.go:171","msg":"trace[512813697] transaction","detail":"{read_only:false; response_revision:26184; number_of_response:1; }","duration":"114.685017ms","start":"2026-08-18T19:47:23.262136Z","end":"2026-08-18T19:47:23.376821Z","steps":["trace[512813697] 'process raft request'  (duration: 114.613595ms)"],"step_count":1}
{"level":"info","ts":"2026-08-18T19:47:23.377056Z","caller":"traceutil/trace.go:171","msg":"trace[1144968017] transaction","detail":"{read_only:false; response_revision:26183; number_of_response:1; }","duration":"116.610417ms","start":"2026-08-18T19:47:23.26039Z","end":"2026-08-18T19:47:23.377001Z","steps":["trace[1144968017] 'process raft request'  (duration: 116.193236ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-18T19:47:24.663643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.829575ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13360948736884454824 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:26174 > 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-18T19:47:24.663808Z","caller":"traceutil/trace.go:171","msg":"trace[966477706] transaction","detail":"{read_only:false; response_revision:26192; number_of_response:1; }","duration":"131.385413ms","start":"2026-08-18T19:47:24.532389Z","end":"2026-08-18T19:47:24.663775Z","steps":["trace[966477706] 'process raft request'  (duration: 12.332682ms)","trace[966477706] 'compare'  (duration: 118.400284ms)"],"step_count":2}