{"level":"warn","ts":"2026-04-23T16:29:51.643767Z","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-23T16:29:51.643861Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.116: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.116:2380","--initial-cluster=instance=https://199.19.213.116:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.116:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.116: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-23T16:29:51.643945Z","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-23T16:29:51.643959Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.116:2380"]}
{"level":"info","ts":"2026-04-23T16:29:51.643979Z","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-23T16:29:51.644645Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.116:2379"]}
{"level":"info","ts":"2026-04-23T16:29:51.644722Z","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.116:2380"],"listen-peer-urls":["https://199.19.213.116:2380"],"advertise-client-urls":["https://199.19.213.116:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.116:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.116: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-23T16:29:51.649588Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.576216ms"}
{"level":"info","ts":"2026-04-23T16:29:51.655436Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"ca739d563b259b56","cluster-id":"2052ec4484eed829"}
{"level":"info","ts":"2026-04-23T16:29:51.655574Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca739d563b259b56 switched to configuration voters=()"}
{"level":"info","ts":"2026-04-23T16:29:51.655616Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca739d563b259b56 became follower at term 0"}
{"level":"info","ts":"2026-04-23T16:29:51.655636Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft ca739d563b259b56 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-04-23T16:29:51.655654Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca739d563b259b56 became follower at term 1"}
{"level":"info","ts":"2026-04-23T16:29:51.655707Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca739d563b259b56 switched to configuration voters=(14588176611668237142)"}
{"level":"warn","ts":"2026-04-23T16:29:51.666841Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-04-23T16:29:51.669935Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-04-23T16:29:51.672796Z","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-23T16:29:51.675907Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"ca739d563b259b56","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-04-23T16:29:51.676193Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"ca739d563b259b56","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-04-23T16:29:51.676353Z","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-23T16:29:51.677307Z","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-23T16:29:51.677351Z","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-23T16:29:51.682118Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca739d563b259b56 switched to configuration voters=(14588176611668237142)"}
{"level":"info","ts":"2026-04-23T16:29:51.682363Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"2052ec4484eed829","local-member-id":"ca739d563b259b56","added-peer-id":"ca739d563b259b56","added-peer-peer-urls":["https://199.19.213.116:2380"]}
{"level":"info","ts":"2026-04-23T16:29:51.683259Z","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-23T16:29:51.683346Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.116:2380"}
{"level":"info","ts":"2026-04-23T16:29:51.683381Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.116:2380"}
{"level":"info","ts":"2026-04-23T16:29:51.683576Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"ca739d563b259b56","initial-advertise-peer-urls":["https://199.19.213.116:2380"],"listen-peer-urls":["https://199.19.213.116:2380"],"advertise-client-urls":["https://199.19.213.116:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.116:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-04-23T16:29:51.683612Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-04-23T16:29:51.958727Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca739d563b259b56 is starting a new election at term 1"}
{"level":"info","ts":"2026-04-23T16:29:51.958939Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca739d563b259b56 became pre-candidate at term 1"}
{"level":"info","ts":"2026-04-23T16:29:51.958991Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca739d563b259b56 received MsgPreVoteResp from ca739d563b259b56 at term 1"}
{"level":"info","ts":"2026-04-23T16:29:51.959039Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca739d563b259b56 became candidate at term 2"}
{"level":"info","ts":"2026-04-23T16:29:51.959078Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca739d563b259b56 received MsgVoteResp from ca739d563b259b56 at term 2"}
{"level":"info","ts":"2026-04-23T16:29:51.959118Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca739d563b259b56 became leader at term 2"}
{"level":"info","ts":"2026-04-23T16:29:51.959157Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ca739d563b259b56 elected leader ca739d563b259b56 at term 2"}
{"level":"info","ts":"2026-04-23T16:29:51.960079Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-23T16:29:51.961134Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"ca739d563b259b56","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.116:2379]}","request-path":"/0/members/ca739d563b259b56/attributes","cluster-id":"2052ec4484eed829","publish-timeout":"7s"}
{"level":"info","ts":"2026-04-23T16:29:51.961142Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-23T16:29:51.961226Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-23T16:29:51.962012Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"2052ec4484eed829","local-member-id":"ca739d563b259b56","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-23T16:29:51.962024Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-04-23T16:29:51.962142Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-04-23T16:29:51.962235Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-23T16:29:51.962302Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-23T16:29:51.964396Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.116:2379"}
{"level":"info","ts":"2026-04-23T16:29:51.964722Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-04-23T16:30:08.310202Z","caller":"traceutil/trace.go:171","msg":"trace[565692074] transaction","detail":"{read_only:false; response_revision:402; number_of_response:1; }","duration":"160.172192ms","start":"2026-04-23T16:30:08.149993Z","end":"2026-04-23T16:30:08.310166Z","steps":["trace[565692074] 'process raft request'  (duration: 132.369998ms)","trace[565692074] 'compare'  (duration: 27.676654ms)"],"step_count":2}
{"level":"info","ts":"2026-04-23T16:30:23.050267Z","caller":"traceutil/trace.go:171","msg":"trace[1715806631] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"167.660449ms","start":"2026-04-23T16:30:22.882281Z","end":"2026-04-23T16:30:23.049942Z","steps":["trace[1715806631] 'process raft request'  (duration: 137.05229ms)","trace[1715806631] 'compare'  (duration: 30.404337ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-23T16:30:23.530392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.623064ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11193307351117900975 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/kube-system/cilium-64lcq\" mod_revision:451 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-64lcq\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-64lcq\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-23T16:30:23.530525Z","caller":"traceutil/trace.go:171","msg":"trace[1081688962] linearizableReadLoop","detail":"{readStateIndex:586; appliedIndex:585; }","duration":"383.431825ms","start":"2026-04-23T16:30:23.147079Z","end":"2026-04-23T16:30:23.530511Z","steps":["trace[1081688962] 'read index received'  (duration: 116.080633ms)","trace[1081688962] 'applied index is now lower than readState.Index'  (duration: 267.350162ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-23T16:30:23.530696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.625577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-04-23T16:30:23.530721Z","caller":"traceutil/trace.go:171","msg":"trace[1040702348] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:566; }","duration":"383.651977ms","start":"2026-04-23T16:30:23.147061Z","end":"2026-04-23T16:30:23.530713Z","steps":["trace[1040702348] 'agreement among raft nodes before linearized reading'  (duration: 383.537506ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-23T16:30:23.530749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T16:30:23.146982Z","time spent":"383.761468ms","remote":"127.0.0.1:51116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-04-23T16:30:23.530952Z","caller":"traceutil/trace.go:171","msg":"trace[937685726] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"453.987504ms","start":"2026-04-23T16:30:23.076554Z","end":"2026-04-23T16:30:23.530541Z","steps":["trace[937685726] 'process raft request'  (duration: 186.719643ms)","trace[937685726] 'compare'  (duration: 266.475493ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-23T16:30:23.532229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T16:30:23.076532Z","time spent":"454.533439ms","remote":"127.0.0.1:51024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-64lcq\" mod_revision:451 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-64lcq\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-64lcq\" > >"}
{"level":"warn","ts":"2026-04-23T16:33:20.69521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.051622ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11193307351117904375 > lease_revoke:<id:1b569dbb2d26b6bf>","response":"size:28"}
{"level":"info","ts":"2026-04-23T16:33:20.695784Z","caller":"traceutil/trace.go:171","msg":"trace[309950380] transaction","detail":"{read_only:false; response_revision:2212; number_of_response:1; }","duration":"261.571473ms","start":"2026-04-23T16:33:20.434193Z","end":"2026-04-23T16:33:20.695765Z","steps":["trace[309950380] 'process raft request'  (duration: 261.373838ms)"],"step_count":1}
{"level":"info","ts":"2026-04-23T16:33:20.69579Z","caller":"traceutil/trace.go:171","msg":"trace[78215011] linearizableReadLoop","detail":"{readStateIndex:2303; appliedIndex:2301; }","duration":"168.168271ms","start":"2026-04-23T16:33:20.5276Z","end":"2026-04-23T16:33:20.695768Z","steps":["trace[78215011] 'read index received'  (duration: 167.894443ms)","trace[78215011] 'applied index is now lower than readState.Index'  (duration: 273.018µs)"],"step_count":2}
{"level":"warn","ts":"2026-04-23T16:33:20.695924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.314656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-23T16:33:20.695961Z","caller":"traceutil/trace.go:171","msg":"trace[1595536764] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2213; }","duration":"168.368377ms","start":"2026-04-23T16:33:20.527583Z","end":"2026-04-23T16:33:20.695952Z","steps":["trace[1595536764] 'agreement among raft nodes before linearized reading'  (duration: 168.292845ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-23T16:33:20.696056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.566815ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-04-23T16:33:20.696114Z","caller":"traceutil/trace.go:171","msg":"trace[1027007590] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2213; }","duration":"167.686718ms","start":"2026-04-23T16:33:20.528412Z","end":"2026-04-23T16:33:20.696099Z","steps":["trace[1027007590] 'agreement among raft nodes before linearized reading'  (duration: 167.522194ms)"],"step_count":1}
{"level":"info","ts":"2026-04-23T16:33:20.695944Z","caller":"traceutil/trace.go:171","msg":"trace[1138492491] transaction","detail":"{read_only:false; response_revision:2213; number_of_response:1; }","duration":"255.650265ms","start":"2026-04-23T16:33:20.440241Z","end":"2026-04-23T16:33:20.695892Z","steps":["trace[1138492491] 'process raft request'  (duration: 255.466959ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-23T16:33:53.681968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.224391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-04-23T16:33:53.682093Z","caller":"traceutil/trace.go:171","msg":"trace[1219413424] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2484; }","duration":"124.647133ms","start":"2026-04-23T16:33:53.557423Z","end":"2026-04-23T16:33:53.68207Z","steps":["trace[1219413424] 'range keys from in-memory index tree'  (duration: 124.043256ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-23T16:33:54.293464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.381043ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11193307351117904940 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:2476 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-23T16:33:54.293559Z","caller":"traceutil/trace.go:171","msg":"trace[548138831] linearizableReadLoop","detail":"{readStateIndex:2587; appliedIndex:2586; }","duration":"252.686389ms","start":"2026-04-23T16:33:54.040858Z","end":"2026-04-23T16:33:54.293545Z","steps":["trace[548138831] 'read index received'  (duration: 24.09527ms)","trace[548138831] 'applied index is now lower than readState.Index'  (duration: 228.589699ms)"],"step_count":2}
{"level":"info","ts":"2026-04-23T16:33:54.293668Z","caller":"traceutil/trace.go:171","msg":"trace[211848253] transaction","detail":"{read_only:false; response_revision:2487; number_of_response:1; }","duration":"269.424273ms","start":"2026-04-23T16:33:54.024187Z","end":"2026-04-23T16:33:54.293611Z","steps":["trace[211848253] 'process raft request'  (duration: 40.812344ms)","trace[211848253] 'compare'  (duration: 228.085615ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-23T16:33:54.293729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.883574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-04-23T16:33:54.293751Z","caller":"traceutil/trace.go:171","msg":"trace[1061228875] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2487; }","duration":"252.996947ms","start":"2026-04-23T16:33:54.040747Z","end":"2026-04-23T16:33:54.293744Z","steps":["trace[1061228875] 'agreement among raft nodes before linearized reading'  (duration: 252.876224ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-23T16:33:54.293757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.397169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-04-23T16:33:54.293813Z","caller":"traceutil/trace.go:171","msg":"trace[250884922] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2487; }","duration":"223.456161ms","start":"2026-04-23T16:33:54.070342Z","end":"2026-04-23T16:33:54.293798Z","steps":["trace[250884922] 'agreement among raft nodes before linearized reading'  (duration: 223.307027ms)"],"step_count":1}
{"level":"info","ts":"2026-04-23T16:33:55.214784Z","caller":"traceutil/trace.go:171","msg":"trace[1285158005] transaction","detail":"{read_only:false; response_revision:2491; number_of_response:1; }","duration":"140.172586ms","start":"2026-04-23T16:33:55.074585Z","end":"2026-04-23T16:33:55.214758Z","steps":["trace[1285158005] 'process raft request'  (duration: 139.93662ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-23T16:33:55.359686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.419951ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11193307351117904954 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:2480 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-23T16:33:55.360003Z","caller":"traceutil/trace.go:171","msg":"trace[754247059] transaction","detail":"{read_only:false; response_revision:2493; number_of_response:1; }","duration":"175.479662ms","start":"2026-04-23T16:33:55.184502Z","end":"2026-04-23T16:33:55.359982Z","steps":["trace[754247059] 'process raft request'  (duration: 175.357907ms)"],"step_count":1}
{"level":"info","ts":"2026-04-23T16:33:55.360096Z","caller":"traceutil/trace.go:171","msg":"trace[977993778] transaction","detail":"{read_only:false; response_revision:2492; number_of_response:1; }","duration":"285.077171ms","start":"2026-04-23T16:33:55.074972Z","end":"2026-04-23T16:33:55.360049Z","steps":["trace[977993778] 'process raft request'  (duration: 172.169705ms)","trace[977993778] 'compare'  (duration: 112.284347ms)"],"step_count":2}
{"level":"info","ts":"2026-04-23T16:33:55.360152Z","caller":"traceutil/trace.go:171","msg":"trace[1922611363] linearizableReadLoop","detail":"{readStateIndex:2592; appliedIndex:2590; }","duration":"283.781593ms","start":"2026-04-23T16:33:55.07634Z","end":"2026-04-23T16:33:55.360121Z","steps":["trace[1922611363] 'read index received'  (duration: 138.180569ms)","trace[1922611363] 'applied index is now lower than readState.Index'  (duration: 145.598224ms)"],"step_count":2}
{"level":"info","ts":"2026-04-23T16:33:55.360285Z","caller":"traceutil/trace.go:171","msg":"trace[1435206409] transaction","detail":"{read_only:false; response_revision:2494; number_of_response:1; }","duration":"148.049545ms","start":"2026-04-23T16:33:55.212221Z","end":"2026-04-23T16:33:55.360271Z","steps":["trace[1435206409] 'process raft request'  (duration: 147.713164ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-23T16:33:55.360504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.255562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-23T16:33:55.360645Z","caller":"traceutil/trace.go:171","msg":"trace[1106232416] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:2494; }","duration":"279.414527ms","start":"2026-04-23T16:33:55.081178Z","end":"2026-04-23T16:33:55.360593Z","steps":["trace[1106232416] 'agreement among raft nodes before linearized reading'  (duration: 279.16447ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-23T16:33:55.361866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.497352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-04-23T16:33:55.362184Z","caller":"traceutil/trace.go:171","msg":"trace[1801512445] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2494; }","duration":"285.843673ms","start":"2026-04-23T16:33:55.076323Z","end":"2026-04-23T16:33:55.362167Z","steps":["trace[1801512445] 'agreement among raft nodes before linearized reading'  (duration: 284.173384ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-23T16:33:55.781448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.809116ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11193307351117904960 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:15-second id:1b569dbb2d26bc3f>","response":"size:40"}
{"level":"info","ts":"2026-04-23T16:33:55.781585Z","caller":"traceutil/trace.go:171","msg":"trace[1364568156] linearizableReadLoop","detail":"{readStateIndex:2595; appliedIndex:2594; }","duration":"335.485293ms","start":"2026-04-23T16:33:55.446074Z","end":"2026-04-23T16:33:55.781559Z","steps":["trace[1364568156] 'read index received'  (duration: 63.535143ms)","trace[1364568156] 'applied index is now lower than readState.Index'  (duration: 271.94791ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-23T16:33:55.781672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T16:33:55.362446Z","time spent":"419.222183ms","remote":"127.0.0.1:50870","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-04-23T16:33:55.781938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.855624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-23T16:33:55.781981Z","caller":"traceutil/trace.go:171","msg":"trace[1007641634] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:2494; }","duration":"335.953717ms","start":"2026-04-23T16:33:55.446016Z","end":"2026-04-23T16:33:55.78197Z","steps":["trace[1007641634] 'agreement among raft nodes before linearized reading'  (duration: 335.829963ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-23T16:33:55.78201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T16:33:55.445995Z","time spent":"336.007768ms","remote":"127.0.0.1:51154","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":30,"request content":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true "}
{"level":"warn","ts":"2026-04-23T16:33:55.801197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.811667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-04-23T16:33:55.801292Z","caller":"traceutil/trace.go:171","msg":"trace[1760012706] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2495; }","duration":"250.934801ms","start":"2026-04-23T16:33:55.550319Z","end":"2026-04-23T16:33:55.801254Z","steps":["trace[1760012706] 'agreement among raft nodes before linearized reading'  (duration: 250.707434ms)"],"step_count":1}
{"level":"info","ts":"2026-04-23T16:33:55.801606Z","caller":"traceutil/trace.go:171","msg":"trace[1057848013] transaction","detail":"{read_only:false; response_revision:2495; number_of_response:1; }","duration":"135.192302ms","start":"2026-04-23T16:33:55.666405Z","end":"2026-04-23T16:33:55.801597Z","steps":["trace[1057848013] 'process raft request'  (duration: 134.459511ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-23T16:33:55.802259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.964588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-23T16:33:55.802284Z","caller":"traceutil/trace.go:171","msg":"trace[822107457] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:2496; }","duration":"132.03125ms","start":"2026-04-23T16:33:55.670246Z","end":"2026-04-23T16:33:55.802277Z","steps":["trace[822107457] 'agreement among raft nodes before linearized reading'  (duration: 131.983119ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-23T16:35:40.00872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.459587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"}
{"level":"warn","ts":"2026-04-23T16:35:40.008767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.835984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-04-23T16:35:40.008853Z","caller":"traceutil/trace.go:171","msg":"trace[907199569] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:3122; }","duration":"104.65287ms","start":"2026-04-23T16:35:39.904171Z","end":"2026-04-23T16:35:40.008824Z","steps":["trace[907199569] 'range keys from in-memory index tree'  (duration: 104.188393ms)"],"step_count":1}
{"level":"info","ts":"2026-04-23T16:35:40.008869Z","caller":"traceutil/trace.go:171","msg":"trace[1190544732] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:3122; }","duration":"161.985506ms","start":"2026-04-23T16:35:39.846859Z","end":"2026-04-23T16:35:40.008845Z","steps":["trace[1190544732] 'range keys from in-memory index tree'  (duration: 161.56985ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-23T16:36:16.770074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.756695ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11193307351117907026 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:3313 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-23T16:36:16.770333Z","caller":"traceutil/trace.go:171","msg":"trace[2041894838] transaction","detail":"{read_only:false; response_revision:3326; number_of_response:1; }","duration":"227.859866ms","start":"2026-04-23T16:36:16.542446Z","end":"2026-04-23T16:36:16.770306Z","steps":["trace[2041894838] 'process raft request'  (duration: 227.776724ms)"],"step_count":1}
{"level":"info","ts":"2026-04-23T16:36:16.770533Z","caller":"traceutil/trace.go:171","msg":"trace[1750470419] transaction","detail":"{read_only:false; response_revision:3325; number_of_response:1; }","duration":"244.880716ms","start":"2026-04-23T16:36:16.525624Z","end":"2026-04-23T16:36:16.770504Z","steps":["trace[1750470419] 'process raft request'  (duration: 121.579451ms)","trace[1750470419] 'compare'  (duration: 122.596931ms)"],"step_count":2}
{"level":"info","ts":"2026-04-23T16:36:16.770667Z","caller":"traceutil/trace.go:171","msg":"trace[723594689] linearizableReadLoop","detail":"{readStateIndex:3456; appliedIndex:3455; }","duration":"241.90822ms","start":"2026-04-23T16:36:16.528638Z","end":"2026-04-23T16:36:16.770547Z","steps":["trace[723594689] 'read index received'  (duration: 5.485934ms)","trace[723594689] 'applied index is now lower than readState.Index'  (duration: 236.418726ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-23T16:36:16.77087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.193185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-23T16:36:16.770976Z","caller":"traceutil/trace.go:171","msg":"trace[828453827] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3326; }","duration":"242.349288ms","start":"2026-04-23T16:36:16.528601Z","end":"2026-04-23T16:36:16.770951Z","steps":["trace[828453827] 'agreement among raft nodes before linearized reading'  (duration: 242.142644ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-23T16:39:17.775577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.338931ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11193307351117910319 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:4586 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-23T16:39:17.775789Z","caller":"traceutil/trace.go:171","msg":"trace[1103456138] linearizableReadLoop","detail":"{readStateIndex:4775; appliedIndex:4774; }","duration":"217.853092ms","start":"2026-04-23T16:39:17.557915Z","end":"2026-04-23T16:39:17.775769Z","steps":["trace[1103456138] 'read index received'  (duration: 99.085351ms)","trace[1103456138] 'applied index is now lower than readState.Index'  (duration: 118.765891ms)"],"step_count":2}
{"level":"info","ts":"2026-04-23T16:39:17.775921Z","caller":"traceutil/trace.go:171","msg":"trace[1645797651] transaction","detail":"{read_only:false; response_revision:4602; number_of_response:1; }","duration":"225.696087ms","start":"2026-04-23T16:39:17.550208Z","end":"2026-04-23T16:39:17.775904Z","steps":["trace[1645797651] 'process raft request'  (duration: 106.914286ms)","trace[1645797651] 'compare'  (duration: 118.052293ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-23T16:39:17.776397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.455996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-04-23T16:39:17.776515Z","caller":"traceutil/trace.go:171","msg":"trace[1112505644] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4602; }","duration":"218.752193ms","start":"2026-04-23T16:39:17.557733Z","end":"2026-04-23T16:39:17.776485Z","steps":["trace[1112505644] 'agreement among raft nodes before linearized reading'  (duration: 218.458486ms)"],"step_count":1}
{"level":"info","ts":"2026-04-23T16:39:52.18805Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2814}
{"level":"info","ts":"2026-04-23T16:39:52.32993Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2814,"took":"140.497469ms","hash":2275257244,"current-db-size-bytes":44634112,"current-db-size":"45 MB","current-db-size-in-use-bytes":20369408,"current-db-size-in-use":"20 MB"}
{"level":"info","ts":"2026-04-23T16:39:52.33Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2275257244,"revision":2814,"compact-revision":-1}
{"level":"info","ts":"2026-04-23T16:40:25.727872Z","caller":"traceutil/trace.go:171","msg":"trace[1147005088] transaction","detail":"{read_only:false; response_revision:5713; number_of_response:1; }","duration":"168.676571ms","start":"2026-04-23T16:40:25.559143Z","end":"2026-04-23T16:40:25.727819Z","steps":["trace[1147005088] 'process raft request'  (duration: 168.422045ms)"],"step_count":1}
{"level":"info","ts":"2026-04-23T16:42:27.641355Z","caller":"traceutil/trace.go:171","msg":"trace[1526410662] transaction","detail":"{read_only:false; response_revision:6656; number_of_response:1; }","duration":"111.627931ms","start":"2026-04-23T16:42:27.5297Z","end":"2026-04-23T16:42:27.641328Z","steps":["trace[1526410662] 'process raft request'  (duration: 110.991155ms)"],"step_count":1}
{"level":"info","ts":"2026-04-23T16:42:50.304522Z","caller":"traceutil/trace.go:171","msg":"trace[663921285] linearizableReadLoop","detail":"{readStateIndex:7080; appliedIndex:7079; }","duration":"100.063248ms","start":"2026-04-23T16:42:50.204434Z","end":"2026-04-23T16:42:50.304498Z","steps":["trace[663921285] 'read index received'  (duration: 99.935066ms)","trace[663921285] 'applied index is now lower than readState.Index'  (duration: 127.562µs)"],"step_count":2}
{"level":"warn","ts":"2026-04-23T16:42:50.304814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.291109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-04-23T16:42:50.304898Z","caller":"traceutil/trace.go:171","msg":"trace[1636436347] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6826; }","duration":"100.44073ms","start":"2026-04-23T16:42:50.204428Z","end":"2026-04-23T16:42:50.304869Z","steps":["trace[1636436347] 'agreement among raft nodes before linearized reading'  (duration: 100.175999ms)"],"step_count":1}
{"level":"info","ts":"2026-04-23T16:42:50.305292Z","caller":"traceutil/trace.go:171","msg":"trace[345476941] transaction","detail":"{read_only:false; response_revision:6826; number_of_response:1; }","duration":"107.901303ms","start":"2026-04-23T16:42:50.197344Z","end":"2026-04-23T16:42:50.305246Z","steps":["trace[345476941] 'process raft request'  (duration: 107.028106ms)"],"step_count":1}