{"level":"warn","ts":"2026-10-09T14:52:29.622319Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-10-09T14:52:29.622411Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.213: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://162.253.55.213:2380","--initial-cluster=instance=https://162.253.55.213:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.213:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.213: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-10-09T14:52:29.622486Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-10-09T14:52:29.622508Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.213:2380"]}
{"level":"info","ts":"2026-10-09T14:52:29.622533Z","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-10-09T14:52:29.623342Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.213:2379"]}
{"level":"info","ts":"2026-10-09T14:52:29.623464Z","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://162.253.55.213:2380"],"listen-peer-urls":["https://162.253.55.213:2380"],"advertise-client-urls":["https://162.253.55.213:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.213:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.213: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-10-09T14:52:29.701891Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"76.89682ms"}
{"level":"info","ts":"2026-10-09T14:52:29.789848Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"43ce62d0a10d51da","cluster-id":"25e0c2268a6b42c6"}
{"level":"info","ts":"2026-10-09T14:52:29.790007Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"43ce62d0a10d51da switched to configuration voters=()"}
{"level":"info","ts":"2026-10-09T14:52:29.790064Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"43ce62d0a10d51da became follower at term 0"}
{"level":"info","ts":"2026-10-09T14:52:29.790099Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 43ce62d0a10d51da [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-10-09T14:52:29.790112Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"43ce62d0a10d51da became follower at term 1"}
{"level":"info","ts":"2026-10-09T14:52:29.790186Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"43ce62d0a10d51da switched to configuration voters=(4885951293938291162)"}
{"level":"warn","ts":"2026-10-09T14:52:29.878821Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-10-09T14:52:29.896459Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-10-09T14:52:29.903926Z","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-10-09T14:52:29.907226Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"43ce62d0a10d51da","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-10-09T14:52:29.907654Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"43ce62d0a10d51da","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-10-09T14:52:29.907931Z","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-10-09T14:52:29.908049Z","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-10-09T14:52:29.909378Z","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-10-09T14:52:29.910425Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"43ce62d0a10d51da switched to configuration voters=(4885951293938291162)"}
{"level":"info","ts":"2026-10-09T14:52:29.910657Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"25e0c2268a6b42c6","local-member-id":"43ce62d0a10d51da","added-peer-id":"43ce62d0a10d51da","added-peer-peer-urls":["https://162.253.55.213:2380"]}
{"level":"info","ts":"2026-10-09T14:52:29.913327Z","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-10-09T14:52:29.913506Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.213:2380"}
{"level":"info","ts":"2026-10-09T14:52:29.913552Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.213:2380"}
{"level":"info","ts":"2026-10-09T14:52:29.913721Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"43ce62d0a10d51da","initial-advertise-peer-urls":["https://162.253.55.213:2380"],"listen-peer-urls":["https://162.253.55.213:2380"],"advertise-client-urls":["https://162.253.55.213:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.213:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-10-09T14:52:29.913767Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-10-09T14:52:30.599521Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"43ce62d0a10d51da is starting a new election at term 1"}
{"level":"info","ts":"2026-10-09T14:52:30.599563Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"43ce62d0a10d51da became pre-candidate at term 1"}
{"level":"info","ts":"2026-10-09T14:52:30.599586Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"43ce62d0a10d51da received MsgPreVoteResp from 43ce62d0a10d51da at term 1"}
{"level":"info","ts":"2026-10-09T14:52:30.599597Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"43ce62d0a10d51da became candidate at term 2"}
{"level":"info","ts":"2026-10-09T14:52:30.599602Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"43ce62d0a10d51da received MsgVoteResp from 43ce62d0a10d51da at term 2"}
{"level":"info","ts":"2026-10-09T14:52:30.599609Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"43ce62d0a10d51da became leader at term 2"}
{"level":"info","ts":"2026-10-09T14:52:30.599617Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 43ce62d0a10d51da elected leader 43ce62d0a10d51da at term 2"}
{"level":"info","ts":"2026-10-09T14:52:30.600822Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-09T14:52:30.601615Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"43ce62d0a10d51da","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.213:2379]}","request-path":"/0/members/43ce62d0a10d51da/attributes","cluster-id":"25e0c2268a6b42c6","publish-timeout":"7s"}
{"level":"info","ts":"2026-10-09T14:52:30.601628Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-10-09T14:52:30.601674Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-10-09T14:52:30.601933Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-10-09T14:52:30.602037Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-10-09T14:52:30.602753Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"25e0c2268a6b42c6","local-member-id":"43ce62d0a10d51da","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-09T14:52:30.602878Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-09T14:52:30.602913Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-09T14:52:30.603222Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.213:2379"}
{"level":"info","ts":"2026-10-09T14:52:30.604747Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-10-09T14:53:12.825102Z","caller":"traceutil/trace.go:171","msg":"trace[19999413] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"100.530908ms","start":"2026-10-09T14:53:12.724548Z","end":"2026-10-09T14:53:12.825079Z","steps":["trace[19999413] 'process raft request'  (duration: 100.189112ms)"],"step_count":1}
{"level":"info","ts":"2026-10-09T14:53:12.974023Z","caller":"traceutil/trace.go:171","msg":"trace[1682657851] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"101.275809ms","start":"2026-10-09T14:53:12.872731Z","end":"2026-10-09T14:53:12.974007Z","steps":["trace[1682657851] 'process raft request'  (duration: 64.202918ms)","trace[1682657851] 'compare'  (duration: 36.551644ms)"],"step_count":2}
{"level":"info","ts":"2026-10-09T14:53:18.13553Z","caller":"traceutil/trace.go:171","msg":"trace[359800593] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"108.421278ms","start":"2026-10-09T14:53:18.027073Z","end":"2026-10-09T14:53:18.135494Z","steps":["trace[359800593] 'process raft request'  (duration: 107.664787ms)"],"step_count":1}
{"level":"info","ts":"2026-10-09T14:53:18.819445Z","caller":"traceutil/trace.go:171","msg":"trace[2099376925] linearizableReadLoop","detail":"{readStateIndex:623; appliedIndex:622; }","duration":"136.682511ms","start":"2026-10-09T14:53:18.682735Z","end":"2026-10-09T14:53:18.819417Z","steps":["trace[2099376925] 'read index received'  (duration: 136.64359ms)","trace[2099376925] 'applied index is now lower than readState.Index'  (duration: 37.711µs)"],"step_count":2}
{"level":"info","ts":"2026-10-09T14:53:18.81959Z","caller":"traceutil/trace.go:171","msg":"trace[2079005090] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"144.499842ms","start":"2026-10-09T14:53:18.67506Z","end":"2026-10-09T14:53:18.81956Z","steps":["trace[2079005090] 'process raft request'  (duration: 144.222728ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-09T14:53:18.819637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.876653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-10-09T14:53:18.819704Z","caller":"traceutil/trace.go:171","msg":"trace[487698936] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:600; }","duration":"136.997256ms","start":"2026-10-09T14:53:18.682697Z","end":"2026-10-09T14:53:18.819694Z","steps":["trace[487698936] 'agreement among raft nodes before linearized reading'  (duration: 136.812133ms)"],"step_count":1}
{"level":"info","ts":"2026-10-09T14:53:18.901225Z","caller":"traceutil/trace.go:171","msg":"trace[140352842] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"215.868982ms","start":"2026-10-09T14:53:18.685329Z","end":"2026-10-09T14:53:18.901198Z","steps":["trace[140352842] 'process raft request'  (duration: 178.953299ms)","trace[140352842] 'compare'  (duration: 18.497943ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-09T14:53:19.317967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.42272ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5898203825751125015 > lease_revoke:<id:51daa12126beeae9>","response":"size:27"}
{"level":"info","ts":"2026-10-09T14:53:19.318191Z","caller":"traceutil/trace.go:171","msg":"trace[291781923] linearizableReadLoop","detail":"{readStateIndex:627; appliedIndex:625; }","duration":"265.836406ms","start":"2026-10-09T14:53:19.052342Z","end":"2026-10-09T14:53:19.318178Z","steps":["trace[291781923] 'read index received'  (duration: 155.100102ms)","trace[291781923] 'applied index is now lower than readState.Index'  (duration: 110.735434ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-09T14:53:19.318272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.921147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-09T14:53:19.318308Z","caller":"traceutil/trace.go:171","msg":"trace[288920748] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:603; }","duration":"265.984248ms","start":"2026-10-09T14:53:19.052316Z","end":"2026-10-09T14:53:19.3183Z","steps":["trace[288920748] 'agreement among raft nodes before linearized reading'  (duration: 265.914747ms)"],"step_count":1}
{"level":"info","ts":"2026-10-09T14:53:19.318367Z","caller":"traceutil/trace.go:171","msg":"trace[497656591] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"321.071886ms","start":"2026-10-09T14:53:18.997265Z","end":"2026-10-09T14:53:19.318337Z","steps":["trace[497656591] 'process raft request'  (duration: 320.840034ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-09T14:53:19.319047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T14:53:18.997245Z","time spent":"321.191238ms","remote":"127.0.0.1:39090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" mod_revision:0 > success:<request_put:<key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" value_size:1527 >> failure:<>"}
{"level":"info","ts":"2026-10-09T14:53:33.888256Z","caller":"traceutil/trace.go:171","msg":"trace[366868673] linearizableReadLoop","detail":"{readStateIndex:788; appliedIndex:787; }","duration":"179.568093ms","start":"2026-10-09T14:53:33.708666Z","end":"2026-10-09T14:53:33.888234Z","steps":["trace[366868673] 'read index received'  (duration: 179.330899ms)","trace[366868673] 'applied index is now lower than readState.Index'  (duration: 236.414µs)"],"step_count":2}
{"level":"warn","ts":"2026-10-09T14:53:33.888431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.745665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-k2w22\" ","response":"range_response_count:1 size:3965"}
{"level":"info","ts":"2026-10-09T14:53:33.888471Z","caller":"traceutil/trace.go:171","msg":"trace[1024264483] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-k2w22; range_end:; response_count:1; response_revision:761; }","duration":"179.822907ms","start":"2026-10-09T14:53:33.708634Z","end":"2026-10-09T14:53:33.888456Z","steps":["trace[1024264483] 'agreement among raft nodes before linearized reading'  (duration: 179.692875ms)"],"step_count":1}
{"level":"info","ts":"2026-10-09T14:53:33.888433Z","caller":"traceutil/trace.go:171","msg":"trace[749253672] transaction","detail":"{read_only:false; response_revision:761; number_of_response:1; }","duration":"250.55569ms","start":"2026-10-09T14:53:33.637766Z","end":"2026-10-09T14:53:33.888322Z","steps":["trace[749253672] 'process raft request'  (duration: 250.336367ms)"],"step_count":1}
{"level":"info","ts":"2026-10-09T14:54:05.243023Z","caller":"traceutil/trace.go:171","msg":"trace[1125196541] transaction","detail":"{read_only:false; response_revision:1168; number_of_response:1; }","duration":"113.734188ms","start":"2026-10-09T14:54:05.129263Z","end":"2026-10-09T14:54:05.242998Z","steps":["trace[1125196541] 'process raft request'  (duration: 113.589016ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-09T14:54:52.537036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.239048ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5898203825751127460 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:1770 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >>","response":"size:16"}
{"level":"info","ts":"2026-10-09T14:54:52.537129Z","caller":"traceutil/trace.go:171","msg":"trace[2011363683] linearizableReadLoop","detail":"{readStateIndex:1904; appliedIndex:1903; }","duration":"104.856483ms","start":"2026-10-09T14:54:52.432256Z","end":"2026-10-09T14:54:52.537113Z","steps":["trace[2011363683] 'read index received'  (duration: 75.48µs)","trace[2011363683] 'applied index is now lower than readState.Index'  (duration: 104.779503ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-09T14:54:52.537257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.006866ms","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-10-09T14:54:52.537313Z","caller":"traceutil/trace.go:171","msg":"trace[33126981] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1833; }","duration":"105.099487ms","start":"2026-10-09T14:54:52.432204Z","end":"2026-10-09T14:54:52.537303Z","steps":["trace[33126981] 'agreement among raft nodes before linearized reading'  (duration: 104.951705ms)"],"step_count":1}
{"level":"info","ts":"2026-10-09T14:54:52.537664Z","caller":"traceutil/trace.go:171","msg":"trace[1962322446] transaction","detail":"{read_only:false; response_revision:1833; number_of_response:1; }","duration":"249.531238ms","start":"2026-10-09T14:54:52.287873Z","end":"2026-10-09T14:54:52.537404Z","steps":["trace[1962322446] 'process raft request'  (duration: 75.666553ms)","trace[1962322446] 'compare'  (duration: 173.082436ms)"],"step_count":2}
{"level":"info","ts":"2026-10-09T14:54:52.996101Z","caller":"traceutil/trace.go:171","msg":"trace[1244754624] transaction","detail":"{read_only:false; response_revision:1835; number_of_response:1; }","duration":"231.109254ms","start":"2026-10-09T14:54:52.764954Z","end":"2026-10-09T14:54:52.996063Z","steps":["trace[1244754624] 'process raft request'  (duration: 230.900412ms)"],"step_count":1}
{"level":"info","ts":"2026-10-09T14:54:53.01773Z","caller":"traceutil/trace.go:171","msg":"trace[124447875] transaction","detail":"{read_only:false; response_revision:1836; number_of_response:1; }","duration":"119.518777ms","start":"2026-10-09T14:54:52.898187Z","end":"2026-10-09T14:54:53.017706Z","steps":["trace[124447875] 'process raft request'  (duration: 119.345615ms)"],"step_count":1}
{"level":"info","ts":"2026-10-09T14:55:06.172277Z","caller":"traceutil/trace.go:171","msg":"trace[394543192] linearizableReadLoop","detail":"{readStateIndex:2025; appliedIndex:2024; }","duration":"119.446193ms","start":"2026-10-09T14:55:06.052792Z","end":"2026-10-09T14:55:06.172238Z","steps":["trace[394543192] 'read index received'  (duration: 119.11093ms)","trace[394543192] 'applied index is now lower than readState.Index'  (duration: 333.373µs)"],"step_count":2}
{"level":"warn","ts":"2026-10-09T14:55:06.172479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.622375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-09T14:55:06.172517Z","caller":"traceutil/trace.go:171","msg":"trace[699366704] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1951; }","duration":"119.752776ms","start":"2026-10-09T14:55:06.052751Z","end":"2026-10-09T14:55:06.172504Z","steps":["trace[699366704] 'agreement among raft nodes before linearized reading'  (duration: 119.629835ms)"],"step_count":1}
{"level":"info","ts":"2026-10-09T14:55:06.172643Z","caller":"traceutil/trace.go:171","msg":"trace[1301522453] transaction","detail":"{read_only:false; response_revision:1951; number_of_response:1; }","duration":"142.328002ms","start":"2026-10-09T14:55:06.030285Z","end":"2026-10-09T14:55:06.172613Z","steps":["trace[1301522453] 'process raft request'  (duration: 141.675104ms)"],"step_count":1}
{"level":"info","ts":"2026-10-09T14:55:21.335856Z","caller":"traceutil/trace.go:171","msg":"trace[2097223792] transaction","detail":"{read_only:false; response_revision:2054; number_of_response:1; }","duration":"136.143402ms","start":"2026-10-09T14:55:21.199689Z","end":"2026-10-09T14:55:21.335833Z","steps":["trace[2097223792] 'process raft request'  (duration: 135.641706ms)"],"step_count":1}
{"level":"info","ts":"2026-10-09T14:55:22.876385Z","caller":"traceutil/trace.go:171","msg":"trace[608562644] linearizableReadLoop","detail":"{readStateIndex:2136; appliedIndex:2135; }","duration":"142.651811ms","start":"2026-10-09T14:55:22.733703Z","end":"2026-10-09T14:55:22.876355Z","steps":["trace[608562644] 'read index received'  (duration: 142.417438ms)","trace[608562644] 'applied index is now lower than readState.Index'  (duration: 233.563µs)"],"step_count":2}
{"level":"info","ts":"2026-10-09T14:55:22.87649Z","caller":"traceutil/trace.go:171","msg":"trace[1567367830] transaction","detail":"{read_only:false; response_revision:2059; number_of_response:1; }","duration":"219.319377ms","start":"2026-10-09T14:55:22.657159Z","end":"2026-10-09T14:55:22.876479Z","steps":["trace[1567367830] 'process raft request'  (duration: 219.002913ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-09T14:55:22.876791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.072205ms","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-10-09T14:55:22.87688Z","caller":"traceutil/trace.go:171","msg":"trace[57112565] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2059; }","duration":"143.201286ms","start":"2026-10-09T14:55:22.73366Z","end":"2026-10-09T14:55:22.876861Z","steps":["trace[57112565] 'agreement among raft nodes before linearized reading'  (duration: 143.034344ms)"],"step_count":1}
{"level":"info","ts":"2026-10-09T14:55:22.999634Z","caller":"traceutil/trace.go:171","msg":"trace[1424183611] transaction","detail":"{read_only:false; response_revision:2060; number_of_response:1; }","duration":"119.047749ms","start":"2026-10-09T14:55:22.880553Z","end":"2026-10-09T14:55:22.999601Z","steps":["trace[1424183611] 'process raft request'  (duration: 46.663218ms)","trace[1424183611] 'compare'  (duration: 72.245259ms)"],"step_count":2}
{"level":"info","ts":"2026-10-09T14:56:35.763258Z","caller":"traceutil/trace.go:171","msg":"trace[338762459] transaction","detail":"{read_only:false; response_revision:2554; number_of_response:1; }","duration":"181.40556ms","start":"2026-10-09T14:56:35.581825Z","end":"2026-10-09T14:56:35.763231Z","steps":["trace[338762459] 'process raft request'  (duration: 181.244067ms)"],"step_count":1}
{"level":"info","ts":"2026-10-09T14:56:35.765206Z","caller":"traceutil/trace.go:171","msg":"trace[1274008974] linearizableReadLoop","detail":"{readStateIndex:2649; appliedIndex:2647; }","duration":"102.619133ms","start":"2026-10-09T14:56:35.662559Z","end":"2026-10-09T14:56:35.765178Z","steps":["trace[1274008974] 'read index received'  (duration: 100.609518ms)","trace[1274008974] 'applied index is now lower than readState.Index'  (duration: 2.008005ms)"],"step_count":2}
{"level":"info","ts":"2026-10-09T14:56:35.765319Z","caller":"traceutil/trace.go:171","msg":"trace[1399126872] transaction","detail":"{read_only:false; response_revision:2555; number_of_response:1; }","duration":"146.699828ms","start":"2026-10-09T14:56:35.618596Z","end":"2026-10-09T14:56:35.765296Z","steps":["trace[1399126872] 'process raft request'  (duration: 146.429491ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-09T14:56:35.765475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.894069ms","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-10-09T14:56:35.765536Z","caller":"traceutil/trace.go:171","msg":"trace[46906375] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2555; }","duration":"102.995312ms","start":"2026-10-09T14:56:35.662524Z","end":"2026-10-09T14:56:35.765519Z","steps":["trace[46906375] 'agreement among raft nodes before linearized reading'  (duration: 102.814538ms)"],"step_count":1}
{"level":"info","ts":"2026-10-09T14:57:08.133542Z","caller":"traceutil/trace.go:171","msg":"trace[458202544] linearizableReadLoop","detail":"{readStateIndex:2832; appliedIndex:2831; }","duration":"178.737611ms","start":"2026-10-09T14:57:07.95477Z","end":"2026-10-09T14:57:08.133508Z","steps":["trace[458202544] 'read index received'  (duration: 112.382636ms)","trace[458202544] 'applied index is now lower than readState.Index'  (duration: 66.352995ms)"],"step_count":2}
{"level":"info","ts":"2026-10-09T14:57:08.13451Z","caller":"traceutil/trace.go:171","msg":"trace[315681355] transaction","detail":"{read_only:false; response_revision:2731; number_of_response:1; }","duration":"197.424189ms","start":"2026-10-09T14:57:07.937056Z","end":"2026-10-09T14:57:08.13448Z","steps":["trace[315681355] 'process raft request'  (duration: 130.201306ms)","trace[315681355] 'compare'  (duration: 65.768943ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-09T14:57:08.134907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.034314ms","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-10-09T14:57:08.134983Z","caller":"traceutil/trace.go:171","msg":"trace[770296872] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2731; }","duration":"164.144416ms","start":"2026-10-09T14:57:07.970821Z","end":"2026-10-09T14:57:08.134965Z","steps":["trace[770296872] 'agreement among raft nodes before linearized reading'  (duration: 163.929271ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-09T14:57:08.134969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.157459ms","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-10-09T14:57:08.13549Z","caller":"traceutil/trace.go:171","msg":"trace[270170599] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2731; }","duration":"180.573228ms","start":"2026-10-09T14:57:07.954726Z","end":"2026-10-09T14:57:08.135299Z","steps":["trace[270170599] 'agreement among raft nodes before linearized reading'  (duration: 179.909535ms)"],"step_count":1}
{"level":"info","ts":"2026-10-09T15:01:55.149681Z","caller":"traceutil/trace.go:171","msg":"trace[1528509441] transaction","detail":"{read_only:false; response_revision:5000; number_of_response:1; }","duration":"170.506507ms","start":"2026-10-09T15:01:54.97912Z","end":"2026-10-09T15:01:55.149626Z","steps":["trace[1528509441] 'process raft request'  (duration: 170.238564ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-09T15:01:55.576262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.796334ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5898203825751135161 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/endpointslices/monitoring/prometheus-operated-zwvl8\" mod_revision:4758 > success:<request_put:<key:\"/registry/endpointslices/monitoring/prometheus-operated-zwvl8\" value_size:1324 >> failure:<request_range:<key:\"/registry/endpointslices/monitoring/prometheus-operated-zwvl8\" > >>","response":"size:16"}
{"level":"info","ts":"2026-10-09T15:01:55.576577Z","caller":"traceutil/trace.go:171","msg":"trace[618513417] transaction","detail":"{read_only:false; response_revision:5005; number_of_response:1; }","duration":"266.142214ms","start":"2026-10-09T15:01:55.310393Z","end":"2026-10-09T15:01:55.576535Z","steps":["trace[618513417] 'process raft request'  (duration: 29.884354ms)","trace[618513417] 'compare'  (duration: 235.570242ms)"],"step_count":2}
{"level":"info","ts":"2026-10-09T15:01:55.576665Z","caller":"traceutil/trace.go:171","msg":"trace[405876992] linearizableReadLoop","detail":"{readStateIndex:5199; appliedIndex:5195; }","duration":"232.29892ms","start":"2026-10-09T15:01:55.344339Z","end":"2026-10-09T15:01:55.576638Z","steps":["trace[405876992] 'read index received'  (duration: 55.551µs)","trace[405876992] 'applied index is now lower than readState.Index'  (duration: 232.240959ms)"],"step_count":2}
{"level":"info","ts":"2026-10-09T15:01:55.576795Z","caller":"traceutil/trace.go:171","msg":"trace[1536087674] transaction","detail":"{read_only:false; response_revision:5007; number_of_response:1; }","duration":"264.672015ms","start":"2026-10-09T15:01:55.312078Z","end":"2026-10-09T15:01:55.57675Z","steps":["trace[1536087674] 'process raft request'  (duration: 264.410271ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-09T15:01:55.576908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.573124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-836cb034-0cde-4ab4-9d53-77fddaa2660f\" ","response":"range_response_count:1 size:3646"}
{"level":"info","ts":"2026-10-09T15:01:55.576945Z","caller":"traceutil/trace.go:171","msg":"trace[809236515] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-836cb034-0cde-4ab4-9d53-77fddaa2660f; range_end:; response_count:1; response_revision:5008; }","duration":"232.650594ms","start":"2026-10-09T15:01:55.34428Z","end":"2026-10-09T15:01:55.576931Z","steps":["trace[809236515] 'agreement among raft nodes before linearized reading'  (duration: 232.437211ms)"],"step_count":1}
{"level":"info","ts":"2026-10-09T15:01:55.577073Z","caller":"traceutil/trace.go:171","msg":"trace[1235604847] transaction","detail":"{read_only:false; response_revision:5006; number_of_response:1; }","duration":"266.167084ms","start":"2026-10-09T15:01:55.310893Z","end":"2026-10-09T15:01:55.57706Z","steps":["trace[1235604847] 'process raft request'  (duration: 265.507265ms)"],"step_count":1}
{"level":"info","ts":"2026-10-09T15:01:55.577299Z","caller":"traceutil/trace.go:171","msg":"trace[876818422] transaction","detail":"{read_only:false; response_revision:5008; number_of_response:1; }","duration":"264.623853ms","start":"2026-10-09T15:01:55.312619Z","end":"2026-10-09T15:01:55.577243Z","steps":["trace[876818422] 'process raft request'  (duration: 263.950324ms)"],"step_count":1}
{"level":"info","ts":"2026-10-09T15:02:09.590212Z","caller":"traceutil/trace.go:171","msg":"trace[108153890] transaction","detail":"{read_only:false; response_revision:5187; number_of_response:1; }","duration":"177.4342ms","start":"2026-10-09T15:02:09.412755Z","end":"2026-10-09T15:02:09.590189Z","steps":["trace[108153890] 'process raft request'  (duration: 177.215688ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-09T15:02:09.755686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.866757ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5898203825751135563 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/openstack/rabbitmq-keystone.18dce49ced84ec7b\" mod_revision:4989 > success:<request_put:<key:\"/registry/events/openstack/rabbitmq-keystone.18dce49ced84ec7b\" value_size:652 lease:5898203825751134918 >> failure:<request_range:<key:\"/registry/events/openstack/rabbitmq-keystone.18dce49ced84ec7b\" > >>","response":"size:16"}
{"level":"info","ts":"2026-10-09T15:02:09.755781Z","caller":"traceutil/trace.go:171","msg":"trace[1377376681] linearizableReadLoop","detail":"{readStateIndex:5385; appliedIndex:5383; }","duration":"337.695202ms","start":"2026-10-09T15:02:09.418069Z","end":"2026-10-09T15:02:09.755764Z","steps":["trace[1377376681] 'read index received'  (duration: 171.928851ms)","trace[1377376681] 'applied index is now lower than readState.Index'  (duration: 165.765001ms)"],"step_count":2}
{"level":"info","ts":"2026-10-09T15:02:09.755963Z","caller":"traceutil/trace.go:171","msg":"trace[1083268686] transaction","detail":"{read_only:false; response_revision:5188; number_of_response:1; }","duration":"341.388008ms","start":"2026-10-09T15:02:09.414562Z","end":"2026-10-09T15:02:09.75595Z","steps":["trace[1083268686] 'process raft request'  (duration: 195.168776ms)","trace[1083268686] 'compare'  (duration: 145.552914ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-09T15:02:09.756032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T15:02:09.414546Z","time spent":"341.451ms","remote":"127.0.0.1:38622","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":731,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/events/openstack/rabbitmq-keystone.18dce49ced84ec7b\" mod_revision:4989 > success:<request_put:<key:\"/registry/events/openstack/rabbitmq-keystone.18dce49ced84ec7b\" value_size:652 lease:5898203825751134918 >> failure:<request_range:<key:\"/registry/events/openstack/rabbitmq-keystone.18dce49ced84ec7b\" > >"}
{"level":"warn","ts":"2026-10-09T15:02:09.756299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.213718ms","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-10-09T15:02:09.7564Z","caller":"traceutil/trace.go:171","msg":"trace[2004064132] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:5188; }","duration":"338.34803ms","start":"2026-10-09T15:02:09.418034Z","end":"2026-10-09T15:02:09.756382Z","steps":["trace[2004064132] 'agreement among raft nodes before linearized reading'  (duration: 337.990265ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-09T15:02:09.756476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T15:02:09.418024Z","time spent":"338.439531ms","remote":"127.0.0.1:39050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":9661,"request content":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" "}
{"level":"info","ts":"2026-10-09T15:02:09.77262Z","caller":"traceutil/trace.go:171","msg":"trace[914558959] transaction","detail":"{read_only:false; response_revision:5189; number_of_response:1; }","duration":"174.995678ms","start":"2026-10-09T15:02:09.597602Z","end":"2026-10-09T15:02:09.772597Z","steps":["trace[914558959] 'process raft request'  (duration: 174.823746ms)"],"step_count":1}
{"level":"info","ts":"2026-10-09T15:02:09.772921Z","caller":"traceutil/trace.go:171","msg":"trace[43845326] transaction","detail":"{read_only:false; response_revision:5190; number_of_response:1; }","duration":"175.009029ms","start":"2026-10-09T15:02:09.597892Z","end":"2026-10-09T15:02:09.772901Z","steps":["trace[43845326] 'process raft request'  (duration: 174.642584ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-09T15:02:09.773237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.395062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:16402"}
{"level":"info","ts":"2026-10-09T15:02:09.773288Z","caller":"traceutil/trace.go:171","msg":"trace[81988894] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:5192; }","duration":"178.493243ms","start":"2026-10-09T15:02:09.594781Z","end":"2026-10-09T15:02:09.773274Z","steps":["trace[81988894] 'agreement among raft nodes before linearized reading'  (duration: 178.332701ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-09T15:02:09.773396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.590648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"}
{"level":"info","ts":"2026-10-09T15:02:09.773449Z","caller":"traceutil/trace.go:171","msg":"trace[1527070650] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:5192; }","duration":"340.683929ms","start":"2026-10-09T15:02:09.432748Z","end":"2026-10-09T15:02:09.773432Z","steps":["trace[1527070650] 'agreement among raft nodes before linearized reading'  (duration: 340.564477ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-09T15:02:09.773485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T15:02:09.432723Z","time spent":"340.75329ms","remote":"127.0.0.1:38718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":139,"response count":1,"response size":2104,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" "}
{"level":"info","ts":"2026-10-09T15:02:09.773498Z","caller":"traceutil/trace.go:171","msg":"trace[1987918463] transaction","detail":"{read_only:false; response_revision:5191; number_of_response:1; }","duration":"175.153ms","start":"2026-10-09T15:02:09.598313Z","end":"2026-10-09T15:02:09.773466Z","steps":["trace[1987918463] 'process raft request'  (duration: 174.457001ms)"],"step_count":1}
{"level":"info","ts":"2026-10-09T15:02:09.773712Z","caller":"traceutil/trace.go:171","msg":"trace[1055706017] transaction","detail":"{read_only:false; response_revision:5192; number_of_response:1; }","duration":"174.815087ms","start":"2026-10-09T15:02:09.598886Z","end":"2026-10-09T15:02:09.773701Z","steps":["trace[1055706017] 'process raft request'  (duration: 173.973506ms)"],"step_count":1}
{"level":"info","ts":"2026-10-09T15:02:30.63257Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2854}
{"level":"info","ts":"2026-10-09T15:02:30.702613Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2854,"took":"68.781967ms","hash":2948864030,"current-db-size-bytes":53420032,"current-db-size":"53 MB","current-db-size-in-use-bytes":27672576,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-10-09T15:02:30.702691Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2948864030,"revision":2854,"compact-revision":-1}
{"level":"info","ts":"2026-10-09T15:06:07.238855Z","caller":"traceutil/trace.go:171","msg":"trace[944660610] transaction","detail":"{read_only:false; response_revision:6882; number_of_response:1; }","duration":"102.087899ms","start":"2026-10-09T15:06:07.136715Z","end":"2026-10-09T15:06:07.238803Z","steps":["trace[944660610] 'process raft request'  (duration: 101.896326ms)"],"step_count":1}
{"level":"info","ts":"2026-10-09T15:06:08.418318Z","caller":"traceutil/trace.go:171","msg":"trace[1284074834] linearizableReadLoop","detail":"{readStateIndex:7141; appliedIndex:7140; }","duration":"129.114547ms","start":"2026-10-09T15:06:08.289181Z","end":"2026-10-09T15:06:08.418296Z","steps":["trace[1284074834] 'read index received'  (duration: 128.958905ms)","trace[1284074834] 'applied index is now lower than readState.Index'  (duration: 154.052µs)"],"step_count":2}
{"level":"info","ts":"2026-10-09T15:06:08.418386Z","caller":"traceutil/trace.go:171","msg":"trace[1004893107] transaction","detail":"{read_only:false; response_revision:6888; number_of_response:1; }","duration":"133.080523ms","start":"2026-10-09T15:06:08.285262Z","end":"2026-10-09T15:06:08.418342Z","steps":["trace[1004893107] 'process raft request'  (duration: 132.88523ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-09T15:06:08.418461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.252189ms","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:7"}
{"level":"info","ts":"2026-10-09T15:06:08.418496Z","caller":"traceutil/trace.go:171","msg":"trace[2036180628] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:6888; }","duration":"129.35351ms","start":"2026-10-09T15:06:08.289132Z","end":"2026-10-09T15:06:08.418485Z","steps":["trace[2036180628] 'agreement among raft nodes before linearized reading'  (duration: 129.255488ms)"],"step_count":1}
{"level":"info","ts":"2026-10-09T15:06:13.502694Z","caller":"traceutil/trace.go:171","msg":"trace[1048609613] linearizableReadLoop","detail":"{readStateIndex:7168; appliedIndex:7167; }","duration":"122.623459ms","start":"2026-10-09T15:06:13.380038Z","end":"2026-10-09T15:06:13.502662Z","steps":["trace[1048609613] 'read index received'  (duration: 122.363925ms)","trace[1048609613] 'applied index is now lower than readState.Index'  (duration: 258.154µs)"],"step_count":2}
{"level":"info","ts":"2026-10-09T15:06:13.502751Z","caller":"traceutil/trace.go:171","msg":"trace[490453338] transaction","detail":"{read_only:false; response_revision:6914; number_of_response:1; }","duration":"209.072738ms","start":"2026-10-09T15:06:13.293648Z","end":"2026-10-09T15:06:13.502721Z","steps":["trace[490453338] 'process raft request'  (duration: 208.779743ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-09T15:06:13.503013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.957383ms","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-10-09T15:06:13.503081Z","caller":"traceutil/trace.go:171","msg":"trace[2077945353] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6914; }","duration":"123.090726ms","start":"2026-10-09T15:06:13.379971Z","end":"2026-10-09T15:06:13.503061Z","steps":["trace[2077945353] 'agreement among raft nodes before linearized reading'  (duration: 122.824542ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-09T15:06:14.025252Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5898203825751139866,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-10-09T15:06:14.178555Z","caller":"traceutil/trace.go:171","msg":"trace[1371096976] transaction","detail":"{read_only:false; response_revision:6915; number_of_response:1; }","duration":"669.273407ms","start":"2026-10-09T15:06:13.509252Z","end":"2026-10-09T15:06:14.178526Z","steps":["trace[1371096976] 'process raft request'  (duration: 669.133715ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-09T15:06:14.178844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T15:06:13.509225Z","time spent":"669.395538ms","remote":"127.0.0.1:38850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:6904 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-10-09T15:06:14.266762Z","caller":"traceutil/trace.go:171","msg":"trace[19747304] transaction","detail":"{read_only:false; response_revision:6917; number_of_response:1; }","duration":"753.89914ms","start":"2026-10-09T15:06:13.512837Z","end":"2026-10-09T15:06:14.266736Z","steps":["trace[19747304] 'process raft request'  (duration: 753.817208ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-09T15:06:14.266973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T15:06:13.512799Z","time spent":"754.055432ms","remote":"127.0.0.1:38850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:6905 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-10-09T15:06:14.267157Z","caller":"traceutil/trace.go:171","msg":"trace[171733250] transaction","detail":"{read_only:false; response_revision:6916; number_of_response:1; }","duration":"755.663564ms","start":"2026-10-09T15:06:13.511454Z","end":"2026-10-09T15:06:14.267117Z","steps":["trace[171733250] 'process raft request'  (duration: 755.070535ms)"],"step_count":1}
{"level":"info","ts":"2026-10-09T15:06:14.267304Z","caller":"traceutil/trace.go:171","msg":"trace[623562346] linearizableReadLoop","detail":"{readStateIndex:7173; appliedIndex:7168; }","duration":"742.895972ms","start":"2026-10-09T15:06:13.524382Z","end":"2026-10-09T15:06:14.267278Z","steps":["trace[623562346] 'read index received'  (duration: 653.990137ms)","trace[623562346] 'applied index is now lower than readState.Index'  (duration: 88.904255ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-09T15:06:14.26737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T15:06:13.511426Z","time spent":"755.853048ms","remote":"127.0.0.1:38850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:6906 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-10-09T15:06:14.267421Z","caller":"traceutil/trace.go:171","msg":"trace[885921182] transaction","detail":"{read_only:false; response_revision:6918; number_of_response:1; }","duration":"685.075902ms","start":"2026-10-09T15:06:13.582332Z","end":"2026-10-09T15:06:14.267408Z","steps":["trace[885921182] 'process raft request'  (duration: 684.363032ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-09T15:06:14.267511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T15:06:13.582307Z","time spent":"685.138063ms","remote":"127.0.0.1:38850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:6907 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-10-09T15:06:14.267637Z","caller":"traceutil/trace.go:171","msg":"trace[1205211969] transaction","detail":"{read_only:false; response_revision:6919; number_of_response:1; }","duration":"485.686304ms","start":"2026-10-09T15:06:13.781936Z","end":"2026-10-09T15:06:14.267623Z","steps":["trace[1205211969] 'process raft request'  (duration: 485.254357ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-09T15:06:14.267677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"743.274628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/horizon-db-sync\" ","response":"range_response_count:1 size:4784"}
{"level":"info","ts":"2026-10-09T15:06:14.267792Z","caller":"traceutil/trace.go:171","msg":"trace[1002573877] range","detail":"{range_begin:/registry/jobs/openstack/horizon-db-sync; range_end:; response_count:1; response_revision:6919; }","duration":"743.466621ms","start":"2026-10-09T15:06:13.524301Z","end":"2026-10-09T15:06:14.267768Z","steps":["trace[1002573877] 'agreement among raft nodes before linearized reading'  (duration: 743.168276ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-09T15:06:14.267854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"632.555509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/horizon-db-sync\" ","response":"range_response_count:1 size:4784"}
{"level":"warn","ts":"2026-10-09T15:06:14.267706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"632.59945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/horizon-db-sync\" ","response":"range_response_count:1 size:4784"}
{"level":"warn","ts":"2026-10-09T15:06:14.267865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.915141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.213\" ","response":"range_response_count:1 size:135"}
{"level":"warn","ts":"2026-10-09T15:06:14.267883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T15:06:13.524285Z","time spent":"743.586892ms","remote":"127.0.0.1:38822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":4806,"request content":"key:\"/registry/jobs/openstack/horizon-db-sync\" "}
{"level":"info","ts":"2026-10-09T15:06:14.267894Z","caller":"traceutil/trace.go:171","msg":"trace[608758519] range","detail":"{range_begin:/registry/jobs/openstack/horizon-db-sync; range_end:; response_count:1; response_revision:6919; }","duration":"632.61262ms","start":"2026-10-09T15:06:13.635269Z","end":"2026-10-09T15:06:14.267882Z","steps":["trace[608758519] 'agreement among raft nodes before linearized reading'  (duration: 632.446188ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-09T15:06:14.267935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T15:06:13.635262Z","time spent":"632.667001ms","remote":"127.0.0.1:38822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":4806,"request content":"key:\"/registry/jobs/openstack/horizon-db-sync\" "}
{"level":"info","ts":"2026-10-09T15:06:14.267934Z","caller":"traceutil/trace.go:171","msg":"trace[1258348329] range","detail":"{range_begin:/registry/masterleases/162.253.55.213; range_end:; response_count:1; response_revision:6919; }","duration":"321.036463ms","start":"2026-10-09T15:06:13.946879Z","end":"2026-10-09T15:06:14.267915Z","steps":["trace[1258348329] 'agreement among raft nodes before linearized reading'  (duration: 320.799399ms)"],"step_count":1}
{"level":"info","ts":"2026-10-09T15:06:14.267927Z","caller":"traceutil/trace.go:171","msg":"trace[231037689] range","detail":"{range_begin:/registry/jobs/openstack/horizon-db-sync; range_end:; response_count:1; response_revision:6919; }","duration":"632.810573ms","start":"2026-10-09T15:06:13.635096Z","end":"2026-10-09T15:06:14.267907Z","steps":["trace[231037689] 'agreement among raft nodes before linearized reading'  (duration: 632.445777ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-09T15:06:14.268053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T15:06:13.781909Z","time spent":"485.751604ms","remote":"127.0.0.1:38850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:6909 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-10-09T15:06:14.268084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T15:06:13.635048Z","time spent":"632.971206ms","remote":"127.0.0.1:38822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":4806,"request content":"key:\"/registry/jobs/openstack/horizon-db-sync\" "}
{"level":"warn","ts":"2026-10-09T15:06:14.268084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T15:06:13.946845Z","time spent":"321.135364ms","remote":"127.0.0.1:38588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/162.253.55.213\" "}
{"level":"warn","ts":"2026-10-09T15:06:14.631715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.342748ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5898203825751139875 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:15-second id:51daa12126bf2622>","response":"size:39"}
{"level":"warn","ts":"2026-10-09T15:06:14.631861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T15:06:14.269641Z","time spent":"362.214742ms","remote":"127.0.0.1:38588","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"info","ts":"2026-10-09T15:06:14.662568Z","caller":"traceutil/trace.go:171","msg":"trace[1887379150] linearizableReadLoop","detail":"{readStateIndex:7175; appliedIndex:7174; }","duration":"194.454458ms","start":"2026-10-09T15:06:14.468085Z","end":"2026-10-09T15:06:14.662539Z","steps":["trace[1887379150] 'read index received'  (duration: 194.195994ms)","trace[1887379150] 'applied index is now lower than readState.Index'  (duration: 256.744µs)"],"step_count":2}
{"level":"info","ts":"2026-10-09T15:06:14.662621Z","caller":"traceutil/trace.go:171","msg":"trace[941064349] transaction","detail":"{read_only:false; response_revision:6920; number_of_response:1; }","duration":"214.860229ms","start":"2026-10-09T15:06:14.447718Z","end":"2026-10-09T15:06:14.662578Z","steps":["trace[941064349] 'process raft request'  (duration: 214.593515ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-09T15:06:14.662777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.654651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-10-09T15:06:14.662859Z","caller":"traceutil/trace.go:171","msg":"trace[1631177252] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:6920; }","duration":"194.815372ms","start":"2026-10-09T15:06:14.468031Z","end":"2026-10-09T15:06:14.662847Z","steps":["trace[1631177252] 'agreement among raft nodes before linearized reading'  (duration: 194.6491ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-09T15:06:15.163326Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5898203825751139879,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-10-09T15:06:15.509562Z","caller":"traceutil/trace.go:171","msg":"trace[1456026609] transaction","detail":"{read_only:false; response_revision:6921; number_of_response:1; }","duration":"1.016430514s","start":"2026-10-09T15:06:14.493109Z","end":"2026-10-09T15:06:15.509539Z","steps":["trace[1456026609] 'process raft request'  (duration: 1.014626549s)"],"step_count":1}
{"level":"info","ts":"2026-10-09T15:06:15.509561Z","caller":"traceutil/trace.go:171","msg":"trace[1755147044] transaction","detail":"{read_only:false; response_revision:6922; number_of_response:1; }","duration":"876.639811ms","start":"2026-10-09T15:06:14.632895Z","end":"2026-10-09T15:06:15.509535Z","steps":["trace[1755147044] 'process raft request'  (duration: 876.499369ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-09T15:06:15.509713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T15:06:14.493086Z","time spent":"1.016541186s","remote":"127.0.0.1:38850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:6911 > 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\" > >"}
{"level":"warn","ts":"2026-10-09T15:06:15.509713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T15:06:14.632871Z","time spent":"876.756822ms","remote":"127.0.0.1:38588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/masterleases/162.253.55.213\" mod_revision:6869 > success:<request_put:<key:\"/registry/masterleases/162.253.55.213\" value_size:67 lease:5898203825751139874 >> failure:<request_range:<key:\"/registry/masterleases/162.253.55.213\" > >"}
{"level":"info","ts":"2026-10-09T15:06:15.582742Z","caller":"traceutil/trace.go:171","msg":"trace[686067852] linearizableReadLoop","detail":"{readStateIndex:7178; appliedIndex:7175; }","duration":"920.048982ms","start":"2026-10-09T15:06:14.662651Z","end":"2026-10-09T15:06:15.5827Z","steps":["trace[686067852] 'read index received'  (duration: 845.073708ms)","trace[686067852] 'applied index is now lower than readState.Index'  (duration: 74.973854ms)"],"step_count":2}
{"level":"info","ts":"2026-10-09T15:06:15.582767Z","caller":"traceutil/trace.go:171","msg":"trace[975927946] transaction","detail":"{read_only:false; response_revision:6923; number_of_response:1; }","duration":"778.22228ms","start":"2026-10-09T15:06:14.804514Z","end":"2026-10-09T15:06:15.582736Z","steps":["trace[975927946] 'process raft request'  (duration: 778.055587ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-09T15:06:15.582987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T15:06:14.804485Z","time spent":"778.388292ms","remote":"127.0.0.1:38850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:6913 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-10-09T15:06:15.583044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"946.454011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-10-09T15:06:15.583103Z","caller":"traceutil/trace.go:171","msg":"trace[1634757952] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6923; }","duration":"946.570133ms","start":"2026-10-09T15:06:14.636518Z","end":"2026-10-09T15:06:15.583088Z","steps":["trace[1634757952] 'agreement among raft nodes before linearized reading'  (duration: 946.36282ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-09T15:06:15.583143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T15:06:14.636503Z","time spent":"946.629223ms","remote":"127.0.0.1:38850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-10-09T15:06:15.583071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"531.004887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-09T15:06:15.583237Z","caller":"traceutil/trace.go:171","msg":"trace[2138844597] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6923; }","duration":"531.26439ms","start":"2026-10-09T15:06:15.051957Z","end":"2026-10-09T15:06:15.583221Z","steps":["trace[2138844597] 'agreement among raft nodes before linearized reading'  (duration: 531.029506ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-09T15:06:15.583302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T15:06:15.05192Z","time spent":"531.370212ms","remote":"127.0.0.1:38554","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-10-09T15:06:15.583516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.862308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-09T15:06:15.583587Z","caller":"traceutil/trace.go:171","msg":"trace[1262235931] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:6923; }","duration":"482.945859ms","start":"2026-10-09T15:06:15.100629Z","end":"2026-10-09T15:06:15.583575Z","steps":["trace[1262235931] 'agreement among raft nodes before linearized reading'  (duration: 482.852208ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-09T15:06:15.583647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T15:06:15.100623Z","time spent":"483.01209ms","remote":"127.0.0.1:38794","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":27,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "}
{"level":"warn","ts":"2026-10-09T15:06:15.583718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"494.20956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"}
{"level":"info","ts":"2026-10-09T15:06:15.583759Z","caller":"traceutil/trace.go:171","msg":"trace[2081720049] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:6923; }","duration":"494.272811ms","start":"2026-10-09T15:06:15.089476Z","end":"2026-10-09T15:06:15.583749Z","steps":["trace[2081720049] 'agreement among raft nodes before linearized reading'  (duration: 494.158879ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-09T15:06:15.58379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T15:06:15.08947Z","time spent":"494.313121ms","remote":"127.0.0.1:38758","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12234,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"warn","ts":"2026-10-09T15:06:15.997109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.996897ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5898203825751139886 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:6914 > 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-10-09T15:06:15.997218Z","caller":"traceutil/trace.go:171","msg":"trace[689314410] linearizableReadLoop","detail":"{readStateIndex:7179; appliedIndex:7178; }","duration":"406.979311ms","start":"2026-10-09T15:06:15.590221Z","end":"2026-10-09T15:06:15.9972Z","steps":["trace[689314410] 'read index received'  (duration: 261.749131ms)","trace[689314410] 'applied index is now lower than readState.Index'  (duration: 145.22839ms)"],"step_count":2}
{"level":"info","ts":"2026-10-09T15:06:15.997494Z","caller":"traceutil/trace.go:171","msg":"trace[1617707736] transaction","detail":"{read_only:false; response_revision:6924; number_of_response:1; }","duration":"407.911093ms","start":"2026-10-09T15:06:15.589567Z","end":"2026-10-09T15:06:15.997478Z","steps":["trace[1617707736] 'process raft request'  (duration: 262.401989ms)","trace[1617707736] 'compare'  (duration: 144.860124ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-09T15:06:15.99758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T15:06:15.589551Z","time spent":"407.992064ms","remote":"127.0.0.1:38850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:6914 > 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\" > >"}
{"level":"warn","ts":"2026-10-09T15:06:15.997932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"407.679581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:12448"}
{"level":"info","ts":"2026-10-09T15:06:15.998022Z","caller":"traceutil/trace.go:171","msg":"trace[575116073] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:6924; }","duration":"407.809793ms","start":"2026-10-09T15:06:15.590188Z","end":"2026-10-09T15:06:15.997997Z","steps":["trace[575116073] 'agreement among raft nodes before linearized reading'  (duration: 407.469868ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-09T15:06:15.998079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T15:06:15.590175Z","time spent":"407.889594ms","remote":"127.0.0.1:38742","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":12470,"request content":"key:\"/registry/minions/instance\" "}
{"level":"warn","ts":"2026-10-09T15:06:16.078916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.269818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-10-09T15:06:16.078971Z","caller":"traceutil/trace.go:171","msg":"trace[1495407994] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:6925; }","duration":"357.39424ms","start":"2026-10-09T15:06:15.721566Z","end":"2026-10-09T15:06:16.07896Z","steps":["trace[1495407994] 'agreement among raft nodes before linearized reading'  (duration: 357.276578ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-09T15:06:16.078995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T15:06:15.721535Z","time spent":"357.45455ms","remote":"127.0.0.1:38982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":29,"request content":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true "}
{"level":"info","ts":"2026-10-09T15:06:16.079168Z","caller":"traceutil/trace.go:171","msg":"trace[271052315] transaction","detail":"{read_only:false; response_revision:6925; number_of_response:1; }","duration":"487.644546ms","start":"2026-10-09T15:06:15.591447Z","end":"2026-10-09T15:06:16.079092Z","steps":["trace[271052315] 'process raft request'  (duration: 487.25278ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-09T15:06:16.079291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T15:06:15.59143Z","time spent":"487.787317ms","remote":"127.0.0.1:38850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:6912 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-10-09T15:06:16.079494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"488.698691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-10-09T15:06:16.080559Z","caller":"traceutil/trace.go:171","msg":"trace[1594308231] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:6925; }","duration":"488.850423ms","start":"2026-10-09T15:06:15.590737Z","end":"2026-10-09T15:06:16.079587Z","steps":["trace[1594308231] 'agreement among raft nodes before linearized reading'  (duration: 488.548098ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-09T15:06:16.080673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T15:06:15.590715Z","time spent":"489.941147ms","remote":"127.0.0.1:38856","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/endpointslices/default/kubernetes\" "}
{"level":"warn","ts":"2026-10-09T15:06:16.45622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.452274ms","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-10-09T15:06:16.456292Z","caller":"traceutil/trace.go:171","msg":"trace[455082182] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6925; }","duration":"273.541095ms","start":"2026-10-09T15:06:16.182734Z","end":"2026-10-09T15:06:16.456275Z","steps":["trace[455082182] 'range keys from in-memory index tree'  (duration: 273.401324ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-09T15:06:16.456482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.980411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5651"}
{"level":"info","ts":"2026-10-09T15:06:16.457079Z","caller":"traceutil/trace.go:171","msg":"trace[1448578779] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:6925; }","duration":"357.58586ms","start":"2026-10-09T15:06:16.099477Z","end":"2026-10-09T15:06:16.457063Z","steps":["trace[1448578779] 'range keys from in-memory index tree'  (duration: 356.86549ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-09T15:06:16.457111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T15:06:16.099459Z","time spent":"357.64145ms","remote":"127.0.0.1:49160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5673,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"warn","ts":"2026-10-09T15:06:16.457121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.450246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-10-09T15:06:16.457165Z","caller":"traceutil/trace.go:171","msg":"trace[2062387115] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6925; }","duration":"185.517426ms","start":"2026-10-09T15:06:16.271636Z","end":"2026-10-09T15:06:16.457153Z","steps":["trace[2062387115] 'range keys from in-memory index tree'  (duration: 185.243142ms)"],"step_count":1}
{"level":"info","ts":"2026-10-09T15:06:16.457461Z","caller":"traceutil/trace.go:171","msg":"trace[1289752049] linearizableReadLoop","detail":"{readStateIndex:7181; appliedIndex:7180; }","duration":"183.981814ms","start":"2026-10-09T15:06:16.273462Z","end":"2026-10-09T15:06:16.457444Z","steps":["trace[1289752049] 'read index received'  (duration: 148.026189ms)","trace[1289752049] 'applied index is now lower than readState.Index'  (duration: 35.954335ms)"],"step_count":2}
{"level":"info","ts":"2026-10-09T15:06:16.457486Z","caller":"traceutil/trace.go:171","msg":"trace[254263393] transaction","detail":"{read_only:false; response_revision:6926; number_of_response:1; }","duration":"185.1025ms","start":"2026-10-09T15:06:16.272373Z","end":"2026-10-09T15:06:16.457475Z","steps":["trace[254263393] 'process raft request'  (duration: 149.163405ms)","trace[254263393] 'compare'  (duration: 35.357426ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-09T15:06:16.457685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.182157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-10-09T15:06:16.457813Z","caller":"traceutil/trace.go:171","msg":"trace[1449751257] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6926; }","duration":"184.325869ms","start":"2026-10-09T15:06:16.273441Z","end":"2026-10-09T15:06:16.457766Z","steps":["trace[1449751257] 'agreement among raft nodes before linearized reading'  (duration: 184.103726ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-09T15:06:16.511452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.769774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/horizon-db-sync\" ","response":"range_response_count:1 size:4784"}
{"level":"warn","ts":"2026-10-09T15:06:16.511509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.808565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/horizon-db-sync\" ","response":"range_response_count:1 size:4784"}
{"level":"info","ts":"2026-10-09T15:06:16.511529Z","caller":"traceutil/trace.go:171","msg":"trace[1429827572] range","detail":"{range_begin:/registry/jobs/openstack/horizon-db-sync; range_end:; response_count:1; response_revision:6927; }","duration":"237.874046ms","start":"2026-10-09T15:06:16.273638Z","end":"2026-10-09T15:06:16.511512Z","steps":["trace[1429827572] 'agreement among raft nodes before linearized reading'  (duration: 237.665713ms)"],"step_count":1}
{"level":"info","ts":"2026-10-09T15:06:16.511602Z","caller":"traceutil/trace.go:171","msg":"trace[1482815237] range","detail":"{range_begin:/registry/jobs/openstack/horizon-db-sync; range_end:; response_count:1; response_revision:6927; }","duration":"237.911846ms","start":"2026-10-09T15:06:16.273672Z","end":"2026-10-09T15:06:16.511584Z","steps":["trace[1482815237] 'agreement among raft nodes before linearized reading'  (duration: 237.714983ms)"],"step_count":1}
{"level":"info","ts":"2026-10-09T15:06:16.511431Z","caller":"traceutil/trace.go:171","msg":"trace[2055280699] transaction","detail":"{read_only:false; response_revision:6927; number_of_response:1; }","duration":"236.16582ms","start":"2026-10-09T15:06:16.275231Z","end":"2026-10-09T15:06:16.511397Z","steps":["trace[2055280699] 'process raft request'  (duration: 235.921737ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-09T15:06:16.512387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.043588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/horizon-db-sync\" ","response":"range_response_count:1 size:4784"}
{"level":"info","ts":"2026-10-09T15:06:16.512433Z","caller":"traceutil/trace.go:171","msg":"trace[1890331970] range","detail":"{range_begin:/registry/jobs/openstack/horizon-db-sync; range_end:; response_count:1; response_revision:6927; }","duration":"238.103669ms","start":"2026-10-09T15:06:16.274316Z","end":"2026-10-09T15:06:16.51242Z","steps":["trace[1890331970] 'agreement among raft nodes before linearized reading'  (duration: 237.011013ms)"],"step_count":1}
{"level":"info","ts":"2026-10-09T15:06:18.629453Z","caller":"traceutil/trace.go:171","msg":"trace[636072575] transaction","detail":"{read_only:false; response_revision:6938; number_of_response:1; }","duration":"107.306885ms","start":"2026-10-09T15:06:18.522123Z","end":"2026-10-09T15:06:18.62943Z","steps":["trace[636072575] 'process raft request'  (duration: 107.145243ms)"],"step_count":1}
{"level":"info","ts":"2026-10-09T15:06:18.629756Z","caller":"traceutil/trace.go:171","msg":"trace[156123406] transaction","detail":"{read_only:false; response_revision:6939; number_of_response:1; }","duration":"107.489618ms","start":"2026-10-09T15:06:18.522238Z","end":"2026-10-09T15:06:18.629727Z","steps":["trace[156123406] 'process raft request'  (duration: 107.152193ms)"],"step_count":1}
{"level":"info","ts":"2026-10-09T15:06:18.630132Z","caller":"traceutil/trace.go:171","msg":"trace[295364323] transaction","detail":"{read_only:false; response_revision:6940; number_of_response:1; }","duration":"107.860503ms","start":"2026-10-09T15:06:18.52225Z","end":"2026-10-09T15:06:18.63011Z","steps":["trace[295364323] 'process raft request'  (duration: 107.390176ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-09T15:06:18.630252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.8487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/horizon-db-sync\" ","response":"range_response_count:1 size:4784"}
{"level":"info","ts":"2026-10-09T15:06:18.630307Z","caller":"traceutil/trace.go:171","msg":"trace[236156948] range","detail":"{range_begin:/registry/jobs/openstack/horizon-db-sync; range_end:; response_count:1; response_revision:6940; }","duration":"111.934631ms","start":"2026-10-09T15:06:18.518359Z","end":"2026-10-09T15:06:18.630294Z","steps":["trace[236156948] 'agreement among raft nodes before linearized reading'  (duration: 111.78593ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-09T15:06:18.630312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.821101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/horizon-db-sync\" ","response":"range_response_count:1 size:4784"}
{"level":"info","ts":"2026-10-09T15:06:18.630425Z","caller":"traceutil/trace.go:171","msg":"trace[292922335] range","detail":"{range_begin:/registry/jobs/openstack/horizon-db-sync; range_end:; response_count:1; response_revision:6940; }","duration":"112.013513ms","start":"2026-10-09T15:06:18.518328Z","end":"2026-10-09T15:06:18.630341Z","steps":["trace[292922335] 'agreement among raft nodes before linearized reading'  (duration: 111.7924ms)"],"step_count":1}
{"level":"info","ts":"2026-10-09T15:07:30.638871Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5329}
{"level":"info","ts":"2026-10-09T15:07:30.725078Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5329,"took":"84.704281ms","hash":3853012451,"current-db-size-bytes":53420032,"current-db-size":"53 MB","current-db-size-in-use-bytes":18927616,"current-db-size-in-use":"19 MB"}
{"level":"info","ts":"2026-10-09T15:07:30.725222Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3853012451,"revision":5329,"compact-revision":2854}