{"level":"warn","ts":"2026-05-20T00:17:37.792303Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-20T00:17:37.792394Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.244: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.244:2380","--initial-cluster=instance=https://199.204.45.244:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.244:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.244: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-05-20T00:17:37.792463Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-20T00:17:37.792471Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.244:2380"]}
{"level":"info","ts":"2026-05-20T00:17:37.792504Z","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-05-20T00:17:37.793088Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.244:2379"]}
{"level":"info","ts":"2026-05-20T00:17:37.793166Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.244:2380"],"listen-peer-urls":["https://199.204.45.244:2380"],"advertise-client-urls":["https://199.204.45.244:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.244:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.244: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-05-20T00:17:37.797636Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.25568ms"}
{"level":"info","ts":"2026-05-20T00:17:37.803143Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1686e9b1ea717edf","cluster-id":"71c60fe001ca5b3c"}
{"level":"info","ts":"2026-05-20T00:17:37.803244Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf switched to configuration voters=()"}
{"level":"info","ts":"2026-05-20T00:17:37.803281Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became follower at term 0"}
{"level":"info","ts":"2026-05-20T00:17:37.803306Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1686e9b1ea717edf [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-05-20T00:17:37.80332Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became follower at term 1"}
{"level":"info","ts":"2026-05-20T00:17:37.803379Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf switched to configuration voters=(1623241666065432287)"}
{"level":"warn","ts":"2026-05-20T00:17:37.812615Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-05-20T00:17:37.814103Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-05-20T00:17:37.815184Z","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-05-20T00:17:37.817703Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1686e9b1ea717edf","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-05-20T00:17:37.824482Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1686e9b1ea717edf","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-05-20T00:17:37.824846Z","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-05-20T00:17:37.824915Z","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-05-20T00:17:37.825015Z","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-05-20T00:17:37.825172Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf switched to configuration voters=(1623241666065432287)"}
{"level":"info","ts":"2026-05-20T00:17:37.82546Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.244:2380"}
{"level":"info","ts":"2026-05-20T00:17:37.825554Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"71c60fe001ca5b3c","local-member-id":"1686e9b1ea717edf","added-peer-id":"1686e9b1ea717edf","added-peer-peer-urls":["https://199.204.45.244:2380"]}
{"level":"info","ts":"2026-05-20T00:17:37.825554Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.244:2380"}
{"level":"info","ts":"2026-05-20T00:17:37.825801Z","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-05-20T00:17:37.826197Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1686e9b1ea717edf","initial-advertise-peer-urls":["https://199.204.45.244:2380"],"listen-peer-urls":["https://199.204.45.244:2380"],"advertise-client-urls":["https://199.204.45.244:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.244:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-05-20T00:17:37.826254Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-05-20T00:17:38.70462Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf is starting a new election at term 1"}
{"level":"info","ts":"2026-05-20T00:17:38.704806Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became pre-candidate at term 1"}
{"level":"info","ts":"2026-05-20T00:17:38.704891Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf received MsgPreVoteResp from 1686e9b1ea717edf at term 1"}
{"level":"info","ts":"2026-05-20T00:17:38.704921Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became candidate at term 2"}
{"level":"info","ts":"2026-05-20T00:17:38.704934Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf received MsgVoteResp from 1686e9b1ea717edf at term 2"}
{"level":"info","ts":"2026-05-20T00:17:38.704955Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became leader at term 2"}
{"level":"info","ts":"2026-05-20T00:17:38.705266Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1686e9b1ea717edf elected leader 1686e9b1ea717edf at term 2"}
{"level":"info","ts":"2026-05-20T00:17:38.819894Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-20T00:17:38.860687Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-20T00:17:38.860693Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1686e9b1ea717edf","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.244:2379]}","request-path":"/0/members/1686e9b1ea717edf/attributes","cluster-id":"71c60fe001ca5b3c","publish-timeout":"7s"}
{"level":"info","ts":"2026-05-20T00:17:38.860744Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-20T00:17:38.861145Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-05-20T00:17:38.861226Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-05-20T00:17:38.864086Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.244:2379"}
{"level":"info","ts":"2026-05-20T00:17:38.864393Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-05-20T00:17:38.99354Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"71c60fe001ca5b3c","local-member-id":"1686e9b1ea717edf","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-20T00:17:38.993753Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-20T00:17:38.993859Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-20T00:17:40.408455Z","caller":"traceutil/trace.go:171","msg":"trace[534565360] transaction","detail":"{read_only:false; number_of_response:0; response_revision:10; }","duration":"123.322108ms","start":"2026-05-20T00:17:40.285102Z","end":"2026-05-20T00:17:40.408424Z","steps":["trace[534565360] 'process raft request'  (duration: 100.780853ms)"],"step_count":1}
{"level":"info","ts":"2026-05-20T00:17:40.408589Z","caller":"traceutil/trace.go:171","msg":"trace[1793458991] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"122.332588ms","start":"2026-05-20T00:17:40.286217Z","end":"2026-05-20T00:17:40.40855Z","steps":["trace[1793458991] 'process raft request'  (duration: 122.025084ms)"],"step_count":1}
{"level":"info","ts":"2026-05-20T00:17:40.408603Z","caller":"traceutil/trace.go:171","msg":"trace[836443283] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"113.312106ms","start":"2026-05-20T00:17:40.295248Z","end":"2026-05-20T00:17:40.40856Z","steps":["trace[836443283] 'process raft request'  (duration: 113.138044ms)"],"step_count":1}
{"level":"info","ts":"2026-05-20T00:17:40.408515Z","caller":"traceutil/trace.go:171","msg":"trace[1243617148] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"113.609649ms","start":"2026-05-20T00:17:40.294869Z","end":"2026-05-20T00:17:40.408479Z","steps":["trace[1243617148] 'process raft request'  (duration: 113.469527ms)"],"step_count":1}
{"level":"info","ts":"2026-05-20T00:18:15.061645Z","caller":"traceutil/trace.go:171","msg":"trace[734783367] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"207.254737ms","start":"2026-05-20T00:18:14.85432Z","end":"2026-05-20T00:18:15.061574Z","steps":["trace[734783367] 'process raft request'  (duration: 207.065345ms)"],"step_count":1}
{"level":"info","ts":"2026-05-20T00:18:15.254174Z","caller":"traceutil/trace.go:171","msg":"trace[138218397] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"240.982933ms","start":"2026-05-20T00:18:15.013167Z","end":"2026-05-20T00:18:15.25415Z","steps":["trace[138218397] 'process raft request'  (duration: 239.546461ms)"],"step_count":1}
{"level":"info","ts":"2026-05-20T00:18:15.256433Z","caller":"traceutil/trace.go:171","msg":"trace[407305581] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"190.439702ms","start":"2026-05-20T00:18:15.065965Z","end":"2026-05-20T00:18:15.256405Z","steps":["trace[407305581] 'process raft request'  (duration: 188.132753ms)"],"step_count":1}
{"level":"info","ts":"2026-05-20T00:18:15.685208Z","caller":"traceutil/trace.go:171","msg":"trace[742035790] linearizableReadLoop","detail":"{readStateIndex:598; appliedIndex:597; }","duration":"189.188223ms","start":"2026-05-20T00:18:15.495992Z","end":"2026-05-20T00:18:15.685181Z","steps":["trace[742035790] 'read index received'  (duration: 177.675859ms)","trace[742035790] 'applied index is now lower than readState.Index'  (duration: 11.510894ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-20T00:18:15.685597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.576506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-spk2l\" ","response":"range_response_count:1 size:16965"}
{"level":"info","ts":"2026-05-20T00:18:15.685675Z","caller":"traceutil/trace.go:171","msg":"trace[845987261] range","detail":"{range_begin:/registry/pods/kube-system/cilium-spk2l; range_end:; response_count:1; response_revision:577; }","duration":"189.729267ms","start":"2026-05-20T00:18:15.495934Z","end":"2026-05-20T00:18:15.685663Z","steps":["trace[845987261] 'agreement among raft nodes before linearized reading'  (duration: 189.482595ms)"],"step_count":1}
{"level":"info","ts":"2026-05-20T00:18:15.685371Z","caller":"traceutil/trace.go:171","msg":"trace[596845482] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"366.292946ms","start":"2026-05-20T00:18:15.31906Z","end":"2026-05-20T00:18:15.685353Z","steps":["trace[596845482] 'process raft request'  (duration: 354.669712ms)","trace[596845482] 'compare'  (duration: 11.200971ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-20T00:18:15.686746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T00:18:15.319037Z","time spent":"367.174103ms","remote":"127.0.0.1:43578","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" mod_revision:0 > success:<request_put:<key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" value_size:1527 >> failure:<>"}
{"level":"info","ts":"2026-05-20T00:18:15.823512Z","caller":"traceutil/trace.go:171","msg":"trace[880492550] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"123.336355ms","start":"2026-05-20T00:18:15.700153Z","end":"2026-05-20T00:18:15.82349Z","steps":["trace[880492550] 'process raft request'  (duration: 118.452305ms)"],"step_count":1}
{"level":"info","ts":"2026-05-20T00:19:56.667322Z","caller":"traceutil/trace.go:171","msg":"trace[1949222577] linearizableReadLoop","detail":"{readStateIndex:1881; appliedIndex:1880; }","duration":"308.904224ms","start":"2026-05-20T00:19:56.358402Z","end":"2026-05-20T00:19:56.667307Z","steps":["trace[1949222577] 'read index received'  (duration: 308.857492ms)","trace[1949222577] 'applied index is now lower than readState.Index'  (duration: 45.901µs)"],"step_count":2}
{"level":"info","ts":"2026-05-20T00:19:56.667422Z","caller":"traceutil/trace.go:171","msg":"trace[1353550250] transaction","detail":"{read_only:false; response_revision:1827; number_of_response:1; }","duration":"330.173643ms","start":"2026-05-20T00:19:56.337233Z","end":"2026-05-20T00:19:56.667407Z","steps":["trace[1353550250] 'process raft request'  (duration: 329.944197ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-20T00:19:56.667681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T00:19:56.337216Z","time spent":"330.230284ms","remote":"127.0.0.1:43302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:1753 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-05-20T00:19:56.667677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.236991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:644"}
{"level":"info","ts":"2026-05-20T00:19:56.667797Z","caller":"traceutil/trace.go:171","msg":"trace[1308457161] range","detail":"{range_begin:/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1827; }","duration":"309.390535ms","start":"2026-05-20T00:19:56.358366Z","end":"2026-05-20T00:19:56.667757Z","steps":["trace[1308457161] 'agreement among raft nodes before linearized reading'  (duration: 309.048857ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-20T00:19:56.66797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T00:19:56.358348Z","time spent":"309.602161ms","remote":"127.0.0.1:43148","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":666,"request content":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"warn","ts":"2026-05-20T00:19:56.702084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.097367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:4591"}
{"level":"info","ts":"2026-05-20T00:19:56.70212Z","caller":"traceutil/trace.go:171","msg":"trace[670247249] transaction","detail":"{read_only:false; response_revision:1828; number_of_response:1; }","duration":"114.756047ms","start":"2026-05-20T00:19:56.587343Z","end":"2026-05-20T00:19:56.702099Z","steps":["trace[670247249] 'process raft request'  (duration: 104.673036ms)"],"step_count":1}
{"level":"info","ts":"2026-05-20T00:19:56.702164Z","caller":"traceutil/trace.go:171","msg":"trace[1313170368] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1828; }","duration":"202.21308ms","start":"2026-05-20T00:19:56.499932Z","end":"2026-05-20T00:19:56.702145Z","steps":["trace[1313170368] 'agreement among raft nodes before linearized reading'  (duration: 201.983664ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-20T00:19:56.702119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.006818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-20T00:19:56.702851Z","caller":"traceutil/trace.go:171","msg":"trace[957611127] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1828; }","duration":"208.812227ms","start":"2026-05-20T00:19:56.494013Z","end":"2026-05-20T00:19:56.702825Z","steps":["trace[957611127] 'agreement among raft nodes before linearized reading'  (duration: 207.957317ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-20T00:20:02.989976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.94553ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9142199778090686975 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:1873 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-20T00:20:02.990502Z","caller":"traceutil/trace.go:171","msg":"trace[231181365] linearizableReadLoop","detail":"{readStateIndex:1959; appliedIndex:1958; }","duration":"261.859045ms","start":"2026-05-20T00:20:02.728616Z","end":"2026-05-20T00:20:02.990475Z","steps":["trace[231181365] 'read index received'  (duration: 26.056867ms)","trace[231181365] 'applied index is now lower than readState.Index'  (duration: 235.799408ms)"],"step_count":2}
{"level":"info","ts":"2026-05-20T00:20:02.990756Z","caller":"traceutil/trace.go:171","msg":"trace[846517817] transaction","detail":"{read_only:false; response_revision:1902; number_of_response:1; }","duration":"269.345875ms","start":"2026-05-20T00:20:02.721386Z","end":"2026-05-20T00:20:02.990732Z","steps":["trace[846517817] 'process raft request'  (duration: 33.363822ms)","trace[846517817] 'compare'  (duration: 234.844188ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-20T00:20:02.990844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.217413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"}
{"level":"info","ts":"2026-05-20T00:20:02.991269Z","caller":"traceutil/trace.go:171","msg":"trace[946913119] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:1903; }","duration":"262.668453ms","start":"2026-05-20T00:20:02.728579Z","end":"2026-05-20T00:20:02.991247Z","steps":["trace[946913119] 'agreement among raft nodes before linearized reading'  (duration: 262.213363ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-20T00:20:02.991732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.745352ms","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-05-20T00:20:02.991803Z","caller":"traceutil/trace.go:171","msg":"trace[1644764013] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1903; }","duration":"184.854855ms","start":"2026-05-20T00:20:02.806927Z","end":"2026-05-20T00:20:02.991782Z","steps":["trace[1644764013] 'agreement among raft nodes before linearized reading'  (duration: 184.64267ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-20T00:20:02.991808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.826749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-20T00:20:02.991859Z","caller":"traceutil/trace.go:171","msg":"trace[1887149650] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1903; }","duration":"249.907111ms","start":"2026-05-20T00:20:02.741938Z","end":"2026-05-20T00:20:02.991845Z","steps":["trace[1887149650] 'agreement among raft nodes before linearized reading'  (duration: 249.792659ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-20T00:20:02.991985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.226681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:4591"}
{"level":"warn","ts":"2026-05-20T00:20:02.992099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.45114ms","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-05-20T00:20:02.992157Z","caller":"traceutil/trace.go:171","msg":"trace[699123815] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1903; }","duration":"252.557793ms","start":"2026-05-20T00:20:02.739587Z","end":"2026-05-20T00:20:02.992145Z","steps":["trace[699123815] 'agreement among raft nodes before linearized reading'  (duration: 251.444037ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-20T00:20:02.992143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.937149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:644"}
{"level":"info","ts":"2026-05-20T00:20:02.9921Z","caller":"traceutil/trace.go:171","msg":"trace[1671954056] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1903; }","duration":"244.465657ms","start":"2026-05-20T00:20:02.747594Z","end":"2026-05-20T00:20:02.99206Z","steps":["trace[1671954056] 'agreement among raft nodes before linearized reading'  (duration: 244.077257ms)"],"step_count":1}
{"level":"info","ts":"2026-05-20T00:20:02.992254Z","caller":"traceutil/trace.go:171","msg":"trace[822307263] range","detail":"{range_begin:/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1903; }","duration":"154.060691ms","start":"2026-05-20T00:20:02.838154Z","end":"2026-05-20T00:20:02.992214Z","steps":["trace[822307263] 'agreement among raft nodes before linearized reading'  (duration: 153.897518ms)"],"step_count":1}
{"level":"info","ts":"2026-05-20T00:20:05.767247Z","caller":"traceutil/trace.go:171","msg":"trace[2011458977] linearizableReadLoop","detail":"{readStateIndex:1986; appliedIndex:1985; }","duration":"116.404261ms","start":"2026-05-20T00:20:05.650812Z","end":"2026-05-20T00:20:05.767216Z","steps":["trace[2011458977] 'read index received'  (duration: 116.095694ms)","trace[2011458977] 'applied index is now lower than readState.Index'  (duration: 286.896µs)"],"step_count":2}
{"level":"info","ts":"2026-05-20T00:20:05.767304Z","caller":"traceutil/trace.go:171","msg":"trace[207436043] transaction","detail":"{read_only:false; response_revision:1928; number_of_response:1; }","duration":"118.723133ms","start":"2026-05-20T00:20:05.648545Z","end":"2026-05-20T00:20:05.767268Z","steps":["trace[207436043] 'process raft request'  (duration: 118.445467ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-20T00:20:05.767539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.706817ms","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-05-20T00:20:05.767606Z","caller":"traceutil/trace.go:171","msg":"trace[2114547301] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1928; }","duration":"116.82231ms","start":"2026-05-20T00:20:05.650765Z","end":"2026-05-20T00:20:05.767587Z","steps":["trace[2114547301] 'agreement among raft nodes before linearized reading'  (duration: 116.603895ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-20T00:20:39.938325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.574215ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9142199778090687655 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:2158 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:461 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-20T00:20:39.938536Z","caller":"traceutil/trace.go:171","msg":"trace[659867361] transaction","detail":"{read_only:false; response_revision:2170; number_of_response:1; }","duration":"259.98276ms","start":"2026-05-20T00:20:39.678522Z","end":"2026-05-20T00:20:39.938505Z","steps":["trace[659867361] 'process raft request'  (duration: 129.14403ms)","trace[659867361] 'compare'  (duration: 130.383502ms)"],"step_count":2}
{"level":"info","ts":"2026-05-20T00:20:40.06539Z","caller":"traceutil/trace.go:171","msg":"trace[1902316632] transaction","detail":"{read_only:false; response_revision:2171; number_of_response:1; }","duration":"123.386621ms","start":"2026-05-20T00:20:39.941977Z","end":"2026-05-20T00:20:40.065363Z","steps":["trace[1902316632] 'process raft request'  (duration: 123.205577ms)"],"step_count":1}
{"level":"info","ts":"2026-05-20T00:20:40.067493Z","caller":"traceutil/trace.go:171","msg":"trace[1242361556] transaction","detail":"{read_only:false; response_revision:2172; number_of_response:1; }","duration":"125.384835ms","start":"2026-05-20T00:20:39.942054Z","end":"2026-05-20T00:20:40.067439Z","steps":["trace[1242361556] 'process raft request'  (duration: 125.173092ms)"],"step_count":1}
{"level":"info","ts":"2026-05-20T00:21:22.06464Z","caller":"traceutil/trace.go:171","msg":"trace[1151413822] transaction","detail":"{read_only:false; number_of_response:0; response_revision:2560; }","duration":"210.446534ms","start":"2026-05-20T00:21:21.854167Z","end":"2026-05-20T00:21:22.064613Z","steps":["trace[1151413822] 'process raft request'  (duration: 209.895205ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-20T00:21:49.825874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.122405ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9142199778090689160 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:2739 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-20T00:21:49.826027Z","caller":"traceutil/trace.go:171","msg":"trace[261604998] linearizableReadLoop","detail":"{readStateIndex:2856; appliedIndex:2855; }","duration":"221.861439ms","start":"2026-05-20T00:21:49.604144Z","end":"2026-05-20T00:21:49.826006Z","steps":["trace[261604998] 'read index received'  (duration: 102.42252ms)","trace[261604998] 'applied index is now lower than readState.Index'  (duration: 119.437519ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-20T00:21:49.826238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.096422ms","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-05-20T00:21:49.826281Z","caller":"traceutil/trace.go:171","msg":"trace[2113963820] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2753; }","duration":"222.158944ms","start":"2026-05-20T00:21:49.60411Z","end":"2026-05-20T00:21:49.826269Z","steps":["trace[2113963820] 'agreement among raft nodes before linearized reading'  (duration: 221.987752ms)"],"step_count":1}
{"level":"info","ts":"2026-05-20T00:21:49.826042Z","caller":"traceutil/trace.go:171","msg":"trace[749652896] transaction","detail":"{read_only:false; response_revision:2753; number_of_response:1; }","duration":"241.859618ms","start":"2026-05-20T00:21:49.584149Z","end":"2026-05-20T00:21:49.826009Z","steps":["trace[749652896] 'process raft request'  (duration: 122.48626ms)","trace[749652896] 'compare'  (duration: 118.75313ms)"],"step_count":2}
{"level":"info","ts":"2026-05-20T00:21:49.986136Z","caller":"traceutil/trace.go:171","msg":"trace[328515013] transaction","detail":"{read_only:false; response_revision:2754; number_of_response:1; }","duration":"230.537691ms","start":"2026-05-20T00:21:49.755559Z","end":"2026-05-20T00:21:49.986096Z","steps":["trace[328515013] 'process raft request'  (duration: 230.299098ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-20T00:21:49.986394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.014471ms","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-05-20T00:21:49.986526Z","caller":"traceutil/trace.go:171","msg":"trace[1727104717] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2754; }","duration":"285.153734ms","start":"2026-05-20T00:21:49.701317Z","end":"2026-05-20T00:21:49.986471Z","steps":["trace[1727104717] 'agreement among raft nodes before linearized reading'  (duration: 284.8818ms)"],"step_count":1}
{"level":"info","ts":"2026-05-20T00:21:49.986685Z","caller":"traceutil/trace.go:171","msg":"trace[1046487729] linearizableReadLoop","detail":"{readStateIndex:2857; appliedIndex:2856; }","duration":"159.986165ms","start":"2026-05-20T00:21:49.826059Z","end":"2026-05-20T00:21:49.986045Z","steps":["trace[1046487729] 'read index received'  (duration: 159.764172ms)","trace[1046487729] 'applied index is now lower than readState.Index'  (duration: 220.733µs)"],"step_count":2}
{"level":"info","ts":"2026-05-20T00:21:49.991785Z","caller":"traceutil/trace.go:171","msg":"trace[809185979] transaction","detail":"{read_only:false; response_revision:2755; number_of_response:1; }","duration":"159.371437ms","start":"2026-05-20T00:21:49.832392Z","end":"2026-05-20T00:21:49.991763Z","steps":["trace[809185979] 'process raft request'  (duration: 158.213861ms)"],"step_count":1}
{"level":"info","ts":"2026-05-20T00:24:09.359393Z","caller":"traceutil/trace.go:171","msg":"trace[329190066] transaction","detail":"{read_only:false; response_revision:4277; number_of_response:1; }","duration":"130.362397ms","start":"2026-05-20T00:24:09.228993Z","end":"2026-05-20T00:24:09.359355Z","steps":["trace[329190066] 'process raft request'  (duration: 130.073688ms)"],"step_count":1}
{"level":"info","ts":"2026-05-20T00:24:09.35965Z","caller":"traceutil/trace.go:171","msg":"trace[2066209095] transaction","detail":"{read_only:false; response_revision:4278; number_of_response:1; }","duration":"130.175711ms","start":"2026-05-20T00:24:09.229459Z","end":"2026-05-20T00:24:09.359635Z","steps":["trace[2066209095] 'process raft request'  (duration: 129.756718ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-20T00:24:09.360046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.670956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1285"}
{"level":"info","ts":"2026-05-20T00:24:09.360108Z","caller":"traceutil/trace.go:171","msg":"trace[1359897678] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:4278; }","duration":"130.77586ms","start":"2026-05-20T00:24:09.229323Z","end":"2026-05-20T00:24:09.360098Z","steps":["trace[1359897678] 'agreement among raft nodes before linearized reading'  (duration: 130.531542ms)"],"step_count":1}
{"level":"info","ts":"2026-05-20T00:24:09.359478Z","caller":"traceutil/trace.go:171","msg":"trace[1451269803] linearizableReadLoop","detail":"{readStateIndex:4460; appliedIndex:4458; }","duration":"130.102919ms","start":"2026-05-20T00:24:09.229346Z","end":"2026-05-20T00:24:09.359449Z","steps":["trace[1451269803] 'read index received'  (duration: 29.254064ms)","trace[1451269803] 'applied index is now lower than readState.Index'  (duration: 100.847355ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-20T00:24:09.360481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.70711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:15301"}
{"level":"info","ts":"2026-05-20T00:24:09.360541Z","caller":"traceutil/trace.go:171","msg":"trace[666047456] range","detail":"{range_begin:/registry/statefulsets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4278; }","duration":"125.781012ms","start":"2026-05-20T00:24:09.234745Z","end":"2026-05-20T00:24:09.360526Z","steps":["trace[666047456] 'agreement among raft nodes before linearized reading'  (duration: 125.515364ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-20T00:24:09.360726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.369732ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-20T00:24:09.360805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.990201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:7465"}
{"level":"info","ts":"2026-05-20T00:24:09.360844Z","caller":"traceutil/trace.go:171","msg":"trace[1674695110] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4278; }","duration":"121.051202ms","start":"2026-05-20T00:24:09.239779Z","end":"2026-05-20T00:24:09.36083Z","steps":["trace[1674695110] 'agreement among raft nodes before linearized reading'  (duration: 120.944868ms)"],"step_count":1}
{"level":"info","ts":"2026-05-20T00:24:09.360826Z","caller":"traceutil/trace.go:171","msg":"trace[653642449] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:4278; }","duration":"114.507266ms","start":"2026-05-20T00:24:09.246299Z","end":"2026-05-20T00:24:09.360806Z","steps":["trace[653642449] 'agreement among raft nodes before linearized reading'  (duration: 114.334121ms)"],"step_count":1}
{"level":"info","ts":"2026-05-20T00:24:20.870792Z","caller":"traceutil/trace.go:171","msg":"trace[1963167955] transaction","detail":"{read_only:false; response_revision:4508; number_of_response:1; }","duration":"144.002338ms","start":"2026-05-20T00:24:20.72675Z","end":"2026-05-20T00:24:20.870752Z","steps":["trace[1963167955] 'process raft request'  (duration: 112.367051ms)","trace[1963167955] 'compare'  (duration: 31.458101ms)"],"step_count":2}
{"level":"info","ts":"2026-05-20T00:24:20.884648Z","caller":"traceutil/trace.go:171","msg":"trace[398334209] linearizableReadLoop","detail":"{readStateIndex:4699; appliedIndex:4697; }","duration":"144.678058ms","start":"2026-05-20T00:24:20.739946Z","end":"2026-05-20T00:24:20.884624Z","steps":["trace[398334209] 'read index received'  (duration: 99.230524ms)","trace[398334209] 'applied index is now lower than readState.Index'  (duration: 45.446164ms)"],"step_count":2}
{"level":"info","ts":"2026-05-20T00:24:20.884784Z","caller":"traceutil/trace.go:171","msg":"trace[1932289396] transaction","detail":"{read_only:false; response_revision:4509; number_of_response:1; }","duration":"155.636ms","start":"2026-05-20T00:24:20.729134Z","end":"2026-05-20T00:24:20.88477Z","steps":["trace[1932289396] 'process raft request'  (duration: 155.355731ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-20T00:24:20.885111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.142422ms","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-05-20T00:24:20.88518Z","caller":"traceutil/trace.go:171","msg":"trace[1328584871] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4509; }","duration":"145.221794ms","start":"2026-05-20T00:24:20.739934Z","end":"2026-05-20T00:24:20.885156Z","steps":["trace[1328584871] 'agreement among raft nodes before linearized reading'  (duration: 145.044309ms)"],"step_count":1}
{"level":"info","ts":"2026-05-20T00:24:21.382028Z","caller":"traceutil/trace.go:171","msg":"trace[2109891745] transaction","detail":"{read_only:false; response_revision:4514; number_of_response:1; }","duration":"114.44733ms","start":"2026-05-20T00:24:21.267554Z","end":"2026-05-20T00:24:21.382001Z","steps":["trace[2109891745] 'process raft request'  (duration: 36.518541ms)","trace[2109891745] 'compare'  (duration: 77.741893ms)"],"step_count":2}
{"level":"info","ts":"2026-05-20T00:24:57.185954Z","caller":"traceutil/trace.go:171","msg":"trace[525922170] transaction","detail":"{read_only:false; response_revision:4914; number_of_response:1; }","duration":"104.64169ms","start":"2026-05-20T00:24:57.081254Z","end":"2026-05-20T00:24:57.185895Z","steps":["trace[525922170] 'process raft request'  (duration: 104.385453ms)"],"step_count":1}
{"level":"info","ts":"2026-05-20T00:24:58.66593Z","caller":"traceutil/trace.go:171","msg":"trace[2028677869] linearizableReadLoop","detail":"{readStateIndex:5218; appliedIndex:5216; }","duration":"135.145519ms","start":"2026-05-20T00:24:58.530739Z","end":"2026-05-20T00:24:58.665885Z","steps":["trace[2028677869] 'read index received'  (duration: 34.927605ms)","trace[2028677869] 'applied index is now lower than readState.Index'  (duration: 100.216404ms)"],"step_count":2}
{"level":"info","ts":"2026-05-20T00:24:58.665972Z","caller":"traceutil/trace.go:171","msg":"trace[1376876920] transaction","detail":"{read_only:false; response_revision:5007; number_of_response:1; }","duration":"136.084684ms","start":"2026-05-20T00:24:58.529847Z","end":"2026-05-20T00:24:58.665932Z","steps":["trace[1376876920] 'process raft request'  (duration: 128.70676ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-20T00:24:58.666427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.648913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:7454"}
{"level":"info","ts":"2026-05-20T00:24:58.6666Z","caller":"traceutil/trace.go:171","msg":"trace[1249838947] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:5007; }","duration":"135.834659ms","start":"2026-05-20T00:24:58.530733Z","end":"2026-05-20T00:24:58.666567Z","steps":["trace[1249838947] 'agreement among raft nodes before linearized reading'  (duration: 135.284024ms)"],"step_count":1}
{"level":"info","ts":"2026-05-20T00:25:01.300904Z","caller":"traceutil/trace.go:171","msg":"trace[984131565] transaction","detail":"{read_only:false; response_revision:5036; number_of_response:1; }","duration":"103.478025ms","start":"2026-05-20T00:25:01.197385Z","end":"2026-05-20T00:25:01.300863Z","steps":["trace[984131565] 'process raft request'  (duration: 67.116301ms)","trace[984131565] 'compare'  (duration: 36.062166ms)"],"step_count":2}
{"level":"info","ts":"2026-05-20T00:25:07.049833Z","caller":"traceutil/trace.go:171","msg":"trace[2006650325] transaction","detail":"{read_only:false; response_revision:5076; number_of_response:1; }","duration":"128.658759ms","start":"2026-05-20T00:25:06.921147Z","end":"2026-05-20T00:25:07.049806Z","steps":["trace[2006650325] 'process raft request'  (duration: 51.668795ms)","trace[2006650325] 'compare'  (duration: 76.654486ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-20T00:25:21.105668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.995955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-fernet-setup\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-20T00:25:21.105746Z","caller":"traceutil/trace.go:171","msg":"trace[605617474] range","detail":"{range_begin:/registry/jobs/openstack/keystone-fernet-setup; range_end:; response_count:0; response_revision:5194; }","duration":"118.131098ms","start":"2026-05-20T00:25:20.987598Z","end":"2026-05-20T00:25:21.10573Z","steps":["trace[605617474] 'range keys from in-memory index tree'  (duration: 117.890303ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-20T00:25:21.105764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.085724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-db-sync\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-20T00:25:21.105858Z","caller":"traceutil/trace.go:171","msg":"trace[897227576] range","detail":"{range_begin:/registry/jobs/openstack/keystone-db-sync; range_end:; response_count:0; response_revision:5194; }","duration":"117.201146ms","start":"2026-05-20T00:25:20.988629Z","end":"2026-05-20T00:25:21.10583Z","steps":["trace[897227576] 'range keys from in-memory index tree'  (duration: 117.012641ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-20T00:25:21.516317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.14965ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9142199778090695266 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:5182 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-20T00:25:21.516746Z","caller":"traceutil/trace.go:171","msg":"trace[1012558971] transaction","detail":"{read_only:false; response_revision:5198; number_of_response:1; }","duration":"200.46708ms","start":"2026-05-20T00:25:21.31625Z","end":"2026-05-20T00:25:21.516717Z","steps":["trace[1012558971] 'process raft request'  (duration: 23.788787ms)","trace[1012558971] 'compare'  (duration: 176.029207ms)"],"step_count":2}
{"level":"info","ts":"2026-05-20T00:25:21.517202Z","caller":"traceutil/trace.go:171","msg":"trace[652401312] transaction","detail":"{read_only:false; response_revision:5199; number_of_response:1; }","duration":"138.331197ms","start":"2026-05-20T00:25:21.378851Z","end":"2026-05-20T00:25:21.517182Z","steps":["trace[652401312] 'process raft request'  (duration: 137.582328ms)"],"step_count":1}
{"level":"info","ts":"2026-05-20T00:25:21.878607Z","caller":"traceutil/trace.go:171","msg":"trace[351264676] linearizableReadLoop","detail":"{readStateIndex:5419; appliedIndex:5418; }","duration":"296.990974ms","start":"2026-05-20T00:25:21.581588Z","end":"2026-05-20T00:25:21.878579Z","steps":["trace[351264676] 'read index received'  (duration: 296.871691ms)","trace[351264676] 'applied index is now lower than readState.Index'  (duration: 118.163µs)"],"step_count":2}
{"level":"info","ts":"2026-05-20T00:25:21.878664Z","caller":"traceutil/trace.go:171","msg":"trace[1073475100] transaction","detail":"{read_only:false; response_revision:5200; number_of_response:1; }","duration":"358.243627ms","start":"2026-05-20T00:25:21.520394Z","end":"2026-05-20T00:25:21.878637Z","steps":["trace[1073475100] 'process raft request'  (duration: 358.010742ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-20T00:25:21.878798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T00:25:21.520383Z","time spent":"358.341869ms","remote":"127.0.0.1:43302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:5184 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-05-20T00:25:21.878827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.219619ms","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-05-20T00:25:21.878865Z","caller":"traceutil/trace.go:171","msg":"trace[1299840735] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5200; }","duration":"297.304521ms","start":"2026-05-20T00:25:21.581547Z","end":"2026-05-20T00:25:21.878851Z","steps":["trace[1299840735] 'agreement among raft nodes before linearized reading'  (duration: 297.156508ms)"],"step_count":1}
{"level":"info","ts":"2026-05-20T00:25:22.027643Z","caller":"traceutil/trace.go:171","msg":"trace[53010899] linearizableReadLoop","detail":"{readStateIndex:5421; appliedIndex:5419; }","duration":"148.937026ms","start":"2026-05-20T00:25:21.878677Z","end":"2026-05-20T00:25:22.027614Z","steps":["trace[53010899] 'read index received'  (duration: 148.561207ms)","trace[53010899] 'applied index is now lower than readState.Index'  (duration: 374.679µs)"],"step_count":2}
{"level":"info","ts":"2026-05-20T00:25:22.027662Z","caller":"traceutil/trace.go:171","msg":"trace[321773960] transaction","detail":"{read_only:false; response_revision:5202; number_of_response:1; }","duration":"230.776118ms","start":"2026-05-20T00:25:21.796857Z","end":"2026-05-20T00:25:22.027633Z","steps":["trace[321773960] 'process raft request'  (duration: 230.623284ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-20T00:25:22.027833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.86754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-05-20T00:25:22.027936Z","caller":"traceutil/trace.go:171","msg":"trace[1175579228] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5202; }","duration":"263.019494ms","start":"2026-05-20T00:25:21.764892Z","end":"2026-05-20T00:25:22.027912Z","steps":["trace[1175579228] 'agreement among raft nodes before linearized reading'  (duration: 262.741677ms)"],"step_count":1}
{"level":"info","ts":"2026-05-20T00:25:22.027724Z","caller":"traceutil/trace.go:171","msg":"trace[1241738923] transaction","detail":"{read_only:false; response_revision:5201; number_of_response:1; }","duration":"441.151763ms","start":"2026-05-20T00:25:21.58656Z","end":"2026-05-20T00:25:22.027712Z","steps":["trace[1241738923] 'process raft request'  (duration: 440.530748ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-20T00:25:22.02814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T00:25:21.586537Z","time spent":"441.469691ms","remote":"127.0.0.1:43302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:5152 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:415 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"warn","ts":"2026-05-20T00:25:22.028334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.181441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-05-20T00:25:22.028434Z","caller":"traceutil/trace.go:171","msg":"trace[1393843185] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5202; }","duration":"300.335465ms","start":"2026-05-20T00:25:21.728081Z","end":"2026-05-20T00:25:22.028417Z","steps":["trace[1393843185] 'agreement among raft nodes before linearized reading'  (duration: 299.683619ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-20T00:25:22.028509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T00:25:21.72806Z","time spent":"300.434247ms","remote":"127.0.0.1:43302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-05-20T00:25:22.028087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"407.075581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:660"}
{"level":"info","ts":"2026-05-20T00:25:22.029286Z","caller":"traceutil/trace.go:171","msg":"trace[789939475] range","detail":"{range_begin:/registry/configmaps/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:5202; }","duration":"408.328692ms","start":"2026-05-20T00:25:21.62094Z","end":"2026-05-20T00:25:22.029268Z","steps":["trace[789939475] 'agreement among raft nodes before linearized reading'  (duration: 406.833435ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-20T00:25:22.029336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T00:25:21.620918Z","time spent":"408.401993ms","remote":"127.0.0.1:43148","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":1,"response size":682,"request content":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" "}
{"level":"info","ts":"2026-05-20T00:25:22.095001Z","caller":"traceutil/trace.go:171","msg":"trace[1071234139] transaction","detail":"{read_only:false; response_revision:5203; number_of_response:1; }","duration":"211.63492ms","start":"2026-05-20T00:25:21.883337Z","end":"2026-05-20T00:25:22.094971Z","steps":["trace[1071234139] 'process raft request'  (duration: 211.443465ms)"],"step_count":1}
{"level":"info","ts":"2026-05-20T00:25:22.173402Z","caller":"traceutil/trace.go:171","msg":"trace[1743055372] transaction","detail":"{read_only:false; response_revision:5205; number_of_response:1; }","duration":"138.950722ms","start":"2026-05-20T00:25:22.03442Z","end":"2026-05-20T00:25:22.17337Z","steps":["trace[1743055372] 'process raft request'  (duration: 138.884131ms)"],"step_count":1}
{"level":"info","ts":"2026-05-20T00:25:22.173685Z","caller":"traceutil/trace.go:171","msg":"trace[48784632] transaction","detail":"{read_only:false; response_revision:5204; number_of_response:1; }","duration":"141.077483ms","start":"2026-05-20T00:25:22.032576Z","end":"2026-05-20T00:25:22.173653Z","steps":["trace[48784632] 'process raft request'  (duration: 140.53548ms)"],"step_count":1}
{"level":"info","ts":"2026-05-20T00:27:38.890817Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3175}
{"level":"info","ts":"2026-05-20T00:27:39.006286Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3175,"took":"113.678748ms","hash":1160869849,"current-db-size-bytes":58957824,"current-db-size":"59 MB","current-db-size-in-use-bytes":31395840,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-05-20T00:27:39.006359Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1160869849,"revision":3175,"compact-revision":-1}
{"level":"info","ts":"2026-05-20T00:28:22.79661Z","caller":"traceutil/trace.go:171","msg":"trace[1156692434] transaction","detail":"{read_only:false; response_revision:6733; number_of_response:1; }","duration":"126.624097ms","start":"2026-05-20T00:28:22.66993Z","end":"2026-05-20T00:28:22.796554Z","steps":["trace[1156692434] 'process raft request'  (duration: 126.154487ms)"],"step_count":1}