{"level":"warn","ts":"2026-03-12T19:15:21.116381Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-12T19:15:21.116485Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.238:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.238:2380","--initial-cluster=instance=https://199.204.45.238:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.238:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.238: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-03-12T19:15:21.116548Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-12T19:15:21.116559Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.238:2380"]}
{"level":"info","ts":"2026-03-12T19:15:21.116578Z","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-03-12T19:15:21.117281Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.238:2379"]}
{"level":"info","ts":"2026-03-12T19:15:21.117355Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.238:2380"],"listen-peer-urls":["https://199.204.45.238:2380"],"advertise-client-urls":["https://199.204.45.238:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.238:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.238: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-03-12T19:15:21.123662Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.101454ms"}
{"level":"info","ts":"2026-03-12T19:15:21.135861Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d7dbc9f5893cc1f6","cluster-id":"823d1d08ab21430c"}
{"level":"info","ts":"2026-03-12T19:15:21.13601Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 switched to configuration voters=()"}
{"level":"info","ts":"2026-03-12T19:15:21.136045Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became follower at term 0"}
{"level":"info","ts":"2026-03-12T19:15:21.136069Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d7dbc9f5893cc1f6 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-03-12T19:15:21.136093Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became follower at term 1"}
{"level":"info","ts":"2026-03-12T19:15:21.136169Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 switched to configuration voters=(15554247794460770806)"}
{"level":"warn","ts":"2026-03-12T19:15:21.142854Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-03-12T19:15:21.144247Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-03-12T19:15:21.14537Z","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-03-12T19:15:21.147551Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d7dbc9f5893cc1f6","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-03-12T19:15:21.147758Z","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-03-12T19:15:21.147816Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d7dbc9f5893cc1f6","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-03-12T19:15:21.147916Z","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-03-12T19:15:21.147929Z","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-03-12T19:15:21.149698Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 switched to configuration voters=(15554247794460770806)"}
{"level":"info","ts":"2026-03-12T19:15:21.149874Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"823d1d08ab21430c","local-member-id":"d7dbc9f5893cc1f6","added-peer-id":"d7dbc9f5893cc1f6","added-peer-peer-urls":["https://199.204.45.238:2380"]}
{"level":"info","ts":"2026-03-12T19:15:21.154816Z","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-03-12T19:15:21.154979Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.238:2380"}
{"level":"info","ts":"2026-03-12T19:15:21.155059Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.238:2380"}
{"level":"info","ts":"2026-03-12T19:15:21.155109Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d7dbc9f5893cc1f6","initial-advertise-peer-urls":["https://199.204.45.238:2380"],"listen-peer-urls":["https://199.204.45.238:2380"],"advertise-client-urls":["https://199.204.45.238:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.238:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-03-12T19:15:21.155164Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-03-12T19:15:21.436988Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 is starting a new election at term 1"}
{"level":"info","ts":"2026-03-12T19:15:21.437105Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became pre-candidate at term 1"}
{"level":"info","ts":"2026-03-12T19:15:21.437145Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 received MsgPreVoteResp from d7dbc9f5893cc1f6 at term 1"}
{"level":"info","ts":"2026-03-12T19:15:21.437195Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became candidate at term 2"}
{"level":"info","ts":"2026-03-12T19:15:21.437271Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 received MsgVoteResp from d7dbc9f5893cc1f6 at term 2"}
{"level":"info","ts":"2026-03-12T19:15:21.437296Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became leader at term 2"}
{"level":"info","ts":"2026-03-12T19:15:21.437323Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d7dbc9f5893cc1f6 elected leader d7dbc9f5893cc1f6 at term 2"}
{"level":"info","ts":"2026-03-12T19:15:21.438469Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-12T19:15:21.439356Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-12T19:15:21.439359Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d7dbc9f5893cc1f6","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.238:2379]}","request-path":"/0/members/d7dbc9f5893cc1f6/attributes","cluster-id":"823d1d08ab21430c","publish-timeout":"7s"}
{"level":"info","ts":"2026-03-12T19:15:21.439411Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-12T19:15:21.439831Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-03-12T19:15:21.439957Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-03-12T19:15:21.440085Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"823d1d08ab21430c","local-member-id":"d7dbc9f5893cc1f6","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-12T19:15:21.440241Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-12T19:15:21.440294Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-12T19:15:21.443576Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-03-12T19:15:21.443853Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.238:2379"}
{"level":"info","ts":"2026-03-12T19:15:48.284643Z","caller":"traceutil/trace.go:171","msg":"trace[934563037] linearizableReadLoop","detail":"{readStateIndex:487; appliedIndex:486; }","duration":"103.133303ms","start":"2026-03-12T19:15:48.181484Z","end":"2026-03-12T19:15:48.284618Z","steps":["trace[934563037] 'read index received'  (duration: 102.913729ms)","trace[934563037] 'applied index is now lower than readState.Index'  (duration: 218.394µs)"],"step_count":2}
{"level":"info","ts":"2026-03-12T19:15:48.284708Z","caller":"traceutil/trace.go:171","msg":"trace[1063525843] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"109.873118ms","start":"2026-03-12T19:15:48.174796Z","end":"2026-03-12T19:15:48.284669Z","steps":["trace[1063525843] 'process raft request'  (duration: 109.671934ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T19:15:48.28482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.308427ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-12T19:15:48.28491Z","caller":"traceutil/trace.go:171","msg":"trace[658582459] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:469; }","duration":"103.422129ms","start":"2026-03-12T19:15:48.181472Z","end":"2026-03-12T19:15:48.284895Z","steps":["trace[658582459] 'agreement among raft nodes before linearized reading'  (duration: 103.289076ms)"],"step_count":1}
{"level":"info","ts":"2026-03-12T19:15:53.279324Z","caller":"traceutil/trace.go:171","msg":"trace[652895547] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"115.643524ms","start":"2026-03-12T19:15:53.16364Z","end":"2026-03-12T19:15:53.279284Z","steps":["trace[652895547] 'process raft request'  (duration: 115.326328ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T19:15:57.67147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.884309ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-tgmng\" ","response":"range_response_count:1 size:16965"}
{"level":"info","ts":"2026-03-12T19:15:57.671595Z","caller":"traceutil/trace.go:171","msg":"trace[2067970200] range","detail":"{range_begin:/registry/pods/kube-system/cilium-tgmng; range_end:; response_count:1; response_revision:550; }","duration":"115.029442ms","start":"2026-03-12T19:15:57.556539Z","end":"2026-03-12T19:15:57.671568Z","steps":["trace[2067970200] 'range keys from in-memory index tree'  (duration: 114.580103ms)"],"step_count":1}
{"level":"info","ts":"2026-03-12T19:15:57.87423Z","caller":"traceutil/trace.go:171","msg":"trace[2018265544] linearizableReadLoop","detail":"{readStateIndex:571; appliedIndex:570; }","duration":"127.708406ms","start":"2026-03-12T19:15:57.746473Z","end":"2026-03-12T19:15:57.874181Z","steps":["trace[2018265544] 'read index received'  (duration: 127.39981ms)","trace[2018265544] 'applied index is now lower than readState.Index'  (duration: 307.006µs)"],"step_count":2}
{"level":"info","ts":"2026-03-12T19:15:57.87428Z","caller":"traceutil/trace.go:171","msg":"trace[251394691] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"185.280684ms","start":"2026-03-12T19:15:57.688953Z","end":"2026-03-12T19:15:57.874234Z","steps":["trace[251394691] 'process raft request'  (duration: 184.985019ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T19:15:57.87455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.032513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-03-12T19:15:57.874693Z","caller":"traceutil/trace.go:171","msg":"trace[846904931] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:551; }","duration":"128.209647ms","start":"2026-03-12T19:15:57.746449Z","end":"2026-03-12T19:15:57.874659Z","steps":["trace[846904931] 'agreement among raft nodes before linearized reading'  (duration: 127.87574ms)"],"step_count":1}
{"level":"info","ts":"2026-03-12T19:16:17.068446Z","caller":"traceutil/trace.go:171","msg":"trace[1064327277] transaction","detail":"{read_only:false; response_revision:924; number_of_response:1; }","duration":"332.606121ms","start":"2026-03-12T19:16:16.735806Z","end":"2026-03-12T19:16:17.068413Z","steps":["trace[1064327277] 'process raft request'  (duration: 332.355926ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T19:16:17.070181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-12T19:16:16.735793Z","time spent":"332.760945ms","remote":"127.0.0.1:34758","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3745,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/deployments/local-path-storage/local-path-provisioner\" mod_revision:539 > success:<request_put:<key:\"/registry/deployments/local-path-storage/local-path-provisioner\" value_size:3674 >> failure:<request_range:<key:\"/registry/deployments/local-path-storage/local-path-provisioner\" > >"}
{"level":"warn","ts":"2026-03-12T19:17:07.245278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.97173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" ","response":"range_response_count:1 size:10668"}
{"level":"info","ts":"2026-03-12T19:17:07.245388Z","caller":"traceutil/trace.go:171","msg":"trace[1655215904] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-haproxy-0; range_end:; response_count:1; response_revision:1580; }","duration":"273.152764ms","start":"2026-03-12T19:17:06.972215Z","end":"2026-03-12T19:17:07.245368Z","steps":["trace[1655215904] 'range keys from in-memory index tree'  (duration: 272.720056ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T19:17:07.245383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.515071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-12T19:17:07.245521Z","caller":"traceutil/trace.go:171","msg":"trace[1186555530] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:1580; }","duration":"203.751076ms","start":"2026-03-12T19:17:07.041742Z","end":"2026-03-12T19:17:07.245493Z","steps":["trace[1186555530] 'count revisions from in-memory index tree'  (duration: 203.339297ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T19:17:23.738279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.848361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-03-12T19:17:23.738409Z","caller":"traceutil/trace.go:171","msg":"trace[112872842] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1705; }","duration":"109.068715ms","start":"2026-03-12T19:17:23.629312Z","end":"2026-03-12T19:17:23.738381Z","steps":["trace[112872842] 'range keys from in-memory index tree'  (duration: 108.507973ms)"],"step_count":1}
{"level":"info","ts":"2026-03-12T19:17:56.758867Z","caller":"traceutil/trace.go:171","msg":"trace[228220375] transaction","detail":"{read_only:false; response_revision:1876; number_of_response:1; }","duration":"180.952771ms","start":"2026-03-12T19:17:56.577886Z","end":"2026-03-12T19:17:56.758839Z","steps":["trace[228220375] 'process raft request'  (duration: 180.794188ms)"],"step_count":1}
{"level":"info","ts":"2026-03-12T19:17:56.812615Z","caller":"traceutil/trace.go:171","msg":"trace[20786095] transaction","detail":"{read_only:false; response_revision:1877; number_of_response:1; }","duration":"169.275071ms","start":"2026-03-12T19:17:56.643314Z","end":"2026-03-12T19:17:56.812589Z","steps":["trace[20786095] 'process raft request'  (duration: 169.122357ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T19:18:03.061016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.531508ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13976530994402017160 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:1898 > 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-03-12T19:18:03.061236Z","caller":"traceutil/trace.go:171","msg":"trace[878086590] transaction","detail":"{read_only:false; response_revision:1907; number_of_response:1; }","duration":"217.698772ms","start":"2026-03-12T19:18:02.843465Z","end":"2026-03-12T19:18:03.061164Z","steps":["trace[878086590] 'process raft request'  (duration: 101.753895ms)","trace[878086590] 'compare'  (duration: 115.436037ms)"],"step_count":2}
{"level":"info","ts":"2026-03-12T19:18:49.55991Z","caller":"traceutil/trace.go:171","msg":"trace[429150659] transaction","detail":"{read_only:false; response_revision:2308; number_of_response:1; }","duration":"199.386975ms","start":"2026-03-12T19:18:49.360497Z","end":"2026-03-12T19:18:49.559884Z","steps":["trace[429150659] 'process raft request'  (duration: 199.235192ms)"],"step_count":1}
{"level":"info","ts":"2026-03-12T19:19:23.404719Z","caller":"traceutil/trace.go:171","msg":"trace[504244160] transaction","detail":"{read_only:false; response_revision:2494; number_of_response:1; }","duration":"125.385316ms","start":"2026-03-12T19:19:23.279304Z","end":"2026-03-12T19:19:23.40469Z","steps":["trace[504244160] 'process raft request'  (duration: 125.247413ms)"],"step_count":1}
{"level":"info","ts":"2026-03-12T19:19:23.628081Z","caller":"traceutil/trace.go:171","msg":"trace[665101978] transaction","detail":"{read_only:false; response_revision:2495; number_of_response:1; }","duration":"251.508146ms","start":"2026-03-12T19:19:23.376546Z","end":"2026-03-12T19:19:23.628054Z","steps":["trace[665101978] 'process raft request'  (duration: 178.757743ms)","trace[665101978] 'compare'  (duration: 72.559169ms)"],"step_count":2}
{"level":"info","ts":"2026-03-12T19:23:26.212388Z","caller":"traceutil/trace.go:171","msg":"trace[640651487] transaction","detail":"{read_only:false; response_revision:4619; number_of_response:1; }","duration":"135.393063ms","start":"2026-03-12T19:23:26.076967Z","end":"2026-03-12T19:23:26.21236Z","steps":["trace[640651487] 'process raft request'  (duration: 92.444815ms)","trace[640651487] 'compare'  (duration: 42.751684ms)"],"step_count":2}
{"level":"info","ts":"2026-03-12T19:23:34.81308Z","caller":"traceutil/trace.go:171","msg":"trace[1827297152] transaction","detail":"{read_only:false; response_revision:4784; number_of_response:1; }","duration":"139.156293ms","start":"2026-03-12T19:23:34.673888Z","end":"2026-03-12T19:23:34.813044Z","steps":["trace[1827297152] 'process raft request'  (duration: 72.677197ms)","trace[1827297152] 'compare'  (duration: 66.274842ms)"],"step_count":2}
{"level":"info","ts":"2026-03-12T19:23:43.474305Z","caller":"traceutil/trace.go:171","msg":"trace[623761245] transaction","detail":"{read_only:false; response_revision:4936; number_of_response:1; }","duration":"191.764668ms","start":"2026-03-12T19:23:43.282497Z","end":"2026-03-12T19:23:43.474262Z","steps":["trace[623761245] 'process raft request'  (duration: 102.920893ms)","trace[623761245] 'compare'  (duration: 88.619051ms)"],"step_count":2}
{"level":"info","ts":"2026-03-12T19:23:43.641687Z","caller":"traceutil/trace.go:171","msg":"trace[1368969485] linearizableReadLoop","detail":"{readStateIndex:5127; appliedIndex:5126; }","duration":"161.471909ms","start":"2026-03-12T19:23:43.480185Z","end":"2026-03-12T19:23:43.641657Z","steps":["trace[1368969485] 'read index received'  (duration: 100.671285ms)","trace[1368969485] 'applied index is now lower than readState.Index'  (duration: 60.799434ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-12T19:23:43.641997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.774615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:2643"}
{"level":"info","ts":"2026-03-12T19:23:43.642078Z","caller":"traceutil/trace.go:171","msg":"trace[1432755269] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4937; }","duration":"161.887967ms","start":"2026-03-12T19:23:43.48017Z","end":"2026-03-12T19:23:43.642058Z","steps":["trace[1432755269] 'agreement among raft nodes before linearized reading'  (duration: 161.587451ms)"],"step_count":1}
{"level":"info","ts":"2026-03-12T19:23:43.642345Z","caller":"traceutil/trace.go:171","msg":"trace[1818461711] transaction","detail":"{read_only:false; response_revision:4937; number_of_response:1; }","duration":"161.949358ms","start":"2026-03-12T19:23:43.479729Z","end":"2026-03-12T19:23:43.641678Z","steps":["trace[1818461711] 'process raft request'  (duration: 101.158115ms)","trace[1818461711] 'compare'  (duration: 60.63148ms)"],"step_count":2}
{"level":"info","ts":"2026-03-12T19:23:43.711978Z","caller":"traceutil/trace.go:171","msg":"trace[1901092581] transaction","detail":"{read_only:false; response_revision:4938; number_of_response:1; }","duration":"225.03005ms","start":"2026-03-12T19:23:43.486903Z","end":"2026-03-12T19:23:43.711933Z","steps":["trace[1901092581] 'process raft request'  (duration: 224.724804ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T19:23:43.712286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.618897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:529"}
{"level":"info","ts":"2026-03-12T19:23:43.712387Z","caller":"traceutil/trace.go:171","msg":"trace[415008609] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:4938; }","duration":"211.800531ms","start":"2026-03-12T19:23:43.500566Z","end":"2026-03-12T19:23:43.712366Z","steps":["trace[415008609] 'agreement among raft nodes before linearized reading'  (duration: 211.489275ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T19:23:43.937824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.729214ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13976530994402024596 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/cert-manager/cert-manager-controller\" mod_revision:4675 > success:<request_put:<key:\"/registry/leases/cert-manager/cert-manager-controller\" value_size:453 >> failure:<request_range:<key:\"/registry/leases/cert-manager/cert-manager-controller\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-12T19:23:43.938235Z","caller":"traceutil/trace.go:171","msg":"trace[1940982015] transaction","detail":"{read_only:false; response_revision:4939; number_of_response:1; }","duration":"218.355647ms","start":"2026-03-12T19:23:43.719824Z","end":"2026-03-12T19:23:43.93818Z","steps":["trace[1940982015] 'process raft request'  (duration: 38.180455ms)","trace[1940982015] 'compare'  (duration: 179.58219ms)"],"step_count":2}
{"level":"info","ts":"2026-03-12T19:23:43.938284Z","caller":"traceutil/trace.go:171","msg":"trace[1567200877] transaction","detail":"{read_only:false; response_revision:4940; number_of_response:1; }","duration":"210.080394ms","start":"2026-03-12T19:23:43.728188Z","end":"2026-03-12T19:23:43.938268Z","steps":["trace[1567200877] 'process raft request'  (duration: 209.747096ms)"],"step_count":1}
{"level":"info","ts":"2026-03-12T19:23:43.938498Z","caller":"traceutil/trace.go:171","msg":"trace[1221952500] linearizableReadLoop","detail":"{readStateIndex:5129; appliedIndex:5128; }","duration":"218.245096ms","start":"2026-03-12T19:23:43.720226Z","end":"2026-03-12T19:23:43.938471Z","steps":["trace[1221952500] 'read index received'  (duration: 37.831758ms)","trace[1221952500] 'applied index is now lower than readState.Index'  (duration: 180.412028ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-12T19:23:43.93867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.239544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls\" ","response":"range_response_count:1 size:2592"}
{"level":"info","ts":"2026-03-12T19:23:43.938694Z","caller":"traceutil/trace.go:171","msg":"trace[1833930259] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls; range_end:; response_count:1; response_revision:4941; }","duration":"216.286756ms","start":"2026-03-12T19:23:43.722397Z","end":"2026-03-12T19:23:43.938684Z","steps":["trace[1833930259] 'agreement among raft nodes before linearized reading'  (duration: 216.179223ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T19:23:43.938841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.547822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1131"}
{"level":"info","ts":"2026-03-12T19:23:43.938941Z","caller":"traceutil/trace.go:171","msg":"trace[1258995651] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:4941; }","duration":"218.706755ms","start":"2026-03-12T19:23:43.720206Z","end":"2026-03-12T19:23:43.938913Z","steps":["trace[1258995651] 'agreement among raft nodes before linearized reading'  (duration: 218.347898ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T19:23:43.939818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.392256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:57 size:2210803"}
{"level":"info","ts":"2026-03-12T19:23:43.939905Z","caller":"traceutil/trace.go:171","msg":"trace[829005877] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:57; response_revision:4941; }","duration":"215.533749ms","start":"2026-03-12T19:23:43.724351Z","end":"2026-03-12T19:23:43.939885Z","steps":["trace[829005877] 'agreement among raft nodes before linearized reading'  (duration: 214.423066ms)"],"step_count":1}
{"level":"info","ts":"2026-03-12T19:25:21.573624Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2781}
{"level":"info","ts":"2026-03-12T19:25:21.628741Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2781,"took":"53.321946ms","hash":3997037466,"current-db-size-bytes":41406464,"current-db-size":"41 MB","current-db-size-in-use-bytes":30715904,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-03-12T19:25:21.628822Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3997037466,"revision":2781,"compact-revision":-1}
{"level":"info","ts":"2026-03-12T19:29:54.226548Z","caller":"traceutil/trace.go:171","msg":"trace[376722747] linearizableReadLoop","detail":"{readStateIndex:7913; appliedIndex:7912; }","duration":"179.216243ms","start":"2026-03-12T19:29:54.04731Z","end":"2026-03-12T19:29:54.226526Z","steps":["trace[376722747] 'read index received'  (duration: 179.03541ms)","trace[376722747] 'applied index is now lower than readState.Index'  (duration: 179.263µs)"],"step_count":2}
{"level":"info","ts":"2026-03-12T19:29:54.226838Z","caller":"traceutil/trace.go:171","msg":"trace[1984538529] transaction","detail":"{read_only:false; response_revision:7632; number_of_response:1; }","duration":"183.545486ms","start":"2026-03-12T19:29:54.043276Z","end":"2026-03-12T19:29:54.226821Z","steps":["trace[1984538529] 'process raft request'  (duration: 183.071816ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T19:29:54.227164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.831756ms","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-03-12T19:29:54.227222Z","caller":"traceutil/trace.go:171","msg":"trace[80725733] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7632; }","duration":"179.924609ms","start":"2026-03-12T19:29:54.047284Z","end":"2026-03-12T19:29:54.227209Z","steps":["trace[80725733] 'agreement among raft nodes before linearized reading'  (duration: 179.759965ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T19:29:54.227968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.799806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"}
{"level":"info","ts":"2026-03-12T19:29:54.228061Z","caller":"traceutil/trace.go:171","msg":"trace[1985494744] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:7633; }","duration":"179.927538ms","start":"2026-03-12T19:29:54.04811Z","end":"2026-03-12T19:29:54.228038Z","steps":["trace[1985494744] 'agreement among raft nodes before linearized reading'  (duration: 179.693323ms)"],"step_count":1}
{"level":"info","ts":"2026-03-12T19:29:54.228073Z","caller":"traceutil/trace.go:171","msg":"trace[1512480316] transaction","detail":"{read_only:false; response_revision:7633; number_of_response:1; }","duration":"178.761834ms","start":"2026-03-12T19:29:54.049268Z","end":"2026-03-12T19:29:54.228029Z","steps":["trace[1512480316] 'process raft request'  (duration: 178.409907ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T19:29:54.228722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.343502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-03-12T19:29:54.228867Z","caller":"traceutil/trace.go:171","msg":"trace[2019443190] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7633; }","duration":"176.542207ms","start":"2026-03-12T19:29:54.052295Z","end":"2026-03-12T19:29:54.228837Z","steps":["trace[2019443190] 'agreement among raft nodes before linearized reading'  (duration: 176.004584ms)"],"step_count":1}
{"level":"info","ts":"2026-03-12T19:30:05.566311Z","caller":"traceutil/trace.go:171","msg":"trace[862195806] transaction","detail":"{read_only:false; response_revision:7688; number_of_response:1; }","duration":"102.243091ms","start":"2026-03-12T19:30:05.46404Z","end":"2026-03-12T19:30:05.566283Z","steps":["trace[862195806] 'process raft request'  (duration: 102.057467ms)"],"step_count":1}
{"level":"info","ts":"2026-03-12T19:30:06.161185Z","caller":"traceutil/trace.go:171","msg":"trace[1593720276] linearizableReadLoop","detail":"{readStateIndex:7975; appliedIndex:7974; }","duration":"101.524205ms","start":"2026-03-12T19:30:06.05963Z","end":"2026-03-12T19:30:06.161154Z","steps":["trace[1593720276] 'read index received'  (duration: 101.30777ms)","trace[1593720276] 'applied index is now lower than readState.Index'  (duration: 214.875µs)"],"step_count":2}
{"level":"info","ts":"2026-03-12T19:30:06.161232Z","caller":"traceutil/trace.go:171","msg":"trace[1011805688] transaction","detail":"{read_only:false; response_revision:7690; number_of_response:1; }","duration":"134.403882ms","start":"2026-03-12T19:30:06.026797Z","end":"2026-03-12T19:30:06.161201Z","steps":["trace[1011805688] 'process raft request'  (duration: 134.162287ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T19:30:06.161617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.980824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-mwdlp\" ","response":"range_response_count:1 size:6524"}
{"level":"info","ts":"2026-03-12T19:30:06.161666Z","caller":"traceutil/trace.go:171","msg":"trace[265515902] range","detail":"{range_begin:/registry/pods/openstack/keepalived-mwdlp; range_end:; response_count:1; response_revision:7690; }","duration":"102.076866ms","start":"2026-03-12T19:30:06.059566Z","end":"2026-03-12T19:30:06.161643Z","steps":["trace[265515902] 'agreement among raft nodes before linearized reading'  (duration: 101.919673ms)"],"step_count":1}
{"level":"info","ts":"2026-03-12T19:30:21.579675Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5746}
{"level":"info","ts":"2026-03-12T19:30:21.679903Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5746,"took":"97.926939ms","hash":3101634359,"current-db-size-bytes":42889216,"current-db-size":"43 MB","current-db-size-in-use-bytes":23384064,"current-db-size-in-use":"23 MB"}
{"level":"info","ts":"2026-03-12T19:30:21.679998Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3101634359,"revision":5746,"compact-revision":2781}
{"level":"info","ts":"2026-03-12T19:30:34.576172Z","caller":"traceutil/trace.go:171","msg":"trace[1407655352] linearizableReadLoop","detail":"{readStateIndex:8175; appliedIndex:8174; }","duration":"117.630187ms","start":"2026-03-12T19:30:34.458514Z","end":"2026-03-12T19:30:34.576144Z","steps":["trace[1407655352] 'read index received'  (duration: 117.175648ms)","trace[1407655352] 'applied index is now lower than readState.Index'  (duration: 453.049µs)"],"step_count":2}
{"level":"info","ts":"2026-03-12T19:30:34.576808Z","caller":"traceutil/trace.go:171","msg":"trace[903356412] transaction","detail":"{read_only:false; response_revision:7882; number_of_response:1; }","duration":"180.651006ms","start":"2026-03-12T19:30:34.396136Z","end":"2026-03-12T19:30:34.576787Z","steps":["trace[903356412] 'process raft request'  (duration: 179.727157ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T19:30:34.577421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.895415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-03-12T19:30:34.5775Z","caller":"traceutil/trace.go:171","msg":"trace[1796219655] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7882; }","duration":"119.031518ms","start":"2026-03-12T19:30:34.458453Z","end":"2026-03-12T19:30:34.577484Z","steps":["trace[1796219655] 'agreement among raft nodes before linearized reading'  (duration: 118.780723ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T19:30:34.577634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.420802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-03-12T19:30:34.577741Z","caller":"traceutil/trace.go:171","msg":"trace[201269944] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7882; }","duration":"107.583125ms","start":"2026-03-12T19:30:34.470135Z","end":"2026-03-12T19:30:34.577718Z","steps":["trace[201269944] 'agreement among raft nodes before linearized reading'  (duration: 107.292659ms)"],"step_count":1}
{"level":"info","ts":"2026-03-12T19:30:34.749823Z","caller":"traceutil/trace.go:171","msg":"trace[712153748] linearizableReadLoop","detail":"{readStateIndex:8176; appliedIndex:8175; }","duration":"167.205879ms","start":"2026-03-12T19:30:34.582593Z","end":"2026-03-12T19:30:34.749799Z","steps":["trace[712153748] 'read index received'  (duration: 164.860239ms)","trace[712153748] 'applied index is now lower than readState.Index'  (duration: 2.34425ms)"],"step_count":2}
{"level":"info","ts":"2026-03-12T19:30:34.750059Z","caller":"traceutil/trace.go:171","msg":"trace[135576976] transaction","detail":"{read_only:false; response_revision:7883; number_of_response:1; }","duration":"167.579848ms","start":"2026-03-12T19:30:34.582468Z","end":"2026-03-12T19:30:34.750048Z","steps":["trace[135576976] 'process raft request'  (duration: 164.460042ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T19:30:34.750336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.7275ms","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-03-12T19:30:34.750374Z","caller":"traceutil/trace.go:171","msg":"trace[1235524021] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7883; }","duration":"167.824532ms","start":"2026-03-12T19:30:34.582541Z","end":"2026-03-12T19:30:34.750366Z","steps":["trace[1235524021] 'agreement among raft nodes before linearized reading'  (duration: 167.682259ms)"],"step_count":1}
{"level":"info","ts":"2026-03-12T19:30:34.76698Z","caller":"traceutil/trace.go:171","msg":"trace[1785978520] transaction","detail":"{read_only:false; response_revision:7884; number_of_response:1; }","duration":"184.204171ms","start":"2026-03-12T19:30:34.58275Z","end":"2026-03-12T19:30:34.766954Z","steps":["trace[1785978520] 'process raft request'  (duration: 183.993036ms)"],"step_count":1}
{"level":"info","ts":"2026-03-12T19:30:34.76722Z","caller":"traceutil/trace.go:171","msg":"trace[1220045626] transaction","detail":"{read_only:false; response_revision:7885; number_of_response:1; }","duration":"183.144359ms","start":"2026-03-12T19:30:34.584004Z","end":"2026-03-12T19:30:34.767148Z","steps":["trace[1220045626] 'process raft request'  (duration: 182.895884ms)"],"step_count":1}
{"level":"info","ts":"2026-03-12T19:30:37.873195Z","caller":"traceutil/trace.go:171","msg":"trace[953470289] transaction","detail":"{read_only:false; response_revision:7899; number_of_response:1; }","duration":"126.599948ms","start":"2026-03-12T19:30:37.746555Z","end":"2026-03-12T19:30:37.873155Z","steps":["trace[953470289] 'process raft request'  (duration: 126.388004ms)"],"step_count":1}
{"level":"info","ts":"2026-03-12T19:30:38.053274Z","caller":"traceutil/trace.go:171","msg":"trace[716059053] transaction","detail":"{read_only:false; response_revision:7900; number_of_response:1; }","duration":"175.874214ms","start":"2026-03-12T19:30:37.877367Z","end":"2026-03-12T19:30:38.053241Z","steps":["trace[716059053] 'process raft request'  (duration: 161.198592ms)","trace[716059053] 'compare'  (duration: 14.331105ms)"],"step_count":2}
{"level":"info","ts":"2026-03-12T19:30:47.12172Z","caller":"traceutil/trace.go:171","msg":"trace[1166412931] transaction","detail":"{read_only:false; response_revision:7991; number_of_response:1; }","duration":"121.48567ms","start":"2026-03-12T19:30:47.000215Z","end":"2026-03-12T19:30:47.121701Z","steps":["trace[1166412931] 'process raft request'  (duration: 121.344307ms)"],"step_count":1}
{"level":"info","ts":"2026-03-12T19:30:47.994995Z","caller":"traceutil/trace.go:171","msg":"trace[738778611] transaction","detail":"{read_only:false; response_revision:7994; number_of_response:1; }","duration":"204.343579ms","start":"2026-03-12T19:30:47.790623Z","end":"2026-03-12T19:30:47.994966Z","steps":["trace[738778611] 'process raft request'  (duration: 204.101234ms)"],"step_count":1}
{"level":"info","ts":"2026-03-12T19:32:03.940303Z","caller":"traceutil/trace.go:171","msg":"trace[1845086052] linearizableReadLoop","detail":"{readStateIndex:9017; appliedIndex:9016; }","duration":"112.970817ms","start":"2026-03-12T19:32:03.82731Z","end":"2026-03-12T19:32:03.94028Z","steps":["trace[1845086052] 'read index received'  (duration: 112.742892ms)","trace[1845086052] 'applied index is now lower than readState.Index'  (duration: 227.255µs)"],"step_count":2}
{"level":"info","ts":"2026-03-12T19:32:03.940412Z","caller":"traceutil/trace.go:171","msg":"trace[717211619] transaction","detail":"{read_only:false; response_revision:8699; number_of_response:1; }","duration":"245.759264ms","start":"2026-03-12T19:32:03.694605Z","end":"2026-03-12T19:32:03.940364Z","steps":["trace[717211619] 'process raft request'  (duration: 245.511209ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T19:32:03.940549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.187521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-12T19:32:03.94068Z","caller":"traceutil/trace.go:171","msg":"trace[1525603091] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:8699; }","duration":"113.399917ms","start":"2026-03-12T19:32:03.827253Z","end":"2026-03-12T19:32:03.940653Z","steps":["trace[1525603091] 'agreement among raft nodes before linearized reading'  (duration: 113.13535ms)"],"step_count":1}
{"level":"info","ts":"2026-03-12T19:34:19.166429Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"d7dbc9f5893cc1f6","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-03-12T19:34:19.17089Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-03-12T19:34:19.17097Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-03-12T19:35:21.587659Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7769}
{"level":"info","ts":"2026-03-12T19:35:21.65242Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7769,"took":"62.425437ms","hash":2794221034,"current-db-size-bytes":42889216,"current-db-size":"43 MB","current-db-size-in-use-bytes":26038272,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-03-12T19:35:21.652484Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2794221034,"revision":7769,"compact-revision":5746}
{"level":"info","ts":"2026-03-12T19:40:21.593299Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10008}
{"level":"info","ts":"2026-03-12T19:40:21.673864Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10008,"took":"78.282884ms","hash":816800978,"current-db-size-bytes":42889216,"current-db-size":"43 MB","current-db-size-in-use-bytes":17547264,"current-db-size-in-use":"18 MB"}
{"level":"info","ts":"2026-03-12T19:40:21.673943Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":816800978,"revision":10008,"compact-revision":7769}