{"level":"warn","ts":"2026-04-22T16:22:35.032882Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-04-22T16:22:35.033119Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.224: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.19.213.224:2380","--initial-cluster=instance=https://199.19.213.224:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.224:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.224: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-04-22T16:22:35.03321Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-04-22T16:22:35.033226Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.224:2380"]}
{"level":"info","ts":"2026-04-22T16:22:35.03325Z","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-04-22T16:22:35.033961Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.224:2379"]}
{"level":"info","ts":"2026-04-22T16:22:35.034056Z","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.19.213.224:2380"],"listen-peer-urls":["https://199.19.213.224:2380"],"advertise-client-urls":["https://199.19.213.224:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.224:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.224: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-04-22T16:22:35.035968Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"1.731213ms"}
{"level":"info","ts":"2026-04-22T16:22:35.045704Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"9870e1635c99d2ec","cluster-id":"185398c074a8a76b"}
{"level":"info","ts":"2026-04-22T16:22:35.045805Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9870e1635c99d2ec switched to configuration voters=()"}
{"level":"info","ts":"2026-04-22T16:22:35.045852Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9870e1635c99d2ec became follower at term 0"}
{"level":"info","ts":"2026-04-22T16:22:35.045875Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 9870e1635c99d2ec [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-04-22T16:22:35.045892Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9870e1635c99d2ec became follower at term 1"}
{"level":"info","ts":"2026-04-22T16:22:35.045998Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9870e1635c99d2ec switched to configuration voters=(10984527308028236524)"}
{"level":"warn","ts":"2026-04-22T16:22:35.052672Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-04-22T16:22:35.054777Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-04-22T16:22:35.055788Z","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-04-22T16:22:35.058454Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"9870e1635c99d2ec","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-04-22T16:22:35.058562Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"9870e1635c99d2ec","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-04-22T16:22:35.058785Z","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-04-22T16:22:35.058826Z","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-04-22T16:22:35.058835Z","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-04-22T16:22:35.059331Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9870e1635c99d2ec switched to configuration voters=(10984527308028236524)"}
{"level":"info","ts":"2026-04-22T16:22:35.059497Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"185398c074a8a76b","local-member-id":"9870e1635c99d2ec","added-peer-id":"9870e1635c99d2ec","added-peer-peer-urls":["https://199.19.213.224:2380"]}
{"level":"info","ts":"2026-04-22T16:22:35.06225Z","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-04-22T16:22:35.062391Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.224:2380"}
{"level":"info","ts":"2026-04-22T16:22:35.062483Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.224:2380"}
{"level":"info","ts":"2026-04-22T16:22:35.062623Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"9870e1635c99d2ec","initial-advertise-peer-urls":["https://199.19.213.224:2380"],"listen-peer-urls":["https://199.19.213.224:2380"],"advertise-client-urls":["https://199.19.213.224:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.224:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-04-22T16:22:35.062665Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-04-22T16:22:35.446718Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9870e1635c99d2ec is starting a new election at term 1"}
{"level":"info","ts":"2026-04-22T16:22:35.446836Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9870e1635c99d2ec became pre-candidate at term 1"}
{"level":"info","ts":"2026-04-22T16:22:35.446874Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9870e1635c99d2ec received MsgPreVoteResp from 9870e1635c99d2ec at term 1"}
{"level":"info","ts":"2026-04-22T16:22:35.446897Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9870e1635c99d2ec became candidate at term 2"}
{"level":"info","ts":"2026-04-22T16:22:35.446914Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9870e1635c99d2ec received MsgVoteResp from 9870e1635c99d2ec at term 2"}
{"level":"info","ts":"2026-04-22T16:22:35.446932Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9870e1635c99d2ec became leader at term 2"}
{"level":"info","ts":"2026-04-22T16:22:35.446948Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 9870e1635c99d2ec elected leader 9870e1635c99d2ec at term 2"}
{"level":"info","ts":"2026-04-22T16:22:35.461418Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"9870e1635c99d2ec","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.224:2379]}","request-path":"/0/members/9870e1635c99d2ec/attributes","cluster-id":"185398c074a8a76b","publish-timeout":"7s"}
{"level":"info","ts":"2026-04-22T16:22:35.461737Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-22T16:22:35.461935Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-22T16:22:35.4621Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-22T16:22:35.462314Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-04-22T16:22:35.462373Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-04-22T16:22:35.464098Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.224:2379"}
{"level":"info","ts":"2026-04-22T16:22:35.46657Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-04-22T16:22:35.466732Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"185398c074a8a76b","local-member-id":"9870e1635c99d2ec","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-22T16:22:35.466857Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-22T16:22:35.466913Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-22T16:23:08.579289Z","caller":"traceutil/trace.go:171","msg":"trace[1428191187] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"132.96474ms","start":"2026-04-22T16:23:08.446291Z","end":"2026-04-22T16:23:08.579256Z","steps":["trace[1428191187] 'process raft request'  (duration: 125.308354ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:23:09.032639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.760367ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15198696247480363751 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:15-second id:52ec9db600212ae6>","response":"size:40"}
{"level":"warn","ts":"2026-04-22T16:23:09.032785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:23:08.583162Z","time spent":"449.617868ms","remote":"127.0.0.1:42350","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"info","ts":"2026-04-22T16:23:09.035364Z","caller":"traceutil/trace.go:171","msg":"trace[1921774849] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"394.667544ms","start":"2026-04-22T16:23:08.64067Z","end":"2026-04-22T16:23:09.035338Z","steps":["trace[1921774849] 'process raft request'  (duration: 394.514785ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:23:09.035945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:23:08.640648Z","time spent":"394.822163ms","remote":"127.0.0.1:42526","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":818,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" mod_revision:0 > success:<request_put:<key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" value_size:729 >> failure:<>"}
{"level":"info","ts":"2026-04-22T16:23:11.498435Z","caller":"traceutil/trace.go:171","msg":"trace[2135962451] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"172.595444ms","start":"2026-04-22T16:23:11.325801Z","end":"2026-04-22T16:23:11.498396Z","steps":["trace[2135962451] 'process raft request'  (duration: 171.57476ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:23:11.67754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.146794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T16:23:11.677663Z","caller":"traceutil/trace.go:171","msg":"trace[1292260523] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:621; }","duration":"120.333103ms","start":"2026-04-22T16:23:11.557301Z","end":"2026-04-22T16:23:11.677634Z","steps":["trace[1292260523] 'range keys from in-memory index tree'  (duration: 120.063744ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:23:11.682032Z","caller":"traceutil/trace.go:171","msg":"trace[1820494908] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"120.162455ms","start":"2026-04-22T16:23:11.561848Z","end":"2026-04-22T16:23:11.68201Z","steps":["trace[1820494908] 'process raft request'  (duration: 119.975976ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:23:12.329679Z","caller":"traceutil/trace.go:171","msg":"trace[785167886] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"258.88176ms","start":"2026-04-22T16:23:12.070761Z","end":"2026-04-22T16:23:12.329643Z","steps":["trace[785167886] 'process raft request'  (duration: 243.590504ms)","trace[785167886] 'compare'  (duration: 12.590741ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T16:23:13.889356Z","caller":"traceutil/trace.go:171","msg":"trace[1082101294] transaction","detail":"{read_only:false; response_revision:659; number_of_response:1; }","duration":"106.376783ms","start":"2026-04-22T16:23:13.782953Z","end":"2026-04-22T16:23:13.88933Z","steps":["trace[1082101294] 'process raft request'  (duration: 89.030257ms)","trace[1082101294] 'compare'  (duration: 17.218367ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T16:23:58.271897Z","caller":"traceutil/trace.go:171","msg":"trace[489471751] transaction","detail":"{read_only:false; response_revision:1191; number_of_response:1; }","duration":"217.877354ms","start":"2026-04-22T16:23:58.053992Z","end":"2026-04-22T16:23:58.271869Z","steps":["trace[489471751] 'process raft request'  (duration: 217.661874ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:24:38.614131Z","caller":"traceutil/trace.go:171","msg":"trace[1898672263] linearizableReadLoop","detail":"{readStateIndex:1807; appliedIndex:1806; }","duration":"134.865446ms","start":"2026-04-22T16:24:38.479249Z","end":"2026-04-22T16:24:38.614114Z","steps":["trace[1898672263] 'read index received'  (duration: 134.774314ms)","trace[1898672263] 'applied index is now lower than readState.Index'  (duration: 90.382µs)"],"step_count":2}
{"level":"info","ts":"2026-04-22T16:24:38.614249Z","caller":"traceutil/trace.go:171","msg":"trace[147659827] transaction","detail":"{read_only:false; response_revision:1739; number_of_response:1; }","duration":"138.37607ms","start":"2026-04-22T16:24:38.475824Z","end":"2026-04-22T16:24:38.6142Z","steps":["trace[147659827] 'process raft request'  (duration: 138.190995ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:24:38.614321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.055011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T16:24:38.614394Z","caller":"traceutil/trace.go:171","msg":"trace[1780998718] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:1739; }","duration":"135.152974ms","start":"2026-04-22T16:24:38.47923Z","end":"2026-04-22T16:24:38.614383Z","steps":["trace[1780998718] 'agreement among raft nodes before linearized reading'  (duration: 135.049322ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:24:38.61449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.170474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T16:24:38.614602Z","caller":"traceutil/trace.go:171","msg":"trace[146738722] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:1739; }","duration":"135.313819ms","start":"2026-04-22T16:24:38.479271Z","end":"2026-04-22T16:24:38.614585Z","steps":["trace[146738722] 'agreement among raft nodes before linearized reading'  (duration: 135.140994ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:24:38.615299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.557633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T16:24:38.615374Z","caller":"traceutil/trace.go:171","msg":"trace[1327348722] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:1739; }","duration":"124.657266ms","start":"2026-04-22T16:24:38.490708Z","end":"2026-04-22T16:24:38.615365Z","steps":["trace[1327348722] 'agreement among raft nodes before linearized reading'  (duration: 124.570383ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:24:38.615515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.733097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-22T16:24:38.615583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.84238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T16:24:38.615975Z","caller":"traceutil/trace.go:171","msg":"trace[486738610] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:1739; }","duration":"114.24871ms","start":"2026-04-22T16:24:38.501715Z","end":"2026-04-22T16:24:38.615964Z","steps":["trace[486738610] 'agreement among raft nodes before linearized reading'  (duration: 113.846989ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:24:38.615728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.014895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T16:24:38.615879Z","caller":"traceutil/trace.go:171","msg":"trace[1969164251] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:1739; }","duration":"114.098656ms","start":"2026-04-22T16:24:38.50176Z","end":"2026-04-22T16:24:38.615858Z","steps":["trace[1969164251] 'agreement among raft nodes before linearized reading'  (duration: 113.734187ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:24:38.616116Z","caller":"traceutil/trace.go:171","msg":"trace[615722395] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:1739; }","duration":"125.383945ms","start":"2026-04-22T16:24:38.490705Z","end":"2026-04-22T16:24:38.616089Z","steps":["trace[615722395] 'agreement among raft nodes before linearized reading'  (duration: 125.004925ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:24:46.489786Z","caller":"traceutil/trace.go:171","msg":"trace[222464216] transaction","detail":"{read_only:false; response_revision:1856; number_of_response:1; }","duration":"449.291453ms","start":"2026-04-22T16:24:46.040468Z","end":"2026-04-22T16:24:46.489759Z","steps":["trace[222464216] 'process raft request'  (duration: 449.009517ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:24:46.49014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.529971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4b8eefb5-3f83-46de-a75f-0db7073d1665\" ","response":"range_response_count:1 size:3627"}
{"level":"info","ts":"2026-04-22T16:24:46.490266Z","caller":"traceutil/trace.go:171","msg":"trace[292141503] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-4b8eefb5-3f83-46de-a75f-0db7073d1665; range_end:; response_count:1; response_revision:1856; }","duration":"382.711715ms","start":"2026-04-22T16:24:46.107523Z","end":"2026-04-22T16:24:46.490235Z","steps":["trace[292141503] 'agreement among raft nodes before linearized reading'  (duration: 382.346546ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:24:46.490297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:24:46.040256Z","time spent":"449.612971ms","remote":"127.0.0.1:42590","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:1785 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-04-22T16:24:46.490353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:24:46.107508Z","time spent":"382.832718ms","remote":"127.0.0.1:42500","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3650,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4b8eefb5-3f83-46de-a75f-0db7073d1665\" "}
{"level":"info","ts":"2026-04-22T16:24:46.489696Z","caller":"traceutil/trace.go:171","msg":"trace[2063635527] linearizableReadLoop","detail":"{readStateIndex:1927; appliedIndex:1926; }","duration":"382.10347ms","start":"2026-04-22T16:24:46.107563Z","end":"2026-04-22T16:24:46.489667Z","steps":["trace[2063635527] 'read index received'  (duration: 381.833314ms)","trace[2063635527] 'applied index is now lower than readState.Index'  (duration: 268.886µs)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T16:24:46.490655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.390599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:553"}
{"level":"info","ts":"2026-04-22T16:24:46.490728Z","caller":"traceutil/trace.go:171","msg":"trace[2074062917] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1856; }","duration":"288.507001ms","start":"2026-04-22T16:24:46.202202Z","end":"2026-04-22T16:24:46.490709Z","steps":["trace[2074062917] 'agreement among raft nodes before linearized reading'  (duration: 288.315707ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:24:46.730478Z","caller":"traceutil/trace.go:171","msg":"trace[17306456] linearizableReadLoop","detail":"{readStateIndex:1929; appliedIndex:1928; }","duration":"166.115239ms","start":"2026-04-22T16:24:46.564344Z","end":"2026-04-22T16:24:46.730459Z","steps":["trace[17306456] 'read index received'  (duration: 158.98946ms)","trace[17306456] 'applied index is now lower than readState.Index'  (duration: 7.124699ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T16:24:46.730587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.233021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T16:24:46.730618Z","caller":"traceutil/trace.go:171","msg":"trace[646459699] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1858; }","duration":"166.320043ms","start":"2026-04-22T16:24:46.564288Z","end":"2026-04-22T16:24:46.730608Z","steps":["trace[646459699] 'agreement among raft nodes before linearized reading'  (duration: 166.252972ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:24:46.730687Z","caller":"traceutil/trace.go:171","msg":"trace[1075950258] transaction","detail":"{read_only:false; response_revision:1858; number_of_response:1; }","duration":"234.191562ms","start":"2026-04-22T16:24:46.496465Z","end":"2026-04-22T16:24:46.730657Z","steps":["trace[1075950258] 'process raft request'  (duration: 226.858339ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:24:46.761454Z","caller":"traceutil/trace.go:171","msg":"trace[758767238] transaction","detail":"{read_only:false; response_revision:1859; number_of_response:1; }","duration":"104.149909ms","start":"2026-04-22T16:24:46.657284Z","end":"2026-04-22T16:24:46.761434Z","steps":["trace[758767238] 'process raft request'  (duration: 103.824891ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:24:46.970924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.351967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"}
{"level":"info","ts":"2026-04-22T16:24:46.971011Z","caller":"traceutil/trace.go:171","msg":"trace[1680110311] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1859; }","duration":"137.487871ms","start":"2026-04-22T16:24:46.833502Z","end":"2026-04-22T16:24:46.97099Z","steps":["trace[1680110311] 'range keys from in-memory index tree'  (duration: 137.158113ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:25:20.2109Z","caller":"traceutil/trace.go:171","msg":"trace[311759300] transaction","detail":"{read_only:false; response_revision:2097; number_of_response:1; }","duration":"179.180395ms","start":"2026-04-22T16:25:20.031691Z","end":"2026-04-22T16:25:20.210871Z","steps":["trace[311759300] 'process raft request'  (duration: 179.036813ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:25:20.210939Z","caller":"traceutil/trace.go:171","msg":"trace[731458675] transaction","detail":"{read_only:false; response_revision:2096; number_of_response:1; }","duration":"196.389904ms","start":"2026-04-22T16:25:20.014495Z","end":"2026-04-22T16:25:20.210884Z","steps":["trace[731458675] 'process raft request'  (duration: 196.049079ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:25:20.211076Z","caller":"traceutil/trace.go:171","msg":"trace[419339303] linearizableReadLoop","detail":"{readStateIndex:2175; appliedIndex:2173; }","duration":"142.358581ms","start":"2026-04-22T16:25:20.068706Z","end":"2026-04-22T16:25:20.211065Z","steps":["trace[419339303] 'read index received'  (duration: 30.58941ms)","trace[419339303] 'applied index is now lower than readState.Index'  (duration: 111.763441ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T16:25:20.211099Z","caller":"traceutil/trace.go:171","msg":"trace[414048144] transaction","detail":"{read_only:false; response_revision:2098; number_of_response:1; }","duration":"122.994319ms","start":"2026-04-22T16:25:20.08808Z","end":"2026-04-22T16:25:20.211074Z","steps":["trace[414048144] 'process raft request'  (duration: 122.727186ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:25:20.211222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.510243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"}
{"level":"info","ts":"2026-04-22T16:25:20.211738Z","caller":"traceutil/trace.go:171","msg":"trace[1818284425] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2098; }","duration":"143.046212ms","start":"2026-04-22T16:25:20.068646Z","end":"2026-04-22T16:25:20.211693Z","steps":["trace[1818284425] 'agreement among raft nodes before linearized reading'  (duration: 142.449563ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:25:20.776961Z","caller":"traceutil/trace.go:171","msg":"trace[1305001658] transaction","detail":"{read_only:false; response_revision:2101; number_of_response:1; }","duration":"103.536047ms","start":"2026-04-22T16:25:20.673408Z","end":"2026-04-22T16:25:20.776944Z","steps":["trace[1305001658] 'process raft request'  (duration: 27.851169ms)","trace[1305001658] 'compare'  (duration: 75.422355ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T16:25:20.929554Z","caller":"traceutil/trace.go:171","msg":"trace[2028183645] transaction","detail":"{read_only:false; response_revision:2103; number_of_response:1; }","duration":"147.230174ms","start":"2026-04-22T16:25:20.7823Z","end":"2026-04-22T16:25:20.92953Z","steps":["trace[2028183645] 'process raft request'  (duration: 147.107702ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:25:21.45834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.175383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"}
{"level":"info","ts":"2026-04-22T16:25:21.458423Z","caller":"traceutil/trace.go:171","msg":"trace[2019320823] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2104; }","duration":"299.304624ms","start":"2026-04-22T16:25:21.1591Z","end":"2026-04-22T16:25:21.458404Z","steps":["trace[2019320823] 'range keys from in-memory index tree'  (duration: 298.98286ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:25:21.459401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.622242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"}
{"level":"info","ts":"2026-04-22T16:25:21.459458Z","caller":"traceutil/trace.go:171","msg":"trace[59665465] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2104; }","duration":"240.717064ms","start":"2026-04-22T16:25:21.218723Z","end":"2026-04-22T16:25:21.45944Z","steps":["trace[59665465] 'range keys from in-memory index tree'  (duration: 240.47532ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:25:21.768424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.193646ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15198696247480366811 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/cert-manager/cert-manager-controller\" mod_revision:2025 > success:<request_put:<key:\"/registry/leases/cert-manager/cert-manager-controller\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/cert-manager/cert-manager-controller\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-22T16:25:21.768528Z","caller":"traceutil/trace.go:171","msg":"trace[778570245] linearizableReadLoop","detail":"{readStateIndex:2184; appliedIndex:2183; }","duration":"208.203091ms","start":"2026-04-22T16:25:21.560308Z","end":"2026-04-22T16:25:21.768511Z","steps":["trace[778570245] 'read index received'  (duration: 2.75972ms)","trace[778570245] 'applied index is now lower than readState.Index'  (duration: 205.442361ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T16:25:21.768621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.316613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T16:25:21.769092Z","caller":"traceutil/trace.go:171","msg":"trace[682771812] transaction","detail":"{read_only:false; response_revision:2106; number_of_response:1; }","duration":"218.85224ms","start":"2026-04-22T16:25:21.550212Z","end":"2026-04-22T16:25:21.769064Z","steps":["trace[682771812] 'process raft request'  (duration: 12.936793ms)","trace[682771812] 'compare'  (duration: 205.008344ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T16:25:21.769645Z","caller":"traceutil/trace.go:171","msg":"trace[1809520020] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2106; }","duration":"209.266358ms","start":"2026-04-22T16:25:21.560264Z","end":"2026-04-22T16:25:21.769531Z","steps":["trace[1809520020] 'agreement among raft nodes before linearized reading'  (duration: 208.322774ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:26:59.65516Z","caller":"traceutil/trace.go:171","msg":"trace[265894444] linearizableReadLoop","detail":"{readStateIndex:2841; appliedIndex:2840; }","duration":"187.439476ms","start":"2026-04-22T16:26:59.467695Z","end":"2026-04-22T16:26:59.655134Z","steps":["trace[265894444] 'read index received'  (duration: 106.969064ms)","trace[265894444] 'applied index is now lower than readState.Index'  (duration: 80.469282ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T16:26:59.655218Z","caller":"traceutil/trace.go:171","msg":"trace[791895903] transaction","detail":"{read_only:false; response_revision:2740; number_of_response:1; }","duration":"279.584611ms","start":"2026-04-22T16:26:59.375595Z","end":"2026-04-22T16:26:59.65518Z","steps":["trace[791895903] 'process raft request'  (duration: 199.120749ms)","trace[791895903] 'compare'  (duration: 80.289832ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T16:26:59.655383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.665117ms","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-04-22T16:26:59.655447Z","caller":"traceutil/trace.go:171","msg":"trace[1640634169] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2740; }","duration":"187.788089ms","start":"2026-04-22T16:26:59.467642Z","end":"2026-04-22T16:26:59.655431Z","steps":["trace[1640634169] 'agreement among raft nodes before linearized reading'  (duration: 187.603358ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:26:59.6557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.498137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18a8ba94633c7936\" ","response":"range_response_count:1 size:781"}
{"level":"info","ts":"2026-04-22T16:26:59.655748Z","caller":"traceutil/trace.go:171","msg":"trace[2084559345] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18a8ba94633c7936; range_end:; response_count:1; response_revision:2740; }","duration":"172.584277ms","start":"2026-04-22T16:26:59.483152Z","end":"2026-04-22T16:26:59.655736Z","steps":["trace[2084559345] 'agreement among raft nodes before linearized reading'  (duration: 172.458867ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:30:39.782194Z","caller":"traceutil/trace.go:171","msg":"trace[656656394] transaction","detail":"{read_only:false; response_revision:4432; number_of_response:1; }","duration":"102.669229ms","start":"2026-04-22T16:30:39.679486Z","end":"2026-04-22T16:30:39.782155Z","steps":["trace[656656394] 'process raft request'  (duration: 39.878355ms)","trace[656656394] 'compare'  (duration: 62.571878ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T16:30:39.816309Z","caller":"traceutil/trace.go:171","msg":"trace[1455142401] transaction","detail":"{read_only:false; response_revision:4433; number_of_response:1; }","duration":"119.870342ms","start":"2026-04-22T16:30:39.696412Z","end":"2026-04-22T16:30:39.816283Z","steps":["trace[1455142401] 'process raft request'  (duration: 119.557045ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:30:39.882638Z","caller":"traceutil/trace.go:171","msg":"trace[1951609934] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4433; }","duration":"136.088642ms","start":"2026-04-22T16:30:39.746511Z","end":"2026-04-22T16:30:39.8826Z","steps":["trace[1951609934] 'process raft request'  (duration: 135.889878ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:30:40.038782Z","caller":"traceutil/trace.go:171","msg":"trace[1533785591] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4437; }","duration":"124.147048ms","start":"2026-04-22T16:30:39.914614Z","end":"2026-04-22T16:30:40.038761Z","steps":["trace[1533785591] 'process raft request'  (duration: 104.838447ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:30:43.643522Z","caller":"traceutil/trace.go:171","msg":"trace[1140888242] transaction","detail":"{read_only:false; response_revision:4516; number_of_response:1; }","duration":"115.466676ms","start":"2026-04-22T16:30:43.528024Z","end":"2026-04-22T16:30:43.643491Z","steps":["trace[1140888242] 'process raft request'  (duration: 115.330433ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:30:44.59324Z","caller":"traceutil/trace.go:171","msg":"trace[1639371290] transaction","detail":"{read_only:false; response_revision:4557; number_of_response:1; }","duration":"117.994382ms","start":"2026-04-22T16:30:44.475198Z","end":"2026-04-22T16:30:44.593192Z","steps":["trace[1639371290] 'process raft request'  (duration: 117.743906ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:30:44.593185Z","caller":"traceutil/trace.go:171","msg":"trace[782410548] linearizableReadLoop","detail":"{readStateIndex:4729; appliedIndex:4728; }","duration":"103.427789ms","start":"2026-04-22T16:30:44.489732Z","end":"2026-04-22T16:30:44.59316Z","steps":["trace[782410548] 'read index received'  (duration: 103.218944ms)","trace[782410548] 'applied index is now lower than readState.Index'  (duration: 205.465µs)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T16:30:44.593437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.683275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-bd6eab10-ab62-49b4-af28-47ba45731e46\" ","response":"range_response_count:1 size:3774"}
{"level":"info","ts":"2026-04-22T16:30:44.593536Z","caller":"traceutil/trace.go:171","msg":"trace[1039805815] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-bd6eab10-ab62-49b4-af28-47ba45731e46; range_end:; response_count:1; response_revision:4557; }","duration":"103.813787ms","start":"2026-04-22T16:30:44.4897Z","end":"2026-04-22T16:30:44.593514Z","steps":["trace[1039805815] 'agreement among raft nodes before linearized reading'  (duration: 103.561131ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:30:48.063913Z","caller":"traceutil/trace.go:171","msg":"trace[2136189615] transaction","detail":"{read_only:false; response_revision:4616; number_of_response:1; }","duration":"106.982709ms","start":"2026-04-22T16:30:47.956905Z","end":"2026-04-22T16:30:48.063887Z","steps":["trace[2136189615] 'process raft request'  (duration: 106.810985ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:30:53.469143Z","caller":"traceutil/trace.go:171","msg":"trace[1484439624] transaction","detail":"{read_only:false; response_revision:4749; number_of_response:1; }","duration":"130.204008ms","start":"2026-04-22T16:30:53.338913Z","end":"2026-04-22T16:30:53.469117Z","steps":["trace[1484439624] 'process raft request'  (duration: 130.016053ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:30:54.410906Z","caller":"traceutil/trace.go:171","msg":"trace[1321546880] linearizableReadLoop","detail":"{readStateIndex:4937; appliedIndex:4936; }","duration":"106.458076ms","start":"2026-04-22T16:30:54.304421Z","end":"2026-04-22T16:30:54.410879Z","steps":["trace[1321546880] 'read index received'  (duration: 89.344151ms)","trace[1321546880] 'applied index is now lower than readState.Index'  (duration: 17.111995ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T16:30:54.411221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.775272ms","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-04-22T16:30:54.411289Z","caller":"traceutil/trace.go:171","msg":"trace[24353029] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4758; }","duration":"106.887365ms","start":"2026-04-22T16:30:54.304382Z","end":"2026-04-22T16:30:54.411269Z","steps":["trace[24353029] 'agreement among raft nodes before linearized reading'  (duration: 106.593269ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:30:54.411302Z","caller":"traceutil/trace.go:171","msg":"trace[1517061206] transaction","detail":"{read_only:false; response_revision:4758; number_of_response:1; }","duration":"146.639474ms","start":"2026-04-22T16:30:54.264599Z","end":"2026-04-22T16:30:54.411239Z","steps":["trace[1517061206] 'process raft request'  (duration: 129.08633ms)","trace[1517061206] 'compare'  (duration: 16.961521ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T16:30:54.628373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.657019ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15198696247480373392 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:4704 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-22T16:30:54.628506Z","caller":"traceutil/trace.go:171","msg":"trace[1025082844] linearizableReadLoop","detail":"{readStateIndex:4938; appliedIndex:4937; }","duration":"128.330454ms","start":"2026-04-22T16:30:54.500153Z","end":"2026-04-22T16:30:54.628483Z","steps":["trace[1025082844] 'read index received'  (duration: 22.386709ms)","trace[1025082844] 'applied index is now lower than readState.Index'  (duration: 105.941795ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T16:30:54.628796Z","caller":"traceutil/trace.go:171","msg":"trace[841586302] transaction","detail":"{read_only:false; response_revision:4759; number_of_response:1; }","duration":"213.219548ms","start":"2026-04-22T16:30:54.415534Z","end":"2026-04-22T16:30:54.628753Z","steps":["trace[841586302] 'process raft request'  (duration: 107.07716ms)","trace[841586302] 'compare'  (duration: 105.508335ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T16:30:54.628875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.713961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ca34ab6d-18cc-49e6-9054-b976aab5a08a\" ","response":"range_response_count:1 size:3766"}
{"level":"info","ts":"2026-04-22T16:30:54.62894Z","caller":"traceutil/trace.go:171","msg":"trace[1245463939] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-ca34ab6d-18cc-49e6-9054-b976aab5a08a; range_end:; response_count:1; response_revision:4759; }","duration":"128.827374ms","start":"2026-04-22T16:30:54.500101Z","end":"2026-04-22T16:30:54.628928Z","steps":["trace[1245463939] 'agreement among raft nodes before linearized reading'  (duration: 128.606589ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:31:06.110214Z","caller":"traceutil/trace.go:171","msg":"trace[1513872486] linearizableReadLoop","detail":"{readStateIndex:5090; appliedIndex:5089; }","duration":"123.087208ms","start":"2026-04-22T16:31:05.987104Z","end":"2026-04-22T16:31:06.110191Z","steps":["trace[1513872486] 'read index received'  (duration: 122.849823ms)","trace[1513872486] 'applied index is now lower than readState.Index'  (duration: 236.685µs)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T16:31:06.110423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.308532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:10392"}
{"level":"info","ts":"2026-04-22T16:31:06.110462Z","caller":"traceutil/trace.go:171","msg":"trace[1522820428] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4905; }","duration":"123.397804ms","start":"2026-04-22T16:31:05.987054Z","end":"2026-04-22T16:31:06.110452Z","steps":["trace[1522820428] 'agreement among raft nodes before linearized reading'  (duration: 123.245481ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:31:06.110685Z","caller":"traceutil/trace.go:171","msg":"trace[829398465] transaction","detail":"{read_only:false; response_revision:4905; number_of_response:1; }","duration":"155.044671ms","start":"2026-04-22T16:31:05.955267Z","end":"2026-04-22T16:31:06.110312Z","steps":["trace[829398465] 'process raft request'  (duration: 154.768876ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:31:06.182029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.923531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"}
{"level":"info","ts":"2026-04-22T16:31:06.182107Z","caller":"traceutil/trace.go:171","msg":"trace[696399720] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4906; }","duration":"179.052243ms","start":"2026-04-22T16:31:06.003035Z","end":"2026-04-22T16:31:06.182088Z","steps":["trace[696399720] 'agreement among raft nodes before linearized reading'  (duration: 178.831659ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:31:06.182104Z","caller":"traceutil/trace.go:171","msg":"trace[1647002426] transaction","detail":"{read_only:false; response_revision:4906; number_of_response:1; }","duration":"118.035631ms","start":"2026-04-22T16:31:06.064039Z","end":"2026-04-22T16:31:06.182074Z","steps":["trace[1647002426] 'process raft request'  (duration: 72.777665ms)","trace[1647002426] 'compare'  (duration: 44.807057ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T16:31:06.887612Z","caller":"traceutil/trace.go:171","msg":"trace[1695167602] transaction","detail":"{read_only:false; response_revision:4915; number_of_response:1; }","duration":"140.063067ms","start":"2026-04-22T16:31:06.747514Z","end":"2026-04-22T16:31:06.887577Z","steps":["trace[1695167602] 'process raft request'  (duration: 91.325439ms)","trace[1695167602] 'compare'  (duration: 48.35052ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T16:31:06.88807Z","caller":"traceutil/trace.go:171","msg":"trace[1403691578] transaction","detail":"{read_only:false; response_revision:4916; number_of_response:1; }","duration":"137.927304ms","start":"2026-04-22T16:31:06.750129Z","end":"2026-04-22T16:31:06.888056Z","steps":["trace[1403691578] 'process raft request'  (duration: 137.2949ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:32:35.686341Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2930}
{"level":"info","ts":"2026-04-22T16:32:35.760222Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2930,"took":"71.495785ms","hash":646453209,"current-db-size-bytes":52510720,"current-db-size":"52 MB","current-db-size-in-use-bytes":29048832,"current-db-size-in-use":"29 MB"}
{"level":"info","ts":"2026-04-22T16:32:35.760351Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":646453209,"revision":2930,"compact-revision":-1}
{"level":"warn","ts":"2026-04-22T16:35:00.483287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.079346ms","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-04-22T16:35:00.483358Z","caller":"traceutil/trace.go:171","msg":"trace[1749537736] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6655; }","duration":"233.198638ms","start":"2026-04-22T16:35:00.250145Z","end":"2026-04-22T16:35:00.483344Z","steps":["trace[1749537736] 'range keys from in-memory index tree'  (duration: 232.930325ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:37:35.697492Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5650}
{"level":"info","ts":"2026-04-22T16:37:35.786373Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5650,"took":"87.75467ms","hash":3832360211,"current-db-size-bytes":52510720,"current-db-size":"52 MB","current-db-size-in-use-bytes":18173952,"current-db-size-in-use":"18 MB"}
{"level":"info","ts":"2026-04-22T16:37:35.786438Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3832360211,"revision":5650,"compact-revision":2930}