{"level":"warn","ts":"2026-03-18T00:48:11.572236Z","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:48:11.572325Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.149: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.149:2380","--initial-cluster=instance=https://199.204.45.149:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.149:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.149: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:48:11.572387Z","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:48:11.572394Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.149:2380"]}
{"level":"info","ts":"2026-03-18T00:48:11.572415Z","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:48:11.57306Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.149:2379"]}
{"level":"info","ts":"2026-03-18T00:48:11.573133Z","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.149:2380"],"listen-peer-urls":["https://199.204.45.149:2380"],"advertise-client-urls":["https://199.204.45.149:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.149:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.149: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:48:11.576495Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.183976ms"}
{"level":"info","ts":"2026-03-18T00:48:11.593539Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b1b675f124322401","cluster-id":"913dfbf24a38e0aa"}
{"level":"info","ts":"2026-03-18T00:48:11.593653Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b1b675f124322401 switched to configuration voters=()"}
{"level":"info","ts":"2026-03-18T00:48:11.59368Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b1b675f124322401 became follower at term 0"}
{"level":"info","ts":"2026-03-18T00:48:11.593695Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b1b675f124322401 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-03-18T00:48:11.593712Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b1b675f124322401 became follower at term 1"}
{"level":"info","ts":"2026-03-18T00:48:11.593758Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b1b675f124322401 switched to configuration voters=(12805552269029417985)"}
{"level":"warn","ts":"2026-03-18T00:48:11.600701Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-03-18T00:48:11.602117Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-03-18T00:48:11.603395Z","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:48:11.605635Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b1b675f124322401","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-03-18T00:48:11.605811Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b1b675f124322401","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-03-18T00:48:11.605946Z","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:48:11.606019Z","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:48:11.60603Z","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:48:11.606947Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b1b675f124322401 switched to configuration voters=(12805552269029417985)"}
{"level":"info","ts":"2026-03-18T00:48:11.607133Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"913dfbf24a38e0aa","local-member-id":"b1b675f124322401","added-peer-id":"b1b675f124322401","added-peer-peer-urls":["https://199.204.45.149:2380"]}
{"level":"info","ts":"2026-03-18T00:48:11.610562Z","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:48:11.610811Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b1b675f124322401","initial-advertise-peer-urls":["https://199.204.45.149:2380"],"listen-peer-urls":["https://199.204.45.149:2380"],"advertise-client-urls":["https://199.204.45.149:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.149:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-03-18T00:48:11.610835Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-03-18T00:48:11.610906Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.149:2380"}
{"level":"info","ts":"2026-03-18T00:48:11.610915Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.149:2380"}
{"level":"info","ts":"2026-03-18T00:48:12.095765Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b1b675f124322401 is starting a new election at term 1"}
{"level":"info","ts":"2026-03-18T00:48:12.097434Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b1b675f124322401 became pre-candidate at term 1"}
{"level":"info","ts":"2026-03-18T00:48:12.097458Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b1b675f124322401 received MsgPreVoteResp from b1b675f124322401 at term 1"}
{"level":"info","ts":"2026-03-18T00:48:12.100166Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b1b675f124322401 became candidate at term 2"}
{"level":"info","ts":"2026-03-18T00:48:12.10018Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b1b675f124322401 received MsgVoteResp from b1b675f124322401 at term 2"}
{"level":"info","ts":"2026-03-18T00:48:12.10019Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b1b675f124322401 became leader at term 2"}
{"level":"info","ts":"2026-03-18T00:48:12.100199Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b1b675f124322401 elected leader b1b675f124322401 at term 2"}
{"level":"info","ts":"2026-03-18T00:48:12.102943Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b1b675f124322401","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.149:2379]}","request-path":"/0/members/b1b675f124322401/attributes","cluster-id":"913dfbf24a38e0aa","publish-timeout":"7s"}
{"level":"info","ts":"2026-03-18T00:48:12.102963Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-18T00:48:12.103029Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-18T00:48:12.103058Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-18T00:48:12.103898Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"913dfbf24a38e0aa","local-member-id":"b1b675f124322401","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-18T00:48:12.103424Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-03-18T00:48:12.104007Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-03-18T00:48:12.104016Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-18T00:48:12.10406Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-18T00:48:12.106703Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.149:2379"}
{"level":"info","ts":"2026-03-18T00:48:12.10691Z","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:48:48.273307Z","caller":"traceutil/trace.go:171","msg":"trace[734277846] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"415.635104ms","start":"2026-03-18T00:48:47.85764Z","end":"2026-03-18T00:48:48.273275Z","steps":["trace[734277846] 'process raft request'  (duration: 415.42973ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:48:48.273965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:48:47.857615Z","time spent":"415.807768ms","remote":"127.0.0.1:34040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4749,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:505 > success:<request_put:<key:\"/registry/minions/instance\" value_size:4715 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"warn","ts":"2026-03-18T00:48:48.498794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.387042ms","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:48.49899Z","caller":"traceutil/trace.go:171","msg":"trace[1610352644] range","detail":"{range_begin:/registry/secrets/cert-manager/; range_end:/registry/secrets/cert-manager0; response_count:0; response_revision:548; }","duration":"121.620957ms","start":"2026-03-18T00:48:48.377332Z","end":"2026-03-18T00:48:48.498953Z","steps":["trace[1610352644] 'range keys from in-memory index tree'  (duration: 121.246779ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:50:01.898397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.386847ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2594527476857656980 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" mod_revision:1534 > success:<request_put:<key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" value_size:10913 >> failure:<request_range:<key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-18T00:50:01.898512Z","caller":"traceutil/trace.go:171","msg":"trace[21475908] linearizableReadLoop","detail":"{readStateIndex:1645; appliedIndex:1644; }","duration":"171.118901ms","start":"2026-03-18T00:50:01.727377Z","end":"2026-03-18T00:50:01.898496Z","steps":["trace[21475908] 'read index received'  (duration: 49.931µs)","trace[21475908] 'applied index is now lower than readState.Index'  (duration: 171.06783ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T00:50:01.898652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.280624ms","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:01.89869Z","caller":"traceutil/trace.go:171","msg":"trace[1170196120] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1585; }","duration":"171.352216ms","start":"2026-03-18T00:50:01.727325Z","end":"2026-03-18T00:50:01.898677Z","steps":["trace[1170196120] 'agreement among raft nodes before linearized reading'  (duration: 171.215913ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:50:01.898672Z","caller":"traceutil/trace.go:171","msg":"trace[1460799447] transaction","detail":"{read_only:false; response_revision:1585; number_of_response:1; }","duration":"389.120493ms","start":"2026-03-18T00:50:01.509511Z","end":"2026-03-18T00:50:01.898631Z","steps":["trace[1460799447] 'process raft request'  (duration: 104.291016ms)","trace[1460799447] 'compare'  (duration: 283.621202ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T00:50:01.898956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:50:01.509498Z","time spent":"389.348927ms","remote":"127.0.0.1:34048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10970,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" mod_revision:1534 > success:<request_put:<key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" value_size:10913 >> failure:<request_range:<key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" > >"}
{"level":"info","ts":"2026-03-18T00:50:02.040163Z","caller":"traceutil/trace.go:171","msg":"trace[1256810848] transaction","detail":"{read_only:false; response_revision:1587; number_of_response:1; }","duration":"136.015714ms","start":"2026-03-18T00:50:01.904112Z","end":"2026-03-18T00:50:02.040128Z","steps":["trace[1256810848] 'process raft request'  (duration: 135.801889ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:50:02.04016Z","caller":"traceutil/trace.go:171","msg":"trace[76792692] transaction","detail":"{read_only:false; response_revision:1589; number_of_response:1; }","duration":"133.704548ms","start":"2026-03-18T00:50:01.906438Z","end":"2026-03-18T00:50:02.040143Z","steps":["trace[76792692] 'process raft request'  (duration: 133.660777ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:50:02.040283Z","caller":"traceutil/trace.go:171","msg":"trace[757621496] transaction","detail":"{read_only:false; response_revision:1588; number_of_response:1; }","duration":"136.097746ms","start":"2026-03-18T00:50:01.904142Z","end":"2026-03-18T00:50:02.04024Z","steps":["trace[757621496] 'process raft request'  (duration: 135.901622ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:50:02.353353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.404112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"warn","ts":"2026-03-18T00:50:02.353447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.745775ms","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-18T00:50:02.353454Z","caller":"traceutil/trace.go:171","msg":"trace[1230123923] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1589; }","duration":"130.561016ms","start":"2026-03-18T00:50:02.22287Z","end":"2026-03-18T00:50:02.353431Z","steps":["trace[1230123923] 'range keys from in-memory index tree'  (duration: 130.214398ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:50:02.353514Z","caller":"traceutil/trace.go:171","msg":"trace[1699227103] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1589; }","duration":"188.870787ms","start":"2026-03-18T00:50:02.164629Z","end":"2026-03-18T00:50:02.3535Z","steps":["trace[1699227103] 'range keys from in-memory index tree'  (duration: 188.51835ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:50:52.950218Z","caller":"traceutil/trace.go:171","msg":"trace[2100790928] transaction","detail":"{read_only:false; response_revision:1885; number_of_response:1; }","duration":"165.253623ms","start":"2026-03-18T00:50:52.784934Z","end":"2026-03-18T00:50:52.950188Z","steps":["trace[2100790928] 'process raft request'  (duration: 67.050109ms)","trace[2100790928] 'compare'  (duration: 98.105912ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T00:50:53.070949Z","caller":"traceutil/trace.go:171","msg":"trace[657515402] transaction","detail":"{read_only:false; response_revision:1886; number_of_response:1; }","duration":"285.195103ms","start":"2026-03-18T00:50:52.785727Z","end":"2026-03-18T00:50:53.070923Z","steps":["trace[657515402] 'process raft request'  (duration: 280.762555ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:52:13.525476Z","caller":"traceutil/trace.go:171","msg":"trace[1362190177] transaction","detail":"{read_only:false; response_revision:2476; number_of_response:1; }","duration":"168.844686ms","start":"2026-03-18T00:52:13.356604Z","end":"2026-03-18T00:52:13.525449Z","steps":["trace[1362190177] 'process raft request'  (duration: 120.339851ms)","trace[1362190177] 'compare'  (duration: 48.23451ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T00:52:13.525649Z","caller":"traceutil/trace.go:171","msg":"trace[371315190] transaction","detail":"{read_only:false; response_revision:2477; number_of_response:1; }","duration":"165.279465ms","start":"2026-03-18T00:52:13.360331Z","end":"2026-03-18T00:52:13.525611Z","steps":["trace[371315190] 'process raft request'  (duration: 165.05968ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:52:13.815108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.745042ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2594527476857659144 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:2443 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:416 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-18T00:52:13.815233Z","caller":"traceutil/trace.go:171","msg":"trace[1464086829] linearizableReadLoop","detail":"{readStateIndex:2574; appliedIndex:2573; }","duration":"225.943546ms","start":"2026-03-18T00:52:13.589272Z","end":"2026-03-18T00:52:13.815215Z","steps":["trace[1464086829] 'read index received'  (duration: 87.923909ms)","trace[1464086829] 'applied index is now lower than readState.Index'  (duration: 138.018297ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T00:52:13.81537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.054055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-18T00:52:13.815351Z","caller":"traceutil/trace.go:171","msg":"trace[259585132] transaction","detail":"{read_only:false; response_revision:2479; number_of_response:1; }","duration":"228.11411ms","start":"2026-03-18T00:52:13.587177Z","end":"2026-03-18T00:52:13.815291Z","steps":["trace[259585132] 'process raft request'  (duration: 90.078792ms)","trace[259585132] 'compare'  (duration: 137.084538ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T00:52:13.815409Z","caller":"traceutil/trace.go:171","msg":"trace[300865824] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:2479; }","duration":"201.135516ms","start":"2026-03-18T00:52:13.614264Z","end":"2026-03-18T00:52:13.8154Z","steps":["trace[300865824] 'agreement among raft nodes before linearized reading'  (duration: 201.061325ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:52:13.815505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.214551ms","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:52:13.815591Z","caller":"traceutil/trace.go:171","msg":"trace[1559514325] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2479; }","duration":"226.340003ms","start":"2026-03-18T00:52:13.589227Z","end":"2026-03-18T00:52:13.815567Z","steps":["trace[1559514325] 'agreement among raft nodes before linearized reading'  (duration: 226.081028ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:52:14.029051Z","caller":"traceutil/trace.go:171","msg":"trace[1590159134] transaction","detail":"{read_only:false; response_revision:2480; number_of_response:1; }","duration":"208.926683ms","start":"2026-03-18T00:52:13.820089Z","end":"2026-03-18T00:52:14.029015Z","steps":["trace[1590159134] 'process raft request'  (duration: 138.328883ms)","trace[1590159134] 'compare'  (duration: 70.336875ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T00:52:14.029055Z","caller":"traceutil/trace.go:171","msg":"trace[795476593] linearizableReadLoop","detail":"{readStateIndex:2575; appliedIndex:2574; }","duration":"111.391671ms","start":"2026-03-18T00:52:13.917617Z","end":"2026-03-18T00:52:14.029009Z","steps":["trace[795476593] 'read index received'  (duration: 40.732579ms)","trace[795476593] 'applied index is now lower than readState.Index'  (duration: 70.657412ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T00:52:14.02935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.699587ms","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:52:14.029454Z","caller":"traceutil/trace.go:171","msg":"trace[728645475] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2480; }","duration":"111.86371ms","start":"2026-03-18T00:52:13.917564Z","end":"2026-03-18T00:52:14.029428Z","steps":["trace[728645475] 'agreement among raft nodes before linearized reading'  (duration: 111.544354ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:55:59.578766Z","caller":"traceutil/trace.go:171","msg":"trace[1359902518] transaction","detail":"{read_only:false; response_revision:4344; number_of_response:1; }","duration":"137.805791ms","start":"2026-03-18T00:55:59.440931Z","end":"2026-03-18T00:55:59.578737Z","steps":["trace[1359902518] 'process raft request'  (duration: 137.640758ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:55:59.77533Z","caller":"traceutil/trace.go:171","msg":"trace[451935499] transaction","detail":"{read_only:false; response_revision:4349; number_of_response:1; }","duration":"115.410894ms","start":"2026-03-18T00:55:59.659885Z","end":"2026-03-18T00:55:59.775296Z","steps":["trace[451935499] 'process raft request'  (duration: 91.943505ms)","trace[451935499] 'compare'  (duration: 23.276375ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T00:55:59.77541Z","caller":"traceutil/trace.go:171","msg":"trace[1320307552] linearizableReadLoop","detail":"{readStateIndex:4517; appliedIndex:4516; }","duration":"104.22713ms","start":"2026-03-18T00:55:59.671157Z","end":"2026-03-18T00:55:59.775384Z","steps":["trace[1320307552] 'read index received'  (duration: 80.769702ms)","trace[1320307552] 'applied index is now lower than readState.Index'  (duration: 23.454558ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T00:55:59.775643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.465716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-3479439d-9169-46b4-a4cb-22c9e7bc3f06\" ","response":"range_response_count:1 size:1435"}
{"level":"info","ts":"2026-03-18T00:55:59.775691Z","caller":"traceutil/trace.go:171","msg":"trace[178235606] range","detail":"{range_begin:/registry/persistentvolumes/pvc-3479439d-9169-46b4-a4cb-22c9e7bc3f06; range_end:; response_count:1; response_revision:4350; }","duration":"104.564808ms","start":"2026-03-18T00:55:59.671114Z","end":"2026-03-18T00:55:59.775679Z","steps":["trace[178235606] 'agreement among raft nodes before linearized reading'  (duration: 104.376503ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:55:59.775691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.829614ms","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-18T00:55:59.77577Z","caller":"traceutil/trace.go:171","msg":"trace[813014448] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4350; }","duration":"102.942306ms","start":"2026-03-18T00:55:59.67281Z","end":"2026-03-18T00:55:59.775752Z","steps":["trace[813014448] 'agreement among raft nodes before linearized reading'  (duration: 102.73243ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:56:04.157368Z","caller":"traceutil/trace.go:171","msg":"trace[736669069] linearizableReadLoop","detail":"{readStateIndex:4674; appliedIndex:4673; }","duration":"156.29713ms","start":"2026-03-18T00:56:04.001041Z","end":"2026-03-18T00:56:04.157338Z","steps":["trace[736669069] 'read index received'  (duration: 156.027305ms)","trace[736669069] 'applied index is now lower than readState.Index'  (duration: 268.235µs)"],"step_count":2}
{"level":"info","ts":"2026-03-18T00:56:04.157465Z","caller":"traceutil/trace.go:171","msg":"trace[1788497332] transaction","detail":"{read_only:false; response_revision:4500; number_of_response:1; }","duration":"175.379691ms","start":"2026-03-18T00:56:03.982056Z","end":"2026-03-18T00:56:04.157435Z","steps":["trace[1788497332] 'process raft request'  (duration: 175.060205ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:56:04.157636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.577235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6ea19be8-eb77-4ab4-9f2d-71c563ce2f82\" ","response":"range_response_count:1 size:3601"}
{"level":"info","ts":"2026-03-18T00:56:04.157695Z","caller":"traceutil/trace.go:171","msg":"trace[1248205615] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-6ea19be8-eb77-4ab4-9f2d-71c563ce2f82; range_end:; response_count:1; response_revision:4500; }","duration":"156.653478ms","start":"2026-03-18T00:56:04.001026Z","end":"2026-03-18T00:56:04.15768Z","steps":["trace[1248205615] 'agreement among raft nodes before linearized reading'  (duration: 156.451484ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:56:04.432215Z","caller":"traceutil/trace.go:171","msg":"trace[1145911499] transaction","detail":"{read_only:false; response_revision:4510; number_of_response:1; }","duration":"131.763841ms","start":"2026-03-18T00:56:04.300425Z","end":"2026-03-18T00:56:04.432189Z","steps":["trace[1145911499] 'process raft request'  (duration: 131.617238ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:56:04.437749Z","caller":"traceutil/trace.go:171","msg":"trace[751382814] transaction","detail":"{read_only:false; response_revision:4511; number_of_response:1; }","duration":"136.508285ms","start":"2026-03-18T00:56:04.301224Z","end":"2026-03-18T00:56:04.437732Z","steps":["trace[751382814] 'process raft request'  (duration: 136.040206ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:56:04.438347Z","caller":"traceutil/trace.go:171","msg":"trace[714606749] transaction","detail":"{read_only:false; response_revision:4513; number_of_response:1; }","duration":"113.21344ms","start":"2026-03-18T00:56:04.325111Z","end":"2026-03-18T00:56:04.438324Z","steps":["trace[714606749] 'process raft request'  (duration: 113.012416ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:56:04.438742Z","caller":"traceutil/trace.go:171","msg":"trace[898849502] transaction","detail":"{read_only:false; response_revision:4512; number_of_response:1; }","duration":"133.922414ms","start":"2026-03-18T00:56:04.304803Z","end":"2026-03-18T00:56:04.438726Z","steps":["trace[898849502] 'process raft request'  (duration: 132.838483ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:56:06.459196Z","caller":"traceutil/trace.go:171","msg":"trace[1296866275] transaction","detail":"{read_only:false; response_revision:4540; number_of_response:1; }","duration":"114.340152ms","start":"2026-03-18T00:56:06.344814Z","end":"2026-03-18T00:56:06.459154Z","steps":["trace[1296866275] 'process raft request'  (duration: 66.001087ms)","trace[1296866275] 'compare'  (duration: 48.07529ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T00:56:24.969792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.327792ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2594527476857665091 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:4832 > 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:56:24.969889Z","caller":"traceutil/trace.go:171","msg":"trace[816342406] transaction","detail":"{read_only:false; response_revision:4901; number_of_response:1; }","duration":"298.344635ms","start":"2026-03-18T00:56:24.671526Z","end":"2026-03-18T00:56:24.96987Z","steps":["trace[816342406] 'process raft request'  (duration: 173.8546ms)","trace[816342406] 'compare'  (duration: 124.127058ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T00:56:24.989851Z","caller":"traceutil/trace.go:171","msg":"trace[1200682166] linearizableReadLoop","detail":"{readStateIndex:5087; appliedIndex:5084; }","duration":"276.726955ms","start":"2026-03-18T00:56:24.713093Z","end":"2026-03-18T00:56:24.98982Z","steps":["trace[1200682166] 'read index received'  (duration: 132.341882ms)","trace[1200682166] 'applied index is now lower than readState.Index'  (duration: 144.383492ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T00:56:24.990146Z","caller":"traceutil/trace.go:171","msg":"trace[1415737469] transaction","detail":"{read_only:false; response_revision:4902; number_of_response:1; }","duration":"318.432767ms","start":"2026-03-18T00:56:24.671703Z","end":"2026-03-18T00:56:24.990136Z","steps":["trace[1415737469] 'process raft request'  (duration: 317.894306ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:56:24.990253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:56:24.671682Z","time spent":"318.489197ms","remote":"127.0.0.1:34124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:4831 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-03-18T00:56:24.990526Z","caller":"traceutil/trace.go:171","msg":"trace[1508045065] transaction","detail":"{read_only:false; response_revision:4903; number_of_response:1; }","duration":"315.510438ms","start":"2026-03-18T00:56:24.674999Z","end":"2026-03-18T00:56:24.990509Z","steps":["trace[1508045065] 'process raft request'  (duration: 314.722053ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:56:24.990554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.90997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"warn","ts":"2026-03-18T00:56:24.990524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.397838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1781"}
{"level":"warn","ts":"2026-03-18T00:56:24.990582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:56:24.67498Z","time spent":"315.57002ms","remote":"127.0.0.1:34048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3748,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5c831f48-36ec-4e39-a923-c3e83fe15ef1\" mod_revision:4882 > success:<request_put:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5c831f48-36ec-4e39-a923-c3e83fe15ef1\" value_size:3648 >> failure:<request_range:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5c831f48-36ec-4e39-a923-c3e83fe15ef1\" > >"}
{"level":"info","ts":"2026-03-18T00:56:24.990597Z","caller":"traceutil/trace.go:171","msg":"trace[799849192] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4903; }","duration":"223.999172ms","start":"2026-03-18T00:56:24.766588Z","end":"2026-03-18T00:56:24.990587Z","steps":["trace[799849192] 'agreement among raft nodes before linearized reading'  (duration: 223.828518ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:56:24.990624Z","caller":"traceutil/trace.go:171","msg":"trace[78942189] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:4903; }","duration":"277.549491ms","start":"2026-03-18T00:56:24.713055Z","end":"2026-03-18T00:56:24.990604Z","steps":["trace[78942189] 'agreement among raft nodes before linearized reading'  (duration: 277.179124ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:56:25.372681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.396783ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2594527476857665099 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" mod_revision:4649 > success:<request_put:<key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" value_size:467 >> failure:<request_range:<key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-18T00:56:25.372807Z","caller":"traceutil/trace.go:171","msg":"trace[1058519453] linearizableReadLoop","detail":"{readStateIndex:5090; appliedIndex:5088; }","duration":"164.438853ms","start":"2026-03-18T00:56:25.208359Z","end":"2026-03-18T00:56:25.372797Z","steps":["trace[1058519453] 'read index received'  (duration: 39.861466ms)","trace[1058519453] 'applied index is now lower than readState.Index'  (duration: 124.576637ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T00:56:25.372862Z","caller":"traceutil/trace.go:171","msg":"trace[1295242460] transaction","detail":"{read_only:false; response_revision:4905; number_of_response:1; }","duration":"374.985556ms","start":"2026-03-18T00:56:24.997871Z","end":"2026-03-18T00:56:25.372857Z","steps":["trace[1295242460] 'process raft request'  (duration: 250.348918ms)","trace[1295242460] 'compare'  (duration: 124.23692ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T00:56:25.372895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:56:24.997858Z","time spent":"375.019977ms","remote":"127.0.0.1:34124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" mod_revision:4649 > success:<request_put:<key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" value_size:467 >> failure:<request_range:<key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" > >"}
{"level":"warn","ts":"2026-03-18T00:56:25.373109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.77259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheusrules/\" range_end:\"/registry/monitoring.coreos.com/prometheusrules0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-18T00:56:25.373266Z","caller":"traceutil/trace.go:171","msg":"trace[2031296789] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheusrules/; range_end:/registry/monitoring.coreos.com/prometheusrules0; response_count:0; response_revision:4906; }","duration":"152.971334ms","start":"2026-03-18T00:56:25.220288Z","end":"2026-03-18T00:56:25.373259Z","steps":["trace[2031296789] 'agreement among raft nodes before linearized reading'  (duration: 152.75464ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:56:25.373129Z","caller":"traceutil/trace.go:171","msg":"trace[393021029] transaction","detail":"{read_only:false; response_revision:4906; number_of_response:1; }","duration":"371.731161ms","start":"2026-03-18T00:56:25.001361Z","end":"2026-03-18T00:56:25.373092Z","steps":["trace[393021029] 'process raft request'  (duration: 371.392184ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:56:25.373338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.403962ms","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:56:25.373425Z","caller":"traceutil/trace.go:171","msg":"trace[1828494573] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4906; }","duration":"146.544235ms","start":"2026-03-18T00:56:25.22686Z","end":"2026-03-18T00:56:25.373404Z","steps":["trace[1828494573] 'agreement among raft nodes before linearized reading'  (duration: 146.27272ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:56:25.373206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.968474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-03-18T00:56:25.373439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.020815ms","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-18T00:56:25.373503Z","caller":"traceutil/trace.go:171","msg":"trace[499111908] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4906; }","duration":"146.096187ms","start":"2026-03-18T00:56:25.227391Z","end":"2026-03-18T00:56:25.373487Z","steps":["trace[499111908] 'agreement among raft nodes before linearized reading'  (duration: 145.819041ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:56:25.373477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:56:25.001352Z","time spent":"372.019856ms","remote":"127.0.0.1:34048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6117,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/monitoring/loki-0\" mod_revision:4605 > success:<request_put:<key:\"/registry/pods/monitoring/loki-0\" value_size:6077 >> failure:<request_range:<key:\"/registry/pods/monitoring/loki-0\" > >"}
{"level":"info","ts":"2026-03-18T00:56:25.373466Z","caller":"traceutil/trace.go:171","msg":"trace[1150850867] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4906; }","duration":"148.25934ms","start":"2026-03-18T00:56:25.2252Z","end":"2026-03-18T00:56:25.373459Z","steps":["trace[1150850867] 'agreement among raft nodes before linearized reading'  (duration: 147.946144ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:56:25.374629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.235909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.149\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-03-18T00:56:25.3747Z","caller":"traceutil/trace.go:171","msg":"trace[1930987207] range","detail":"{range_begin:/registry/masterleases/199.204.45.149; range_end:; response_count:1; response_revision:4906; }","duration":"166.379022ms","start":"2026-03-18T00:56:25.208303Z","end":"2026-03-18T00:56:25.374682Z","steps":["trace[1930987207] 'agreement among raft nodes before linearized reading'  (duration: 164.723079ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:56:35.134605Z","caller":"traceutil/trace.go:171","msg":"trace[1238579935] transaction","detail":"{read_only:false; response_revision:5046; number_of_response:1; }","duration":"104.225197ms","start":"2026-03-18T00:56:35.030354Z","end":"2026-03-18T00:56:35.134579Z","steps":["trace[1238579935] 'process raft request'  (duration: 11.464991ms)","trace[1238579935] 'compare'  (duration: 92.619883ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T00:58:12.309782Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2767}
{"level":"info","ts":"2026-03-18T00:58:12.368971Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2767,"took":"57.028844ms","hash":4078512132,"current-db-size-bytes":41590784,"current-db-size":"42 MB","current-db-size-in-use-bytes":31653888,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-03-18T00:58:12.369076Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4078512132,"revision":2767,"compact-revision":-1}
{"level":"info","ts":"2026-03-18T01:02:53.008664Z","caller":"traceutil/trace.go:171","msg":"trace[596289218] transaction","detail":"{read_only:false; response_revision:7650; number_of_response:1; }","duration":"100.559932ms","start":"2026-03-18T01:02:52.908067Z","end":"2026-03-18T01:02:53.008627Z","steps":["trace[596289218] 'process raft request'  (duration: 99.537101ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T01:03:12.318378Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5782}
{"level":"info","ts":"2026-03-18T01:03:12.474211Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5782,"took":"153.53244ms","hash":1330424606,"current-db-size-bytes":43020288,"current-db-size":"43 MB","current-db-size-in-use-bytes":23257088,"current-db-size-in-use":"23 MB"}
{"level":"info","ts":"2026-03-18T01:03:12.47429Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1330424606,"revision":5782,"compact-revision":2767}
{"level":"info","ts":"2026-03-18T01:03:19.356556Z","caller":"traceutil/trace.go:171","msg":"trace[1330101563] linearizableReadLoop","detail":"{readStateIndex:8120; appliedIndex:8119; }","duration":"150.109013ms","start":"2026-03-18T01:03:19.206426Z","end":"2026-03-18T01:03:19.356535Z","steps":["trace[1330101563] 'read index received'  (duration: 128.437634ms)","trace[1330101563] 'applied index is now lower than readState.Index'  (duration: 21.670459ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T01:03:19.356801Z","caller":"traceutil/trace.go:171","msg":"trace[1054969047] transaction","detail":"{read_only:false; response_revision:7833; number_of_response:1; }","duration":"150.528891ms","start":"2026-03-18T01:03:19.206259Z","end":"2026-03-18T01:03:19.356788Z","steps":["trace[1054969047] 'process raft request'  (duration: 128.656068ms)","trace[1054969047] 'compare'  (duration: 21.533087ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T01:03:19.357788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.342238ms","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:03:19.357848Z","caller":"traceutil/trace.go:171","msg":"trace[733555406] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7833; }","duration":"151.434419ms","start":"2026-03-18T01:03:19.206398Z","end":"2026-03-18T01:03:19.357832Z","steps":["trace[733555406] 'agreement among raft nodes before linearized reading'  (duration: 150.569172ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T01:03:27.542864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.429279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-03-18T01:03:27.542955Z","caller":"traceutil/trace.go:171","msg":"trace[957126459] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7874; }","duration":"152.566562ms","start":"2026-03-18T01:03:27.39037Z","end":"2026-03-18T01:03:27.542937Z","steps":["trace[957126459] 'range keys from in-memory index tree'  (duration: 152.208905ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T01:03:27.543194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.266901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-03-18T01:03:27.543257Z","caller":"traceutil/trace.go:171","msg":"trace[40882103] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7874; }","duration":"130.371663ms","start":"2026-03-18T01:03:27.41287Z","end":"2026-03-18T01:03:27.543242Z","steps":["trace[40882103] 'range keys from in-memory index tree'  (duration: 130.138638ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T01:03:28.399179Z","caller":"traceutil/trace.go:171","msg":"trace[700546785] transaction","detail":"{read_only:false; response_revision:7881; number_of_response:1; }","duration":"113.533879ms","start":"2026-03-18T01:03:28.285615Z","end":"2026-03-18T01:03:28.399149Z","steps":["trace[700546785] 'process raft request'  (duration: 109.742224ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T01:03:31.731051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.11388ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2594527476857673508 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/cilium.io/ciliumendpoints/openstack/rook-ceph-detect-version-4ksww\" mod_revision:7815 > success:<request_delete_range:<key:\"/registry/cilium.io/ciliumendpoints/openstack/rook-ceph-detect-version-4ksww\" > > failure:<request_range:<key:\"/registry/cilium.io/ciliumendpoints/openstack/rook-ceph-detect-version-4ksww\" > >>","response":"size:18"}
{"level":"info","ts":"2026-03-18T01:03:31.731154Z","caller":"traceutil/trace.go:171","msg":"trace[122360879] linearizableReadLoop","detail":"{readStateIndex:8197; appliedIndex:8196; }","duration":"135.684669ms","start":"2026-03-18T01:03:31.59546Z","end":"2026-03-18T01:03:31.731144Z","steps":["trace[122360879] 'read index received'  (duration: 45.421µs)","trace[122360879] 'applied index is now lower than readState.Index'  (duration: 135.638538ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T01:03:31.731184Z","caller":"traceutil/trace.go:171","msg":"trace[5695363] transaction","detail":"{read_only:false; number_of_response:1; response_revision:7905; }","duration":"357.757097ms","start":"2026-03-18T01:03:31.373392Z","end":"2026-03-18T01:03:31.731149Z","steps":["trace[5695363] 'process raft request'  (duration: 138.452872ms)","trace[5695363] 'compare'  (duration: 219.045809ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T01:03:31.731285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.498855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-03-18T01:03:31.731304Z","caller":"traceutil/trace.go:171","msg":"trace[990973357] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:7905; }","duration":"128.558757ms","start":"2026-03-18T01:03:31.602738Z","end":"2026-03-18T01:03:31.731297Z","steps":["trace[990973357] 'agreement among raft nodes before linearized reading'  (duration: 128.466075ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T01:03:31.731361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T01:03:31.373376Z","time spent":"357.89337ms","remote":"127.0.0.1:55288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":80,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/cilium.io/ciliumendpoints/openstack/rook-ceph-detect-version-4ksww\" mod_revision:7815 > success:<request_delete_range:<key:\"/registry/cilium.io/ciliumendpoints/openstack/rook-ceph-detect-version-4ksww\" > > failure:<request_range:<key:\"/registry/cilium.io/ciliumendpoints/openstack/rook-ceph-detect-version-4ksww\" > >"}
{"level":"warn","ts":"2026-03-18T01:03:31.731339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.862132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"}
{"level":"warn","ts":"2026-03-18T01:03:31.731525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.096949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-kknzf\" ","response":"range_response_count:1 size:6531"}
{"level":"info","ts":"2026-03-18T01:03:31.731549Z","caller":"traceutil/trace.go:171","msg":"trace[1947515152] range","detail":"{range_begin:/registry/pods/openstack/keepalived-kknzf; range_end:; response_count:1; response_revision:7905; }","duration":"120.14026ms","start":"2026-03-18T01:03:31.611402Z","end":"2026-03-18T01:03:31.731543Z","steps":["trace[1947515152] 'agreement among raft nodes before linearized reading'  (duration: 120.087159ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T01:03:31.731708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.384994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"warn","ts":"2026-03-18T01:03:31.731728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.688069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-03-18T01:03:31.731775Z","caller":"traceutil/trace.go:171","msg":"trace[482241789] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7905; }","duration":"123.771832ms","start":"2026-03-18T01:03:31.607992Z","end":"2026-03-18T01:03:31.731764Z","steps":["trace[482241789] 'agreement among raft nodes before linearized reading'  (duration: 123.633719ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T01:03:31.731779Z","caller":"traceutil/trace.go:171","msg":"trace[1541584890] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7905; }","duration":"123.567448ms","start":"2026-03-18T01:03:31.608195Z","end":"2026-03-18T01:03:31.731763Z","steps":["trace[1541584890] 'agreement among raft nodes before linearized reading'  (duration: 123.376924ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T01:03:31.731441Z","caller":"traceutil/trace.go:171","msg":"trace[277340016] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:7905; }","duration":"136.004315ms","start":"2026-03-18T01:03:31.595417Z","end":"2026-03-18T01:03:31.731422Z","steps":["trace[277340016] 'agreement among raft nodes before linearized reading'  (duration: 135.77386ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T01:03:31.732214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.2031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-03-18T01:03:31.732296Z","caller":"traceutil/trace.go:171","msg":"trace[1796309943] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:7905; }","duration":"125.338743ms","start":"2026-03-18T01:03:31.606937Z","end":"2026-03-18T01:03:31.732276Z","steps":["trace[1796309943] 'agreement among raft nodes before linearized reading'  (duration: 124.584138ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T01:03:31.864912Z","caller":"traceutil/trace.go:171","msg":"trace[1951311586] transaction","detail":"{read_only:false; response_revision:7907; number_of_response:1; }","duration":"126.998915ms","start":"2026-03-18T01:03:31.737885Z","end":"2026-03-18T01:03:31.864884Z","steps":["trace[1951311586] 'process raft request'  (duration: 126.911343ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T01:03:31.865221Z","caller":"traceutil/trace.go:171","msg":"trace[1426734961] transaction","detail":"{read_only:false; response_revision:7908; number_of_response:1; }","duration":"127.198909ms","start":"2026-03-18T01:03:31.738003Z","end":"2026-03-18T01:03:31.865202Z","steps":["trace[1426734961] 'process raft request'  (duration: 126.844382ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T01:03:31.865418Z","caller":"traceutil/trace.go:171","msg":"trace[866974419] linearizableReadLoop","detail":"{readStateIndex:8202; appliedIndex:8197; }","duration":"126.455495ms","start":"2026-03-18T01:03:31.738947Z","end":"2026-03-18T01:03:31.865403Z","steps":["trace[866974419] 'read index received'  (duration: 110.446559ms)","trace[866974419] 'applied index is now lower than readState.Index'  (duration: 16.007786ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T01:03:31.86543Z","caller":"traceutil/trace.go:171","msg":"trace[89236815] transaction","detail":"{read_only:false; response_revision:7909; number_of_response:1; }","duration":"127.337812ms","start":"2026-03-18T01:03:31.738073Z","end":"2026-03-18T01:03:31.865411Z","steps":["trace[89236815] 'process raft request'  (duration: 127.055507ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T01:03:31.865845Z","caller":"traceutil/trace.go:171","msg":"trace[590332000] transaction","detail":"{read_only:false; response_revision:7910; number_of_response:1; }","duration":"127.74134ms","start":"2026-03-18T01:03:31.738087Z","end":"2026-03-18T01:03:31.865828Z","steps":["trace[590332000] 'process raft request'  (duration: 127.178268ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T01:03:31.865877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.901655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-4ksww\" ","response":"range_response_count:1 size:4653"}
{"level":"info","ts":"2026-03-18T01:03:31.865931Z","caller":"traceutil/trace.go:171","msg":"trace[1329905176] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-4ksww; range_end:; response_count:1; response_revision:7910; }","duration":"126.991456ms","start":"2026-03-18T01:03:31.738925Z","end":"2026-03-18T01:03:31.865916Z","steps":["trace[1329905176] 'agreement among raft nodes before linearized reading'  (duration: 126.633829ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T01:03:31.866229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.785321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:26 size:228534"}
{"level":"info","ts":"2026-03-18T01:03:31.86634Z","caller":"traceutil/trace.go:171","msg":"trace[590277519] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:26; response_revision:7910; }","duration":"126.918964ms","start":"2026-03-18T01:03:31.739408Z","end":"2026-03-18T01:03:31.866327Z","steps":["trace[590277519] 'agreement among raft nodes before linearized reading'  (duration: 126.380174ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T01:03:31.86666Z","caller":"traceutil/trace.go:171","msg":"trace[302799447] transaction","detail":"{read_only:false; response_revision:7906; number_of_response:1; }","duration":"127.643248ms","start":"2026-03-18T01:03:31.73722Z","end":"2026-03-18T01:03:31.864863Z","steps":["trace[302799447] 'process raft request'  (duration: 112.07476ms)","trace[302799447] 'compare'  (duration: 15.352133ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T01:07:11.044158Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"b1b675f124322401","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-03-18T01:07:11.052067Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-03-18T01:07:11.052255Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-03-18T01:08:12.324784Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7752}
{"level":"info","ts":"2026-03-18T01:08:12.39352Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7752,"took":"66.437257ms","hash":4071100680,"current-db-size-bytes":43020288,"current-db-size":"43 MB","current-db-size-in-use-bytes":26230784,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-03-18T01:08:12.393576Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4071100680,"revision":7752,"compact-revision":5782}
{"level":"info","ts":"2026-03-18T01:13:12.330474Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10001}
{"level":"info","ts":"2026-03-18T01:13:12.404567Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10001,"took":"72.154969ms","hash":3573422392,"current-db-size-bytes":43020288,"current-db-size":"43 MB","current-db-size-in-use-bytes":17387520,"current-db-size-in-use":"17 MB"}
{"level":"info","ts":"2026-03-18T01:13:12.404618Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3573422392,"revision":10001,"compact-revision":7752}