{"level":"warn","ts":"2026-10-26T00:54:04.628012Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-10-26T00:54:04.628144Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.5: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.5:2380","--initial-cluster=instance=https://162.253.55.5:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.5:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.5:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-10-26T00:54:04.628285Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-10-26T00:54:04.628305Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.5:2380"]}
{"level":"info","ts":"2026-10-26T00:54:04.628343Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-10-26T00:54:04.630041Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.5:2379"]}
{"level":"info","ts":"2026-10-26T00:54:04.630218Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.5:2380"],"listen-peer-urls":["https://162.253.55.5:2380"],"advertise-client-urls":["https://162.253.55.5:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.5:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.5:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-10-26T00:54:04.634251Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.719213ms"}
{"level":"info","ts":"2026-10-26T00:54:04.640774Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b512f7d8ac93be25","cluster-id":"e1953d9a3e7368e5"}
{"level":"info","ts":"2026-10-26T00:54:04.640887Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b512f7d8ac93be25 switched to configuration voters=()"}
{"level":"info","ts":"2026-10-26T00:54:04.640915Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b512f7d8ac93be25 became follower at term 0"}
{"level":"info","ts":"2026-10-26T00:54:04.640935Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b512f7d8ac93be25 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-10-26T00:54:04.640947Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b512f7d8ac93be25 became follower at term 1"}
{"level":"info","ts":"2026-10-26T00:54:04.640997Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b512f7d8ac93be25 switched to configuration voters=(13047763580426108453)"}
{"level":"warn","ts":"2026-10-26T00:54:04.649996Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-10-26T00:54:04.653323Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-10-26T00:54:04.655592Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
{"level":"info","ts":"2026-10-26T00:54:04.661469Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b512f7d8ac93be25","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-10-26T00:54:04.661685Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b512f7d8ac93be25","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-10-26T00:54:04.661615Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-10-26T00:54:04.662952Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-10-26T00:54:04.662977Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-10-26T00:54:04.663258Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b512f7d8ac93be25 switched to configuration voters=(13047763580426108453)"}
{"level":"info","ts":"2026-10-26T00:54:04.663367Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e1953d9a3e7368e5","local-member-id":"b512f7d8ac93be25","added-peer-id":"b512f7d8ac93be25","added-peer-peer-urls":["https://162.253.55.5:2380"]}
{"level":"info","ts":"2026-10-26T00:54:04.669805Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-10-26T00:54:04.670073Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b512f7d8ac93be25","initial-advertise-peer-urls":["https://162.253.55.5:2380"],"listen-peer-urls":["https://162.253.55.5:2380"],"advertise-client-urls":["https://162.253.55.5:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.5:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-10-26T00:54:04.670107Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-10-26T00:54:04.671638Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.5:2380"}
{"level":"info","ts":"2026-10-26T00:54:04.671687Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.5:2380"}
{"level":"info","ts":"2026-10-26T00:54:05.542191Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b512f7d8ac93be25 is starting a new election at term 1"}
{"level":"info","ts":"2026-10-26T00:54:05.542311Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b512f7d8ac93be25 became pre-candidate at term 1"}
{"level":"info","ts":"2026-10-26T00:54:05.542336Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b512f7d8ac93be25 received MsgPreVoteResp from b512f7d8ac93be25 at term 1"}
{"level":"info","ts":"2026-10-26T00:54:05.542356Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b512f7d8ac93be25 became candidate at term 2"}
{"level":"info","ts":"2026-10-26T00:54:05.542365Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b512f7d8ac93be25 received MsgVoteResp from b512f7d8ac93be25 at term 2"}
{"level":"info","ts":"2026-10-26T00:54:05.54238Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b512f7d8ac93be25 became leader at term 2"}
{"level":"info","ts":"2026-10-26T00:54:05.542392Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b512f7d8ac93be25 elected leader b512f7d8ac93be25 at term 2"}
{"level":"info","ts":"2026-10-26T00:54:05.544892Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b512f7d8ac93be25","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.5:2379]}","request-path":"/0/members/b512f7d8ac93be25/attributes","cluster-id":"e1953d9a3e7368e5","publish-timeout":"7s"}
{"level":"info","ts":"2026-10-26T00:54:05.544928Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-26T00:54:05.544953Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-10-26T00:54:05.545008Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-10-26T00:54:05.545048Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-10-26T00:54:05.545062Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-10-26T00:54:05.546124Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e1953d9a3e7368e5","local-member-id":"b512f7d8ac93be25","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-26T00:54:05.546246Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-26T00:54:05.546282Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-26T00:54:05.54732Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.5:2379"}
{"level":"info","ts":"2026-10-26T00:54:05.548293Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-10-26T00:54:19.154831Z","caller":"traceutil/trace.go:171","msg":"trace[1263532646] transaction","detail":"{read_only:false; response_revision:408; number_of_response:1; }","duration":"170.301971ms","start":"2026-10-26T00:54:18.984491Z","end":"2026-10-26T00:54:19.154793Z","steps":["trace[1263532646] 'process raft request'  (duration: 170.083097ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T00:54:51.959291Z","caller":"traceutil/trace.go:171","msg":"trace[809742064] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"115.090461ms","start":"2026-10-26T00:54:51.844173Z","end":"2026-10-26T00:54:51.959263Z","steps":["trace[809742064] 'process raft request'  (duration: 112.526761ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T00:54:51.959743Z","caller":"traceutil/trace.go:171","msg":"trace[1075474536] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"101.408847ms","start":"2026-10-26T00:54:51.858275Z","end":"2026-10-26T00:54:51.959684Z","steps":["trace[1075474536] 'process raft request'  (duration: 101.011921ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T00:54:57.523596Z","caller":"traceutil/trace.go:171","msg":"trace[82307751] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"112.140828ms","start":"2026-10-26T00:54:57.411358Z","end":"2026-10-26T00:54:57.523499Z","steps":["trace[82307751] 'process raft request'  (duration: 111.447098ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T00:54:57.751183Z","caller":"traceutil/trace.go:171","msg":"trace[1872915519] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"152.143911ms","start":"2026-10-26T00:54:57.59901Z","end":"2026-10-26T00:54:57.751154Z","steps":["trace[1872915519] 'process raft request'  (duration: 151.917667ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T00:54:57.752129Z","caller":"traceutil/trace.go:171","msg":"trace[1724780290] linearizableReadLoop","detail":"{readStateIndex:675; appliedIndex:675; }","duration":"141.418157ms","start":"2026-10-26T00:54:57.610679Z","end":"2026-10-26T00:54:57.752097Z","steps":["trace[1724780290] 'read index received'  (duration: 141.409617ms)","trace[1724780290] 'applied index is now lower than readState.Index'  (duration: 6.19µs)"],"step_count":2}
{"level":"warn","ts":"2026-10-26T00:54:57.752335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.63239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-26T00:54:57.75243Z","caller":"traceutil/trace.go:171","msg":"trace[25659413] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:656; }","duration":"141.787922ms","start":"2026-10-26T00:54:57.61063Z","end":"2026-10-26T00:54:57.752418Z","steps":["trace[25659413] 'agreement among raft nodes before linearized reading'  (duration: 141.583069ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T00:54:58.359546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.413096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-9gt4r\" ","response":"range_response_count:1 size:16957"}
{"level":"info","ts":"2026-10-26T00:54:58.359681Z","caller":"traceutil/trace.go:171","msg":"trace[1100503413] range","detail":"{range_begin:/registry/pods/kube-system/cilium-9gt4r; range_end:; response_count:1; response_revision:656; }","duration":"370.61551ms","start":"2026-10-26T00:54:57.989045Z","end":"2026-10-26T00:54:58.359661Z","steps":["trace[1100503413] 'range keys from in-memory index tree'  (duration: 370.151253ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T00:54:58.359737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T00:54:57.989025Z","time spent":"370.698651ms","remote":"127.0.0.1:54244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16981,"request content":"key:\"/registry/pods/kube-system/cilium-9gt4r\" "}
{"level":"info","ts":"2026-10-26T00:54:58.364217Z","caller":"traceutil/trace.go:171","msg":"trace[611082098] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"153.375122ms","start":"2026-10-26T00:54:58.210804Z","end":"2026-10-26T00:54:58.364179Z","steps":["trace[611082098] 'process raft request'  (duration: 150.481808ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T00:55:14.003324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.257846ms","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-10-26T00:55:14.003436Z","caller":"traceutil/trace.go:171","msg":"trace[85942578] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:823; }","duration":"153.461349ms","start":"2026-10-26T00:55:13.84995Z","end":"2026-10-26T00:55:14.003411Z","steps":["trace[85942578] 'count revisions from in-memory index tree'  (duration: 153.120514ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T00:55:14.004666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.638365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-10-26T00:55:14.005211Z","caller":"traceutil/trace.go:171","msg":"trace[1697679593] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:823; }","duration":"181.484308ms","start":"2026-10-26T00:55:13.823713Z","end":"2026-10-26T00:55:14.005197Z","steps":["trace[1697679593] 'range keys from in-memory index tree'  (duration: 179.57676ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T00:56:36.029839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.298769ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13701534968235323420 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:1840 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-10-26T00:56:36.030118Z","caller":"traceutil/trace.go:171","msg":"trace[1893788659] transaction","detail":"{read_only:false; response_revision:1906; number_of_response:1; }","duration":"447.383831ms","start":"2026-10-26T00:56:35.582682Z","end":"2026-10-26T00:56:36.030066Z","steps":["trace[1893788659] 'process raft request'  (duration: 257.156015ms)","trace[1893788659] 'compare'  (duration: 188.938114ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-26T00:56:36.030322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T00:56:35.582648Z","time spent":"447.578899ms","remote":"127.0.0.1:54340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:1840 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-10-26T00:56:36.406787Z","caller":"traceutil/trace.go:171","msg":"trace[1701676229] transaction","detail":"{read_only:false; response_revision:1908; number_of_response:1; }","duration":"165.318629ms","start":"2026-10-26T00:56:36.24144Z","end":"2026-10-26T00:56:36.406758Z","steps":["trace[1701676229] 'process raft request'  (duration: 109.968966ms)","trace[1701676229] 'compare'  (duration: 55.221288ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T00:56:36.439393Z","caller":"traceutil/trace.go:171","msg":"trace[220168508] transaction","detail":"{read_only:false; response_revision:1909; number_of_response:1; }","duration":"197.215245ms","start":"2026-10-26T00:56:36.242142Z","end":"2026-10-26T00:56:36.439358Z","steps":["trace[220168508] 'process raft request'  (duration: 196.951095ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T00:56:36.439612Z","caller":"traceutil/trace.go:171","msg":"trace[2019857234] transaction","detail":"{read_only:false; response_revision:1910; number_of_response:1; }","duration":"193.901982ms","start":"2026-10-26T00:56:36.24553Z","end":"2026-10-26T00:56:36.439432Z","steps":["trace[2019857234] 'process raft request'  (duration: 193.693694ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T00:56:51.24139Z","caller":"traceutil/trace.go:171","msg":"trace[1125181282] linearizableReadLoop","detail":"{readStateIndex:2118; appliedIndex:2117; }","duration":"106.301512ms","start":"2026-10-26T00:56:51.135065Z","end":"2026-10-26T00:56:51.241366Z","steps":["trace[1125181282] 'read index received'  (duration: 106.067033ms)","trace[1125181282] 'applied index is now lower than readState.Index'  (duration: 233.489µs)"],"step_count":2}
{"level":"info","ts":"2026-10-26T00:56:51.241497Z","caller":"traceutil/trace.go:171","msg":"trace[1658385670] transaction","detail":"{read_only:false; response_revision:2045; number_of_response:1; }","duration":"264.983136ms","start":"2026-10-26T00:56:50.976504Z","end":"2026-10-26T00:56:51.241487Z","steps":["trace[1658385670] 'process raft request'  (duration: 264.726767ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T00:56:51.241874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.795841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5700"}
{"level":"info","ts":"2026-10-26T00:56:51.241948Z","caller":"traceutil/trace.go:171","msg":"trace[210281633] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2045; }","duration":"106.913815ms","start":"2026-10-26T00:56:51.135014Z","end":"2026-10-26T00:56:51.241928Z","steps":["trace[210281633] 'agreement among raft nodes before linearized reading'  (duration: 106.750629ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T00:57:06.511347Z","caller":"traceutil/trace.go:171","msg":"trace[1113736655] transaction","detail":"{read_only:false; response_revision:2134; number_of_response:1; }","duration":"132.976366ms","start":"2026-10-26T00:57:06.378334Z","end":"2026-10-26T00:57:06.51131Z","steps":["trace[1113736655] 'process raft request'  (duration: 132.852811ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T00:57:06.732245Z","caller":"traceutil/trace.go:171","msg":"trace[1100481124] linearizableReadLoop","detail":"{readStateIndex:2212; appliedIndex:2211; }","duration":"134.077424ms","start":"2026-10-26T00:57:06.598132Z","end":"2026-10-26T00:57:06.73221Z","steps":["trace[1100481124] 'read index received'  (duration: 101.944537ms)","trace[1100481124] 'applied index is now lower than readState.Index'  (duration: 32.130997ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T00:57:06.732429Z","caller":"traceutil/trace.go:171","msg":"trace[437749723] transaction","detail":"{read_only:false; response_revision:2136; number_of_response:1; }","duration":"138.434337ms","start":"2026-10-26T00:57:06.593974Z","end":"2026-10-26T00:57:06.732408Z","steps":["trace[437749723] 'process raft request'  (duration: 106.166585ms)","trace[437749723] 'compare'  (duration: 31.786195ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-26T00:57:06.732671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.123634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-26T00:57:06.732747Z","caller":"traceutil/trace.go:171","msg":"trace[946913358] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2136; }","duration":"122.237198ms","start":"2026-10-26T00:57:06.61049Z","end":"2026-10-26T00:57:06.732727Z","steps":["trace[946913358] 'agreement among raft nodes before linearized reading'  (duration: 122.104724ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T00:57:06.732737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.601582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-10-26T00:57:06.732799Z","caller":"traceutil/trace.go:171","msg":"trace[546503477] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2136; }","duration":"134.700556ms","start":"2026-10-26T00:57:06.598085Z","end":"2026-10-26T00:57:06.732785Z","steps":["trace[546503477] 'agreement among raft nodes before linearized reading'  (duration: 134.521789ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T00:57:07.738667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.340498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-26T00:57:07.738892Z","caller":"traceutil/trace.go:171","msg":"trace[1171925053] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2142; }","duration":"127.644179ms","start":"2026-10-26T00:57:07.611218Z","end":"2026-10-26T00:57:07.738862Z","steps":["trace[1171925053] 'range keys from in-memory index tree'  (duration: 127.154481ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T00:58:55.262902Z","caller":"traceutil/trace.go:171","msg":"trace[1381419706] transaction","detail":"{read_only:false; response_revision:2807; number_of_response:1; }","duration":"146.955882ms","start":"2026-10-26T00:58:55.1159Z","end":"2026-10-26T00:58:55.262856Z","steps":["trace[1381419706] 'process raft request'  (duration: 146.769498ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T00:59:26.150111Z","caller":"traceutil/trace.go:171","msg":"trace[507331580] transaction","detail":"{read_only:false; response_revision:2981; number_of_response:1; }","duration":"149.285216ms","start":"2026-10-26T00:59:26.000798Z","end":"2026-10-26T00:59:26.150083Z","steps":["trace[507331580] 'process raft request'  (duration: 148.846347ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T00:59:31.5809Z","caller":"traceutil/trace.go:171","msg":"trace[1880331895] transaction","detail":"{read_only:false; response_revision:3006; number_of_response:1; }","duration":"170.112708ms","start":"2026-10-26T00:59:31.410762Z","end":"2026-10-26T00:59:31.580875Z","steps":["trace[1880331895] 'process raft request'  (duration: 169.922514ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T00:59:31.731906Z","caller":"traceutil/trace.go:171","msg":"trace[583411899] linearizableReadLoop","detail":"{readStateIndex:3115; appliedIndex:3113; }","duration":"268.763091ms","start":"2026-10-26T00:59:31.463117Z","end":"2026-10-26T00:59:31.73188Z","steps":["trace[583411899] 'read index received'  (duration: 117.567662ms)","trace[583411899] 'applied index is now lower than readState.Index'  (duration: 151.194379ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-26T00:59:31.732152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.029417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-10-26T00:59:31.732186Z","caller":"traceutil/trace.go:171","msg":"trace[1562091009] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3007; }","duration":"269.14653ms","start":"2026-10-26T00:59:31.463027Z","end":"2026-10-26T00:59:31.732173Z","steps":["trace[1562091009] 'agreement among raft nodes before linearized reading'  (duration: 268.985776ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T00:59:31.732136Z","caller":"traceutil/trace.go:171","msg":"trace[1894158103] transaction","detail":"{read_only:false; response_revision:3007; number_of_response:1; }","duration":"277.865238ms","start":"2026-10-26T00:59:31.454225Z","end":"2026-10-26T00:59:31.73209Z","steps":["trace[1894158103] 'process raft request'  (duration: 261.442893ms)","trace[1894158103] 'compare'  (duration: 16.076937ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-26T00:59:31.73244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.91072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-10-26T00:59:31.732468Z","caller":"traceutil/trace.go:171","msg":"trace[251920465] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3007; }","duration":"253.975062ms","start":"2026-10-26T00:59:31.478485Z","end":"2026-10-26T00:59:31.73246Z","steps":["trace[251920465] 'agreement among raft nodes before linearized reading'  (duration: 253.89048ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T00:59:31.732879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.983984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-10-26T00:59:31.732925Z","caller":"traceutil/trace.go:171","msg":"trace[1245980377] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3007; }","duration":"206.021325ms","start":"2026-10-26T00:59:31.526883Z","end":"2026-10-26T00:59:31.732905Z","steps":["trace[1245980377] 'agreement among raft nodes before linearized reading'  (duration: 205.887732ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T00:59:31.733058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.024543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-10-26T00:59:31.733086Z","caller":"traceutil/trace.go:171","msg":"trace[1242620433] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:3007; }","duration":"211.097284ms","start":"2026-10-26T00:59:31.52198Z","end":"2026-10-26T00:59:31.733078Z","steps":["trace[1242620433] 'agreement among raft nodes before linearized reading'  (duration: 211.006812ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T01:03:52.519777Z","caller":"traceutil/trace.go:171","msg":"trace[1990179121] transaction","detail":"{read_only:false; response_revision:4996; number_of_response:1; }","duration":"181.136854ms","start":"2026-10-26T01:03:52.338601Z","end":"2026-10-26T01:03:52.519737Z","steps":["trace[1990179121] 'process raft request'  (duration: 180.139508ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T01:04:01.313729Z","caller":"traceutil/trace.go:171","msg":"trace[176474671] linearizableReadLoop","detail":"{readStateIndex:5351; appliedIndex:5350; }","duration":"439.725501ms","start":"2026-10-26T01:04:00.873967Z","end":"2026-10-26T01:04:01.313693Z","steps":["trace[176474671] 'read index received'  (duration: 424.10944ms)","trace[176474671] 'applied index is now lower than readState.Index'  (duration: 15.614791ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T01:04:01.314101Z","caller":"traceutil/trace.go:171","msg":"trace[960136722] transaction","detail":"{read_only:false; response_revision:5159; number_of_response:1; }","duration":"442.887542ms","start":"2026-10-26T01:04:00.871184Z","end":"2026-10-26T01:04:01.314071Z","steps":["trace[960136722] 'process raft request'  (duration: 426.895045ms)","trace[960136722] 'compare'  (duration: 14.96003ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-26T01:04:01.314226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T01:04:00.871176Z","time spent":"442.995483ms","remote":"127.0.0.1:54574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9346,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" mod_revision:0 > success:<request_put:<key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" value_size:9281 >> failure:<>"}
{"level":"warn","ts":"2026-10-26T01:04:01.31456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"440.566154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:6 size:61661"}
{"level":"info","ts":"2026-10-26T01:04:01.314667Z","caller":"traceutil/trace.go:171","msg":"trace[968439653] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:6; response_revision:5159; }","duration":"440.702936ms","start":"2026-10-26T01:04:00.873951Z","end":"2026-10-26T01:04:01.314654Z","steps":["trace[968439653] 'agreement among raft nodes before linearized reading'  (duration: 440.190128ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T01:04:01.314729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T01:04:00.873945Z","time spent":"440.771248ms","remote":"127.0.0.1:54244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":6,"response size":61685,"request content":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" "}
{"level":"info","ts":"2026-10-26T01:04:01.324077Z","caller":"traceutil/trace.go:171","msg":"trace[1717666924] transaction","detail":"{read_only:false; response_revision:5160; number_of_response:1; }","duration":"427.805ms","start":"2026-10-26T01:04:00.896244Z","end":"2026-10-26T01:04:01.324049Z","steps":["trace[1717666924] 'process raft request'  (duration: 427.18256ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T01:04:01.324274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T01:04:00.896233Z","time spent":"427.921391ms","remote":"127.0.0.1:54340","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:5106 > 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-10-26T01:04:01.341728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.669799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"}
{"level":"info","ts":"2026-10-26T01:04:01.341831Z","caller":"traceutil/trace.go:171","msg":"trace[154833291] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:5163; }","duration":"467.78876ms","start":"2026-10-26T01:04:00.874018Z","end":"2026-10-26T01:04:01.341807Z","steps":["trace[154833291] 'agreement among raft nodes before linearized reading'  (duration: 467.541776ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T01:04:01.341931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T01:04:00.874015Z","time spent":"467.903482ms","remote":"127.0.0.1:54488","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":1148,"request content":"key:\"/registry/storageclasses/general\" "}
{"level":"warn","ts":"2026-10-26T01:04:01.342471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.902616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12427"}
{"level":"info","ts":"2026-10-26T01:04:01.34253Z","caller":"traceutil/trace.go:171","msg":"trace[1781440322] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5163; }","duration":"162.003798ms","start":"2026-10-26T01:04:01.180511Z","end":"2026-10-26T01:04:01.342515Z","steps":["trace[1781440322] 'agreement among raft nodes before linearized reading'  (duration: 161.838635ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T01:04:01.34275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.621151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-10-26T01:04:01.342787Z","caller":"traceutil/trace.go:171","msg":"trace[77352606] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5163; }","duration":"103.685822ms","start":"2026-10-26T01:04:01.239091Z","end":"2026-10-26T01:04:01.342777Z","steps":["trace[77352606] 'agreement among raft nodes before linearized reading'  (duration: 103.59146ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T01:04:01.343234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.093357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2207404"}
{"level":"info","ts":"2026-10-26T01:04:01.343311Z","caller":"traceutil/trace.go:171","msg":"trace[1206427659] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:5163; }","duration":"349.198439ms","start":"2026-10-26T01:04:00.994099Z","end":"2026-10-26T01:04:01.343297Z","steps":["trace[1206427659] 'agreement among raft nodes before linearized reading'  (duration: 348.301565ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T01:04:01.343351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T01:04:00.994085Z","time spent":"349.25086ms","remote":"127.0.0.1:54148","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":47,"response size":2207428,"request content":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" "}
{"level":"info","ts":"2026-10-26T01:04:01.771997Z","caller":"traceutil/trace.go:171","msg":"trace[637017820] linearizableReadLoop","detail":"{readStateIndex:5368; appliedIndex:5365; }","duration":"297.484399ms","start":"2026-10-26T01:04:01.474484Z","end":"2026-10-26T01:04:01.771968Z","steps":["trace[637017820] 'read index received'  (duration: 19.037265ms)","trace[637017820] 'applied index is now lower than readState.Index'  (duration: 278.446084ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T01:04:01.772054Z","caller":"traceutil/trace.go:171","msg":"trace[1994515746] transaction","detail":"{read_only:false; response_revision:5175; number_of_response:1; }","duration":"298.10734ms","start":"2026-10-26T01:04:01.473913Z","end":"2026-10-26T01:04:01.77202Z","steps":["trace[1994515746] 'process raft request'  (duration: 297.936597ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T01:04:01.77214Z","caller":"traceutil/trace.go:171","msg":"trace[1899237867] transaction","detail":"{read_only:false; response_revision:5174; number_of_response:1; }","duration":"298.259322ms","start":"2026-10-26T01:04:01.473849Z","end":"2026-10-26T01:04:01.772109Z","steps":["trace[1899237867] 'process raft request'  (duration: 245.260312ms)","trace[1899237867] 'compare'  (duration: 52.566734ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T01:04:01.772352Z","caller":"traceutil/trace.go:171","msg":"trace[940014932] transaction","detail":"{read_only:false; response_revision:5176; number_of_response:1; }","duration":"298.377724ms","start":"2026-10-26T01:04:01.47396Z","end":"2026-10-26T01:04:01.772338Z","steps":["trace[940014932] 'process raft request'  (duration: 297.962977ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T01:04:01.77256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.361588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-10-26T01:04:01.772599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.88977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0\" ","response":"range_response_count:1 size:650"}
{"level":"info","ts":"2026-10-26T01:04:01.772611Z","caller":"traceutil/trace.go:171","msg":"trace[69304342] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:5176; }","duration":"249.451649ms","start":"2026-10-26T01:04:01.523146Z","end":"2026-10-26T01:04:01.772598Z","steps":["trace[69304342] 'agreement among raft nodes before linearized reading'  (duration: 249.367578ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T01:04:01.772635Z","caller":"traceutil/trace.go:171","msg":"trace[2008629559] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0; range_end:; response_count:1; response_revision:5176; }","duration":"291.959331ms","start":"2026-10-26T01:04:01.480664Z","end":"2026-10-26T01:04:01.772623Z","steps":["trace[2008629559] 'agreement among raft nodes before linearized reading'  (duration: 291.772488ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T01:04:01.772841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.326484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3368"}
{"level":"warn","ts":"2026-10-26T01:04:01.772854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.150659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-10-26T01:04:01.774881Z","caller":"traceutil/trace.go:171","msg":"trace[1174870613] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5176; }","duration":"134.210501ms","start":"2026-10-26T01:04:01.640649Z","end":"2026-10-26T01:04:01.77486Z","steps":["trace[1174870613] 'agreement among raft nodes before linearized reading'  (duration: 131.884094ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T01:04:01.77291Z","caller":"traceutil/trace.go:171","msg":"trace[483931234] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:5176; }","duration":"298.398635ms","start":"2026-10-26T01:04:01.474478Z","end":"2026-10-26T01:04:01.772877Z","steps":["trace[483931234] 'agreement among raft nodes before linearized reading'  (duration: 297.954838ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T01:04:01.774329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.484081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"}
{"level":"info","ts":"2026-10-26T01:04:01.775314Z","caller":"traceutil/trace.go:171","msg":"trace[2107427694] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:5176; }","duration":"275.502327ms","start":"2026-10-26T01:04:01.499796Z","end":"2026-10-26T01:04:01.775298Z","steps":["trace[2107427694] 'agreement among raft nodes before linearized reading'  (duration: 272.802884ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T01:04:01.77561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T01:04:01.474442Z","time spent":"300.65249ms","remote":"127.0.0.1:33574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":3392,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" "}
{"level":"info","ts":"2026-10-26T01:04:01.909861Z","caller":"traceutil/trace.go:171","msg":"trace[272454900] linearizableReadLoop","detail":"{readStateIndex:5373; appliedIndex:5372; }","duration":"100.687244ms","start":"2026-10-26T01:04:01.80914Z","end":"2026-10-26T01:04:01.909827Z","steps":["trace[272454900] 'read index received'  (duration: 99.694719ms)","trace[272454900] 'applied index is now lower than readState.Index'  (duration: 991.435µs)"],"step_count":2}
{"level":"info","ts":"2026-10-26T01:04:01.909934Z","caller":"traceutil/trace.go:171","msg":"trace[1125774666] transaction","detail":"{read_only:false; response_revision:5181; number_of_response:1; }","duration":"102.532174ms","start":"2026-10-26T01:04:01.807365Z","end":"2026-10-26T01:04:01.909897Z","steps":["trace[1125774666] 'process raft request'  (duration: 101.469257ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T01:04:01.910147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.798952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:6011"}
{"level":"info","ts":"2026-10-26T01:04:01.910206Z","caller":"traceutil/trace.go:171","msg":"trace[1991162360] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:5181; }","duration":"101.895224ms","start":"2026-10-26T01:04:01.808297Z","end":"2026-10-26T01:04:01.910192Z","steps":["trace[1991162360] 'agreement among raft nodes before linearized reading'  (duration: 101.680771ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T01:04:01.910401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.439746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" ","response":"range_response_count:1 size:708"}
{"level":"info","ts":"2026-10-26T01:04:01.910476Z","caller":"traceutil/trace.go:171","msg":"trace[1982461883] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:5181; }","duration":"106.604809ms","start":"2026-10-26T01:04:01.803854Z","end":"2026-10-26T01:04:01.910458Z","steps":["trace[1982461883] 'agreement among raft nodes before linearized reading'  (duration: 106.283784ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T01:04:01.915331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.30706ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:9080"}
{"level":"info","ts":"2026-10-26T01:04:01.915409Z","caller":"traceutil/trace.go:171","msg":"trace[15439326] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:5184; }","duration":"102.411272ms","start":"2026-10-26T01:04:01.81298Z","end":"2026-10-26T01:04:01.915391Z","steps":["trace[15439326] 'agreement among raft nodes before linearized reading'  (duration: 102.181778ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T01:04:01.916004Z","caller":"traceutil/trace.go:171","msg":"trace[106467772] transaction","detail":"{read_only:false; response_revision:5182; number_of_response:1; }","duration":"103.53555ms","start":"2026-10-26T01:04:01.812445Z","end":"2026-10-26T01:04:01.91598Z","steps":["trace[106467772] 'process raft request'  (duration: 102.036646ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T01:04:01.916056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.189852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0\" ","response":"range_response_count:1 size:1342"}
{"level":"info","ts":"2026-10-26T01:04:01.916103Z","caller":"traceutil/trace.go:171","msg":"trace[1774093790] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0; range_end:; response_count:1; response_revision:5184; }","duration":"101.259424ms","start":"2026-10-26T01:04:01.814827Z","end":"2026-10-26T01:04:01.916086Z","steps":["trace[1774093790] 'agreement among raft nodes before linearized reading'  (duration: 101.143172ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T01:04:01.91631Z","caller":"traceutil/trace.go:171","msg":"trace[898182209] transaction","detail":"{read_only:false; response_revision:5183; number_of_response:1; }","duration":"102.570004ms","start":"2026-10-26T01:04:01.813728Z","end":"2026-10-26T01:04:01.916298Z","steps":["trace[898182209] 'process raft request'  (duration: 101.264883ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T01:04:05.573414Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2872}
{"level":"info","ts":"2026-10-26T01:04:05.648579Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2872,"took":"73.754961ms","hash":3742895475,"current-db-size-bytes":51183616,"current-db-size":"51 MB","current-db-size-in-use-bytes":27131904,"current-db-size-in-use":"27 MB"}
{"level":"info","ts":"2026-10-26T01:04:05.648644Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3742895475,"revision":2872,"compact-revision":-1}
{"level":"warn","ts":"2026-10-26T01:04:13.733487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.244717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-26T01:04:13.733571Z","caller":"traceutil/trace.go:171","msg":"trace[283660641] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:5350; }","duration":"133.43567ms","start":"2026-10-26T01:04:13.600116Z","end":"2026-10-26T01:04:13.733552Z","steps":["trace[283660641] 'count revisions from in-memory index tree'  (duration: 133.147156ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T01:04:14.078784Z","caller":"traceutil/trace.go:171","msg":"trace[436672701] linearizableReadLoop","detail":"{readStateIndex:5551; appliedIndex:5550; }","duration":"167.359451ms","start":"2026-10-26T01:04:13.911391Z","end":"2026-10-26T01:04:14.07875Z","steps":["trace[436672701] 'read index received'  (duration: 123.748715ms)","trace[436672701] 'applied index is now lower than readState.Index'  (duration: 43.605636ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-26T01:04:14.079001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.618206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-10-26T01:04:14.079025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.613185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:10684"}
{"level":"info","ts":"2026-10-26T01:04:14.079047Z","caller":"traceutil/trace.go:171","msg":"trace[1928582772] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:5352; }","duration":"162.684047ms","start":"2026-10-26T01:04:13.916354Z","end":"2026-10-26T01:04:14.079038Z","steps":["trace[1928582772] 'agreement among raft nodes before linearized reading'  (duration: 162.611935ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T01:04:14.079056Z","caller":"traceutil/trace.go:171","msg":"trace[629025064] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5352; }","duration":"167.694277ms","start":"2026-10-26T01:04:13.911352Z","end":"2026-10-26T01:04:14.079046Z","steps":["trace[629025064] 'agreement among raft nodes before linearized reading'  (duration: 167.539614ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T01:04:14.414483Z","caller":"traceutil/trace.go:171","msg":"trace[1660514186] transaction","detail":"{read_only:false; response_revision:5353; number_of_response:1; }","duration":"326.352198ms","start":"2026-10-26T01:04:14.088106Z","end":"2026-10-26T01:04:14.414458Z","steps":["trace[1660514186] 'process raft request'  (duration: 326.193266ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T01:04:14.414633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T01:04:14.088094Z","time spent":"326.46108ms","remote":"127.0.0.1:54244","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10894,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" mod_revision:5245 > success:<request_put:<key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" value_size:10835 >> failure:<request_range:<key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" > >"}
{"level":"info","ts":"2026-10-26T01:04:14.484933Z","caller":"traceutil/trace.go:171","msg":"trace[315446253] transaction","detail":"{read_only:false; response_revision:5354; number_of_response:1; }","duration":"241.128139ms","start":"2026-10-26T01:04:14.243778Z","end":"2026-10-26T01:04:14.484907Z","steps":["trace[315446253] 'process raft request'  (duration: 240.940346ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T01:04:14.532455Z","caller":"traceutil/trace.go:171","msg":"trace[204118733] transaction","detail":"{read_only:false; response_revision:5355; number_of_response:1; }","duration":"111.766574ms","start":"2026-10-26T01:04:14.420665Z","end":"2026-10-26T01:04:14.532432Z","steps":["trace[204118733] 'process raft request'  (duration: 91.43315ms)","trace[204118733] 'compare'  (duration: 20.174471ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T01:04:14.532693Z","caller":"traceutil/trace.go:171","msg":"trace[505023106] transaction","detail":"{read_only:false; response_revision:5357; number_of_response:1; }","duration":"110.824248ms","start":"2026-10-26T01:04:14.421859Z","end":"2026-10-26T01:04:14.532683Z","steps":["trace[505023106] 'process raft request'  (duration: 110.745077ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T01:04:14.532771Z","caller":"traceutil/trace.go:171","msg":"trace[988307358] transaction","detail":"{read_only:false; response_revision:5356; number_of_response:1; }","duration":"111.743663ms","start":"2026-10-26T01:04:14.421012Z","end":"2026-10-26T01:04:14.532756Z","steps":["trace[988307358] 'process raft request'  (duration: 111.366827ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T01:04:14.533138Z","caller":"traceutil/trace.go:171","msg":"trace[1056050194] transaction","detail":"{read_only:false; response_revision:5358; number_of_response:1; }","duration":"109.05177ms","start":"2026-10-26T01:04:14.424056Z","end":"2026-10-26T01:04:14.533108Z","steps":["trace[1056050194] 'process raft request'  (duration: 108.613953ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T01:04:14.842973Z","caller":"traceutil/trace.go:171","msg":"trace[1078726235] transaction","detail":"{read_only:false; response_revision:5359; number_of_response:1; }","duration":"143.736674ms","start":"2026-10-26T01:04:14.69921Z","end":"2026-10-26T01:04:14.842947Z","steps":["trace[1078726235] 'process raft request'  (duration: 143.544961ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T01:04:56.23305Z","caller":"traceutil/trace.go:171","msg":"trace[694702691] transaction","detail":"{read_only:false; response_revision:5723; number_of_response:1; }","duration":"104.891083ms","start":"2026-10-26T01:04:56.128133Z","end":"2026-10-26T01:04:56.233024Z","steps":["trace[694702691] 'process raft request'  (duration: 104.743711ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T01:09:05.58266Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5241}
{"level":"info","ts":"2026-10-26T01:09:05.703527Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5241,"took":"119.224619ms","hash":4135509530,"current-db-size-bytes":51183616,"current-db-size":"51 MB","current-db-size-in-use-bytes":18984960,"current-db-size-in-use":"19 MB"}
{"level":"info","ts":"2026-10-26T01:09:05.703896Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4135509530,"revision":5241,"compact-revision":2872}