{"level":"warn","ts":"2026-05-18T17:40:38.486808Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-18T17:40:38.486921Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.91: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.91:2380","--initial-cluster=instance=https://199.19.213.91:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.91:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.91:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-05-18T17:40:38.487023Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-18T17:40:38.487044Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.91:2380"]}
{"level":"info","ts":"2026-05-18T17:40:38.487074Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-05-18T17:40:38.48839Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.91:2379"]}
{"level":"info","ts":"2026-05-18T17:40:38.488524Z","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.91:2380"],"listen-peer-urls":["https://199.19.213.91:2380"],"advertise-client-urls":["https://199.19.213.91:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.91:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.91:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-05-18T17:40:38.493546Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.60359ms"}
{"level":"info","ts":"2026-05-18T17:40:38.504117Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"2c24222821500990","cluster-id":"f38faa6ba493daad"}
{"level":"info","ts":"2026-05-18T17:40:38.504219Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2c24222821500990 switched to configuration voters=()"}
{"level":"info","ts":"2026-05-18T17:40:38.504246Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2c24222821500990 became follower at term 0"}
{"level":"info","ts":"2026-05-18T17:40:38.504258Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 2c24222821500990 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-05-18T17:40:38.504271Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2c24222821500990 became follower at term 1"}
{"level":"info","ts":"2026-05-18T17:40:38.50431Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2c24222821500990 switched to configuration voters=(3180704792583342480)"}
{"level":"warn","ts":"2026-05-18T17:40:38.513629Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-05-18T17:40:38.515418Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-05-18T17:40:38.516832Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
{"level":"info","ts":"2026-05-18T17:40:38.519897Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"2c24222821500990","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-05-18T17:40:38.520829Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"2c24222821500990","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-05-18T17:40:38.520923Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-05-18T17:40:38.521442Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-05-18T17:40:38.521465Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-05-18T17:40:38.521751Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2c24222821500990 switched to configuration voters=(3180704792583342480)"}
{"level":"info","ts":"2026-05-18T17:40:38.521947Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"f38faa6ba493daad","local-member-id":"2c24222821500990","added-peer-id":"2c24222821500990","added-peer-peer-urls":["https://199.19.213.91:2380"]}
{"level":"info","ts":"2026-05-18T17:40:38.52569Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-05-18T17:40:38.525894Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.91:2380"}
{"level":"info","ts":"2026-05-18T17:40:38.525931Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.91:2380"}
{"level":"info","ts":"2026-05-18T17:40:38.526739Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-05-18T17:40:38.526685Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"2c24222821500990","initial-advertise-peer-urls":["https://199.19.213.91:2380"],"listen-peer-urls":["https://199.19.213.91:2380"],"advertise-client-urls":["https://199.19.213.91:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.91:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-05-18T17:40:39.404951Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2c24222821500990 is starting a new election at term 1"}
{"level":"info","ts":"2026-05-18T17:40:39.405053Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2c24222821500990 became pre-candidate at term 1"}
{"level":"info","ts":"2026-05-18T17:40:39.405125Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2c24222821500990 received MsgPreVoteResp from 2c24222821500990 at term 1"}
{"level":"info","ts":"2026-05-18T17:40:39.405149Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2c24222821500990 became candidate at term 2"}
{"level":"info","ts":"2026-05-18T17:40:39.405193Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2c24222821500990 received MsgVoteResp from 2c24222821500990 at term 2"}
{"level":"info","ts":"2026-05-18T17:40:39.405223Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2c24222821500990 became leader at term 2"}
{"level":"info","ts":"2026-05-18T17:40:39.405242Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 2c24222821500990 elected leader 2c24222821500990 at term 2"}
{"level":"info","ts":"2026-05-18T17:40:39.406424Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-18T17:40:39.411288Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"2c24222821500990","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.91:2379]}","request-path":"/0/members/2c24222821500990/attributes","cluster-id":"f38faa6ba493daad","publish-timeout":"7s"}
{"level":"info","ts":"2026-05-18T17:40:39.411339Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-18T17:40:39.412032Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-18T17:40:39.412247Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-05-18T17:40:39.412337Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-05-18T17:40:39.412836Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"f38faa6ba493daad","local-member-id":"2c24222821500990","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-18T17:40:39.412999Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-18T17:40:39.413061Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-18T17:40:39.415813Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.91:2379"}
{"level":"info","ts":"2026-05-18T17:40:39.416033Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-05-18T17:41:13.339565Z","caller":"traceutil/trace.go:171","msg":"trace[1826446028] linearizableReadLoop","detail":"{readStateIndex:591; appliedIndex:590; }","duration":"246.47225ms","start":"2026-05-18T17:41:13.09306Z","end":"2026-05-18T17:41:13.339532Z","steps":["trace[1826446028] 'read index received'  (duration: 245.678667ms)","trace[1826446028] 'applied index is now lower than readState.Index'  (duration: 792.143µs)"],"step_count":2}
{"level":"info","ts":"2026-05-18T17:41:13.339621Z","caller":"traceutil/trace.go:171","msg":"trace[1628588135] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"280.028474ms","start":"2026-05-18T17:41:13.059558Z","end":"2026-05-18T17:41:13.339587Z","steps":["trace[1628588135] 'process raft request'  (duration: 279.335556ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T17:41:13.340032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.937656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-9wxbs\" ","response":"range_response_count:1 size:16961"}
{"level":"info","ts":"2026-05-18T17:41:13.340129Z","caller":"traceutil/trace.go:171","msg":"trace[1852356666] range","detail":"{range_begin:/registry/pods/kube-system/cilium-9wxbs; range_end:; response_count:1; response_revision:568; }","duration":"247.077493ms","start":"2026-05-18T17:41:13.093034Z","end":"2026-05-18T17:41:13.340111Z","steps":["trace[1852356666] 'agreement among raft nodes before linearized reading'  (duration: 246.689432ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T17:41:13.507445Z","caller":"traceutil/trace.go:171","msg":"trace[1877000416] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"152.522439ms","start":"2026-05-18T17:41:13.354887Z","end":"2026-05-18T17:41:13.507409Z","steps":["trace[1877000416] 'process raft request'  (duration: 152.189471ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T17:41:13.508136Z","caller":"traceutil/trace.go:171","msg":"trace[1740470834] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"110.966482ms","start":"2026-05-18T17:41:13.397142Z","end":"2026-05-18T17:41:13.508108Z","steps":["trace[1740470834] 'process raft request'  (duration: 110.180169ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T17:41:13.930557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.882582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-05-18T17:41:13.930634Z","caller":"traceutil/trace.go:171","msg":"trace[387903564] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:572; }","duration":"108.008319ms","start":"2026-05-18T17:41:13.822608Z","end":"2026-05-18T17:41:13.930616Z","steps":["trace[387903564] 'range keys from in-memory index tree'  (duration: 107.731413ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T17:41:59.943645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.36338ms","expected-duration":"100ms","prefix":"","request":"header:<ID:689224724276834602 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:1132 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-18T17:41:59.943791Z","caller":"traceutil/trace.go:171","msg":"trace[1407503665] transaction","detail":"{read_only:false; response_revision:1138; number_of_response:1; }","duration":"203.456353ms","start":"2026-05-18T17:41:59.740311Z","end":"2026-05-18T17:41:59.943767Z","steps":["trace[1407503665] 'process raft request'  (duration: 82.23464ms)","trace[1407503665] 'compare'  (duration: 120.229212ms)"],"step_count":2}
{"level":"info","ts":"2026-05-18T17:42:46.792845Z","caller":"traceutil/trace.go:171","msg":"trace[1836382956] linearizableReadLoop","detail":"{readStateIndex:1880; appliedIndex:1879; }","duration":"258.950713ms","start":"2026-05-18T17:42:46.533865Z","end":"2026-05-18T17:42:46.792816Z","steps":["trace[1836382956] 'read index received'  (duration: 258.695849ms)","trace[1836382956] 'applied index is now lower than readState.Index'  (duration: 253.784µs)"],"step_count":2}
{"level":"info","ts":"2026-05-18T17:42:46.793208Z","caller":"traceutil/trace.go:171","msg":"trace[1746140560] transaction","detail":"{read_only:false; response_revision:1809; number_of_response:1; }","duration":"271.15915ms","start":"2026-05-18T17:42:46.522032Z","end":"2026-05-18T17:42:46.793191Z","steps":["trace[1746140560] 'process raft request'  (duration: 270.621831ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T17:42:46.793373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.137745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5a0d8993-374c-4f8f-ad76-1514fb39dbf4\" ","response":"range_response_count:1 size:3626"}
{"level":"warn","ts":"2026-05-18T17:42:46.793342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.44675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-18T17:42:46.793432Z","caller":"traceutil/trace.go:171","msg":"trace[2050348053] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-5a0d8993-374c-4f8f-ad76-1514fb39dbf4; range_end:; response_count:1; response_revision:1809; }","duration":"225.271077ms","start":"2026-05-18T17:42:46.568144Z","end":"2026-05-18T17:42:46.793415Z","steps":["trace[2050348053] 'agreement among raft nodes before linearized reading'  (duration: 225.001843ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T17:42:46.793455Z","caller":"traceutil/trace.go:171","msg":"trace[1315240829] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1809; }","duration":"259.630143ms","start":"2026-05-18T17:42:46.533801Z","end":"2026-05-18T17:42:46.793431Z","steps":["trace[1315240829] 'agreement among raft nodes before linearized reading'  (duration: 259.40332ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T17:42:46.904607Z","caller":"traceutil/trace.go:171","msg":"trace[1683210199] transaction","detail":"{read_only:false; response_revision:1810; number_of_response:1; }","duration":"103.481005ms","start":"2026-05-18T17:42:46.800821Z","end":"2026-05-18T17:42:46.904302Z","steps":["trace[1683210199] 'process raft request'  (duration: 103.224031ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T17:42:47.22102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.710368ms","expected-duration":"100ms","prefix":"","request":"header:<ID:689224724276835966 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" mod_revision:1759 > success:<request_put:<key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" value_size:10909 >> failure:<request_range:<key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-18T17:42:47.221316Z","caller":"traceutil/trace.go:171","msg":"trace[1299789594] transaction","detail":"{read_only:false; response_revision:1812; number_of_response:1; }","duration":"299.326351ms","start":"2026-05-18T17:42:46.921855Z","end":"2026-05-18T17:42:47.221182Z","steps":["trace[1299789594] 'process raft request'  (duration: 122.300397ms)","trace[1299789594] 'compare'  (duration: 176.479295ms)"],"step_count":2}
{"level":"info","ts":"2026-05-18T17:42:47.253197Z","caller":"traceutil/trace.go:171","msg":"trace[665508382] transaction","detail":"{read_only:false; response_revision:1813; number_of_response:1; }","duration":"192.87943ms","start":"2026-05-18T17:42:47.060281Z","end":"2026-05-18T17:42:47.25316Z","steps":["trace[665508382] 'process raft request'  (duration: 192.697177ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T17:43:02.865306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.523379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"}
{"level":"info","ts":"2026-05-18T17:43:02.865395Z","caller":"traceutil/trace.go:171","msg":"trace[1382229605] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:1942; }","duration":"244.726814ms","start":"2026-05-18T17:43:02.620648Z","end":"2026-05-18T17:43:02.865375Z","steps":["trace[1382229605] 'range keys from in-memory index tree'  (duration: 244.281853ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T17:43:21.72251Z","caller":"traceutil/trace.go:171","msg":"trace[173088131] linearizableReadLoop","detail":"{readStateIndex:2134; appliedIndex:2133; }","duration":"189.318537ms","start":"2026-05-18T17:43:21.53317Z","end":"2026-05-18T17:43:21.722488Z","steps":["trace[173088131] 'read index received'  (duration: 189.169282ms)","trace[173088131] 'applied index is now lower than readState.Index'  (duration: 148.215µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-18T17:43:21.722679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.567585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-18T17:43:21.722646Z","caller":"traceutil/trace.go:171","msg":"trace[1690740853] transaction","detail":"{read_only:false; response_revision:2056; number_of_response:1; }","duration":"214.396206ms","start":"2026-05-18T17:43:21.508211Z","end":"2026-05-18T17:43:21.722607Z","steps":["trace[1690740853] 'process raft request'  (duration: 214.115826ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T17:43:21.722722Z","caller":"traceutil/trace.go:171","msg":"trace[711848876] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2056; }","duration":"189.666768ms","start":"2026-05-18T17:43:21.533046Z","end":"2026-05-18T17:43:21.722713Z","steps":["trace[711848876] 'agreement among raft nodes before linearized reading'  (duration: 189.562825ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T17:43:21.752303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.534487ms","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-05-18T17:43:21.752384Z","caller":"traceutil/trace.go:171","msg":"trace[1761306768] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2057; }","duration":"164.684131ms","start":"2026-05-18T17:43:21.58768Z","end":"2026-05-18T17:43:21.752364Z","steps":["trace[1761306768] 'agreement among raft nodes before linearized reading'  (duration: 164.400652ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T17:43:21.75283Z","caller":"traceutil/trace.go:171","msg":"trace[1468934984] transaction","detail":"{read_only:false; response_revision:2057; number_of_response:1; }","duration":"152.410321ms","start":"2026-05-18T17:43:21.600402Z","end":"2026-05-18T17:43:21.752812Z","steps":["trace[1468934984] 'process raft request'  (duration: 151.462819ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T17:44:14.626333Z","caller":"traceutil/trace.go:171","msg":"trace[322475553] transaction","detail":"{read_only:false; response_revision:2414; number_of_response:1; }","duration":"238.473378ms","start":"2026-05-18T17:44:14.387807Z","end":"2026-05-18T17:44:14.626281Z","steps":["trace[322475553] 'process raft request'  (duration: 213.969056ms)","trace[322475553] 'compare'  (duration: 24.210359ms)"],"step_count":2}
{"level":"info","ts":"2026-05-18T17:44:14.626536Z","caller":"traceutil/trace.go:171","msg":"trace[1496041876] transaction","detail":"{read_only:false; response_revision:2416; number_of_response:1; }","duration":"205.526515ms","start":"2026-05-18T17:44:14.420992Z","end":"2026-05-18T17:44:14.626519Z","steps":["trace[1496041876] 'process raft request'  (duration: 205.315026ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T17:44:14.626389Z","caller":"traceutil/trace.go:171","msg":"trace[983065388] transaction","detail":"{read_only:false; response_revision:2415; number_of_response:1; }","duration":"238.243228ms","start":"2026-05-18T17:44:14.388118Z","end":"2026-05-18T17:44:14.626361Z","steps":["trace[983065388] 'process raft request'  (duration: 238.052219ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T17:44:16.940569Z","caller":"traceutil/trace.go:171","msg":"trace[1776600718] linearizableReadLoop","detail":"{readStateIndex:2551; appliedIndex:2550; }","duration":"202.373023ms","start":"2026-05-18T17:44:16.738175Z","end":"2026-05-18T17:44:16.940548Z","steps":["trace[1776600718] 'read index received'  (duration: 197.27605ms)","trace[1776600718] 'applied index is now lower than readState.Index'  (duration: 5.094742ms)"],"step_count":2}
{"level":"info","ts":"2026-05-18T17:44:16.940867Z","caller":"traceutil/trace.go:171","msg":"trace[1037987258] transaction","detail":"{read_only:false; response_revision:2460; number_of_response:1; }","duration":"206.653947ms","start":"2026-05-18T17:44:16.7342Z","end":"2026-05-18T17:44:16.940854Z","steps":["trace[1037987258] 'process raft request'  (duration: 201.188808ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T17:44:16.941211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.013021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"}
{"level":"info","ts":"2026-05-18T17:44:16.941347Z","caller":"traceutil/trace.go:171","msg":"trace[1406352970] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2460; }","duration":"203.152848ms","start":"2026-05-18T17:44:16.738154Z","end":"2026-05-18T17:44:16.941307Z","steps":["trace[1406352970] 'agreement among raft nodes before linearized reading'  (duration: 202.936508ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T17:48:37.32313Z","caller":"traceutil/trace.go:171","msg":"trace[1622416965] transaction","detail":"{read_only:false; response_revision:4611; number_of_response:1; }","duration":"238.740037ms","start":"2026-05-18T17:48:37.084353Z","end":"2026-05-18T17:48:37.323093Z","steps":["trace[1622416965] 'process raft request'  (duration: 238.11561ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T17:48:37.323893Z","caller":"traceutil/trace.go:171","msg":"trace[1070250540] linearizableReadLoop","detail":"{readStateIndex:4787; appliedIndex:4786; }","duration":"235.44286ms","start":"2026-05-18T17:48:37.087588Z","end":"2026-05-18T17:48:37.323031Z","steps":["trace[1070250540] 'read index received'  (duration: 234.693461ms)","trace[1070250540] 'applied index is now lower than readState.Index'  (duration: 747.689µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-18T17:48:37.324123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.350335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3316"}
{"level":"info","ts":"2026-05-18T17:48:37.325304Z","caller":"traceutil/trace.go:171","msg":"trace[2146773044] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4611; }","duration":"237.6919ms","start":"2026-05-18T17:48:37.087564Z","end":"2026-05-18T17:48:37.325256Z","steps":["trace[2146773044] 'agreement among raft nodes before linearized reading'  (duration: 236.096568ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T17:48:37.39741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.708684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" ","response":"range_response_count:1 size:897"}
{"level":"info","ts":"2026-05-18T17:48:37.397584Z","caller":"traceutil/trace.go:171","msg":"trace[184169626] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/local-path-provisioner; range_end:; response_count:1; response_revision:4612; }","duration":"211.92721ms","start":"2026-05-18T17:48:37.185634Z","end":"2026-05-18T17:48:37.397561Z","steps":["trace[184169626] 'agreement among raft nodes before linearized reading'  (duration: 211.56125ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T17:48:37.397781Z","caller":"traceutil/trace.go:171","msg":"trace[1811208628] transaction","detail":"{read_only:false; response_revision:4612; number_of_response:1; }","duration":"309.26205ms","start":"2026-05-18T17:48:37.088425Z","end":"2026-05-18T17:48:37.397687Z","steps":["trace[1811208628] 'process raft request'  (duration: 308.575482ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T17:48:37.397902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T17:48:37.088403Z","time spent":"309.424885ms","remote":"127.0.0.1:54050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9624,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" mod_revision:4604 > success:<request_put:<key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" value_size:9559 >> failure:<request_range:<key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" > >"}
{"level":"warn","ts":"2026-05-18T17:48:37.397838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.507764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1821"}
{"level":"info","ts":"2026-05-18T17:48:37.398043Z","caller":"traceutil/trace.go:171","msg":"trace[1992997191] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4612; }","duration":"299.977976ms","start":"2026-05-18T17:48:37.098032Z","end":"2026-05-18T17:48:37.39801Z","steps":["trace[1992997191] 'agreement among raft nodes before linearized reading'  (duration: 299.37751ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T17:48:37.398381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T17:48:37.098017Z","time spent":"300.12917ms","remote":"127.0.0.1:53702","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":1844,"request content":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" "}
{"level":"info","ts":"2026-05-18T17:48:37.779952Z","caller":"traceutil/trace.go:171","msg":"trace[1175771510] transaction","detail":"{read_only:false; response_revision:4625; number_of_response:1; }","duration":"232.913063ms","start":"2026-05-18T17:48:37.547011Z","end":"2026-05-18T17:48:37.779924Z","steps":["trace[1175771510] 'process raft request'  (duration: 232.710778ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T17:48:37.821337Z","caller":"traceutil/trace.go:171","msg":"trace[1262008209] transaction","detail":"{read_only:false; response_revision:4626; number_of_response:1; }","duration":"263.794629ms","start":"2026-05-18T17:48:37.557515Z","end":"2026-05-18T17:48:37.821309Z","steps":["trace[1262008209] 'process raft request'  (duration: 263.338057ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T17:48:37.838216Z","caller":"traceutil/trace.go:171","msg":"trace[284634207] linearizableReadLoop","detail":"{readStateIndex:4802; appliedIndex:4800; }","duration":"269.042708ms","start":"2026-05-18T17:48:37.569115Z","end":"2026-05-18T17:48:37.838158Z","steps":["trace[284634207] 'read index received'  (duration: 210.526562ms)","trace[284634207] 'applied index is now lower than readState.Index'  (duration: 58.515086ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-18T17:48:37.838626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.49725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:9639"}
{"level":"info","ts":"2026-05-18T17:48:37.838676Z","caller":"traceutil/trace.go:171","msg":"trace[1511193577] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:4626; }","duration":"269.593342ms","start":"2026-05-18T17:48:37.569072Z","end":"2026-05-18T17:48:37.838665Z","steps":["trace[1511193577] 'agreement among raft nodes before linearized reading'  (duration: 269.424958ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T17:48:37.839035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.338276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-18T17:48:37.839076Z","caller":"traceutil/trace.go:171","msg":"trace[628972785] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4626; }","duration":"188.406058ms","start":"2026-05-18T17:48:37.65066Z","end":"2026-05-18T17:48:37.839066Z","steps":["trace[628972785] 'agreement among raft nodes before linearized reading'  (duration: 188.347116ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T17:48:37.839255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.811479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"}
{"level":"info","ts":"2026-05-18T17:48:37.839318Z","caller":"traceutil/trace.go:171","msg":"trace[725684655] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4626; }","duration":"146.912712ms","start":"2026-05-18T17:48:37.69239Z","end":"2026-05-18T17:48:37.839303Z","steps":["trace[725684655] 'agreement among raft nodes before linearized reading'  (duration: 146.737566ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T17:48:49.808033Z","caller":"traceutil/trace.go:171","msg":"trace[2128842705] linearizableReadLoop","detail":"{readStateIndex:4971; appliedIndex:4970; }","duration":"274.625085ms","start":"2026-05-18T17:48:49.533385Z","end":"2026-05-18T17:48:49.80801Z","steps":["trace[2128842705] 'read index received'  (duration: 274.507552ms)","trace[2128842705] 'applied index is now lower than readState.Index'  (duration: 116.493µs)"],"step_count":2}
{"level":"info","ts":"2026-05-18T17:48:49.808135Z","caller":"traceutil/trace.go:171","msg":"trace[1246893628] transaction","detail":"{read_only:false; response_revision:4788; number_of_response:1; }","duration":"324.123608ms","start":"2026-05-18T17:48:49.483982Z","end":"2026-05-18T17:48:49.808106Z","steps":["trace[1246893628] 'process raft request'  (duration: 323.85196ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T17:48:49.80837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T17:48:49.483964Z","time spent":"324.314843ms","remote":"127.0.0.1:53802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10669,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" mod_revision:4697 > success:<request_put:<key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" value_size:10610 >> failure:<request_range:<key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" > >"}
{"level":"warn","ts":"2026-05-18T17:48:49.808353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.879323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-18T17:48:49.808559Z","caller":"traceutil/trace.go:171","msg":"trace[86121837] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4788; }","duration":"275.076689ms","start":"2026-05-18T17:48:49.53334Z","end":"2026-05-18T17:48:49.808416Z","steps":["trace[86121837] 'agreement among raft nodes before linearized reading'  (duration: 274.78333ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T17:48:49.839379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.846403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"}
{"level":"info","ts":"2026-05-18T17:48:49.83944Z","caller":"traceutil/trace.go:171","msg":"trace[24052365] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4789; }","duration":"291.949206ms","start":"2026-05-18T17:48:49.547477Z","end":"2026-05-18T17:48:49.839426Z","steps":["trace[24052365] 'agreement among raft nodes before linearized reading'  (duration: 291.798481ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T17:48:49.83942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.954262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-05-18T17:48:49.839499Z","caller":"traceutil/trace.go:171","msg":"trace[2015518563] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4789; }","duration":"283.045664ms","start":"2026-05-18T17:48:49.556427Z","end":"2026-05-18T17:48:49.839473Z","steps":["trace[2015518563] 'agreement among raft nodes before linearized reading'  (duration: 282.847438ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T17:48:49.839505Z","caller":"traceutil/trace.go:171","msg":"trace[1861651465] transaction","detail":"{read_only:false; response_revision:4789; number_of_response:1; }","duration":"268.800241ms","start":"2026-05-18T17:48:49.570678Z","end":"2026-05-18T17:48:49.839478Z","steps":["trace[1861651465] 'process raft request'  (duration: 268.482112ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T17:50:39.438436Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2906}
{"level":"info","ts":"2026-05-18T17:50:39.510542Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2906,"took":"70.549469ms","hash":1485960285,"current-db-size-bytes":53596160,"current-db-size":"54 MB","current-db-size-in-use-bytes":29499392,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-05-18T17:50:39.510618Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1485960285,"revision":2906,"compact-revision":-1}
{"level":"warn","ts":"2026-05-18T17:52:33.568081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.334685ms","expected-duration":"100ms","prefix":"","request":"header:<ID:689224724276847113 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:6390 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-18T17:52:33.5686Z","caller":"traceutil/trace.go:171","msg":"trace[179968074] transaction","detail":"{read_only:false; response_revision:6406; number_of_response:1; }","duration":"153.945193ms","start":"2026-05-18T17:52:33.414633Z","end":"2026-05-18T17:52:33.568579Z","steps":["trace[179968074] 'process raft request'  (duration: 153.573436ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T17:52:33.568569Z","caller":"traceutil/trace.go:171","msg":"trace[950134131] transaction","detail":"{read_only:false; response_revision:6405; number_of_response:1; }","duration":"179.48032ms","start":"2026-05-18T17:52:33.389019Z","end":"2026-05-18T17:52:33.568499Z","steps":["trace[950134131] 'process raft request'  (duration: 61.617902ms)","trace[950134131] 'compare'  (duration: 116.980229ms)"],"step_count":2}
{"level":"info","ts":"2026-05-18T17:55:39.445723Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5624}
{"level":"info","ts":"2026-05-18T17:55:39.541254Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5624,"took":"94.150114ms","hash":2041979152,"current-db-size-bytes":53596160,"current-db-size":"54 MB","current-db-size-in-use-bytes":18042880,"current-db-size-in-use":"18 MB"}
{"level":"info","ts":"2026-05-18T17:55:39.541349Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2041979152,"revision":5624,"compact-revision":2906}