{"level":"warn","ts":"2026-09-15T11:23:55.819368Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-09-15T11:23:55.819484Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.82: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.82:2380","--initial-cluster=instance=https://162.253.55.82:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.82:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.82: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-09-15T11:23:55.819621Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-09-15T11:23:55.819638Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.82:2380"]}
{"level":"info","ts":"2026-09-15T11:23:55.819667Z","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-09-15T11:23:55.820401Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.82:2379"]}
{"level":"info","ts":"2026-09-15T11:23:55.820548Z","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.82:2380"],"listen-peer-urls":["https://162.253.55.82:2380"],"advertise-client-urls":["https://162.253.55.82:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.82:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.82: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-09-15T11:23:55.825705Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.878547ms"}
{"level":"info","ts":"2026-09-15T11:23:55.834013Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c5298098e2dc0f92","cluster-id":"e15b04acbd0c3f73"}
{"level":"info","ts":"2026-09-15T11:23:55.834169Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c5298098e2dc0f92 switched to configuration voters=()"}
{"level":"info","ts":"2026-09-15T11:23:55.83423Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c5298098e2dc0f92 became follower at term 0"}
{"level":"info","ts":"2026-09-15T11:23:55.834245Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c5298098e2dc0f92 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-09-15T11:23:55.834277Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c5298098e2dc0f92 became follower at term 1"}
{"level":"info","ts":"2026-09-15T11:23:55.834379Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c5298098e2dc0f92 switched to configuration voters=(14207027893646397330)"}
{"level":"warn","ts":"2026-09-15T11:23:55.840149Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-09-15T11:23:55.841286Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-09-15T11:23:55.843959Z","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-09-15T11:23:55.845714Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c5298098e2dc0f92","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-09-15T11:23:55.84587Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c5298098e2dc0f92","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-09-15T11:23:55.845989Z","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-09-15T11:23:55.847417Z","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-09-15T11:23:55.847572Z","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-09-15T11:23:55.848412Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c5298098e2dc0f92 switched to configuration voters=(14207027893646397330)"}
{"level":"info","ts":"2026-09-15T11:23:55.848586Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e15b04acbd0c3f73","local-member-id":"c5298098e2dc0f92","added-peer-id":"c5298098e2dc0f92","added-peer-peer-urls":["https://162.253.55.82:2380"]}
{"level":"info","ts":"2026-09-15T11:23:55.850252Z","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-09-15T11:23:55.850457Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.82:2380"}
{"level":"info","ts":"2026-09-15T11:23:55.850525Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.82:2380"}
{"level":"info","ts":"2026-09-15T11:23:55.850538Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c5298098e2dc0f92","initial-advertise-peer-urls":["https://162.253.55.82:2380"],"listen-peer-urls":["https://162.253.55.82:2380"],"advertise-client-urls":["https://162.253.55.82:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.82:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-09-15T11:23:55.850568Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-09-15T11:23:56.136418Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c5298098e2dc0f92 is starting a new election at term 1"}
{"level":"info","ts":"2026-09-15T11:23:56.136518Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c5298098e2dc0f92 became pre-candidate at term 1"}
{"level":"info","ts":"2026-09-15T11:23:56.136551Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c5298098e2dc0f92 received MsgPreVoteResp from c5298098e2dc0f92 at term 1"}
{"level":"info","ts":"2026-09-15T11:23:56.136566Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c5298098e2dc0f92 became candidate at term 2"}
{"level":"info","ts":"2026-09-15T11:23:56.136572Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c5298098e2dc0f92 received MsgVoteResp from c5298098e2dc0f92 at term 2"}
{"level":"info","ts":"2026-09-15T11:23:56.136583Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c5298098e2dc0f92 became leader at term 2"}
{"level":"info","ts":"2026-09-15T11:23:56.136592Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c5298098e2dc0f92 elected leader c5298098e2dc0f92 at term 2"}
{"level":"info","ts":"2026-09-15T11:23:56.140681Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-15T11:23:56.140866Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c5298098e2dc0f92","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.82:2379]}","request-path":"/0/members/c5298098e2dc0f92/attributes","cluster-id":"e15b04acbd0c3f73","publish-timeout":"7s"}
{"level":"info","ts":"2026-09-15T11:23:56.140993Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-09-15T11:23:56.141076Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-09-15T11:23:56.141861Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-09-15T11:23:56.141927Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-09-15T11:23:56.142983Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-09-15T11:23:56.143214Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e15b04acbd0c3f73","local-member-id":"c5298098e2dc0f92","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-15T11:23:56.143326Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-15T11:23:56.143368Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-15T11:23:56.143542Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.82:2379"}
{"level":"info","ts":"2026-09-15T11:24:44.156617Z","caller":"traceutil/trace.go:171","msg":"trace[983000594] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"164.157036ms","start":"2026-09-15T11:24:43.992433Z","end":"2026-09-15T11:24:44.15659Z","steps":["trace[983000594] 'process raft request'  (duration: 163.536592ms)"],"step_count":1}
{"level":"info","ts":"2026-09-15T11:24:44.358479Z","caller":"traceutil/trace.go:171","msg":"trace[321886109] linearizableReadLoop","detail":"{readStateIndex:673; appliedIndex:672; }","duration":"107.355113ms","start":"2026-09-15T11:24:44.251101Z","end":"2026-09-15T11:24:44.358456Z","steps":["trace[321886109] 'read index received'  (duration: 107.169249ms)","trace[321886109] 'applied index is now lower than readState.Index'  (duration: 185.034µs)"],"step_count":2}
{"level":"info","ts":"2026-09-15T11:24:44.358495Z","caller":"traceutil/trace.go:171","msg":"trace[383905350] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"110.6543ms","start":"2026-09-15T11:24:44.247827Z","end":"2026-09-15T11:24:44.358481Z","steps":["trace[383905350] 'process raft request'  (duration: 110.506546ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-15T11:24:44.358643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.524997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-09-15T11:24:44.358699Z","caller":"traceutil/trace.go:171","msg":"trace[438611577] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:646; }","duration":"107.62023ms","start":"2026-09-15T11:24:44.251072Z","end":"2026-09-15T11:24:44.358692Z","steps":["trace[438611577] 'agreement among raft nodes before linearized reading'  (duration: 107.456436ms)"],"step_count":1}
{"level":"info","ts":"2026-09-15T11:24:44.558114Z","caller":"traceutil/trace.go:171","msg":"trace[1468025615] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"184.88352ms","start":"2026-09-15T11:24:44.373191Z","end":"2026-09-15T11:24:44.558075Z","steps":["trace[1468025615] 'process raft request'  (duration: 146.571916ms)","trace[1468025615] 'compare'  (duration: 38.13653ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-15T11:24:44.558298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.541243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-15T11:24:44.558351Z","caller":"traceutil/trace.go:171","msg":"trace[2025811468] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system; range_end:; response_count:0; response_revision:647; }","duration":"175.686026ms","start":"2026-09-15T11:24:44.382648Z","end":"2026-09-15T11:24:44.558334Z","steps":["trace[2025811468] 'agreement among raft nodes before linearized reading'  (duration: 175.565833ms)"],"step_count":1}
{"level":"info","ts":"2026-09-15T11:24:44.558503Z","caller":"traceutil/trace.go:171","msg":"trace[185739237] linearizableReadLoop","detail":"{readStateIndex:674; appliedIndex:673; }","duration":"175.301957ms","start":"2026-09-15T11:24:44.382721Z","end":"2026-09-15T11:24:44.558023Z","steps":["trace[185739237] 'read index received'  (duration: 136.963563ms)","trace[185739237] 'applied index is now lower than readState.Index'  (duration: 38.337094ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-15T11:24:45.140411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.185859ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1122135886879539039 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:635 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-15T11:24:45.140693Z","caller":"traceutil/trace.go:171","msg":"trace[1924940086] linearizableReadLoop","detail":"{readStateIndex:675; appliedIndex:674; }","duration":"418.422614ms","start":"2026-09-15T11:24:44.722241Z","end":"2026-09-15T11:24:45.140663Z","steps":["trace[1924940086] 'read index received'  (duration: 204.020756ms)","trace[1924940086] 'applied index is now lower than readState.Index'  (duration: 214.399078ms)"],"step_count":2}
{"level":"info","ts":"2026-09-15T11:24:45.140905Z","caller":"traceutil/trace.go:171","msg":"trace[1665269462] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"494.962178ms","start":"2026-09-15T11:24:44.64565Z","end":"2026-09-15T11:24:45.140612Z","steps":["trace[1665269462] 'process raft request'  (duration: 280.642963ms)","trace[1665269462] 'compare'  (duration: 212.568514ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-15T11:24:45.141147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T11:24:44.645639Z","time spent":"495.345906ms","remote":"127.0.0.1:53036","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:635 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-09-15T11:24:45.166779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.48999ms","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-09-15T11:24:45.166942Z","caller":"traceutil/trace.go:171","msg":"trace[275635802] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:648; }","duration":"444.688626ms","start":"2026-09-15T11:24:44.722212Z","end":"2026-09-15T11:24:45.1669Z","steps":["trace[275635802] 'agreement among raft nodes before linearized reading'  (duration: 418.575108ms)","trace[275635802] 'range keys from in-memory index tree'  (duration: 25.676998ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-15T11:24:45.167099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T11:24:44.722197Z","time spent":"444.819658ms","remote":"127.0.0.1:53036","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-09-15T11:24:45.167818Z","caller":"traceutil/trace.go:171","msg":"trace[346895819] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"175.48628ms","start":"2026-09-15T11:24:44.992301Z","end":"2026-09-15T11:24:45.167787Z","steps":["trace[346895819] 'process raft request'  (duration: 174.356333ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-15T11:24:45.167942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.333807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-zrt4v\" ","response":"range_response_count:1 size:16961"}
{"level":"info","ts":"2026-09-15T11:24:45.167999Z","caller":"traceutil/trace.go:171","msg":"trace[1310631583] range","detail":"{range_begin:/registry/pods/kube-system/cilium-zrt4v; range_end:; response_count:1; response_revision:649; }","duration":"320.448309ms","start":"2026-09-15T11:24:44.847534Z","end":"2026-09-15T11:24:45.167982Z","steps":["trace[1310631583] 'agreement among raft nodes before linearized reading'  (duration: 320.221844ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-15T11:24:45.168117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T11:24:44.84751Z","time spent":"320.561372ms","remote":"127.0.0.1:52952","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16985,"request content":"key:\"/registry/pods/kube-system/cilium-zrt4v\" "}
{"level":"warn","ts":"2026-09-15T11:25:01.679531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.955748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-09-15T11:25:01.679654Z","caller":"traceutil/trace.go:171","msg":"trace[1826752319] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:820; }","duration":"121.135277ms","start":"2026-09-15T11:25:01.558499Z","end":"2026-09-15T11:25:01.679634Z","steps":["trace[1826752319] 'range keys from in-memory index tree'  (duration: 120.71346ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-15T11:25:01.679598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.926672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-15T11:25:01.679735Z","caller":"traceutil/trace.go:171","msg":"trace[1338441270] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:820; }","duration":"139.135491ms","start":"2026-09-15T11:25:01.540576Z","end":"2026-09-15T11:25:01.679712Z","steps":["trace[1338441270] 'range keys from in-memory index tree'  (duration: 138.851262ms)"],"step_count":1}
{"level":"info","ts":"2026-09-15T11:25:01.93894Z","caller":"traceutil/trace.go:171","msg":"trace[1230156378] transaction","detail":"{read_only:false; response_revision:821; number_of_response:1; }","duration":"254.334338ms","start":"2026-09-15T11:25:01.684576Z","end":"2026-09-15T11:25:01.93891Z","steps":["trace[1230156378] 'process raft request'  (duration: 254.129939ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-15T11:26:29.713891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.167715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-1cafd447-9fdc-4de0-aa55-0e67259bcbfa\" ","response":"range_response_count:1 size:3626"}
{"level":"warn","ts":"2026-09-15T11:26:29.714106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.491344ms","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-09-15T11:26:29.714205Z","caller":"traceutil/trace.go:171","msg":"trace[1984130344] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1927; }","duration":"170.661847ms","start":"2026-09-15T11:26:29.543522Z","end":"2026-09-15T11:26:29.714184Z","steps":["trace[1984130344] 'range keys from in-memory index tree'  (duration: 170.290132ms)"],"step_count":1}
{"level":"info","ts":"2026-09-15T11:26:29.714293Z","caller":"traceutil/trace.go:171","msg":"trace[291925506] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-1cafd447-9fdc-4de0-aa55-0e67259bcbfa; range_end:; response_count:1; response_revision:1927; }","duration":"252.542471ms","start":"2026-09-15T11:26:29.461625Z","end":"2026-09-15T11:26:29.714168Z","steps":["trace[291925506] 'range keys from in-memory index tree'  (duration: 251.841961ms)"],"step_count":1}
{"level":"info","ts":"2026-09-15T11:26:29.946779Z","caller":"traceutil/trace.go:171","msg":"trace[793833777] linearizableReadLoop","detail":"{readStateIndex:2008; appliedIndex:2007; }","duration":"145.663655ms","start":"2026-09-15T11:26:29.801079Z","end":"2026-09-15T11:26:29.946742Z","steps":["trace[793833777] 'read index received'  (duration: 129.360525ms)","trace[793833777] 'applied index is now lower than readState.Index'  (duration: 16.30168ms)"],"step_count":2}
{"level":"info","ts":"2026-09-15T11:26:29.946871Z","caller":"traceutil/trace.go:171","msg":"trace[1881858280] transaction","detail":"{read_only:false; response_revision:1929; number_of_response:1; }","duration":"222.003517ms","start":"2026-09-15T11:26:29.724826Z","end":"2026-09-15T11:26:29.946829Z","steps":["trace[1881858280] 'process raft request'  (duration: 205.597206ms)","trace[1881858280] 'compare'  (duration: 16.113317ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-15T11:26:29.947117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.664418ms","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":"warn","ts":"2026-09-15T11:26:29.947143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.03516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.82\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-09-15T11:26:29.947186Z","caller":"traceutil/trace.go:171","msg":"trace[824758986] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1929; }","duration":"139.754699ms","start":"2026-09-15T11:26:29.807411Z","end":"2026-09-15T11:26:29.947166Z","steps":["trace[824758986] 'agreement among raft nodes before linearized reading'  (duration: 139.510765ms)"],"step_count":1}
{"level":"info","ts":"2026-09-15T11:26:29.9472Z","caller":"traceutil/trace.go:171","msg":"trace[273771487] range","detail":"{range_begin:/registry/masterleases/162.253.55.82; range_end:; response_count:1; response_revision:1929; }","duration":"146.153181ms","start":"2026-09-15T11:26:29.801032Z","end":"2026-09-15T11:26:29.947185Z","steps":["trace[273771487] 'agreement among raft nodes before linearized reading'  (duration: 145.844797ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-15T11:26:30.223596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.925038ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1122135886879541607 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:15-second id:0f92a0a4cf2c4966>","response":"size:41"}
{"level":"info","ts":"2026-09-15T11:26:30.224205Z","caller":"traceutil/trace.go:171","msg":"trace[1560510081] transaction","detail":"{read_only:false; response_revision:1931; number_of_response:1; }","duration":"270.577795ms","start":"2026-09-15T11:26:29.95359Z","end":"2026-09-15T11:26:30.224167Z","steps":["trace[1560510081] 'process raft request'  (duration: 270.302051ms)"],"step_count":1}
{"level":"info","ts":"2026-09-15T11:26:30.224558Z","caller":"traceutil/trace.go:171","msg":"trace[170617087] transaction","detail":"{read_only:false; response_revision:1930; number_of_response:1; }","duration":"271.870513ms","start":"2026-09-15T11:26:29.952342Z","end":"2026-09-15T11:26:30.224212Z","steps":["trace[170617087] 'process raft request'  (duration: 271.442957ms)"],"step_count":1}
{"level":"info","ts":"2026-09-15T11:26:30.224858Z","caller":"traceutil/trace.go:171","msg":"trace[1643036577] linearizableReadLoop","detail":"{readStateIndex:2009; appliedIndex:2008; }","duration":"272.712724ms","start":"2026-09-15T11:26:29.951595Z","end":"2026-09-15T11:26:30.224308Z","steps":["trace[1643036577] 'read index received'  (duration: 138.098477ms)","trace[1643036577] 'applied index is now lower than readState.Index'  (duration: 134.612467ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-15T11:26:30.224864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.255691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" ","response":"range_response_count:1 size:10667"}
{"level":"info","ts":"2026-09-15T11:26:30.224946Z","caller":"traceutil/trace.go:171","msg":"trace[1398636084] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-haproxy-0; range_end:; response_count:1; response_revision:1932; }","duration":"273.367592ms","start":"2026-09-15T11:26:29.951563Z","end":"2026-09-15T11:26:30.224931Z","steps":["trace[1398636084] 'agreement among raft nodes before linearized reading'  (duration: 273.096818ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-15T11:27:04.810408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.698429ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1122135886879542169 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:2166 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-15T11:27:04.810698Z","caller":"traceutil/trace.go:171","msg":"trace[1311462227] transaction","detail":"{read_only:false; response_revision:2175; number_of_response:1; }","duration":"291.296729ms","start":"2026-09-15T11:27:04.519365Z","end":"2026-09-15T11:27:04.810662Z","steps":["trace[1311462227] 'process raft request'  (duration: 111.165413ms)","trace[1311462227] 'compare'  (duration: 179.520826ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-15T11:27:04.810949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.061917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-09-15T11:27:04.811012Z","caller":"traceutil/trace.go:171","msg":"trace[1873096853] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2176; }","duration":"147.181149ms","start":"2026-09-15T11:27:04.663817Z","end":"2026-09-15T11:27:04.810999Z","steps":["trace[1873096853] 'agreement among raft nodes before linearized reading'  (duration: 146.941965ms)"],"step_count":1}
{"level":"info","ts":"2026-09-15T11:27:04.810718Z","caller":"traceutil/trace.go:171","msg":"trace[1909802847] linearizableReadLoop","detail":"{readStateIndex:2264; appliedIndex:2262; }","duration":"146.796483ms","start":"2026-09-15T11:27:04.663893Z","end":"2026-09-15T11:27:04.81069Z","steps":["trace[1909802847] 'read index received'  (duration: 94.573273ms)","trace[1909802847] 'applied index is now lower than readState.Index'  (duration: 52.22177ms)"],"step_count":2}
{"level":"info","ts":"2026-09-15T11:27:04.8109Z","caller":"traceutil/trace.go:171","msg":"trace[1938184494] transaction","detail":"{read_only:false; response_revision:2176; number_of_response:1; }","duration":"287.692823ms","start":"2026-09-15T11:27:04.523194Z","end":"2026-09-15T11:27:04.810887Z","steps":["trace[1938184494] 'process raft request'  (duration: 287.413779ms)"],"step_count":1}
{"level":"info","ts":"2026-09-15T11:27:05.553008Z","caller":"traceutil/trace.go:171","msg":"trace[1146785541] linearizableReadLoop","detail":"{readStateIndex:2269; appliedIndex:2268; }","duration":"249.193622ms","start":"2026-09-15T11:27:05.303781Z","end":"2026-09-15T11:27:05.552975Z","steps":["trace[1146785541] 'read index received'  (duration: 248.875528ms)","trace[1146785541] 'applied index is now lower than readState.Index'  (duration: 316.914µs)"],"step_count":2}
{"level":"info","ts":"2026-09-15T11:27:05.553128Z","caller":"traceutil/trace.go:171","msg":"trace[162365099] transaction","detail":"{read_only:false; response_revision:2180; number_of_response:1; }","duration":"314.939738ms","start":"2026-09-15T11:27:05.238153Z","end":"2026-09-15T11:27:05.553093Z","steps":["trace[162365099] 'process raft request'  (duration: 314.604344ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-15T11:27:05.553367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.538709ms","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":"warn","ts":"2026-09-15T11:27:05.553377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T11:27:05.238119Z","time spent":"315.093201ms","remote":"127.0.0.1:53036","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:2169 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-09-15T11:27:05.553421Z","caller":"traceutil/trace.go:171","msg":"trace[1553258445] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2180; }","duration":"249.68853ms","start":"2026-09-15T11:27:05.303719Z","end":"2026-09-15T11:27:05.553407Z","steps":["trace[1553258445] 'agreement among raft nodes before linearized reading'  (duration: 249.407776ms)"],"step_count":1}
{"level":"info","ts":"2026-09-15T11:27:06.011261Z","caller":"traceutil/trace.go:171","msg":"trace[1357377043] transaction","detail":"{read_only:false; response_revision:2182; number_of_response:1; }","duration":"241.687125ms","start":"2026-09-15T11:27:05.769532Z","end":"2026-09-15T11:27:06.01122Z","steps":["trace[1357377043] 'process raft request'  (duration: 241.37113ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-15T11:27:06.293645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.027126ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1122135886879542183 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:2172 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-15T11:27:06.293772Z","caller":"traceutil/trace.go:171","msg":"trace[983946550] transaction","detail":"{read_only:false; response_revision:2183; number_of_response:1; }","duration":"276.398498ms","start":"2026-09-15T11:27:06.017348Z","end":"2026-09-15T11:27:06.293746Z","steps":["trace[983946550] 'process raft request'  (duration: 77.16785ms)","trace[983946550] 'compare'  (duration: 198.7381ms)"],"step_count":2}
{"level":"info","ts":"2026-09-15T11:28:05.850488Z","caller":"traceutil/trace.go:171","msg":"trace[308983574] transaction","detail":"{read_only:false; response_revision:2523; number_of_response:1; }","duration":"110.754388ms","start":"2026-09-15T11:28:05.739707Z","end":"2026-09-15T11:28:05.850461Z","steps":["trace[308983574] 'process raft request'  (duration: 58.598727ms)","trace[308983574] 'compare'  (duration: 52.020429ms)"],"step_count":2}
{"level":"info","ts":"2026-09-15T11:28:44.35584Z","caller":"traceutil/trace.go:171","msg":"trace[1013113067] transaction","detail":"{read_only:false; response_revision:2817; number_of_response:1; }","duration":"204.569459ms","start":"2026-09-15T11:28:44.151242Z","end":"2026-09-15T11:28:44.355812Z","steps":["trace[1013113067] 'process raft request'  (duration: 204.411626ms)"],"step_count":1}
{"level":"info","ts":"2026-09-15T11:28:55.282892Z","caller":"traceutil/trace.go:171","msg":"trace[757699283] transaction","detail":"{read_only:false; response_revision:2871; number_of_response:1; }","duration":"134.295651ms","start":"2026-09-15T11:28:55.14857Z","end":"2026-09-15T11:28:55.282866Z","steps":["trace[757699283] 'process raft request'  (duration: 134.139568ms)"],"step_count":1}
{"level":"info","ts":"2026-09-15T11:28:55.365323Z","caller":"traceutil/trace.go:171","msg":"trace[1281919299] transaction","detail":"{read_only:false; response_revision:2872; number_of_response:1; }","duration":"122.193002ms","start":"2026-09-15T11:28:55.243109Z","end":"2026-09-15T11:28:55.365302Z","steps":["trace[1281919299] 'process raft request'  (duration: 122.034179ms)"],"step_count":1}
{"level":"info","ts":"2026-09-15T11:29:00.714705Z","caller":"traceutil/trace.go:171","msg":"trace[1375194058] transaction","detail":"{read_only:false; response_revision:2902; number_of_response:1; }","duration":"269.827948ms","start":"2026-09-15T11:29:00.444849Z","end":"2026-09-15T11:29:00.714677Z","steps":["trace[1375194058] 'process raft request'  (duration: 269.692957ms)"],"step_count":1}
{"level":"info","ts":"2026-09-15T11:29:01.209655Z","caller":"traceutil/trace.go:171","msg":"trace[417488417] transaction","detail":"{read_only:false; response_revision:2905; number_of_response:1; }","duration":"147.730754ms","start":"2026-09-15T11:29:01.061879Z","end":"2026-09-15T11:29:01.20961Z","steps":["trace[417488417] 'process raft request'  (duration: 78.154598ms)","trace[417488417] 'compare'  (duration: 69.074146ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-15T11:33:35.472771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.966085ms","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-09-15T11:33:35.47286Z","caller":"traceutil/trace.go:171","msg":"trace[2130978974] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5118; }","duration":"279.115849ms","start":"2026-09-15T11:33:35.193726Z","end":"2026-09-15T11:33:35.472841Z","steps":["trace[2130978974] 'range keys from in-memory index tree'  (duration: 278.795422ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-15T11:33:35.472858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.979791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-09-15T11:33:35.472932Z","caller":"traceutil/trace.go:171","msg":"trace[425673184] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5118; }","duration":"150.096624ms","start":"2026-09-15T11:33:35.322817Z","end":"2026-09-15T11:33:35.472913Z","steps":["trace[425673184] 'range keys from in-memory index tree'  (duration: 149.565161ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-15T11:33:35.473088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.529476ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/operatorpolicies/\" range_end:\"/registry/rabbitmq.com/operatorpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-15T11:33:35.473154Z","caller":"traceutil/trace.go:171","msg":"trace[2027275696] range","detail":"{range_begin:/registry/rabbitmq.com/operatorpolicies/; range_end:/registry/rabbitmq.com/operatorpolicies0; response_count:0; response_revision:5118; }","duration":"278.696999ms","start":"2026-09-15T11:33:35.194443Z","end":"2026-09-15T11:33:35.47314Z","steps":["trace[2027275696] 'count revisions from in-memory index tree'  (duration: 278.063914ms)"],"step_count":1}
{"level":"info","ts":"2026-09-15T11:33:35.888979Z","caller":"traceutil/trace.go:171","msg":"trace[2036255962] transaction","detail":"{read_only:false; response_revision:5119; number_of_response:1; }","duration":"494.642623ms","start":"2026-09-15T11:33:35.394312Z","end":"2026-09-15T11:33:35.888955Z","steps":["trace[2036255962] 'process raft request'  (duration: 494.4732ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-15T11:33:35.889124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T11:33:35.394283Z","time spent":"494.763176ms","remote":"127.0.0.1:53036","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:5051 > 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-09-15T11:33:36.109571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.909917ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1122135886879549357 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:5050 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-15T11:33:36.109822Z","caller":"traceutil/trace.go:171","msg":"trace[1253067412] transaction","detail":"{read_only:false; response_revision:5120; number_of_response:1; }","duration":"632.158105ms","start":"2026-09-15T11:33:35.477635Z","end":"2026-09-15T11:33:36.109793Z","steps":["trace[1253067412] 'process raft request'  (duration: 522.92799ms)","trace[1253067412] 'compare'  (duration: 108.779954ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-15T11:33:36.110019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T11:33:35.477606Z","time spent":"632.308258ms","remote":"127.0.0.1:53036","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:5050 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-09-15T11:33:36.110251Z","caller":"traceutil/trace.go:171","msg":"trace[1456157945] linearizableReadLoop","detail":"{readStateIndex:5321; appliedIndex:5318; }","duration":"570.475382ms","start":"2026-09-15T11:33:35.539756Z","end":"2026-09-15T11:33:36.110232Z","steps":["trace[1456157945] 'read index received'  (duration: 349.053114ms)","trace[1456157945] 'applied index is now lower than readState.Index'  (duration: 221.420548ms)"],"step_count":2}
{"level":"info","ts":"2026-09-15T11:33:36.110405Z","caller":"traceutil/trace.go:171","msg":"trace[417435830] transaction","detail":"{read_only:false; response_revision:5122; number_of_response:1; }","duration":"457.940509ms","start":"2026-09-15T11:33:35.652415Z","end":"2026-09-15T11:33:36.110356Z","steps":["trace[417435830] 'process raft request'  (duration: 457.649142ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-15T11:33:36.11051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"536.521513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-09-15T11:33:36.110498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"570.721608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-15T11:33:36.110561Z","caller":"traceutil/trace.go:171","msg":"trace[1455350274] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:5122; }","duration":"536.625425ms","start":"2026-09-15T11:33:35.573921Z","end":"2026-09-15T11:33:36.110546Z","steps":["trace[1455350274] 'agreement among raft nodes before linearized reading'  (duration: 536.484442ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-15T11:33:36.111035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T11:33:35.573901Z","time spent":"537.111597ms","remote":"127.0.0.1:52986","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":29,"request content":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true "}
{"level":"info","ts":"2026-09-15T11:33:36.11058Z","caller":"traceutil/trace.go:171","msg":"trace[1566795082] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5122; }","duration":"570.844111ms","start":"2026-09-15T11:33:35.539718Z","end":"2026-09-15T11:33:36.110562Z","steps":["trace[1566795082] 'agreement among raft nodes before linearized reading'  (duration: 570.675037ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-15T11:33:36.111108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T11:33:35.539701Z","time spent":"571.394343ms","remote":"127.0.0.1:52782","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-09-15T11:33:36.110589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T11:33:35.652368Z","time spent":"458.127863ms","remote":"127.0.0.1:52854","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-7c6bcfbb68-798wz.18d57b513445bfbb\" mod_revision:0 > success:<request_put:<key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-7c6bcfbb68-798wz.18d57b513445bfbb\" value_size:774 lease:1122135886879549142 >> failure:<>"}
{"level":"info","ts":"2026-09-15T11:33:36.11063Z","caller":"traceutil/trace.go:171","msg":"trace[283956777] transaction","detail":"{read_only:false; response_revision:5121; number_of_response:1; }","duration":"632.792158ms","start":"2026-09-15T11:33:35.477795Z","end":"2026-09-15T11:33:36.110587Z","steps":["trace[283956777] 'process raft request'  (duration: 631.892968ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-15T11:33:36.111395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T11:33:35.477766Z","time spent":"633.571397ms","remote":"127.0.0.1:53036","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:5049 > 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\" > >"}
{"level":"warn","ts":"2026-09-15T11:33:36.110708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.046927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-grafana-7c6bcfbb68-798wz\" ","response":"range_response_count:1 size:11256"}
{"level":"info","ts":"2026-09-15T11:33:36.111497Z","caller":"traceutil/trace.go:171","msg":"trace[1966639401] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-grafana-7c6bcfbb68-798wz; range_end:; response_count:1; response_revision:5122; }","duration":"460.859837ms","start":"2026-09-15T11:33:35.650628Z","end":"2026-09-15T11:33:36.111488Z","steps":["trace[1966639401] 'agreement among raft nodes before linearized reading'  (duration: 459.979156ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-15T11:33:36.111514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T11:33:35.650613Z","time spent":"460.896028ms","remote":"127.0.0.1:52952","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":11280,"request content":"key:\"/registry/pods/monitoring/kube-prometheus-stack-grafana-7c6bcfbb68-798wz\" "}
{"level":"warn","ts":"2026-09-15T11:33:36.110731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"485.067308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-09-15T11:33:36.111639Z","caller":"traceutil/trace.go:171","msg":"trace[1689972983] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:5122; }","duration":"486.027261ms","start":"2026-09-15T11:33:35.625605Z","end":"2026-09-15T11:33:36.111632Z","steps":["trace[1689972983] 'agreement among raft nodes before linearized reading'  (duration: 485.032968ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-15T11:33:36.111657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T11:33:35.625586Z","time spent":"486.064232ms","remote":"127.0.0.1:53036","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":14,"response size":31,"request content":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true "}
{"level":"info","ts":"2026-09-15T11:33:36.287702Z","caller":"traceutil/trace.go:171","msg":"trace[1143261329] transaction","detail":"{read_only:false; response_revision:5123; number_of_response:1; }","duration":"161.572988ms","start":"2026-09-15T11:33:36.126102Z","end":"2026-09-15T11:33:36.287675Z","steps":["trace[1143261329] 'process raft request'  (duration: 107.409281ms)","trace[1143261329] 'compare'  (duration: 54.045424ms)"],"step_count":2}
{"level":"info","ts":"2026-09-15T11:33:36.53364Z","caller":"traceutil/trace.go:171","msg":"trace[939313305] transaction","detail":"{read_only:false; response_revision:5125; number_of_response:1; }","duration":"239.994778ms","start":"2026-09-15T11:33:36.293627Z","end":"2026-09-15T11:33:36.533622Z","steps":["trace[939313305] 'process raft request'  (duration: 239.841574ms)"],"step_count":1}
{"level":"info","ts":"2026-09-15T11:33:36.533853Z","caller":"traceutil/trace.go:171","msg":"trace[1714086352] linearizableReadLoop","detail":"{readStateIndex:5326; appliedIndex:5324; }","duration":"156.301166ms","start":"2026-09-15T11:33:36.377532Z","end":"2026-09-15T11:33:36.533833Z","steps":["trace[1714086352] 'read index received'  (duration: 155.972638ms)","trace[1714086352] 'applied index is now lower than readState.Index'  (duration: 327.248µs)"],"step_count":2}
{"level":"info","ts":"2026-09-15T11:33:36.533974Z","caller":"traceutil/trace.go:171","msg":"trace[1310197239] transaction","detail":"{read_only:false; response_revision:5126; number_of_response:1; }","duration":"240.247573ms","start":"2026-09-15T11:33:36.293716Z","end":"2026-09-15T11:33:36.533964Z","steps":["trace[1310197239] 'process raft request'  (duration: 239.863284ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-15T11:33:36.534111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.992931ms","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-09-15T11:33:36.534145Z","caller":"traceutil/trace.go:171","msg":"trace[1216233305] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5126; }","duration":"238.052903ms","start":"2026-09-15T11:33:36.296084Z","end":"2026-09-15T11:33:36.534137Z","steps":["trace[1216233305] 'agreement among raft nodes before linearized reading'  (duration: 237.92912ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-15T11:33:36.534173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.921869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/persistence-rabbitmq-keystone-server-0.18d57b50e7672033\" ","response":"range_response_count:1 size:1012"}
{"level":"info","ts":"2026-09-15T11:33:36.534237Z","caller":"traceutil/trace.go:171","msg":"trace[106134237] range","detail":"{range_begin:/registry/events/openstack/persistence-rabbitmq-keystone-server-0.18d57b50e7672033; range_end:; response_count:1; response_revision:5126; }","duration":"203.06347ms","start":"2026-09-15T11:33:36.331158Z","end":"2026-09-15T11:33:36.534221Z","steps":["trace[106134237] 'agreement among raft nodes before linearized reading'  (duration: 202.809074ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-15T11:33:37.034502Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1122135886879549370,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-09-15T11:33:37.290636Z","caller":"traceutil/trace.go:171","msg":"trace[271763902] transaction","detail":"{read_only:false; response_revision:5128; number_of_response:1; }","duration":"801.644895ms","start":"2026-09-15T11:33:36.488969Z","end":"2026-09-15T11:33:37.290614Z","steps":["trace[271763902] 'process raft request'  (duration: 801.542802ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-15T11:33:37.290795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T11:33:36.488949Z","time spent":"801.761557ms","remote":"127.0.0.1:53036","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:5105 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-09-15T11:33:37.291255Z","caller":"traceutil/trace.go:171","msg":"trace[1659468948] transaction","detail":"{read_only:false; response_revision:5127; number_of_response:1; }","duration":"906.930296ms","start":"2026-09-15T11:33:36.384306Z","end":"2026-09-15T11:33:37.291236Z","steps":["trace[1659468948] 'process raft request'  (duration: 906.042555ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-15T11:33:37.291366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T11:33:36.384257Z","time spent":"907.06502ms","remote":"127.0.0.1:52952","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3750,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-67c4e781-e7e9-43ce-ac13-30c279b70cac\" mod_revision:5097 > success:<request_put:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-67c4e781-e7e9-43ce-ac13-30c279b70cac\" value_size:3650 >> failure:<request_range:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-67c4e781-e7e9-43ce-ac13-30c279b70cac\" > >"}
{"level":"info","ts":"2026-09-15T11:33:37.358753Z","caller":"traceutil/trace.go:171","msg":"trace[2116123986] linearizableReadLoop","detail":"{readStateIndex:5331; appliedIndex:5326; }","duration":"824.787899ms","start":"2026-09-15T11:33:36.533943Z","end":"2026-09-15T11:33:37.358731Z","steps":["trace[2116123986] 'read index received'  (duration: 756.379244ms)","trace[2116123986] 'applied index is now lower than readState.Index'  (duration: 68.407435ms)"],"step_count":2}
{"level":"info","ts":"2026-09-15T11:33:37.35908Z","caller":"traceutil/trace.go:171","msg":"trace[1992060906] transaction","detail":"{read_only:false; response_revision:5131; number_of_response:1; }","duration":"666.338315ms","start":"2026-09-15T11:33:36.692707Z","end":"2026-09-15T11:33:37.359045Z","steps":["trace[1992060906] 'process raft request'  (duration: 665.984406ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-15T11:33:37.359231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"882.090399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-67c4e781-e7e9-43ce-ac13-30c279b70cac\" ","response":"range_response_count:1 size:3765"}
{"level":"info","ts":"2026-09-15T11:33:37.35969Z","caller":"traceutil/trace.go:171","msg":"trace[380498383] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-67c4e781-e7e9-43ce-ac13-30c279b70cac; range_end:; response_count:1; response_revision:5131; }","duration":"882.596371ms","start":"2026-09-15T11:33:36.47707Z","end":"2026-09-15T11:33:37.359666Z","steps":["trace[380498383] 'agreement among raft nodes before linearized reading'  (duration: 881.984467ms)"],"step_count":1}
{"level":"info","ts":"2026-09-15T11:33:37.358806Z","caller":"traceutil/trace.go:171","msg":"trace[2013171830] transaction","detail":"{read_only:false; response_revision:5130; number_of_response:1; }","duration":"820.744516ms","start":"2026-09-15T11:33:36.538042Z","end":"2026-09-15T11:33:37.358786Z","steps":["trace[2013171830] 'process raft request'  (duration: 820.612562ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-15T11:33:37.359756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T11:33:36.477052Z","time spent":"882.684324ms","remote":"127.0.0.1:52952","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3789,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-67c4e781-e7e9-43ce-ac13-30c279b70cac\" "}
{"level":"warn","ts":"2026-09-15T11:33:37.359354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"632.55135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-15T11:33:37.359908Z","caller":"traceutil/trace.go:171","msg":"trace[779985319] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:5131; }","duration":"633.164635ms","start":"2026-09-15T11:33:36.726725Z","end":"2026-09-15T11:33:37.35989Z","steps":["trace[779985319] 'agreement among raft nodes before linearized reading'  (duration: 632.55863ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-15T11:33:37.359968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T11:33:36.726703Z","time spent":"633.246287ms","remote":"127.0.0.1:34096","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "}
{"level":"warn","ts":"2026-09-15T11:33:37.359988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T11:33:36.538029Z","time spent":"821.896803ms","remote":"127.0.0.1:53036","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:5079 > 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-09-15T11:33:37.359404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.217113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-09-15T11:33:37.360123Z","caller":"traceutil/trace.go:171","msg":"trace[785058883] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5131; }","duration":"401.978271ms","start":"2026-09-15T11:33:36.958128Z","end":"2026-09-15T11:33:37.360106Z","steps":["trace[785058883] 'agreement among raft nodes before linearized reading'  (duration: 401.159301ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-15T11:33:37.360185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T11:33:36.958107Z","time spent":"402.058452ms","remote":"127.0.0.1:53036","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-09-15T11:33:37.359351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"818.183587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-15T11:33:37.360335Z","caller":"traceutil/trace.go:171","msg":"trace[947412000] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5131; }","duration":"819.19652ms","start":"2026-09-15T11:33:36.54112Z","end":"2026-09-15T11:33:37.360316Z","steps":["trace[947412000] 'agreement among raft nodes before linearized reading'  (duration: 818.070393ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-15T11:33:37.360452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T11:33:36.541109Z","time spent":"819.327434ms","remote":"127.0.0.1:52782","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-09-15T11:33:37.359505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"747.167859ms","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-09-15T11:33:37.360513Z","caller":"traceutil/trace.go:171","msg":"trace[1697387652] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5131; }","duration":"748.301036ms","start":"2026-09-15T11:33:36.612199Z","end":"2026-09-15T11:33:37.3605Z","steps":["trace[1697387652] 'agreement among raft nodes before linearized reading'  (duration: 747.249421ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-15T11:33:37.360576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T11:33:36.612178Z","time spent":"748.383657ms","remote":"127.0.0.1:53036","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-09-15T11:33:37.359527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"698.721596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-7c6bcfbb68-798wz.18d57b513445bfbb\" ","response":"range_response_count:1 size:898"}
{"level":"info","ts":"2026-09-15T11:33:37.360751Z","caller":"traceutil/trace.go:171","msg":"trace[621863187] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana-7c6bcfbb68-798wz.18d57b513445bfbb; range_end:; response_count:1; response_revision:5131; }","duration":"699.994626ms","start":"2026-09-15T11:33:36.660744Z","end":"2026-09-15T11:33:37.360739Z","steps":["trace[621863187] 'agreement among raft nodes before linearized reading'  (duration: 698.667834ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-15T11:33:37.360791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T11:33:36.660711Z","time spent":"700.070877ms","remote":"127.0.0.1:52854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":93,"response count":1,"response size":922,"request content":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-7c6bcfbb68-798wz.18d57b513445bfbb\" "}
{"level":"warn","ts":"2026-09-15T11:33:37.359547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T11:33:36.692658Z","time spent":"666.524699ms","remote":"127.0.0.1:53036","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:5112 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-09-15T11:33:37.359612Z","caller":"traceutil/trace.go:171","msg":"trace[1144586995] transaction","detail":"{read_only:false; response_revision:5129; number_of_response:1; }","duration":"822.682791ms","start":"2026-09-15T11:33:36.536052Z","end":"2026-09-15T11:33:37.358735Z","steps":["trace[1144586995] 'process raft request'  (duration: 814.027632ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-15T11:33:37.362684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T11:33:36.536036Z","time spent":"825.090768ms","remote":"127.0.0.1:52854","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":997,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/events/openstack/persistence-rabbitmq-keystone-server-0.18d57b50e7672033\" mod_revision:5094 > success:<request_put:<key:\"/registry/events/openstack/persistence-rabbitmq-keystone-server-0.18d57b50e7672033\" value_size:897 lease:1122135886879549142 >> failure:<request_range:<key:\"/registry/events/openstack/persistence-rabbitmq-keystone-server-0.18d57b50e7672033\" > >"}
{"level":"info","ts":"2026-09-15T11:33:50.030998Z","caller":"traceutil/trace.go:171","msg":"trace[160273478] linearizableReadLoop","detail":"{readStateIndex:5499; appliedIndex:5498; }","duration":"207.230891ms","start":"2026-09-15T11:33:49.823743Z","end":"2026-09-15T11:33:50.030974Z","steps":["trace[160273478] 'read index received'  (duration: 207.088577ms)","trace[160273478] 'applied index is now lower than readState.Index'  (duration: 141.264µs)"],"step_count":2}
{"level":"info","ts":"2026-09-15T11:33:50.031088Z","caller":"traceutil/trace.go:171","msg":"trace[68065962] transaction","detail":"{read_only:false; response_revision:5294; number_of_response:1; }","duration":"219.972814ms","start":"2026-09-15T11:33:49.811076Z","end":"2026-09-15T11:33:50.031049Z","steps":["trace[68065962] 'process raft request'  (duration: 219.746029ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-15T11:33:50.031466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.706751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.82\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-09-15T11:33:50.031515Z","caller":"traceutil/trace.go:171","msg":"trace[1487974703] range","detail":"{range_begin:/registry/masterleases/162.253.55.82; range_end:; response_count:1; response_revision:5294; }","duration":"207.813384ms","start":"2026-09-15T11:33:49.823687Z","end":"2026-09-15T11:33:50.0315Z","steps":["trace[1487974703] 'agreement among raft nodes before linearized reading'  (duration: 207.379624ms)"],"step_count":1}
{"level":"info","ts":"2026-09-15T11:33:50.363983Z","caller":"traceutil/trace.go:171","msg":"trace[451256628] transaction","detail":"{read_only:false; response_revision:5295; number_of_response:1; }","duration":"422.631905ms","start":"2026-09-15T11:33:49.941283Z","end":"2026-09-15T11:33:50.363915Z","steps":["trace[451256628] 'process raft request'  (duration: 403.002623ms)","trace[451256628] 'compare'  (duration: 19.10095ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-15T11:33:50.364248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T11:33:49.941264Z","time spent":"422.836539ms","remote":"127.0.0.1:53036","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:5274 > 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":"info","ts":"2026-09-15T11:33:50.373855Z","caller":"traceutil/trace.go:171","msg":"trace[63963964] linearizableReadLoop","detail":"{readStateIndex:5501; appliedIndex:5499; }","duration":"191.468145ms","start":"2026-09-15T11:33:50.182361Z","end":"2026-09-15T11:33:50.373829Z","steps":["trace[63963964] 'read index received'  (duration: 161.827973ms)","trace[63963964] 'applied index is now lower than readState.Index'  (duration: 29.638552ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-15T11:33:50.373996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T11:33:50.033549Z","time spent":"340.442513ms","remote":"127.0.0.1:52814","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-09-15T11:33:50.374525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.13849ms","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-09-15T11:33:50.37457Z","caller":"traceutil/trace.go:171","msg":"trace[736309830] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5295; }","duration":"192.264523ms","start":"2026-09-15T11:33:50.182294Z","end":"2026-09-15T11:33:50.374559Z","steps":["trace[736309830] 'agreement among raft nodes before linearized reading'  (duration: 192.078288ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-15T11:33:50.375001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.002037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-09-15T11:33:50.375052Z","caller":"traceutil/trace.go:171","msg":"trace[1453915728] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5295; }","duration":"192.075569ms","start":"2026-09-15T11:33:50.182964Z","end":"2026-09-15T11:33:50.37504Z","steps":["trace[1453915728] 'agreement among raft nodes before linearized reading'  (duration: 191.946116ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-15T11:33:50.375415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.28653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-grafana-7c6bcfbb68-798wz\" ","response":"range_response_count:1 size:11847"}
{"level":"info","ts":"2026-09-15T11:33:50.375458Z","caller":"traceutil/trace.go:171","msg":"trace[1243969412] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-grafana-7c6bcfbb68-798wz; range_end:; response_count:1; response_revision:5295; }","duration":"151.367532ms","start":"2026-09-15T11:33:50.224077Z","end":"2026-09-15T11:33:50.375445Z","steps":["trace[1243969412] 'agreement among raft nodes before linearized reading'  (duration: 151.207809ms)"],"step_count":1}
{"level":"info","ts":"2026-09-15T11:33:50.533679Z","caller":"traceutil/trace.go:171","msg":"trace[2083529915] transaction","detail":"{read_only:false; response_revision:5297; number_of_response:1; }","duration":"152.243742ms","start":"2026-09-15T11:33:50.381403Z","end":"2026-09-15T11:33:50.533647Z","steps":["trace[2083529915] 'process raft request'  (duration: 132.056268ms)","trace[2083529915] 'compare'  (duration: 19.632542ms)"],"step_count":2}
{"level":"info","ts":"2026-09-15T11:33:50.533903Z","caller":"traceutil/trace.go:171","msg":"trace[1629318817] transaction","detail":"{read_only:false; response_revision:5298; number_of_response:1; }","duration":"150.676547ms","start":"2026-09-15T11:33:50.383057Z","end":"2026-09-15T11:33:50.533734Z","steps":["trace[1629318817] 'process raft request'  (duration: 150.194107ms)"],"step_count":1}
{"level":"info","ts":"2026-09-15T11:33:50.534094Z","caller":"traceutil/trace.go:171","msg":"trace[1959991545] linearizableReadLoop","detail":"{readStateIndex:5505; appliedIndex:5502; }","duration":"132.530929ms","start":"2026-09-15T11:33:50.401544Z","end":"2026-09-15T11:33:50.534075Z","steps":["trace[1959991545] 'read index received'  (duration: 111.926175ms)","trace[1959991545] 'applied index is now lower than readState.Index'  (duration: 20.603924ms)"],"step_count":2}
{"level":"info","ts":"2026-09-15T11:33:50.534176Z","caller":"traceutil/trace.go:171","msg":"trace[1905755292] transaction","detail":"{read_only:false; response_revision:5299; number_of_response:1; }","duration":"144.199417ms","start":"2026-09-15T11:33:50.389964Z","end":"2026-09-15T11:33:50.534163Z","steps":["trace[1905755292] 'process raft request'  (duration: 143.817598ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-15T11:33:50.534358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.792375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:421"}
{"level":"info","ts":"2026-09-15T11:33:50.534476Z","caller":"traceutil/trace.go:171","msg":"trace[1267973969] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:5299; }","duration":"132.859646ms","start":"2026-09-15T11:33:50.401538Z","end":"2026-09-15T11:33:50.534398Z","steps":["trace[1267973969] 'agreement among raft nodes before linearized reading'  (duration: 132.714343ms)"],"step_count":1}
{"level":"info","ts":"2026-09-15T11:33:50.544748Z","caller":"traceutil/trace.go:171","msg":"trace[328195335] transaction","detail":"{read_only:false; response_revision:5300; number_of_response:1; }","duration":"115.837755ms","start":"2026-09-15T11:33:50.428884Z","end":"2026-09-15T11:33:50.544722Z","steps":["trace[328195335] 'process raft request'  (duration: 115.65152ms)"],"step_count":1}
{"level":"info","ts":"2026-09-15T11:33:50.685997Z","caller":"traceutil/trace.go:171","msg":"trace[577898224] linearizableReadLoop","detail":"{readStateIndex:5509; appliedIndex:5508; }","duration":"109.486159ms","start":"2026-09-15T11:33:50.57648Z","end":"2026-09-15T11:33:50.685966Z","steps":["trace[577898224] 'read index received'  (duration: 109.143831ms)","trace[577898224] 'applied index is now lower than readState.Index'  (duration: 341.028µs)"],"step_count":2}
{"level":"info","ts":"2026-09-15T11:33:50.686092Z","caller":"traceutil/trace.go:171","msg":"trace[992096642] transaction","detail":"{read_only:false; response_revision:5303; number_of_response:1; }","duration":"136.520541ms","start":"2026-09-15T11:33:50.549501Z","end":"2026-09-15T11:33:50.686022Z","steps":["trace[992096642] 'process raft request'  (duration: 136.252205ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-15T11:33:50.686248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.709525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-15T11:33:50.686557Z","caller":"traceutil/trace.go:171","msg":"trace[40322735] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5303; }","duration":"110.085184ms","start":"2026-09-15T11:33:50.576458Z","end":"2026-09-15T11:33:50.686543Z","steps":["trace[40322735] 'agreement among raft nodes before linearized reading'  (duration: 109.693544ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-15T11:33:50.687041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.434852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-09-15T11:33:50.687095Z","caller":"traceutil/trace.go:171","msg":"trace[864970123] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:5303; }","duration":"110.514713ms","start":"2026-09-15T11:33:50.576566Z","end":"2026-09-15T11:33:50.687081Z","steps":["trace[864970123] 'agreement among raft nodes before linearized reading'  (duration: 109.913099ms)"],"step_count":1}
{"level":"info","ts":"2026-09-15T11:33:50.85145Z","caller":"traceutil/trace.go:171","msg":"trace[998483511] transaction","detail":"{read_only:false; response_revision:5304; number_of_response:1; }","duration":"144.613807ms","start":"2026-09-15T11:33:50.706807Z","end":"2026-09-15T11:33:50.851421Z","steps":["trace[998483511] 'process raft request'  (duration: 80.507212ms)","trace[998483511] 'compare'  (duration: 63.741296ms)"],"step_count":2}
{"level":"info","ts":"2026-09-15T11:33:56.517489Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2881}
{"level":"info","ts":"2026-09-15T11:33:56.5976Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2881,"took":"78.748126ms","hash":439946900,"current-db-size-bytes":52670464,"current-db-size":"53 MB","current-db-size-in-use-bytes":27586560,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-09-15T11:33:56.597665Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":439946900,"revision":2881,"compact-revision":-1}
{"level":"info","ts":"2026-09-15T11:38:56.525337Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5354}
{"level":"info","ts":"2026-09-15T11:38:56.647206Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5354,"took":"120.29714ms","hash":3792285823,"current-db-size-bytes":52670464,"current-db-size":"53 MB","current-db-size-in-use-bytes":19185664,"current-db-size-in-use":"19 MB"}
{"level":"info","ts":"2026-09-15T11:38:56.647273Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3792285823,"revision":5354,"compact-revision":2881}