{"level":"warn","ts":"2026-03-18T00:47:56.307422Z","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-18T00:47:56.307529Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.115: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.115:2380","--initial-cluster=instance=https://199.204.45.115:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.115:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.115: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-18T00:47:56.307612Z","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-18T00:47:56.30763Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.115:2380"]}
{"level":"info","ts":"2026-03-18T00:47:56.307646Z","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-18T00:47:56.308342Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.115:2379"]}
{"level":"info","ts":"2026-03-18T00:47:56.308426Z","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.115:2380"],"listen-peer-urls":["https://199.204.45.115:2380"],"advertise-client-urls":["https://199.204.45.115:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.115:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.115: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-18T00:47:56.311651Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.01106ms"}
{"level":"info","ts":"2026-03-18T00:47:56.319321Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e3aaa5c123e150e0","cluster-id":"61ec519698823541"}
{"level":"info","ts":"2026-03-18T00:47:56.319413Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 switched to configuration voters=()"}
{"level":"info","ts":"2026-03-18T00:47:56.31944Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became follower at term 0"}
{"level":"info","ts":"2026-03-18T00:47:56.319454Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e3aaa5c123e150e0 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-03-18T00:47:56.319471Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became follower at term 1"}
{"level":"info","ts":"2026-03-18T00:47:56.319509Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 switched to configuration voters=(16405106841599693024)"}
{"level":"warn","ts":"2026-03-18T00:47:56.324326Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-03-18T00:47:56.327129Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-03-18T00:47:56.328752Z","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-18T00:47:56.330828Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e3aaa5c123e150e0","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-03-18T00:47:56.331072Z","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-18T00:47:56.3312Z","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-18T00:47:56.331226Z","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-18T00:47:56.331181Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e3aaa5c123e150e0","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-03-18T00:47:56.334053Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 switched to configuration voters=(16405106841599693024)"}
{"level":"info","ts":"2026-03-18T00:47:56.334313Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"61ec519698823541","local-member-id":"e3aaa5c123e150e0","added-peer-id":"e3aaa5c123e150e0","added-peer-peer-urls":["https://199.204.45.115:2380"]}
{"level":"info","ts":"2026-03-18T00:47:56.335284Z","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-18T00:47:56.335385Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.115:2380"}
{"level":"info","ts":"2026-03-18T00:47:56.335441Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.115:2380"}
{"level":"info","ts":"2026-03-18T00:47:56.335616Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e3aaa5c123e150e0","initial-advertise-peer-urls":["https://199.204.45.115:2380"],"listen-peer-urls":["https://199.204.45.115:2380"],"advertise-client-urls":["https://199.204.45.115:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.115:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-03-18T00:47:56.335651Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-03-18T00:47:56.420251Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 is starting a new election at term 1"}
{"level":"info","ts":"2026-03-18T00:47:56.420325Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became pre-candidate at term 1"}
{"level":"info","ts":"2026-03-18T00:47:56.420392Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 received MsgPreVoteResp from e3aaa5c123e150e0 at term 1"}
{"level":"info","ts":"2026-03-18T00:47:56.420421Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became candidate at term 2"}
{"level":"info","ts":"2026-03-18T00:47:56.420435Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 received MsgVoteResp from e3aaa5c123e150e0 at term 2"}
{"level":"info","ts":"2026-03-18T00:47:56.420459Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became leader at term 2"}
{"level":"info","ts":"2026-03-18T00:47:56.420496Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e3aaa5c123e150e0 elected leader e3aaa5c123e150e0 at term 2"}
{"level":"info","ts":"2026-03-18T00:47:56.421525Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e3aaa5c123e150e0","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.115:2379]}","request-path":"/0/members/e3aaa5c123e150e0/attributes","cluster-id":"61ec519698823541","publish-timeout":"7s"}
{"level":"info","ts":"2026-03-18T00:47:56.421583Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-18T00:47:56.421606Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-18T00:47:56.421866Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-03-18T00:47:56.4219Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-03-18T00:47:56.421883Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-18T00:47:56.423122Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"61ec519698823541","local-member-id":"e3aaa5c123e150e0","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-18T00:47:56.423329Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-18T00:47:56.423414Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-18T00:47:56.424678Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-03-18T00:47:56.426183Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.115:2379"}
{"level":"info","ts":"2026-03-18T00:48:17.100777Z","caller":"traceutil/trace.go:171","msg":"trace[1227183131] transaction","detail":"{read_only:false; response_revision:417; number_of_response:1; }","duration":"240.249328ms","start":"2026-03-18T00:48:16.860509Z","end":"2026-03-18T00:48:17.100759Z","steps":["trace[1227183131] 'process raft request'  (duration: 240.120745ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:48:22.777642Z","caller":"traceutil/trace.go:171","msg":"trace[1815768715] transaction","detail":"{read_only:false; response_revision:431; number_of_response:1; }","duration":"144.763454ms","start":"2026-03-18T00:48:22.632852Z","end":"2026-03-18T00:48:22.777616Z","steps":["trace[1815768715] 'process raft request'  (duration: 144.55099ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:48:33.631395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.451064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/cert-manager/\" range_end:\"/registry/secrets/cert-manager0\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-18T00:48:33.631549Z","caller":"traceutil/trace.go:171","msg":"trace[1990037108] range","detail":"{range_begin:/registry/secrets/cert-manager/; range_end:/registry/secrets/cert-manager0; response_count:0; response_revision:515; }","duration":"257.672577ms","start":"2026-03-18T00:48:33.373853Z","end":"2026-03-18T00:48:33.631526Z","steps":["trace[1990037108] 'range keys from in-memory index tree'  (duration: 257.360791ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:48:33.861946Z","caller":"traceutil/trace.go:171","msg":"trace[1706664584] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"214.39767ms","start":"2026-03-18T00:48:33.647524Z","end":"2026-03-18T00:48:33.861921Z","steps":["trace[1706664584] 'process raft request'  (duration: 214.217845ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:48:34.789949Z","caller":"traceutil/trace.go:171","msg":"trace[383281724] transaction","detail":"{read_only:false; number_of_response:1; response_revision:566; }","duration":"102.599978ms","start":"2026-03-18T00:48:34.68731Z","end":"2026-03-18T00:48:34.78991Z","steps":["trace[383281724] 'process raft request'  (duration: 78.997704ms)","trace[383281724] 'compare'  (duration: 23.227447ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T00:48:34.790179Z","caller":"traceutil/trace.go:171","msg":"trace[1735695499] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"102.15819ms","start":"2026-03-18T00:48:34.687988Z","end":"2026-03-18T00:48:34.790146Z","steps":["trace[1735695499] 'process raft request'  (duration: 101.69179ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:48:34.790248Z","caller":"traceutil/trace.go:171","msg":"trace[352603232] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"102.143389ms","start":"2026-03-18T00:48:34.688074Z","end":"2026-03-18T00:48:34.790217Z","steps":["trace[352603232] 'process raft request'  (duration: 101.786882ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:48:34.790328Z","caller":"traceutil/trace.go:171","msg":"trace[1263456570] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"100.097757ms","start":"2026-03-18T00:48:34.690191Z","end":"2026-03-18T00:48:34.790288Z","steps":["trace[1263456570] 'process raft request'  (duration: 99.935494ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:49:49.327761Z","caller":"traceutil/trace.go:171","msg":"trace[1201341849] transaction","detail":"{read_only:false; response_revision:1564; number_of_response:1; }","duration":"193.253331ms","start":"2026-03-18T00:49:49.134486Z","end":"2026-03-18T00:49:49.327739Z","steps":["trace[1201341849] 'process raft request'  (duration: 193.084818ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:49:49.459116Z","caller":"traceutil/trace.go:171","msg":"trace[887434640] linearizableReadLoop","detail":"{readStateIndex:1632; appliedIndex:1631; }","duration":"109.651173ms","start":"2026-03-18T00:49:49.349432Z","end":"2026-03-18T00:49:49.459083Z","steps":["trace[887434640] 'read index received'  (duration: 83.21403ms)","trace[887434640] 'applied index is now lower than readState.Index'  (duration: 26.435853ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T00:49:49.459418Z","caller":"traceutil/trace.go:171","msg":"trace[2018506262] transaction","detail":"{read_only:false; response_revision:1565; number_of_response:1; }","duration":"127.297213ms","start":"2026-03-18T00:49:49.331992Z","end":"2026-03-18T00:49:49.45929Z","steps":["trace[2018506262] 'process raft request'  (duration: 100.744707ms)","trace[2018506262] 'compare'  (duration: 26.20913ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T00:49:49.459717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.264027ms","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-18T00:49:49.459911Z","caller":"traceutil/trace.go:171","msg":"trace[1338932986] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1565; }","duration":"110.41087ms","start":"2026-03-18T00:49:49.34936Z","end":"2026-03-18T00:49:49.459771Z","steps":["trace[1338932986] 'agreement among raft nodes before linearized reading'  (duration: 109.915299ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:49:49.843211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.005811ms","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-03-18T00:49:49.843295Z","caller":"traceutil/trace.go:171","msg":"trace[80768379] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1567; }","duration":"168.160985ms","start":"2026-03-18T00:49:49.675115Z","end":"2026-03-18T00:49:49.843276Z","steps":["trace[80768379] 'range keys from in-memory index tree'  (duration: 167.808216ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:49:57.091388Z","caller":"traceutil/trace.go:171","msg":"trace[1227711169] transaction","detail":"{read_only:false; response_revision:1632; number_of_response:1; }","duration":"137.913013ms","start":"2026-03-18T00:49:56.95345Z","end":"2026-03-18T00:49:57.091363Z","steps":["trace[1227711169] 'process raft request'  (duration: 76.367312ms)","trace[1227711169] 'compare'  (duration: 61.355527ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T00:50:33.425539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.589564ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-03-18T00:50:33.425659Z","caller":"traceutil/trace.go:171","msg":"trace[1673463027] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1829; }","duration":"171.755858ms","start":"2026-03-18T00:50:33.253879Z","end":"2026-03-18T00:50:33.425635Z","steps":["trace[1673463027] 'range keys from in-memory index tree'  (duration: 171.35387ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:50:33.566735Z","caller":"traceutil/trace.go:171","msg":"trace[1578881946] transaction","detail":"{read_only:false; response_revision:1830; number_of_response:1; }","duration":"136.449103ms","start":"2026-03-18T00:50:33.43016Z","end":"2026-03-18T00:50:33.566609Z","steps":["trace[1578881946] 'process raft request'  (duration: 136.193878ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:50:39.70811Z","caller":"traceutil/trace.go:171","msg":"trace[1012001238] transaction","detail":"{read_only:false; response_revision:1858; number_of_response:1; }","duration":"112.647246ms","start":"2026-03-18T00:50:39.595436Z","end":"2026-03-18T00:50:39.708083Z","steps":["trace[1012001238] 'process raft request'  (duration: 112.478193ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:50:39.729062Z","caller":"traceutil/trace.go:171","msg":"trace[2092852138] transaction","detail":"{read_only:false; response_revision:1859; number_of_response:1; }","duration":"130.210741ms","start":"2026-03-18T00:50:39.598767Z","end":"2026-03-18T00:50:39.728978Z","steps":["trace[2092852138] 'process raft request'  (duration: 130.099069ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:50:40.199232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.086908ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5827830534329052735 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:1851 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-18T00:50:40.199369Z","caller":"traceutil/trace.go:171","msg":"trace[1476275654] linearizableReadLoop","detail":"{readStateIndex:1939; appliedIndex:1938; }","duration":"458.640971ms","start":"2026-03-18T00:50:39.740708Z","end":"2026-03-18T00:50:40.199349Z","steps":["trace[1476275654] 'read index received'  (duration: 23.688586ms)","trace[1476275654] 'applied index is now lower than readState.Index'  (duration: 434.950515ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T00:50:40.199448Z","caller":"traceutil/trace.go:171","msg":"trace[1006146440] transaction","detail":"{read_only:false; response_revision:1860; number_of_response:1; }","duration":"465.75981ms","start":"2026-03-18T00:50:39.733632Z","end":"2026-03-18T00:50:40.199392Z","steps":["trace[1006146440] 'process raft request'  (duration: 30.785245ms)","trace[1006146440] 'compare'  (duration: 433.743632ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T00:50:40.199569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"458.867216ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"}
{"level":"info","ts":"2026-03-18T00:50:40.199615Z","caller":"traceutil/trace.go:171","msg":"trace[1062296147] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1860; }","duration":"458.913176ms","start":"2026-03-18T00:50:39.740689Z","end":"2026-03-18T00:50:40.199602Z","steps":["trace[1062296147] 'agreement among raft nodes before linearized reading'  (duration: 458.756043ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:50:40.19966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:50:39.740636Z","time spent":"459.011158ms","remote":"127.0.0.1:32840","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":577,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"warn","ts":"2026-03-18T00:50:40.199696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:50:39.733602Z","time spent":"465.940804ms","remote":"127.0.0.1:32840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:1851 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-03-18T00:50:40.199716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.467026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.115\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-03-18T00:50:40.19979Z","caller":"traceutil/trace.go:171","msg":"trace[1826358472] range","detail":"{range_begin:/registry/masterleases/199.204.45.115; range_end:; response_count:1; response_revision:1860; }","duration":"399.588059ms","start":"2026-03-18T00:50:39.800182Z","end":"2026-03-18T00:50:40.19977Z","steps":["trace[1826358472] 'agreement among raft nodes before linearized reading'  (duration: 399.304983ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:50:40.199838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.88432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"warn","ts":"2026-03-18T00:50:40.199845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:50:39.800167Z","time spent":"399.66875ms","remote":"127.0.0.1:60852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.115\" "}
{"level":"info","ts":"2026-03-18T00:50:40.199866Z","caller":"traceutil/trace.go:171","msg":"trace[253243143] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1860; }","duration":"110.962231ms","start":"2026-03-18T00:50:40.088895Z","end":"2026-03-18T00:50:40.199857Z","steps":["trace[253243143] 'agreement among raft nodes before linearized reading'  (duration: 110.86746ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:50:40.199822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.252159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-18T00:50:40.199927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.643211ms","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":"warn","ts":"2026-03-18T00:50:40.199946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.690672ms","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-18T00:50:40.200018Z","caller":"traceutil/trace.go:171","msg":"trace[924596132] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1860; }","duration":"318.500664ms","start":"2026-03-18T00:50:39.881489Z","end":"2026-03-18T00:50:40.19999Z","steps":["trace[924596132] 'agreement among raft nodes before linearized reading'  (duration: 318.186038ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:50:40.200022Z","caller":"traceutil/trace.go:171","msg":"trace[729163530] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1860; }","duration":"305.783084ms","start":"2026-03-18T00:50:39.894214Z","end":"2026-03-18T00:50:40.199997Z","steps":["trace[729163530] 'agreement among raft nodes before linearized reading'  (duration: 305.518039ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:50:40.20004Z","caller":"traceutil/trace.go:171","msg":"trace[1377203042] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1860; }","duration":"398.824894ms","start":"2026-03-18T00:50:39.801188Z","end":"2026-03-18T00:50:40.200013Z","steps":["trace[1377203042] 'agreement among raft nodes before linearized reading'  (duration: 398.555439ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:50:40.200095Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:50:39.894187Z","time spent":"305.889057ms","remote":"127.0.0.1:32840","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-03-18T00:50:40.200097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:50:39.881433Z","time spent":"318.625376ms","remote":"127.0.0.1:60822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-18T00:50:40.200102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:50:39.801164Z","time spent":"398.924276ms","remote":"127.0.0.1:39800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"warn","ts":"2026-03-18T00:50:40.517938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.14754ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5827830534329052739 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:15-second id:50e09cfe69dbae42>","response":"size:40"}
{"level":"info","ts":"2026-03-18T00:50:40.518225Z","caller":"traceutil/trace.go:171","msg":"trace[1329578894] linearizableReadLoop","detail":"{readStateIndex:1940; appliedIndex:1939; }","duration":"316.688959ms","start":"2026-03-18T00:50:40.201503Z","end":"2026-03-18T00:50:40.518192Z","steps":["trace[1329578894] 'read index received'  (duration: 214.273785ms)","trace[1329578894] 'applied index is now lower than readState.Index'  (duration: 102.412664ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T00:50:40.51846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.936104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-18T00:50:40.518609Z","caller":"traceutil/trace.go:171","msg":"trace[1186076565] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1860; }","duration":"317.133428ms","start":"2026-03-18T00:50:40.201431Z","end":"2026-03-18T00:50:40.518564Z","steps":["trace[1186076565] 'agreement among raft nodes before linearized reading'  (duration: 316.855612ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:50:40.518732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:50:40.201414Z","time spent":"317.277561ms","remote":"127.0.0.1:60820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-18T00:50:40.518749Z","caller":"traceutil/trace.go:171","msg":"trace[1007532782] transaction","detail":"{read_only:false; response_revision:1862; number_of_response:1; }","duration":"314.037507ms","start":"2026-03-18T00:50:40.204692Z","end":"2026-03-18T00:50:40.51873Z","steps":["trace[1007532782] 'process raft request'  (duration: 313.947025ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:50:40.518617Z","caller":"traceutil/trace.go:171","msg":"trace[56723974] transaction","detail":"{read_only:false; response_revision:1861; number_of_response:1; }","duration":"314.777591ms","start":"2026-03-18T00:50:40.203776Z","end":"2026-03-18T00:50:40.518553Z","steps":["trace[56723974] 'process raft request'  (duration: 314.392814ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:50:40.518843Z","caller":"traceutil/trace.go:171","msg":"trace[936741516] transaction","detail":"{read_only:false; response_revision:1863; number_of_response:1; }","duration":"313.467676ms","start":"2026-03-18T00:50:40.205361Z","end":"2026-03-18T00:50:40.518828Z","steps":["trace[936741516] 'process raft request'  (duration: 313.335113ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:50:40.51894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:50:40.203758Z","time spent":"315.123798ms","remote":"127.0.0.1:32840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:1855 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-03-18T00:50:40.51913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:50:40.204679Z","time spent":"314.130908ms","remote":"127.0.0.1:32840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:1852 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:463 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-03-18T00:50:40.5192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:50:40.205352Z","time spent":"313.577938ms","remote":"127.0.0.1:32840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:1854 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-03-18T00:50:40.518783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:50:40.200846Z","time spent":"317.909502ms","remote":"127.0.0.1:60852","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"info","ts":"2026-03-18T00:50:40.661401Z","caller":"traceutil/trace.go:171","msg":"trace[1314763234] transaction","detail":"{read_only:false; response_revision:1864; number_of_response:1; }","duration":"140.417951ms","start":"2026-03-18T00:50:40.520952Z","end":"2026-03-18T00:50:40.66137Z","steps":["trace[1314763234] 'process raft request'  (duration: 140.293409ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:52:05.3917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.751722ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5827830534329054227 > lease_revoke:<id:50e09cfe69dbb322>","response":"size:28"}
{"level":"info","ts":"2026-03-18T00:54:40.911241Z","caller":"traceutil/trace.go:171","msg":"trace[1425225834] linearizableReadLoop","detail":"{readStateIndex:3561; appliedIndex:3560; }","duration":"144.820599ms","start":"2026-03-18T00:54:40.766386Z","end":"2026-03-18T00:54:40.911207Z","steps":["trace[1425225834] 'read index received'  (duration: 144.450412ms)","trace[1425225834] 'applied index is now lower than readState.Index'  (duration: 368.957µs)"],"step_count":2}
{"level":"info","ts":"2026-03-18T00:54:40.911412Z","caller":"traceutil/trace.go:171","msg":"trace[1511754389] transaction","detail":"{read_only:false; response_revision:3417; number_of_response:1; }","duration":"190.089169ms","start":"2026-03-18T00:54:40.721254Z","end":"2026-03-18T00:54:40.911343Z","steps":["trace[1511754389] 'process raft request'  (duration: 189.751382ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:54:40.911509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.071434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/exchanges/\" range_end:\"/registry/rabbitmq.com/exchanges0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-18T00:54:40.911623Z","caller":"traceutil/trace.go:171","msg":"trace[1322494597] range","detail":"{range_begin:/registry/rabbitmq.com/exchanges/; range_end:/registry/rabbitmq.com/exchanges0; response_count:0; response_revision:3417; }","duration":"145.242597ms","start":"2026-03-18T00:54:40.766356Z","end":"2026-03-18T00:54:40.911599Z","steps":["trace[1322494597] 'agreement among raft nodes before linearized reading'  (duration: 145.021542ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:55:59.299472Z","caller":"traceutil/trace.go:171","msg":"trace[441833264] transaction","detail":"{read_only:false; response_revision:4332; number_of_response:1; }","duration":"137.582047ms","start":"2026-03-18T00:55:59.161838Z","end":"2026-03-18T00:55:59.29942Z","steps":["trace[441833264] 'process raft request'  (duration: 124.046548ms)","trace[441833264] 'compare'  (duration: 13.300415ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T00:56:05.080462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.720343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-18T00:56:05.080533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.895034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"}
{"level":"info","ts":"2026-03-18T00:56:05.080607Z","caller":"traceutil/trace.go:171","msg":"trace[477820420] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4553; }","duration":"233.024957ms","start":"2026-03-18T00:56:04.847562Z","end":"2026-03-18T00:56:05.080587Z","steps":["trace[477820420] 'range keys from in-memory index tree'  (duration: 232.681449ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:56:05.080605Z","caller":"traceutil/trace.go:171","msg":"trace[681435385] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4553; }","duration":"199.936888ms","start":"2026-03-18T00:56:04.88064Z","end":"2026-03-18T00:56:05.080577Z","steps":["trace[681435385] 'range keys from in-memory index tree'  (duration: 199.57185ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:56:05.080658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.748921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/vector\" ","response":"range_response_count:1 size:894"}
{"level":"info","ts":"2026-03-18T00:56:05.080767Z","caller":"traceutil/trace.go:171","msg":"trace[481554765] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/vector; range_end:; response_count:1; response_revision:4553; }","duration":"232.925255ms","start":"2026-03-18T00:56:04.847817Z","end":"2026-03-18T00:56:05.080742Z","steps":["trace[481554765] 'range keys from in-memory index tree'  (duration: 232.528626ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:56:05.080854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.391628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-15c71447-79c2-47d2-98c7-8b3299a0628c\" ","response":"range_response_count:1 size:3601"}
{"level":"info","ts":"2026-03-18T00:56:05.081032Z","caller":"traceutil/trace.go:171","msg":"trace[1000290066] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-15c71447-79c2-47d2-98c7-8b3299a0628c; range_end:; response_count:1; response_revision:4553; }","duration":"199.656463ms","start":"2026-03-18T00:56:04.881335Z","end":"2026-03-18T00:56:05.080992Z","steps":["trace[1000290066] 'range keys from in-memory index tree'  (duration: 199.143493ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:56:05.082243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.20635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:777481"}
{"level":"info","ts":"2026-03-18T00:56:05.082352Z","caller":"traceutil/trace.go:171","msg":"trace[1208558224] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:4553; }","duration":"224.383484ms","start":"2026-03-18T00:56:04.857945Z","end":"2026-03-18T00:56:05.082329Z","steps":["trace[1208558224] 'range keys from in-memory index tree'  (duration: 223.574968ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:56:05.086474Z","caller":"traceutil/trace.go:171","msg":"trace[1663839388] linearizableReadLoop","detail":"{readStateIndex:4744; appliedIndex:4743; }","duration":"134.974036ms","start":"2026-03-18T00:56:04.951477Z","end":"2026-03-18T00:56:05.086451Z","steps":["trace[1663839388] 'read index received'  (duration: 95.573262ms)","trace[1663839388] 'applied index is now lower than readState.Index'  (duration: 39.398014ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T00:56:05.086508Z","caller":"traceutil/trace.go:171","msg":"trace[1819572589] transaction","detail":"{read_only:false; response_revision:4554; number_of_response:1; }","duration":"116.891346ms","start":"2026-03-18T00:56:04.9696Z","end":"2026-03-18T00:56:05.086492Z","steps":["trace[1819572589] 'process raft request'  (duration: 116.772013ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:56:05.086764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.277592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:1219"}
{"level":"info","ts":"2026-03-18T00:56:05.086815Z","caller":"traceutil/trace.go:171","msg":"trace[1223581677] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4554; }","duration":"135.346343ms","start":"2026-03-18T00:56:04.951455Z","end":"2026-03-18T00:56:05.086801Z","steps":["trace[1223581677] 'agreement among raft nodes before linearized reading'  (duration: 135.135809ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:56:05.086835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.976227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-bcfmh\" ","response":"range_response_count:1 size:6524"}
{"level":"warn","ts":"2026-03-18T00:56:05.086876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.307844ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-15c71447-79c2-47d2-98c7-8b3299a0628c\" ","response":"range_response_count:1 size:3601"}
{"level":"info","ts":"2026-03-18T00:56:05.086901Z","caller":"traceutil/trace.go:171","msg":"trace[1698976882] range","detail":"{range_begin:/registry/pods/openstack/keepalived-bcfmh; range_end:; response_count:1; response_revision:4554; }","duration":"112.059329ms","start":"2026-03-18T00:56:04.974825Z","end":"2026-03-18T00:56:05.086884Z","steps":["trace[1698976882] 'agreement among raft nodes before linearized reading'  (duration: 111.882176ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:56:05.086961Z","caller":"traceutil/trace.go:171","msg":"trace[589867830] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-15c71447-79c2-47d2-98c7-8b3299a0628c; range_end:; response_count:1; response_revision:4554; }","duration":"119.396495ms","start":"2026-03-18T00:56:04.96754Z","end":"2026-03-18T00:56:05.086937Z","steps":["trace[589867830] 'agreement among raft nodes before linearized reading'  (duration: 119.192831ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:56:05.086948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.276452ms","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-03-18T00:56:05.087032Z","caller":"traceutil/trace.go:171","msg":"trace[1603730365] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4554; }","duration":"118.396105ms","start":"2026-03-18T00:56:04.968618Z","end":"2026-03-18T00:56:05.087014Z","steps":["trace[1603730365] 'agreement among raft nodes before linearized reading'  (duration: 118.1734ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:56:15.104187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.904144ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5827830534329059861 > lease_revoke:<id:50e09cfe69dbc6c6>","response":"size:28"}
{"level":"info","ts":"2026-03-18T00:56:15.105191Z","caller":"traceutil/trace.go:171","msg":"trace[1004091732] transaction","detail":"{read_only:false; response_revision:4741; number_of_response:1; }","duration":"138.789832ms","start":"2026-03-18T00:56:14.966364Z","end":"2026-03-18T00:56:15.105154Z","steps":["trace[1004091732] 'process raft request'  (duration: 138.538887ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:56:24.920816Z","caller":"traceutil/trace.go:171","msg":"trace[1217814523] transaction","detail":"{read_only:false; response_revision:4950; number_of_response:1; }","duration":"125.170019ms","start":"2026-03-18T00:56:24.795592Z","end":"2026-03-18T00:56:24.920762Z","steps":["trace[1217814523] 'process raft request'  (duration: 83.112173ms)","trace[1217814523] 'compare'  (duration: 41.485645ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T00:56:34.692383Z","caller":"traceutil/trace.go:171","msg":"trace[1712262990] transaction","detail":"{read_only:false; response_revision:5082; number_of_response:1; }","duration":"136.002175ms","start":"2026-03-18T00:56:34.556356Z","end":"2026-03-18T00:56:34.692358Z","steps":["trace[1712262990] 'process raft request'  (duration: 135.956714ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:56:34.692468Z","caller":"traceutil/trace.go:171","msg":"trace[1891356101] transaction","detail":"{read_only:false; response_revision:5081; number_of_response:1; }","duration":"136.896243ms","start":"2026-03-18T00:56:34.555519Z","end":"2026-03-18T00:56:34.692416Z","steps":["trace[1891356101] 'process raft request'  (duration: 101.011189ms)","trace[1891356101] 'compare'  (duration: 35.6865ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T00:57:56.889873Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2726}
{"level":"info","ts":"2026-03-18T00:57:56.948572Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2726,"took":"57.229977ms","hash":1705125349,"current-db-size-bytes":41168896,"current-db-size":"41 MB","current-db-size-in-use-bytes":30650368,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-03-18T00:57:56.948763Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1705125349,"revision":2726,"compact-revision":-1}
{"level":"info","ts":"2026-03-18T01:02:28.805707Z","caller":"traceutil/trace.go:171","msg":"trace[1102935341] linearizableReadLoop","detail":"{readStateIndex:7862; appliedIndex:7861; }","duration":"127.510648ms","start":"2026-03-18T01:02:28.67816Z","end":"2026-03-18T01:02:28.80567Z","steps":["trace[1102935341] 'read index received'  (duration: 127.326134ms)","trace[1102935341] 'applied index is now lower than readState.Index'  (duration: 183.034µs)"],"step_count":2}
{"level":"info","ts":"2026-03-18T01:02:28.805825Z","caller":"traceutil/trace.go:171","msg":"trace[1099456308] transaction","detail":"{read_only:false; response_revision:7574; number_of_response:1; }","duration":"259.341413ms","start":"2026-03-18T01:02:28.54644Z","end":"2026-03-18T01:02:28.805781Z","steps":["trace[1099456308] 'process raft request'  (duration: 259.004906ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T01:02:28.806079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.883166ms","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-18T01:02:28.806193Z","caller":"traceutil/trace.go:171","msg":"trace[125315768] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:7574; }","duration":"128.06403ms","start":"2026-03-18T01:02:28.678104Z","end":"2026-03-18T01:02:28.806168Z","steps":["trace[125315768] 'agreement among raft nodes before linearized reading'  (duration: 127.733322ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T01:02:28.977002Z","caller":"traceutil/trace.go:171","msg":"trace[601315250] transaction","detail":"{read_only:false; response_revision:7575; number_of_response:1; }","duration":"288.645047ms","start":"2026-03-18T01:02:28.688324Z","end":"2026-03-18T01:02:28.976969Z","steps":["trace[601315250] 'process raft request'  (duration: 286.418592ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T01:02:29.007284Z","caller":"traceutil/trace.go:171","msg":"trace[299837803] linearizableReadLoop","detail":"{readStateIndex:7864; appliedIndex:7862; }","duration":"125.980329ms","start":"2026-03-18T01:02:28.881276Z","end":"2026-03-18T01:02:29.007256Z","steps":["trace[299837803] 'read index received'  (duration: 93.482542ms)","trace[299837803] 'applied index is now lower than readState.Index'  (duration: 32.496417ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T01:02:29.007339Z","caller":"traceutil/trace.go:171","msg":"trace[577421041] transaction","detail":"{read_only:false; response_revision:7576; number_of_response:1; }","duration":"196.446881ms","start":"2026-03-18T01:02:28.810862Z","end":"2026-03-18T01:02:29.007309Z","steps":["trace[577421041] 'process raft request'  (duration: 196.209586ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T01:02:29.007486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.189303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-18T01:02:29.0076Z","caller":"traceutil/trace.go:171","msg":"trace[1931253619] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:7576; }","duration":"126.353186ms","start":"2026-03-18T01:02:28.881219Z","end":"2026-03-18T01:02:29.007573Z","steps":["trace[1931253619] 'agreement among raft nodes before linearized reading'  (duration: 126.144552ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T01:02:40.598451Z","caller":"traceutil/trace.go:171","msg":"trace[2133566326] transaction","detail":"{read_only:false; response_revision:7632; number_of_response:1; }","duration":"163.440334ms","start":"2026-03-18T01:02:40.434978Z","end":"2026-03-18T01:02:40.598419Z","steps":["trace[2133566326] 'process raft request'  (duration: 163.075027ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T01:02:41.392107Z","caller":"traceutil/trace.go:171","msg":"trace[1522724730] linearizableReadLoop","detail":"{readStateIndex:7928; appliedIndex:7927; }","duration":"102.196145ms","start":"2026-03-18T01:02:41.289881Z","end":"2026-03-18T01:02:41.392077Z","steps":["trace[1522724730] 'read index received'  (duration: 83.123946ms)","trace[1522724730] 'applied index is now lower than readState.Index'  (duration: 19.070779ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T01:02:41.392165Z","caller":"traceutil/trace.go:171","msg":"trace[1187786308] transaction","detail":"{read_only:false; response_revision:7636; number_of_response:1; }","duration":"256.454376ms","start":"2026-03-18T01:02:41.135674Z","end":"2026-03-18T01:02:41.392128Z","steps":["trace[1187786308] 'process raft request'  (duration: 237.415377ms)","trace[1187786308] 'compare'  (duration: 18.59677ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T01:02:41.392483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.573273ms","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-03-18T01:02:41.392528Z","caller":"traceutil/trace.go:171","msg":"trace[2125664106] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7636; }","duration":"102.729916ms","start":"2026-03-18T01:02:41.289786Z","end":"2026-03-18T01:02:41.392516Z","steps":["trace[2125664106] 'agreement among raft nodes before linearized reading'  (duration: 102.402939ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T01:02:56.897725Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5693}
{"level":"info","ts":"2026-03-18T01:02:56.988317Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5693,"took":"87.534517ms","hash":4236357251,"current-db-size-bytes":41889792,"current-db-size":"42 MB","current-db-size-in-use-bytes":22855680,"current-db-size-in-use":"23 MB"}
{"level":"info","ts":"2026-03-18T01:02:56.988388Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4236357251,"revision":5693,"compact-revision":2726}
{"level":"info","ts":"2026-03-18T01:03:09.322834Z","caller":"traceutil/trace.go:171","msg":"trace[2115714576] transaction","detail":"{read_only:false; response_revision:7824; number_of_response:1; }","duration":"134.253988ms","start":"2026-03-18T01:03:09.188556Z","end":"2026-03-18T01:03:09.32281Z","steps":["trace[2115714576] 'process raft request'  (duration: 98.894863ms)","trace[2115714576] 'compare'  (duration: 35.283584ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T01:04:37.082109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.466639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-18T01:04:37.082208Z","caller":"traceutil/trace.go:171","msg":"trace[1000107479] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8633; }","duration":"201.617462ms","start":"2026-03-18T01:04:36.880572Z","end":"2026-03-18T01:04:37.082189Z","steps":["trace[1000107479] 'range keys from in-memory index tree'  (duration: 201.368467ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T01:06:59.966989Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e3aaa5c123e150e0","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-03-18T01:06:59.981555Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-03-18T01:06:59.981758Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-03-18T01:07:56.904407Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7714}
{"level":"info","ts":"2026-03-18T01:07:56.979637Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7714,"took":"70.985252ms","hash":654809296,"current-db-size-bytes":41889792,"current-db-size":"42 MB","current-db-size-in-use-bytes":25763840,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-03-18T01:07:56.979724Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":654809296,"revision":7714,"compact-revision":5693}
{"level":"info","ts":"2026-03-18T01:12:56.911058Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":9958}
{"level":"info","ts":"2026-03-18T01:12:56.986684Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":9958,"took":"73.723828ms","hash":2522329826,"current-db-size-bytes":41889792,"current-db-size":"42 MB","current-db-size-in-use-bytes":16850944,"current-db-size-in-use":"17 MB"}
{"level":"info","ts":"2026-03-18T01:12:56.986754Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2522329826,"revision":9958,"compact-revision":7714}