{"level":"warn","ts":"2026-10-17T11:32:49.064509Z","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-17T11:32:49.064684Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.85: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.85:2380","--initial-cluster=instance=https://162.253.55.85:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.85:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.85: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-17T11:32:49.06479Z","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-17T11:32:49.064811Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.85:2380"]}
{"level":"info","ts":"2026-10-17T11:32:49.064844Z","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-17T11:32:49.066031Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.85:2379"]}
{"level":"info","ts":"2026-10-17T11:32:49.066166Z","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":16,"max-cpu-available":16,"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.85:2380"],"listen-peer-urls":["https://162.253.55.85:2380"],"advertise-client-urls":["https://162.253.55.85:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.85:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.85: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-17T11:32:49.070889Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.318924ms"}
{"level":"info","ts":"2026-10-17T11:32:49.078022Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"427150911cb3975a","cluster-id":"f76f6804bd8187de"}
{"level":"info","ts":"2026-10-17T11:32:49.078164Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"427150911cb3975a switched to configuration voters=()"}
{"level":"info","ts":"2026-10-17T11:32:49.078199Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"427150911cb3975a became follower at term 0"}
{"level":"info","ts":"2026-10-17T11:32:49.07822Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 427150911cb3975a [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-10-17T11:32:49.078237Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"427150911cb3975a became follower at term 1"}
{"level":"info","ts":"2026-10-17T11:32:49.078296Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"427150911cb3975a switched to configuration voters=(4787696463053559642)"}
{"level":"warn","ts":"2026-10-17T11:32:49.083881Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-10-17T11:32:49.085848Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-10-17T11:32:49.087694Z","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-17T11:32:49.090775Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"427150911cb3975a","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-10-17T11:32:49.091129Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"427150911cb3975a","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-10-17T11:32:49.091177Z","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-17T11:32:49.091344Z","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-17T11:32:49.091366Z","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-17T11:32:49.093376Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"427150911cb3975a switched to configuration voters=(4787696463053559642)"}
{"level":"info","ts":"2026-10-17T11:32:49.094031Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"f76f6804bd8187de","local-member-id":"427150911cb3975a","added-peer-id":"427150911cb3975a","added-peer-peer-urls":["https://162.253.55.85:2380"]}
{"level":"info","ts":"2026-10-17T11:32:49.096502Z","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-17T11:32:49.096621Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.85:2380"}
{"level":"info","ts":"2026-10-17T11:32:49.096676Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.85:2380"}
{"level":"info","ts":"2026-10-17T11:32:49.096961Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"427150911cb3975a","initial-advertise-peer-urls":["https://162.253.55.85:2380"],"listen-peer-urls":["https://162.253.55.85:2380"],"advertise-client-urls":["https://162.253.55.85:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.85:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-10-17T11:32:49.097105Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-10-17T11:32:49.478728Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"427150911cb3975a is starting a new election at term 1"}
{"level":"info","ts":"2026-10-17T11:32:49.478818Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"427150911cb3975a became pre-candidate at term 1"}
{"level":"info","ts":"2026-10-17T11:32:49.478848Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"427150911cb3975a received MsgPreVoteResp from 427150911cb3975a at term 1"}
{"level":"info","ts":"2026-10-17T11:32:49.478872Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"427150911cb3975a became candidate at term 2"}
{"level":"info","ts":"2026-10-17T11:32:49.478885Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"427150911cb3975a received MsgVoteResp from 427150911cb3975a at term 2"}
{"level":"info","ts":"2026-10-17T11:32:49.478904Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"427150911cb3975a became leader at term 2"}
{"level":"info","ts":"2026-10-17T11:32:49.478921Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 427150911cb3975a elected leader 427150911cb3975a at term 2"}
{"level":"info","ts":"2026-10-17T11:32:49.479994Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-17T11:32:49.481802Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"427150911cb3975a","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.85:2379]}","request-path":"/0/members/427150911cb3975a/attributes","cluster-id":"f76f6804bd8187de","publish-timeout":"7s"}
{"level":"info","ts":"2026-10-17T11:32:49.481787Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-10-17T11:32:49.481947Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-10-17T11:32:49.482308Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-10-17T11:32:49.482378Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-10-17T11:32:49.482804Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"f76f6804bd8187de","local-member-id":"427150911cb3975a","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-17T11:32:49.483014Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-17T11:32:49.48307Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-17T11:32:49.48511Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.85:2379"}
{"level":"info","ts":"2026-10-17T11:32:49.485595Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-10-17T11:33:07.558211Z","caller":"traceutil/trace.go:171","msg":"trace[43166152] transaction","detail":"{read_only:false; response_revision:384; number_of_response:1; }","duration":"181.23241ms","start":"2026-10-17T11:33:07.376951Z","end":"2026-10-17T11:33:07.558183Z","steps":["trace[43166152] 'process raft request'  (duration: 181.096307ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T11:33:32.264059Z","caller":"traceutil/trace.go:171","msg":"trace[1139829168] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"129.868341ms","start":"2026-10-17T11:33:32.13416Z","end":"2026-10-17T11:33:32.264028Z","steps":["trace[1139829168] 'process raft request'  (duration: 129.658457ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T11:33:33.061639Z","caller":"traceutil/trace.go:171","msg":"trace[1009562951] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"104.175251ms","start":"2026-10-17T11:33:32.957171Z","end":"2026-10-17T11:33:33.061347Z","steps":["trace[1009562951] 'process raft request'  (duration: 103.969217ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T11:33:38.154176Z","caller":"traceutil/trace.go:171","msg":"trace[1554823262] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"113.681579ms","start":"2026-10-17T11:33:38.040469Z","end":"2026-10-17T11:33:38.154151Z","steps":["trace[1554823262] 'process raft request'  (duration: 112.751888ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T11:33:39.062369Z","caller":"traceutil/trace.go:171","msg":"trace[91580230] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"142.134549ms","start":"2026-10-17T11:33:38.920208Z","end":"2026-10-17T11:33:39.062343Z","steps":["trace[91580230] 'process raft request'  (duration: 141.832023ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T11:33:39.486088Z","caller":"traceutil/trace.go:171","msg":"trace[403851259] linearizableReadLoop","detail":"{readStateIndex:636; appliedIndex:635; }","duration":"147.25221ms","start":"2026-10-17T11:33:39.338811Z","end":"2026-10-17T11:33:39.486063Z","steps":["trace[403851259] 'read index received'  (duration: 116.937919ms)","trace[403851259] 'applied index is now lower than readState.Index'  (duration: 30.313311ms)"],"step_count":2}
{"level":"info","ts":"2026-10-17T11:33:39.486247Z","caller":"traceutil/trace.go:171","msg":"trace[402256002] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"394.338998ms","start":"2026-10-17T11:33:39.091848Z","end":"2026-10-17T11:33:39.486187Z","steps":["trace[402256002] 'process raft request'  (duration: 364.16593ms)","trace[402256002] 'compare'  (duration: 29.645346ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-17T11:33:39.486275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.458645ms","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-10-17T11:33:39.486365Z","caller":"traceutil/trace.go:171","msg":"trace[1882189994] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:610; }","duration":"147.591848ms","start":"2026-10-17T11:33:39.33876Z","end":"2026-10-17T11:33:39.486352Z","steps":["trace[1882189994] 'agreement among raft nodes before linearized reading'  (duration: 147.399124ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:33:39.486977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:33:39.091823Z","time spent":"394.539691ms","remote":"127.0.0.1:52350","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036265,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" mod_revision:607 > success:<request_put:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" value_size:1036181 >> failure:<request_range:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" > >"}
{"level":"info","ts":"2026-10-17T11:33:39.707127Z","caller":"traceutil/trace.go:171","msg":"trace[383650061] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"215.980739ms","start":"2026-10-17T11:33:39.491087Z","end":"2026-10-17T11:33:39.707067Z","steps":["trace[383650061] 'process raft request'  (duration: 213.876113ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T11:33:39.70718Z","caller":"traceutil/trace.go:171","msg":"trace[1132154105] linearizableReadLoop","detail":"{readStateIndex:637; appliedIndex:636; }","duration":"167.41274ms","start":"2026-10-17T11:33:39.539742Z","end":"2026-10-17T11:33:39.707155Z","steps":["trace[1132154105] 'read index received'  (duration: 165.232713ms)","trace[1132154105] 'applied index is now lower than readState.Index'  (duration: 2.177557ms)"],"step_count":2}
{"level":"info","ts":"2026-10-17T11:33:39.707144Z","caller":"traceutil/trace.go:171","msg":"trace[679389615] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"146.956944ms","start":"2026-10-17T11:33:39.560164Z","end":"2026-10-17T11:33:39.707121Z","steps":["trace[679389615] 'process raft request'  (duration: 146.856012ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:33:39.707473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.706853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"warn","ts":"2026-10-17T11:33:39.707496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.740187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-10-17T11:33:39.70754Z","caller":"traceutil/trace.go:171","msg":"trace[1576015102] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:612; }","duration":"167.832989ms","start":"2026-10-17T11:33:39.539693Z","end":"2026-10-17T11:33:39.707526Z","steps":["trace[1576015102] 'agreement among raft nodes before linearized reading'  (duration: 167.605504ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T11:33:39.707534Z","caller":"traceutil/trace.go:171","msg":"trace[2112963738] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:612; }","duration":"165.852586ms","start":"2026-10-17T11:33:39.541666Z","end":"2026-10-17T11:33:39.707519Z","steps":["trace[2112963738] 'agreement among raft nodes before linearized reading'  (duration: 165.630431ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:34:25.002355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.457116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-10-17T11:34:25.002418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.236332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-17T11:34:25.002487Z","caller":"traceutil/trace.go:171","msg":"trace[638797819] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:1172; }","duration":"303.665991ms","start":"2026-10-17T11:34:24.698798Z","end":"2026-10-17T11:34:25.002464Z","steps":["trace[638797819] 'count revisions from in-memory index tree'  (duration: 303.342914ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:34:25.002541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:34:24.698777Z","time spent":"303.751962ms","remote":"127.0.0.1:52582","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":20,"response size":30,"request content":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true "}
{"level":"info","ts":"2026-10-17T11:34:25.002587Z","caller":"traceutil/trace.go:171","msg":"trace[1206873129] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:1172; }","duration":"337.475838ms","start":"2026-10-17T11:34:24.665022Z","end":"2026-10-17T11:34:25.002498Z","steps":["trace[1206873129] 'count revisions from in-memory index tree'  (duration: 337.047289ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:34:25.002997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:34:24.664991Z","time spent":"337.984949ms","remote":"127.0.0.1:52658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":28,"request content":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true "}
{"level":"warn","ts":"2026-10-17T11:35:16.013295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.631625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"}
{"level":"info","ts":"2026-10-17T11:35:16.013441Z","caller":"traceutil/trace.go:171","msg":"trace[1413176244] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1854; }","duration":"328.783618ms","start":"2026-10-17T11:35:15.684629Z","end":"2026-10-17T11:35:16.013413Z","steps":["trace[1413176244] 'range keys from in-memory index tree'  (duration: 328.451411ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:35:16.013499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:35:15.684565Z","time spent":"328.917952ms","remote":"127.0.0.1:52516","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":578,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"warn","ts":"2026-10-17T11:35:16.014377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.719827ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10906206785267254505 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:1824 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-10-17T11:35:16.01462Z","caller":"traceutil/trace.go:171","msg":"trace[1262353078] linearizableReadLoop","detail":"{readStateIndex:1930; appliedIndex:1929; }","duration":"198.468067ms","start":"2026-10-17T11:35:15.816128Z","end":"2026-10-17T11:35:16.014596Z","steps":["trace[1262353078] 'read index received'  (duration: 44.991µs)","trace[1262353078] 'applied index is now lower than readState.Index'  (duration: 198.421086ms)"],"step_count":2}
{"level":"info","ts":"2026-10-17T11:35:16.014684Z","caller":"traceutil/trace.go:171","msg":"trace[1218817784] transaction","detail":"{read_only:false; response_revision:1855; number_of_response:1; }","duration":"256.48005ms","start":"2026-10-17T11:35:15.758156Z","end":"2026-10-17T11:35:16.014636Z","steps":["trace[1218817784] 'process raft request'  (duration: 41.077138ms)","trace[1218817784] 'compare'  (duration: 214.164915ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-17T11:35:16.014929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.768304ms","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-17T11:35:16.015037Z","caller":"traceutil/trace.go:171","msg":"trace[1716791069] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1855; }","duration":"198.929147ms","start":"2026-10-17T11:35:15.816078Z","end":"2026-10-17T11:35:16.015007Z","steps":["trace[1716791069] 'agreement among raft nodes before linearized reading'  (duration: 198.60223ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T11:35:16.477228Z","caller":"traceutil/trace.go:171","msg":"trace[1699729584] transaction","detail":"{read_only:false; response_revision:1858; number_of_response:1; }","duration":"119.120613ms","start":"2026-10-17T11:35:16.358074Z","end":"2026-10-17T11:35:16.477194Z","steps":["trace[1699729584] 'process raft request'  (duration: 116.818262ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T11:35:16.477718Z","caller":"traceutil/trace.go:171","msg":"trace[624413904] transaction","detail":"{read_only:false; response_revision:1859; number_of_response:1; }","duration":"118.637893ms","start":"2026-10-17T11:35:16.359045Z","end":"2026-10-17T11:35:16.477683Z","steps":["trace[624413904] 'process raft request'  (duration: 118.103621ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T11:35:16.477821Z","caller":"traceutil/trace.go:171","msg":"trace[335192446] transaction","detail":"{read_only:false; response_revision:1860; number_of_response:1; }","duration":"118.652943ms","start":"2026-10-17T11:35:16.359134Z","end":"2026-10-17T11:35:16.477787Z","steps":["trace[335192446] 'process raft request'  (duration: 118.362467ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T11:35:33.190635Z","caller":"traceutil/trace.go:171","msg":"trace[2009822808] linearizableReadLoop","detail":"{readStateIndex:2075; appliedIndex:2074; }","duration":"137.810496ms","start":"2026-10-17T11:35:33.052804Z","end":"2026-10-17T11:35:33.190614Z","steps":["trace[2009822808] 'read index received'  (duration: 137.651623ms)","trace[2009822808] 'applied index is now lower than readState.Index'  (duration: 157.893µs)"],"step_count":2}
{"level":"warn","ts":"2026-10-17T11:35:33.190803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.990921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-17T11:35:33.190861Z","caller":"traceutil/trace.go:171","msg":"trace[1598328693] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1996; }","duration":"138.105823ms","start":"2026-10-17T11:35:33.052741Z","end":"2026-10-17T11:35:33.190847Z","steps":["trace[1598328693] 'agreement among raft nodes before linearized reading'  (duration: 138.010091ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T11:35:33.190782Z","caller":"traceutil/trace.go:171","msg":"trace[1972436156] transaction","detail":"{read_only:false; response_revision:1996; number_of_response:1; }","duration":"214.097613ms","start":"2026-10-17T11:35:32.976642Z","end":"2026-10-17T11:35:33.19074Z","steps":["trace[1972436156] 'process raft request'  (duration: 213.829987ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T11:35:33.427011Z","caller":"traceutil/trace.go:171","msg":"trace[826093786] transaction","detail":"{read_only:false; response_revision:1997; number_of_response:1; }","duration":"175.02476ms","start":"2026-10-17T11:35:33.251957Z","end":"2026-10-17T11:35:33.426982Z","steps":["trace[826093786] 'process raft request'  (duration: 174.869486ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T11:36:06.378556Z","caller":"traceutil/trace.go:171","msg":"trace[1372458451] transaction","detail":"{read_only:false; response_revision:2176; number_of_response:1; }","duration":"129.250373ms","start":"2026-10-17T11:36:06.249276Z","end":"2026-10-17T11:36:06.378527Z","steps":["trace[1372458451] 'process raft request'  (duration: 129.053639ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T11:36:06.454054Z","caller":"traceutil/trace.go:171","msg":"trace[363054125] transaction","detail":"{read_only:false; response_revision:2177; number_of_response:1; }","duration":"170.485398ms","start":"2026-10-17T11:36:06.283507Z","end":"2026-10-17T11:36:06.453992Z","steps":["trace[363054125] 'process raft request'  (duration: 170.243983ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T11:36:06.644906Z","caller":"traceutil/trace.go:171","msg":"trace[1962149647] transaction","detail":"{read_only:false; response_revision:2178; number_of_response:1; }","duration":"184.660195ms","start":"2026-10-17T11:36:06.460207Z","end":"2026-10-17T11:36:06.644868Z","steps":["trace[1962149647] 'process raft request'  (duration: 98.67958ms)","trace[1962149647] 'compare'  (duration: 85.787921ms)"],"step_count":2}
{"level":"info","ts":"2026-10-17T11:36:06.844607Z","caller":"traceutil/trace.go:171","msg":"trace[1520609875] transaction","detail":"{read_only:false; response_revision:2179; number_of_response:1; }","duration":"153.432498ms","start":"2026-10-17T11:36:06.691141Z","end":"2026-10-17T11:36:06.844573Z","steps":["trace[1520609875] 'process raft request'  (duration: 142.572513ms)","trace[1520609875] 'compare'  (duration: 10.681611ms)"],"step_count":2}
{"level":"info","ts":"2026-10-17T11:36:12.520648Z","caller":"traceutil/trace.go:171","msg":"trace[1445969920] transaction","detail":"{read_only:false; response_revision:2206; number_of_response:1; }","duration":"122.848345ms","start":"2026-10-17T11:36:12.397771Z","end":"2026-10-17T11:36:12.520619Z","steps":["trace[1445969920] 'process raft request'  (duration: 122.366224ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:36:12.786096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.224027ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"}
{"level":"info","ts":"2026-10-17T11:36:12.786232Z","caller":"traceutil/trace.go:171","msg":"trace[1526916837] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2206; }","duration":"108.426922ms","start":"2026-10-17T11:36:12.677766Z","end":"2026-10-17T11:36:12.786193Z","steps":["trace[1526916837] 'range keys from in-memory index tree'  (duration: 107.89974ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:36:13.26845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.75807ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10906206785267255359 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:2198 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-10-17T11:36:13.268716Z","caller":"traceutil/trace.go:171","msg":"trace[1864538899] transaction","detail":"{read_only:false; response_revision:2209; number_of_response:1; }","duration":"332.994982ms","start":"2026-10-17T11:36:12.935696Z","end":"2026-10-17T11:36:13.268691Z","steps":["trace[1864538899] 'process raft request'  (duration: 332.937271ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:36:13.268816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:36:12.935677Z","time spent":"333.094034ms","remote":"127.0.0.1:52516","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:2203 > 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-10-17T11:36:13.268982Z","caller":"traceutil/trace.go:171","msg":"trace[932432845] transaction","detail":"{read_only:false; response_revision:2207; number_of_response:1; }","duration":"477.617639ms","start":"2026-10-17T11:36:12.791321Z","end":"2026-10-17T11:36:13.268939Z","steps":["trace[932432845] 'process raft request'  (duration: 314.281446ms)","trace[932432845] 'compare'  (duration: 162.623847ms)"],"step_count":2}
{"level":"info","ts":"2026-10-17T11:36:13.269032Z","caller":"traceutil/trace.go:171","msg":"trace[761946527] transaction","detail":"{read_only:false; response_revision:2208; number_of_response:1; }","duration":"337.884738ms","start":"2026-10-17T11:36:12.931084Z","end":"2026-10-17T11:36:13.268968Z","steps":["trace[761946527] 'process raft request'  (duration: 337.476029ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T11:36:13.26899Z","caller":"traceutil/trace.go:171","msg":"trace[130327145] linearizableReadLoop","detail":"{readStateIndex:2295; appliedIndex:2293; }","duration":"395.429607ms","start":"2026-10-17T11:36:12.873511Z","end":"2026-10-17T11:36:13.26894Z","steps":["trace[130327145] 'read index received'  (duration: 56.268711ms)","trace[130327145] 'applied index is now lower than readState.Index'  (duration: 339.157586ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-17T11:36:13.269163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:36:12.93106Z","time spent":"338.026811ms","remote":"127.0.0.1:52316","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/masterleases/162.253.55.85\" mod_revision:2160 > success:<request_put:<key:\"/registry/masterleases/162.253.55.85\" value_size:66 lease:1682834748412479549 >> failure:<request_range:<key:\"/registry/masterleases/162.253.55.85\" > >"}
{"level":"warn","ts":"2026-10-17T11:36:13.269218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:36:12.79127Z","time spent":"477.793682ms","remote":"127.0.0.1:52516","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:2198 > 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-17T11:36:13.269359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.769374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-10-17T11:36:13.269412Z","caller":"traceutil/trace.go:171","msg":"trace[1766522745] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2209; }","duration":"395.901447ms","start":"2026-10-17T11:36:12.873493Z","end":"2026-10-17T11:36:13.269395Z","steps":["trace[1766522745] 'agreement among raft nodes before linearized reading'  (duration: 395.58148ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:36:13.269467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:36:12.873463Z","time spent":"395.993309ms","remote":"127.0.0.1:52516","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-10-17T11:36:13.26948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.399089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"warn","ts":"2026-10-17T11:36:13.269492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.362623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-10-17T11:36:13.269518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.438464ms","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-17T11:36:13.269548Z","caller":"traceutil/trace.go:171","msg":"trace[1762622592] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2209; }","duration":"391.516751ms","start":"2026-10-17T11:36:12.878011Z","end":"2026-10-17T11:36:13.269527Z","steps":["trace[1762622592] 'agreement among raft nodes before linearized reading'  (duration: 391.329857ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T11:36:13.269581Z","caller":"traceutil/trace.go:171","msg":"trace[729895785] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2209; }","duration":"364.560987ms","start":"2026-10-17T11:36:12.905007Z","end":"2026-10-17T11:36:13.269568Z","steps":["trace[729895785] 'agreement among raft nodes before linearized reading'  (duration: 364.339323ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:36:13.26958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.014905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"warn","ts":"2026-10-17T11:36:13.269617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:36:12.877991Z","time spent":"391.613073ms","remote":"127.0.0.1:52516","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-10-17T11:36:13.269631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:36:12.904976Z","time spent":"364.647059ms","remote":"127.0.0.1:52516","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-10-17T11:36:13.269641Z","caller":"traceutil/trace.go:171","msg":"trace[1967880406] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2209; }","duration":"216.522956ms","start":"2026-10-17T11:36:13.053034Z","end":"2026-10-17T11:36:13.269557Z","steps":["trace[1967880406] 'agreement among raft nodes before linearized reading'  (duration: 216.317142ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T11:36:13.269652Z","caller":"traceutil/trace.go:171","msg":"trace[1862372614] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2209; }","duration":"370.092757ms","start":"2026-10-17T11:36:12.899544Z","end":"2026-10-17T11:36:13.269636Z","steps":["trace[1862372614] 'agreement among raft nodes before linearized reading'  (duration: 369.817621ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:36:13.269695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:36:12.89947Z","time spent":"370.21628ms","remote":"127.0.0.1:52516","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-10-17T11:42:49.515067Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2702}
{"level":"info","ts":"2026-10-17T11:42:49.594385Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2702,"took":"78.237267ms","hash":351278180,"current-db-size-bytes":31903744,"current-db-size":"32 MB","current-db-size-in-use-bytes":8216576,"current-db-size-in-use":"8.2 MB"}
{"level":"info","ts":"2026-10-17T11:42:49.594457Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":351278180,"revision":2702,"compact-revision":-1}
{"level":"info","ts":"2026-10-17T11:46:27.241497Z","caller":"traceutil/trace.go:171","msg":"trace[624311409] linearizableReadLoop","detail":"{readStateIndex:5547; appliedIndex:5546; }","duration":"259.853855ms","start":"2026-10-17T11:46:26.981616Z","end":"2026-10-17T11:46:27.24147Z","steps":["trace[624311409] 'read index received'  (duration: 259.585759ms)","trace[624311409] 'applied index is now lower than readState.Index'  (duration: 267.096µs)"],"step_count":2}
{"level":"info","ts":"2026-10-17T11:46:27.241596Z","caller":"traceutil/trace.go:171","msg":"trace[661322783] transaction","detail":"{read_only:false; response_revision:5332; number_of_response:1; }","duration":"290.016964ms","start":"2026-10-17T11:46:26.951548Z","end":"2026-10-17T11:46:27.241565Z","steps":["trace[661322783] 'process raft request'  (duration: 289.717348ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:46:27.241766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.128422ms","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-10-17T11:46:27.241775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.75008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterrestores/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterrestores0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-17T11:46:27.241826Z","caller":"traceutil/trace.go:171","msg":"trace[1198396903] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:5332; }","duration":"260.251755ms","start":"2026-10-17T11:46:26.981556Z","end":"2026-10-17T11:46:27.241808Z","steps":["trace[1198396903] 'agreement among raft nodes before linearized reading'  (duration: 260.05529ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T11:46:27.241855Z","caller":"traceutil/trace.go:171","msg":"trace[817935007] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterrestores/; range_end:/registry/pxc.percona.com/perconaxtradbclusterrestores0; response_count:0; response_revision:5332; }","duration":"235.848922ms","start":"2026-10-17T11:46:27.005987Z","end":"2026-10-17T11:46:27.241836Z","steps":["trace[817935007] 'agreement among raft nodes before linearized reading'  (duration: 235.707469ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:46:27.241929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.870594ms","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-17T11:46:27.241968Z","caller":"traceutil/trace.go:171","msg":"trace[1968743342] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5332; }","duration":"153.949256ms","start":"2026-10-17T11:46:27.088009Z","end":"2026-10-17T11:46:27.241958Z","steps":["trace[1968743342] 'agreement among raft nodes before linearized reading'  (duration: 153.768422ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:46:27.717017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.009017ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10906206785267263562 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:5324 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-10-17T11:46:27.717141Z","caller":"traceutil/trace.go:171","msg":"trace[1724876748] transaction","detail":"{read_only:false; response_revision:5333; number_of_response:1; }","duration":"470.12584ms","start":"2026-10-17T11:46:27.246996Z","end":"2026-10-17T11:46:27.717122Z","steps":["trace[1724876748] 'process raft request'  (duration: 82.934049ms)","trace[1724876748] 'compare'  (duration: 386.765182ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-17T11:46:27.717226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:46:27.24697Z","time spent":"470.226593ms","remote":"127.0.0.1:52516","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:5324 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-10-17T11:46:28.14446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.158856ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10906206785267263563 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:5325 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >>","response":"size:16"}
{"level":"info","ts":"2026-10-17T11:46:28.144588Z","caller":"traceutil/trace.go:171","msg":"trace[1910414730] transaction","detail":"{read_only:false; response_revision:5334; number_of_response:1; }","duration":"461.276154ms","start":"2026-10-17T11:46:27.683291Z","end":"2026-10-17T11:46:28.144567Z","steps":["trace[1910414730] 'process raft request'  (duration: 189.893963ms)","trace[1910414730] 'compare'  (duration: 271.013003ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-17T11:46:28.144649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:46:27.683255Z","time spent":"461.366896ms","remote":"127.0.0.1:52516","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:5325 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-10-17T11:46:28.16158Z","caller":"traceutil/trace.go:171","msg":"trace[421314119] transaction","detail":"{read_only:false; response_revision:5335; number_of_response:1; }","duration":"477.725969ms","start":"2026-10-17T11:46:27.683814Z","end":"2026-10-17T11:46:28.16154Z","steps":["trace[421314119] 'process raft request'  (duration: 477.547675ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:46:28.161788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:46:27.683784Z","time spent":"477.901812ms","remote":"127.0.0.1:52516","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:5326 > 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-10-17T11:46:28.175239Z","caller":"traceutil/trace.go:171","msg":"trace[253997528] transaction","detail":"{read_only:false; response_revision:5336; number_of_response:1; }","duration":"269.743114ms","start":"2026-10-17T11:46:27.905447Z","end":"2026-10-17T11:46:28.17519Z","steps":["trace[253997528] 'process raft request'  (duration: 269.426157ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T11:46:28.23577Z","caller":"traceutil/trace.go:171","msg":"trace[251262696] linearizableReadLoop","detail":"{readStateIndex:5551; appliedIndex:5549; }","duration":"185.078176ms","start":"2026-10-17T11:46:28.050663Z","end":"2026-10-17T11:46:28.235741Z","steps":["trace[251262696] 'read index received'  (duration: 110.686036ms)","trace[251262696] 'applied index is now lower than readState.Index'  (duration: 74.38997ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-17T11:46:28.235987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.30496ms","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-10-17T11:46:28.23606Z","caller":"traceutil/trace.go:171","msg":"trace[1108690435] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:5336; }","duration":"185.609737ms","start":"2026-10-17T11:46:28.050427Z","end":"2026-10-17T11:46:28.236037Z","steps":["trace[1108690435] 'agreement among raft nodes before linearized reading'  (duration: 185.467104ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:46:28.236187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.464311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-17T11:46:28.236271Z","caller":"traceutil/trace.go:171","msg":"trace[1822667060] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5336; }","duration":"184.617835ms","start":"2026-10-17T11:46:28.051632Z","end":"2026-10-17T11:46:28.236249Z","steps":["trace[1822667060] 'agreement among raft nodes before linearized reading'  (duration: 184.431151ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T11:46:28.605355Z","caller":"traceutil/trace.go:171","msg":"trace[1852087840] linearizableReadLoop","detail":"{readStateIndex:5553; appliedIndex:5552; }","duration":"109.082341ms","start":"2026-10-17T11:46:28.49624Z","end":"2026-10-17T11:46:28.605322Z","steps":["trace[1852087840] 'read index received'  (duration: 108.764214ms)","trace[1852087840] 'applied index is now lower than readState.Index'  (duration: 315.957µs)"],"step_count":2}
{"level":"info","ts":"2026-10-17T11:46:28.605462Z","caller":"traceutil/trace.go:171","msg":"trace[631147082] transaction","detail":"{read_only:false; response_revision:5337; number_of_response:1; }","duration":"110.332498ms","start":"2026-10-17T11:46:28.495099Z","end":"2026-10-17T11:46:28.605431Z","steps":["trace[631147082] 'process raft request'  (duration: 109.992031ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:46:28.605624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.390258ms","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-10-17T11:46:28.605673Z","caller":"traceutil/trace.go:171","msg":"trace[1880246390] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5337; }","duration":"109.52006ms","start":"2026-10-17T11:46:28.496139Z","end":"2026-10-17T11:46:28.605659Z","steps":["trace[1880246390] 'agreement among raft nodes before linearized reading'  (duration: 109.353366ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:46:28.605731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.141468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-10-17T11:46:28.605784Z","caller":"traceutil/trace.go:171","msg":"trace[702066293] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5337; }","duration":"103.240141ms","start":"2026-10-17T11:46:28.502528Z","end":"2026-10-17T11:46:28.605768Z","steps":["trace[702066293] 'agreement among raft nodes before linearized reading'  (duration: 103.085887ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:46:28.605831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.553871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"info","ts":"2026-10-17T11:46:28.60594Z","caller":"traceutil/trace.go:171","msg":"trace[1357232631] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5337; }","duration":"100.706485ms","start":"2026-10-17T11:46:28.505209Z","end":"2026-10-17T11:46:28.605915Z","steps":["trace[1357232631] 'agreement among raft nodes before linearized reading'  (duration: 100.436969ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:46:28.606119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.530305ms","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-10-17T11:46:28.60627Z","caller":"traceutil/trace.go:171","msg":"trace[139705710] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5337; }","duration":"102.724749ms","start":"2026-10-17T11:46:28.503513Z","end":"2026-10-17T11:46:28.606238Z","steps":["trace[139705710] 'agreement among raft nodes before linearized reading'  (duration: 102.255629ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T11:46:28.717694Z","caller":"traceutil/trace.go:171","msg":"trace[1967015046] transaction","detail":"{read_only:false; response_revision:5339; number_of_response:1; }","duration":"106.773659ms","start":"2026-10-17T11:46:28.610884Z","end":"2026-10-17T11:46:28.717658Z","steps":["trace[1967015046] 'process raft request'  (duration: 89.865924ms)","trace[1967015046] 'compare'  (duration: 16.67454ms)"],"step_count":2}
{"level":"info","ts":"2026-10-17T11:46:28.717708Z","caller":"traceutil/trace.go:171","msg":"trace[1205178965] transaction","detail":"{read_only:false; response_revision:5340; number_of_response:1; }","duration":"106.704327ms","start":"2026-10-17T11:46:28.610973Z","end":"2026-10-17T11:46:28.717677Z","steps":["trace[1205178965] 'process raft request'  (duration: 106.613685ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T11:46:28.717825Z","caller":"traceutil/trace.go:171","msg":"trace[1682515888] transaction","detail":"{read_only:false; response_revision:5341; number_of_response:1; }","duration":"105.528971ms","start":"2026-10-17T11:46:28.612271Z","end":"2026-10-17T11:46:28.7178Z","steps":["trace[1682515888] 'process raft request'  (duration: 105.362147ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:46:30.238774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.176539ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-17T11:46:30.23893Z","caller":"traceutil/trace.go:171","msg":"trace[1121662151] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:5343; }","duration":"121.348083ms","start":"2026-10-17T11:46:30.117557Z","end":"2026-10-17T11:46:30.238905Z","steps":["trace[1121662151] 'range keys from in-memory index tree'  (duration: 121.163288ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:46:30.238972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.480206ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10906206785267263587 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:5333 > 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-10-17T11:46:30.239251Z","caller":"traceutil/trace.go:171","msg":"trace[1120139910] transaction","detail":"{read_only:false; response_revision:5344; number_of_response:1; }","duration":"474.857525ms","start":"2026-10-17T11:46:29.764357Z","end":"2026-10-17T11:46:30.239215Z","steps":["trace[1120139910] 'process raft request'  (duration: 205.97513ms)","trace[1120139910] 'compare'  (duration: 268.312493ms)"],"step_count":2}
{"level":"info","ts":"2026-10-17T11:46:30.239359Z","caller":"traceutil/trace.go:171","msg":"trace[1458446816] linearizableReadLoop","detail":"{readStateIndex:5560; appliedIndex:5559; }","duration":"186.745854ms","start":"2026-10-17T11:46:30.052535Z","end":"2026-10-17T11:46:30.239281Z","steps":["trace[1458446816] 'read index received'  (duration: 39.351µs)","trace[1458446816] 'applied index is now lower than readState.Index'  (duration: 186.703653ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-17T11:46:30.23943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:46:29.764336Z","time spent":"474.995379ms","remote":"127.0.0.1:52516","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:5333 > 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":"warn","ts":"2026-10-17T11:46:30.239546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.995819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-17T11:46:30.239606Z","caller":"traceutil/trace.go:171","msg":"trace[1894483406] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5345; }","duration":"187.115632ms","start":"2026-10-17T11:46:30.052474Z","end":"2026-10-17T11:46:30.23959Z","steps":["trace[1894483406] 'agreement among raft nodes before linearized reading'  (duration: 186.982839ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T11:46:30.603435Z","caller":"traceutil/trace.go:171","msg":"trace[569276747] transaction","detail":"{read_only:false; response_revision:5346; number_of_response:1; }","duration":"436.661788ms","start":"2026-10-17T11:46:30.16674Z","end":"2026-10-17T11:46:30.603402Z","steps":["trace[569276747] 'process raft request'  (duration: 436.468733ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:46:30.60358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:46:30.166726Z","time spent":"436.778401ms","remote":"127.0.0.1:52516","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:5335 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-10-17T11:46:30.60357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.493893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-17T11:46:30.603631Z","caller":"traceutil/trace.go:171","msg":"trace[1102347427] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5346; }","duration":"362.600745ms","start":"2026-10-17T11:46:30.241015Z","end":"2026-10-17T11:46:30.603616Z","steps":["trace[1102347427] 'agreement among raft nodes before linearized reading'  (duration: 362.486653ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:46:30.603665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:46:30.240992Z","time spent":"362.666346ms","remote":"127.0.0.1:57530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-10-17T11:46:30.603988Z","caller":"traceutil/trace.go:171","msg":"trace[1433491867] linearizableReadLoop","detail":"{readStateIndex:5562; appliedIndex:5561; }","duration":"362.289759ms","start":"2026-10-17T11:46:30.241066Z","end":"2026-10-17T11:46:30.603356Z","steps":["trace[1433491867] 'read index received'  (duration: 362.133095ms)","trace[1433491867] 'applied index is now lower than readState.Index'  (duration: 156.024µs)"],"step_count":2}
{"level":"warn","ts":"2026-10-17T11:46:30.604469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.770126ms","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-17T11:46:30.604522Z","caller":"traceutil/trace.go:171","msg":"trace[473299420] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:5346; }","duration":"283.92468ms","start":"2026-10-17T11:46:30.320583Z","end":"2026-10-17T11:46:30.604508Z","steps":["trace[473299420] 'agreement among raft nodes before linearized reading'  (duration: 283.597683ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:46:31.006666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.325389ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10906206785267263596 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:5338 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-10-17T11:46:31.006836Z","caller":"traceutil/trace.go:171","msg":"trace[608322959] linearizableReadLoop","detail":"{readStateIndex:5564; appliedIndex:5563; }","duration":"285.478074ms","start":"2026-10-17T11:46:30.721339Z","end":"2026-10-17T11:46:31.006817Z","steps":["trace[608322959] 'read index received'  (duration: 137.90909ms)","trace[608322959] 'applied index is now lower than readState.Index'  (duration: 147.567984ms)"],"step_count":2}
{"level":"info","ts":"2026-10-17T11:46:31.006952Z","caller":"traceutil/trace.go:171","msg":"trace[1788047703] transaction","detail":"{read_only:false; response_revision:5348; number_of_response:1; }","duration":"341.027317ms","start":"2026-10-17T11:46:30.66591Z","end":"2026-10-17T11:46:31.006937Z","steps":["trace[1788047703] 'process raft request'  (duration: 193.322309ms)","trace[1788047703] 'compare'  (duration: 147.138745ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-17T11:46:31.007028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:46:30.665869Z","time spent":"341.122778ms","remote":"127.0.0.1:52516","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:5338 > 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":"info","ts":"2026-10-17T11:46:31.007071Z","caller":"traceutil/trace.go:171","msg":"trace[164263599] transaction","detail":"{read_only:false; response_revision:5349; number_of_response:1; }","duration":"186.229612ms","start":"2026-10-17T11:46:30.820781Z","end":"2026-10-17T11:46:31.007011Z","steps":["trace[164263599] 'process raft request'  (duration: 186.000347ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:46:31.007222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.840682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-10-17T11:46:31.007268Z","caller":"traceutil/trace.go:171","msg":"trace[84179100] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5349; }","duration":"285.942105ms","start":"2026-10-17T11:46:30.721313Z","end":"2026-10-17T11:46:31.007255Z","steps":["trace[84179100] 'agreement among raft nodes before linearized reading'  (duration: 285.696239ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:46:31.007273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.905123ms","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-10-17T11:46:31.007371Z","caller":"traceutil/trace.go:171","msg":"trace[383872920] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5349; }","duration":"286.082158ms","start":"2026-10-17T11:46:30.72126Z","end":"2026-10-17T11:46:31.007343Z","steps":["trace[383872920] 'agreement among raft nodes before linearized reading'  (duration: 285.705409ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:46:31.007345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.528315ms","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-10-17T11:46:31.007447Z","caller":"traceutil/trace.go:171","msg":"trace[271365541] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5349; }","duration":"285.676768ms","start":"2026-10-17T11:46:30.721747Z","end":"2026-10-17T11:46:31.007424Z","steps":["trace[271365541] 'agreement among raft nodes before linearized reading'  (duration: 285.259759ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T11:46:31.117627Z","caller":"traceutil/trace.go:171","msg":"trace[284302630] transaction","detail":"{read_only:false; response_revision:5351; number_of_response:1; }","duration":"106.063633ms","start":"2026-10-17T11:46:31.011537Z","end":"2026-10-17T11:46:31.1176Z","steps":["trace[284302630] 'process raft request'  (duration: 105.302066ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T11:46:31.117732Z","caller":"traceutil/trace.go:171","msg":"trace[1954876251] transaction","detail":"{read_only:false; response_revision:5352; number_of_response:1; }","duration":"105.584162ms","start":"2026-10-17T11:46:31.012126Z","end":"2026-10-17T11:46:31.11771Z","steps":["trace[1954876251] 'process raft request'  (duration: 105.436419ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:46:31.536659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.129582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-10-17T11:46:31.536777Z","caller":"traceutil/trace.go:171","msg":"trace[921322348] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:5352; }","duration":"297.348898ms","start":"2026-10-17T11:46:31.239403Z","end":"2026-10-17T11:46:31.536752Z","steps":["trace[921322348] 'count revisions from in-memory index tree'  (duration: 296.981529ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T11:46:31.537274Z","caller":"traceutil/trace.go:171","msg":"trace[851877799] transaction","detail":"{read_only:false; response_revision:5353; number_of_response:1; }","duration":"217.412904ms","start":"2026-10-17T11:46:31.319817Z","end":"2026-10-17T11:46:31.53723Z","steps":["trace[851877799] 'process raft request'  (duration: 177.720394ms)","trace[851877799] 'compare'  (duration: 39.462265ms)"],"step_count":2}
{"level":"info","ts":"2026-10-17T11:46:33.051559Z","caller":"traceutil/trace.go:171","msg":"trace[615736768] linearizableReadLoop","detail":"{readStateIndex:5573; appliedIndex:5572; }","duration":"237.99764ms","start":"2026-10-17T11:46:32.813522Z","end":"2026-10-17T11:46:33.05152Z","steps":["trace[615736768] 'read index received'  (duration: 229.846319ms)","trace[615736768] 'applied index is now lower than readState.Index'  (duration: 8.150081ms)"],"step_count":2}
{"level":"info","ts":"2026-10-17T11:46:33.051746Z","caller":"traceutil/trace.go:171","msg":"trace[971786252] transaction","detail":"{read_only:false; response_revision:5357; number_of_response:1; }","duration":"381.706568ms","start":"2026-10-17T11:46:32.670014Z","end":"2026-10-17T11:46:33.051721Z","steps":["trace[971786252] 'process raft request'  (duration: 373.411945ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:46:33.051998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:46:32.669996Z","time spent":"381.825182ms","remote":"127.0.0.1:52516","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:5347 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-10-17T11:46:33.052271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.943543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"}
{"level":"info","ts":"2026-10-17T11:46:33.052354Z","caller":"traceutil/trace.go:171","msg":"trace[1176644483] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:5357; }","duration":"208.112697ms","start":"2026-10-17T11:46:32.84422Z","end":"2026-10-17T11:46:33.052333Z","steps":["trace[1176644483] 'agreement among raft nodes before linearized reading'  (duration: 207.862312ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:46:33.052612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.714236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.85\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-10-17T11:46:33.052671Z","caller":"traceutil/trace.go:171","msg":"trace[1182074606] range","detail":"{range_begin:/registry/masterleases/162.253.55.85; range_end:; response_count:1; response_revision:5357; }","duration":"239.190167ms","start":"2026-10-17T11:46:32.813467Z","end":"2026-10-17T11:46:33.052657Z","steps":["trace[1182074606] 'agreement among raft nodes before linearized reading'  (duration: 238.261677ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T11:46:33.494918Z","caller":"traceutil/trace.go:171","msg":"trace[1264041651] transaction","detail":"{read_only:false; response_revision:5362; number_of_response:1; }","duration":"367.392372ms","start":"2026-10-17T11:46:33.127469Z","end":"2026-10-17T11:46:33.494862Z","steps":["trace[1264041651] 'process raft request'  (duration: 329.4576ms)","trace[1264041651] 'compare'  (duration: 37.505932ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-17T11:46:33.495369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:46:33.127451Z","time spent":"367.78699ms","remote":"127.0.0.1:52516","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:5351 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-10-17T11:46:33.861375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.321738ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10906206785267263632 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:5352 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-10-17T11:46:33.861699Z","caller":"traceutil/trace.go:171","msg":"trace[365766896] transaction","detail":"{read_only:false; response_revision:5363; number_of_response:1; }","duration":"733.597226ms","start":"2026-10-17T11:46:33.127981Z","end":"2026-10-17T11:46:33.861578Z","steps":["trace[365766896] 'process raft request'  (duration: 581.959971ms)","trace[365766896] 'compare'  (duration: 151.084063ms)"],"step_count":2}
{"level":"info","ts":"2026-10-17T11:46:33.861782Z","caller":"traceutil/trace.go:171","msg":"trace[1119577323] transaction","detail":"{read_only:false; response_revision:5364; number_of_response:1; }","duration":"319.294514ms","start":"2026-10-17T11:46:33.54246Z","end":"2026-10-17T11:46:33.861755Z","steps":["trace[1119577323] 'process raft request'  (duration: 319.12282ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:46:33.861931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:46:33.127963Z","time spent":"733.830882ms","remote":"127.0.0.1:52516","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:5352 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-10-17T11:46:33.861931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:46:33.542421Z","time spent":"319.417747ms","remote":"127.0.0.1:52516","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:5353 > 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-10-17T11:46:33.861756Z","caller":"traceutil/trace.go:171","msg":"trace[1336201833] linearizableReadLoop","detail":"{readStateIndex:5580; appliedIndex:5578; }","duration":"732.974022ms","start":"2026-10-17T11:46:33.128717Z","end":"2026-10-17T11:46:33.861691Z","steps":["trace[1336201833] 'read index received'  (duration: 328.222132ms)","trace[1336201833] 'applied index is now lower than readState.Index'  (duration: 404.74778ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-17T11:46:33.862207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"733.433132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-10-17T11:46:33.862278Z","caller":"traceutil/trace.go:171","msg":"trace[1519351129] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:5364; }","duration":"733.565845ms","start":"2026-10-17T11:46:33.128692Z","end":"2026-10-17T11:46:33.862258Z","steps":["trace[1519351129] 'agreement among raft nodes before linearized reading'  (duration: 733.224377ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:46:33.862318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:46:33.128683Z","time spent":"733.626227ms","remote":"127.0.0.1:52518","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-17T11:46:33.862526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"538.259132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12385"}
{"level":"warn","ts":"2026-10-17T11:46:33.862584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.1166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-10-17T11:46:33.862601Z","caller":"traceutil/trace.go:171","msg":"trace[2057400986] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5364; }","duration":"538.373885ms","start":"2026-10-17T11:46:33.324201Z","end":"2026-10-17T11:46:33.862575Z","steps":["trace[2057400986] 'agreement among raft nodes before linearized reading'  (duration: 538.13431ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T11:46:33.862638Z","caller":"traceutil/trace.go:171","msg":"trace[1226401167] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:5364; }","duration":"200.202642ms","start":"2026-10-17T11:46:33.662414Z","end":"2026-10-17T11:46:33.862617Z","steps":["trace[1226401167] 'agreement among raft nodes before linearized reading'  (duration: 200.11119ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:46:33.862656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:46:33.324184Z","time spent":"538.460517ms","remote":"127.0.0.1:52440","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12408,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"warn","ts":"2026-10-17T11:46:33.86292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.688104ms","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-17T11:46:33.863Z","caller":"traceutil/trace.go:171","msg":"trace[738525889] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:5364; }","duration":"210.835748ms","start":"2026-10-17T11:46:33.652138Z","end":"2026-10-17T11:46:33.862974Z","steps":["trace[738525889] 'agreement among raft nodes before linearized reading'  (duration: 210.576102ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T11:46:34.179566Z","caller":"traceutil/trace.go:171","msg":"trace[1778139127] linearizableReadLoop","detail":"{readStateIndex:5582; appliedIndex:5581; }","duration":"120.885672ms","start":"2026-10-17T11:46:34.058647Z","end":"2026-10-17T11:46:34.179533Z","steps":["trace[1778139127] 'read index received'  (duration: 44.59614ms)","trace[1778139127] 'applied index is now lower than readState.Index'  (duration: 76.287982ms)"],"step_count":2}
{"level":"info","ts":"2026-10-17T11:46:34.179633Z","caller":"traceutil/trace.go:171","msg":"trace[870601049] transaction","detail":"{read_only:false; response_revision:5365; number_of_response:1; }","duration":"243.025012ms","start":"2026-10-17T11:46:33.93658Z","end":"2026-10-17T11:46:34.179605Z","steps":["trace[870601049] 'process raft request'  (duration: 166.555905ms)","trace[870601049] 'compare'  (duration: 76.250192ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-17T11:46:34.179759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.071126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-10-17T11:46:34.179819Z","caller":"traceutil/trace.go:171","msg":"trace[502463348] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:5365; }","duration":"121.195969ms","start":"2026-10-17T11:46:34.058605Z","end":"2026-10-17T11:46:34.179801Z","steps":["trace[502463348] 'agreement among raft nodes before linearized reading'  (duration: 121.064616ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:46:35.207262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.526594ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"}
{"level":"info","ts":"2026-10-17T11:46:35.207357Z","caller":"traceutil/trace.go:171","msg":"trace[1685604580] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5368; }","duration":"134.626967ms","start":"2026-10-17T11:46:35.072705Z","end":"2026-10-17T11:46:35.207332Z","steps":["trace[1685604580] 'range keys from in-memory index tree'  (duration: 134.269229ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:46:35.207313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.067562ms","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-17T11:46:35.207425Z","caller":"traceutil/trace.go:171","msg":"trace[17212689] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5368; }","duration":"151.256475ms","start":"2026-10-17T11:46:35.056151Z","end":"2026-10-17T11:46:35.207408Z","steps":["trace[17212689] 'range keys from in-memory index tree'  (duration: 150.874347ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:46:35.207545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.551471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-17T11:46:35.207578Z","caller":"traceutil/trace.go:171","msg":"trace[1385621257] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5368; }","duration":"155.640483ms","start":"2026-10-17T11:46:35.051929Z","end":"2026-10-17T11:46:35.207569Z","steps":["trace[1385621257] 'range keys from in-memory index tree'  (duration: 155.433318ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:46:35.207751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.066937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"warn","ts":"2026-10-17T11:46:35.207749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.295684ms","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-17T11:46:35.207828Z","caller":"traceutil/trace.go:171","msg":"trace[1818315235] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5368; }","duration":"135.186909ms","start":"2026-10-17T11:46:35.072621Z","end":"2026-10-17T11:46:35.207808Z","steps":["trace[1818315235] 'range keys from in-memory index tree'  (duration: 134.860572ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T11:46:35.207915Z","caller":"traceutil/trace.go:171","msg":"trace[978245557] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:5368; }","duration":"337.463508ms","start":"2026-10-17T11:46:34.870409Z","end":"2026-10-17T11:46:35.207872Z","steps":["trace[978245557] 'range keys from in-memory index tree'  (duration: 336.922065ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:46:35.207979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:46:34.870333Z","time spent":"337.628651ms","remote":"127.0.0.1:57462","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"warn","ts":"2026-10-17T11:46:59.75291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.224039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-10-17T11:46:59.752949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.861555ms","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-10-17T11:46:59.753046Z","caller":"traceutil/trace.go:171","msg":"trace[1529916533] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5493; }","duration":"131.995459ms","start":"2026-10-17T11:46:59.621023Z","end":"2026-10-17T11:46:59.753019Z","steps":["trace[1529916533] 'range keys from in-memory index tree'  (duration: 131.682612ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T11:46:59.753012Z","caller":"traceutil/trace.go:171","msg":"trace[720486151] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:5493; }","duration":"194.457804ms","start":"2026-10-17T11:46:59.55853Z","end":"2026-10-17T11:46:59.752987Z","steps":["trace[720486151] 'count revisions from in-memory index tree'  (duration: 194.165278ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:47:02.998645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.40481ms","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-17T11:47:02.998734Z","caller":"traceutil/trace.go:171","msg":"trace[192322770] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:5509; }","duration":"302.553113ms","start":"2026-10-17T11:47:02.696157Z","end":"2026-10-17T11:47:02.99871Z","steps":["trace[192322770] 'count revisions from in-memory index tree'  (duration: 302.273036ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:47:02.998781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:47:02.696131Z","time spent":"302.635084ms","remote":"127.0.0.1:57414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":30,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "}
{"level":"info","ts":"2026-10-17T11:47:03.006806Z","caller":"traceutil/trace.go:171","msg":"trace[1003975815] linearizableReadLoop","detail":"{readStateIndex:5732; appliedIndex:5731; }","duration":"191.228622ms","start":"2026-10-17T11:47:02.815561Z","end":"2026-10-17T11:47:03.006789Z","steps":["trace[1003975815] 'read index received'  (duration: 191.005297ms)","trace[1003975815] 'applied index is now lower than readState.Index'  (duration: 222.265µs)"],"step_count":2}
{"level":"info","ts":"2026-10-17T11:47:03.006855Z","caller":"traceutil/trace.go:171","msg":"trace[1965719819] transaction","detail":"{read_only:false; response_revision:5510; number_of_response:1; }","duration":"201.421189ms","start":"2026-10-17T11:47:02.805412Z","end":"2026-10-17T11:47:03.006833Z","steps":["trace[1965719819] 'process raft request'  (duration: 201.238005ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:47:03.006978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.434137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.85\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-10-17T11:47:03.007012Z","caller":"traceutil/trace.go:171","msg":"trace[2077534761] range","detail":"{range_begin:/registry/masterleases/162.253.55.85; range_end:; response_count:1; response_revision:5510; }","duration":"191.55877ms","start":"2026-10-17T11:47:02.815444Z","end":"2026-10-17T11:47:03.007003Z","steps":["trace[2077534761] 'agreement among raft nodes before linearized reading'  (duration: 191.438027ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:47:03.007046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.683593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-10-17T11:47:03.007133Z","caller":"traceutil/trace.go:171","msg":"trace[1165842427] range","detail":"{range_begin:/registry/cert-manager.io/certificates/; range_end:/registry/cert-manager.io/certificates0; response_count:0; response_revision:5510; }","duration":"109.840527ms","start":"2026-10-17T11:47:02.897274Z","end":"2026-10-17T11:47:03.007115Z","steps":["trace[1165842427] 'agreement among raft nodes before linearized reading'  (duration: 109.670933ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T11:47:03.244881Z","caller":"traceutil/trace.go:171","msg":"trace[1398429505] linearizableReadLoop","detail":"{readStateIndex:5733; appliedIndex:5732; }","duration":"157.125947ms","start":"2026-10-17T11:47:03.087737Z","end":"2026-10-17T11:47:03.244863Z","steps":["trace[1398429505] 'read index received'  (duration: 110.509712ms)","trace[1398429505] 'applied index is now lower than readState.Index'  (duration: 46.615355ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-17T11:47:03.245076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.325001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:557"}
{"level":"info","ts":"2026-10-17T11:47:03.24521Z","caller":"traceutil/trace.go:171","msg":"trace[1160538752] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:5510; }","duration":"157.483274ms","start":"2026-10-17T11:47:03.087712Z","end":"2026-10-17T11:47:03.245196Z","steps":["trace[1160538752] 'agreement among raft nodes before linearized reading'  (duration: 157.218068ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:47:03.535901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.599117ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10906206785267264035 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" mod_revision:5436 > success:<request_put:<key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-10-17T11:47:03.536021Z","caller":"traceutil/trace.go:171","msg":"trace[2073717504] linearizableReadLoop","detail":"{readStateIndex:5735; appliedIndex:5733; }","duration":"237.143352ms","start":"2026-10-17T11:47:03.298856Z","end":"2026-10-17T11:47:03.536Z","steps":["trace[2073717504] 'read index received'  (duration: 2.500946ms)","trace[2073717504] 'applied index is now lower than readState.Index'  (duration: 234.641256ms)"],"step_count":2}
{"level":"info","ts":"2026-10-17T11:47:03.536061Z","caller":"traceutil/trace.go:171","msg":"trace[1039355102] transaction","detail":"{read_only:false; response_revision:5512; number_of_response:1; }","duration":"287.028498ms","start":"2026-10-17T11:47:03.248998Z","end":"2026-10-17T11:47:03.536026Z","steps":["trace[1039355102] 'process raft request'  (duration: 156.209226ms)","trace[1039355102] 'compare'  (duration: 130.500205ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-17T11:47:03.536202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.337466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-10-17T11:47:03.536286Z","caller":"traceutil/trace.go:171","msg":"trace[1270416694] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:5512; }","duration":"237.463589ms","start":"2026-10-17T11:47:03.298808Z","end":"2026-10-17T11:47:03.536272Z","steps":["trace[1270416694] 'agreement among raft nodes before linearized reading'  (duration: 237.316935ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:47:03.536346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.987559ms","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-10-17T11:47:03.536415Z","caller":"traceutil/trace.go:171","msg":"trace[2111303354] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:5512; }","duration":"233.084932ms","start":"2026-10-17T11:47:03.303316Z","end":"2026-10-17T11:47:03.536401Z","steps":["trace[2111303354] 'agreement among raft nodes before linearized reading'  (duration: 232.892397ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:47:03.536594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.07834ms","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-17T11:47:03.53667Z","caller":"traceutil/trace.go:171","msg":"trace[2093275378] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:5512; }","duration":"123.188813ms","start":"2026-10-17T11:47:03.413459Z","end":"2026-10-17T11:47:03.536647Z","steps":["trace[2093275378] 'agreement among raft nodes before linearized reading'  (duration: 123.028639ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T11:47:03.760804Z","caller":"traceutil/trace.go:171","msg":"trace[1655179109] transaction","detail":"{read_only:false; response_revision:5513; number_of_response:1; }","duration":"220.172735ms","start":"2026-10-17T11:47:03.540602Z","end":"2026-10-17T11:47:03.760775Z","steps":["trace[1655179109] 'process raft request'  (duration: 144.537117ms)","trace[1655179109] 'compare'  (duration: 75.489045ms)"],"step_count":2}
{"level":"info","ts":"2026-10-17T11:47:03.82597Z","caller":"traceutil/trace.go:171","msg":"trace[1015869629] transaction","detail":"{read_only:false; response_revision:5514; number_of_response:1; }","duration":"285.106445ms","start":"2026-10-17T11:47:03.540824Z","end":"2026-10-17T11:47:03.825931Z","steps":["trace[1015869629] 'process raft request'  (duration: 284.8644ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T11:47:03.826207Z","caller":"traceutil/trace.go:171","msg":"trace[43772669] transaction","detail":"{read_only:false; response_revision:5515; number_of_response:1; }","duration":"285.29018ms","start":"2026-10-17T11:47:03.540891Z","end":"2026-10-17T11:47:03.826181Z","steps":["trace[43772669] 'process raft request'  (duration: 284.935002ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:47:04.475741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.801261ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10906206785267264044 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:5505 > 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-10-17T11:47:04.475974Z","caller":"traceutil/trace.go:171","msg":"trace[1947009940] transaction","detail":"{read_only:false; response_revision:5516; number_of_response:1; }","duration":"643.332993ms","start":"2026-10-17T11:47:03.832602Z","end":"2026-10-17T11:47:04.475935Z","steps":["trace[1947009940] 'process raft request'  (duration: 220.205615ms)","trace[1947009940] 'compare'  (duration: 422.382282ms)"],"step_count":2}
{"level":"info","ts":"2026-10-17T11:47:04.476046Z","caller":"traceutil/trace.go:171","msg":"trace[1774861150] linearizableReadLoop","detail":"{readStateIndex:5740; appliedIndex:5738; }","duration":"443.572042ms","start":"2026-10-17T11:47:04.032453Z","end":"2026-10-17T11:47:04.476025Z","steps":["trace[1774861150] 'read index received'  (duration: 20.354202ms)","trace[1774861150] 'applied index is now lower than readState.Index'  (duration: 423.2161ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-17T11:47:04.476168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:47:03.832571Z","time spent":"643.491096ms","remote":"127.0.0.1:52516","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:5505 > 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":"warn","ts":"2026-10-17T11:47:04.476211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.626801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-17T11:47:04.476278Z","caller":"traceutil/trace.go:171","msg":"trace[494999521] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5517; }","duration":"424.694412ms","start":"2026-10-17T11:47:04.051569Z","end":"2026-10-17T11:47:04.476263Z","steps":["trace[494999521] 'agreement among raft nodes before linearized reading'  (duration: 424.59729ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:47:04.476306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.843938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"warn","ts":"2026-10-17T11:47:04.476337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:47:04.051519Z","time spent":"424.805465ms","remote":"127.0.0.1:57540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-10-17T11:47:04.476354Z","caller":"traceutil/trace.go:171","msg":"trace[1307879730] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5517; }","duration":"443.92959ms","start":"2026-10-17T11:47:04.032412Z","end":"2026-10-17T11:47:04.476341Z","steps":["trace[1307879730] 'agreement among raft nodes before linearized reading'  (duration: 443.722216ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T11:47:04.476111Z","caller":"traceutil/trace.go:171","msg":"trace[1775432163] transaction","detail":"{read_only:false; response_revision:5517; number_of_response:1; }","duration":"493.517518ms","start":"2026-10-17T11:47:03.982559Z","end":"2026-10-17T11:47:04.476077Z","steps":["trace[1775432163] 'process raft request'  (duration: 493.326374ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:47:04.476388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:47:04.032393Z","time spent":"443.988231ms","remote":"127.0.0.1:52516","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-10-17T11:47:04.476507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.295764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:528"}
{"level":"warn","ts":"2026-10-17T11:47:04.476534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:47:03.982528Z","time spent":"493.879787ms","remote":"127.0.0.1:52516","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:5506 > 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-17T11:47:04.476539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.373296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12499"}
{"level":"info","ts":"2026-10-17T11:47:04.476593Z","caller":"traceutil/trace.go:171","msg":"trace[1517233176] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:5517; }","duration":"278.407857ms","start":"2026-10-17T11:47:04.198168Z","end":"2026-10-17T11:47:04.476576Z","steps":["trace[1517233176] 'agreement among raft nodes before linearized reading'  (duration: 278.212523ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T11:47:04.476626Z","caller":"traceutil/trace.go:171","msg":"trace[718466333] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5517; }","duration":"415.502759ms","start":"2026-10-17T11:47:04.061107Z","end":"2026-10-17T11:47:04.476609Z","steps":["trace[718466333] 'agreement among raft nodes before linearized reading'  (duration: 415.283934ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:47:04.476679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:47:04.061087Z","time spent":"415.58095ms","remote":"127.0.0.1:52440","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12522,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"warn","ts":"2026-10-17T11:47:04.916127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.995329ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10906206785267264049 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:5507 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-10-17T11:47:04.916265Z","caller":"traceutil/trace.go:171","msg":"trace[946567205] transaction","detail":"{read_only:false; response_revision:5518; number_of_response:1; }","duration":"435.107574ms","start":"2026-10-17T11:47:04.481135Z","end":"2026-10-17T11:47:04.916242Z","steps":["trace[946567205] 'process raft request'  (duration: 224.88223ms)","trace[946567205] 'compare'  (duration: 209.724113ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-17T11:47:04.916327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:47:04.481111Z","time spent":"435.185765ms","remote":"127.0.0.1:52516","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:5507 > 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-17T11:47:04.918673Z","caller":"traceutil/trace.go:171","msg":"trace[1601605915] transaction","detail":"{read_only:false; response_revision:5519; number_of_response:1; }","duration":"436.364371ms","start":"2026-10-17T11:47:04.482281Z","end":"2026-10-17T11:47:04.918645Z","steps":["trace[1601605915] 'process raft request'  (duration: 436.168547ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:47:04.91884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:47:04.482267Z","time spent":"436.486754ms","remote":"127.0.0.1:52516","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":513,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/cert-manager/cert-manager-controller\" mod_revision:5441 > success:<request_put:<key:\"/registry/leases/cert-manager/cert-manager-controller\" value_size:452 >> failure:<request_range:<key:\"/registry/leases/cert-manager/cert-manager-controller\" > >"}
{"level":"info","ts":"2026-10-17T11:47:04.918919Z","caller":"traceutil/trace.go:171","msg":"trace[631123218] linearizableReadLoop","detail":"{readStateIndex:5742; appliedIndex:5740; }","duration":"428.350314ms","start":"2026-10-17T11:47:04.490507Z","end":"2026-10-17T11:47:04.918858Z","steps":["trace[631123218] 'read index received'  (duration: 215.44228ms)","trace[631123218] 'applied index is now lower than readState.Index'  (duration: 212.903974ms)"],"step_count":2}
{"level":"info","ts":"2026-10-17T11:47:04.918974Z","caller":"traceutil/trace.go:171","msg":"trace[1868810459] transaction","detail":"{read_only:false; response_revision:5520; number_of_response:1; }","duration":"398.310857ms","start":"2026-10-17T11:47:04.520639Z","end":"2026-10-17T11:47:04.91895Z","steps":["trace[1868810459] 'process raft request'  (duration: 397.959809ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:47:04.91909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:47:04.520624Z","time spent":"398.40997ms","remote":"127.0.0.1:52516","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:5508 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-10-17T11:47:04.919104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.594919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-17T11:47:04.91916Z","caller":"traceutil/trace.go:171","msg":"trace[1741138064] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:5520; }","duration":"428.700541ms","start":"2026-10-17T11:47:04.490443Z","end":"2026-10-17T11:47:04.919144Z","steps":["trace[1741138064] 'agreement among raft nodes before linearized reading'  (duration: 428.600049ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:47:04.919205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:47:04.490419Z","time spent":"428.775453ms","remote":"127.0.0.1:52698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":28,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "}
{"level":"warn","ts":"2026-10-17T11:47:04.91935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.712906ms","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-17T11:47:04.919409Z","caller":"traceutil/trace.go:171","msg":"trace[646649596] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:5520; }","duration":"375.832928ms","start":"2026-10-17T11:47:04.543561Z","end":"2026-10-17T11:47:04.919394Z","steps":["trace[646649596] 'agreement among raft nodes before linearized reading'  (duration: 375.521271ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:47:04.91939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.98474ms","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":"warn","ts":"2026-10-17T11:47:04.919467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:47:04.54355Z","time spent":"375.90549ms","remote":"127.0.0.1:57462","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"info","ts":"2026-10-17T11:47:04.919479Z","caller":"traceutil/trace.go:171","msg":"trace[183725402] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5520; }","duration":"325.122433ms","start":"2026-10-17T11:47:04.594338Z","end":"2026-10-17T11:47:04.91946Z","steps":["trace[183725402] 'agreement among raft nodes before linearized reading'  (duration: 324.770856ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:47:04.919495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.005534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-10-17T11:47:04.919691Z","caller":"traceutil/trace.go:171","msg":"trace[986940059] range","detail":"{range_begin:/registry/cert-manager.io/certificaterequests/; range_end:/registry/cert-manager.io/certificaterequests0; response_count:0; response_revision:5520; }","duration":"276.334671ms","start":"2026-10-17T11:47:04.643276Z","end":"2026-10-17T11:47:04.919611Z","steps":["trace[986940059] 'agreement among raft nodes before linearized reading'  (duration: 275.818199ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:47:04.919523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:47:04.594317Z","time spent":"325.196246ms","remote":"127.0.0.1:52516","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-10-17T11:47:05.248754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.898131ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10906206785267264055 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:5509 > 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-10-17T11:47:05.248876Z","caller":"traceutil/trace.go:171","msg":"trace[1626245392] transaction","detail":"{read_only:false; response_revision:5521; number_of_response:1; }","duration":"324.554251ms","start":"2026-10-17T11:47:04.924281Z","end":"2026-10-17T11:47:05.248835Z","steps":["trace[1626245392] 'process raft request'  (duration: 222.497107ms)","trace[1626245392] 'compare'  (duration: 101.721827ms)"],"step_count":2}
{"level":"info","ts":"2026-10-17T11:47:05.248927Z","caller":"traceutil/trace.go:171","msg":"trace[1661193852] transaction","detail":"{read_only:false; response_revision:5522; number_of_response:1; }","duration":"237.904698ms","start":"2026-10-17T11:47:05.011008Z","end":"2026-10-17T11:47:05.248913Z","steps":["trace[1661193852] 'process raft request'  (duration: 237.826956ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T11:47:05.248905Z","caller":"traceutil/trace.go:171","msg":"trace[1476538085] linearizableReadLoop","detail":"{readStateIndex:5744; appliedIndex:5743; }","duration":"316.128614ms","start":"2026-10-17T11:47:04.932754Z","end":"2026-10-17T11:47:05.248882Z","steps":["trace[1476538085] 'read index received'  (duration: 214.0745ms)","trace[1476538085] 'applied index is now lower than readState.Index'  (duration: 102.050434ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-17T11:47:05.249073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:47:04.924256Z","time spent":"324.711154ms","remote":"127.0.0.1:52516","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:5509 > 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":"warn","ts":"2026-10-17T11:47:05.249122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.368769ms","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-17T11:47:05.249189Z","caller":"traceutil/trace.go:171","msg":"trace[1850096481] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:5522; }","duration":"316.459922ms","start":"2026-10-17T11:47:04.932713Z","end":"2026-10-17T11:47:05.249173Z","steps":["trace[1850096481] 'agreement among raft nodes before linearized reading'  (duration: 316.227227ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:47:05.249094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.889969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-10-17T11:47:05.249267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:47:04.932691Z","time spent":"316.563063ms","remote":"127.0.0.1:57462","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"info","ts":"2026-10-17T11:47:05.249286Z","caller":"traceutil/trace.go:171","msg":"trace[2024030343] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5522; }","duration":"197.128864ms","start":"2026-10-17T11:47:05.052137Z","end":"2026-10-17T11:47:05.249266Z","steps":["trace[2024030343] 'agreement among raft nodes before linearized reading'  (duration: 196.929989ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T11:47:06.007558Z","caller":"traceutil/trace.go:171","msg":"trace[939926678] linearizableReadLoop","detail":"{readStateIndex:5746; appliedIndex:5745; }","duration":"176.583898ms","start":"2026-10-17T11:47:05.83095Z","end":"2026-10-17T11:47:06.007534Z","steps":["trace[939926678] 'read index received'  (duration: 176.389364ms)","trace[939926678] 'applied index is now lower than readState.Index'  (duration: 193.314µs)"],"step_count":2}
{"level":"warn","ts":"2026-10-17T11:47:06.007783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.276561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"info","ts":"2026-10-17T11:47:06.007827Z","caller":"traceutil/trace.go:171","msg":"trace[2053228263] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5523; }","duration":"176.357674ms","start":"2026-10-17T11:47:05.831458Z","end":"2026-10-17T11:47:06.007816Z","steps":["trace[2053228263] 'agreement among raft nodes before linearized reading'  (duration: 176.20919ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:47:06.007885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.925365ms","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-17T11:47:06.007993Z","caller":"traceutil/trace.go:171","msg":"trace[2113159615] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5523; }","duration":"177.09884ms","start":"2026-10-17T11:47:05.830871Z","end":"2026-10-17T11:47:06.00797Z","steps":["trace[2113159615] 'agreement among raft nodes before linearized reading'  (duration: 176.759042ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T11:47:06.008404Z","caller":"traceutil/trace.go:171","msg":"trace[999509427] transaction","detail":"{read_only:false; response_revision:5523; number_of_response:1; }","duration":"237.854387ms","start":"2026-10-17T11:47:05.770395Z","end":"2026-10-17T11:47:06.00825Z","steps":["trace[999509427] 'process raft request'  (duration: 236.997988ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T11:47:06.460544Z","caller":"traceutil/trace.go:171","msg":"trace[1049832056] linearizableReadLoop","detail":"{readStateIndex:5748; appliedIndex:5747; }","duration":"407.775117ms","start":"2026-10-17T11:47:06.052722Z","end":"2026-10-17T11:47:06.460497Z","steps":["trace[1049832056] 'read index received'  (duration: 398.762367ms)","trace[1049832056] 'applied index is now lower than readState.Index'  (duration: 9.01119ms)"],"step_count":2}
{"level":"info","ts":"2026-10-17T11:47:06.460563Z","caller":"traceutil/trace.go:171","msg":"trace[2073865560] transaction","detail":"{read_only:false; response_revision:5525; number_of_response:1; }","duration":"447.490598ms","start":"2026-10-17T11:47:06.013027Z","end":"2026-10-17T11:47:06.460518Z","steps":["trace[2073865560] 'process raft request'  (duration: 438.460878ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:47:06.460689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.011132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-10-17T11:47:06.460771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:47:06.012993Z","time spent":"447.672433ms","remote":"127.0.0.1:52516","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:5515 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-10-17T11:47:06.460793Z","caller":"traceutil/trace.go:171","msg":"trace[1644327056] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5525; }","duration":"408.179306ms","start":"2026-10-17T11:47:06.052589Z","end":"2026-10-17T11:47:06.460769Z","steps":["trace[1644327056] 'agreement among raft nodes before linearized reading'  (duration: 408.006892ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:47:06.460841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:47:06.052569Z","time spent":"408.263578ms","remote":"127.0.0.1:57540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-10-17T11:47:06.884649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.032244ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10906206785267264068 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:5517 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-10-17T11:47:06.884978Z","caller":"traceutil/trace.go:171","msg":"trace[987780409] transaction","detail":"{read_only:false; response_revision:5526; number_of_response:1; }","duration":"401.767834ms","start":"2026-10-17T11:47:06.483182Z","end":"2026-10-17T11:47:06.88495Z","steps":["trace[987780409] 'process raft request'  (duration: 198.335851ms)","trace[987780409] 'compare'  (duration: 202.918222ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-17T11:47:06.885084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:47:06.483158Z","time spent":"401.874076ms","remote":"127.0.0.1:52516","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:5517 > 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-10-17T11:47:06.885216Z","caller":"traceutil/trace.go:171","msg":"trace[214211632] transaction","detail":"{read_only:false; response_revision:5527; number_of_response:1; }","duration":"400.342323ms","start":"2026-10-17T11:47:06.484802Z","end":"2026-10-17T11:47:06.885145Z","steps":["trace[214211632] 'process raft request'  (duration: 399.952394ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:47:06.885527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:47:06.484783Z","time spent":"400.527216ms","remote":"127.0.0.1:52516","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:5516 > 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":"warn","ts":"2026-10-17T11:47:07.276297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.663216ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10906206785267264071 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:5518 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-10-17T11:47:07.276533Z","caller":"traceutil/trace.go:171","msg":"trace[988703065] linearizableReadLoop","detail":"{readStateIndex:5752; appliedIndex:5750; }","duration":"261.751358ms","start":"2026-10-17T11:47:07.014752Z","end":"2026-10-17T11:47:07.276503Z","steps":["trace[988703065] 'read index received'  (duration: 58.779724ms)","trace[988703065] 'applied index is now lower than readState.Index'  (duration: 202.970714ms)"],"step_count":2}
{"level":"info","ts":"2026-10-17T11:47:07.276559Z","caller":"traceutil/trace.go:171","msg":"trace[1931526918] transaction","detail":"{read_only:false; response_revision:5528; number_of_response:1; }","duration":"351.816266ms","start":"2026-10-17T11:47:06.924692Z","end":"2026-10-17T11:47:07.276508Z","steps":["trace[1931526918] 'process raft request'  (duration: 148.826892ms)","trace[1931526918] 'compare'  (duration: 202.494563ms)"],"step_count":2}
{"level":"info","ts":"2026-10-17T11:47:07.276608Z","caller":"traceutil/trace.go:171","msg":"trace[1991462472] transaction","detail":"{read_only:false; response_revision:5529; number_of_response:1; }","duration":"351.303285ms","start":"2026-10-17T11:47:06.925294Z","end":"2026-10-17T11:47:07.276597Z","steps":["trace[1991462472] 'process raft request'  (duration: 351.133091ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:47:07.276735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:47:06.924657Z","time spent":"351.98119ms","remote":"127.0.0.1:52516","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:5518 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-10-17T11:47:07.276836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.089655ms","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-17T11:47:07.276926Z","caller":"traceutil/trace.go:171","msg":"trace[2047818891] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:5529; }","duration":"262.200978ms","start":"2026-10-17T11:47:07.014713Z","end":"2026-10-17T11:47:07.276914Z","steps":["trace[2047818891] 'agreement among raft nodes before linearized reading'  (duration: 261.909101ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:47:07.277189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:47:06.925267Z","time spent":"351.542589ms","remote":"127.0.0.1:52516","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:5520 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-10-17T11:47:07.563998Z","caller":"traceutil/trace.go:171","msg":"trace[615863918] linearizableReadLoop","detail":"{readStateIndex:5753; appliedIndex:5752; }","duration":"287.410497ms","start":"2026-10-17T11:47:07.276567Z","end":"2026-10-17T11:47:07.563978Z","steps":["trace[615863918] 'read index received'  (duration: 191.883637ms)","trace[615863918] 'applied index is now lower than readState.Index'  (duration: 95.52601ms)"],"step_count":2}
{"level":"info","ts":"2026-10-17T11:47:07.564363Z","caller":"traceutil/trace.go:171","msg":"trace[791036655] transaction","detail":"{read_only:false; response_revision:5530; number_of_response:1; }","duration":"309.598539ms","start":"2026-10-17T11:47:07.25472Z","end":"2026-10-17T11:47:07.564318Z","steps":["trace[791036655] 'process raft request'  (duration: 213.838805ms)","trace[791036655] 'compare'  (duration: 95.331435ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-17T11:47:07.564407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.428698ms","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":"warn","ts":"2026-10-17T11:47:07.564579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:47:07.254705Z","time spent":"309.758682ms","remote":"127.0.0.1:52516","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:5522 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-10-17T11:47:07.564654Z","caller":"traceutil/trace.go:171","msg":"trace[1222725240] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5530; }","duration":"310.704124ms","start":"2026-10-17T11:47:07.253901Z","end":"2026-10-17T11:47:07.564605Z","steps":["trace[1222725240] 'agreement among raft nodes before linearized reading'  (duration: 310.154421ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:47:07.564767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:47:07.253862Z","time spent":"310.865607ms","remote":"127.0.0.1:52516","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-10-17T11:47:07.565471Z","caller":"traceutil/trace.go:171","msg":"trace[1768049949] transaction","detail":"{read_only:false; response_revision:5531; number_of_response:1; }","duration":"262.430122ms","start":"2026-10-17T11:47:07.30301Z","end":"2026-10-17T11:47:07.56544Z","steps":["trace[1768049949] 'process raft request'  (duration: 262.253738ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:47:07.837474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.267455ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10906206785267264077 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:5521 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-10-17T11:47:07.837629Z","caller":"traceutil/trace.go:171","msg":"trace[135154460] transaction","detail":"{read_only:false; response_revision:5532; number_of_response:1; }","duration":"268.22978ms","start":"2026-10-17T11:47:07.569374Z","end":"2026-10-17T11:47:07.837604Z","steps":["trace[135154460] 'process raft request'  (duration: 144.712759ms)","trace[135154460] 'compare'  (duration: 123.075181ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-17T11:47:08.282861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.090007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-17T11:47:08.282972Z","caller":"traceutil/trace.go:171","msg":"trace[1213916564] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5532; }","duration":"231.264151ms","start":"2026-10-17T11:47:08.051677Z","end":"2026-10-17T11:47:08.282941Z","steps":["trace[1213916564] 'range keys from in-memory index tree'  (duration: 230.984895ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:47:08.283086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.61807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"info","ts":"2026-10-17T11:47:08.283139Z","caller":"traceutil/trace.go:171","msg":"trace[673955445] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5532; }","duration":"227.714922ms","start":"2026-10-17T11:47:08.05541Z","end":"2026-10-17T11:47:08.283125Z","steps":["trace[673955445] 'range keys from in-memory index tree'  (duration: 227.411806ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:47:08.283426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.583914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-10-17T11:47:08.283463Z","caller":"traceutil/trace.go:171","msg":"trace[1872874630] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5532; }","duration":"270.620944ms","start":"2026-10-17T11:47:08.012833Z","end":"2026-10-17T11:47:08.283454Z","steps":["trace[1872874630] 'range keys from in-memory index tree'  (duration: 270.4145ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:47:08.732977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.692627ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10906206785267264081 > lease_revoke:<id:175aa149a2cf699a>","response":"size:28"}
{"level":"info","ts":"2026-10-17T11:47:08.733315Z","caller":"traceutil/trace.go:171","msg":"trace[375134067] linearizableReadLoop","detail":"{readStateIndex:5756; appliedIndex:5755; }","duration":"448.807818ms","start":"2026-10-17T11:47:08.284415Z","end":"2026-10-17T11:47:08.733222Z","steps":["trace[375134067] 'read index received'  (duration: 85.916956ms)","trace[375134067] 'applied index is now lower than readState.Index'  (duration: 362.887172ms)"],"step_count":2}
{"level":"info","ts":"2026-10-17T11:47:08.733478Z","caller":"traceutil/trace.go:171","msg":"trace[911031729] transaction","detail":"{read_only:false; response_revision:5534; number_of_response:1; }","duration":"444.962243ms","start":"2026-10-17T11:47:08.288497Z","end":"2026-10-17T11:47:08.73346Z","steps":["trace[911031729] 'process raft request'  (duration: 444.884401ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:47:08.733555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.065423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-17T11:47:08.733614Z","caller":"traceutil/trace.go:171","msg":"trace[1021478078] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5534; }","duration":"449.182926ms","start":"2026-10-17T11:47:08.284415Z","end":"2026-10-17T11:47:08.733598Z","steps":["trace[1021478078] 'agreement among raft nodes before linearized reading'  (duration: 449.051903ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:47:08.733588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.139565ms","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-10-17T11:47:08.733664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:47:08.284376Z","time spent":"449.277078ms","remote":"127.0.0.1:57530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-10-17T11:47:08.733614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:47:08.28848Z","time spent":"445.056915ms","remote":"127.0.0.1:52516","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:5523 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:367 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-10-17T11:47:08.733727Z","caller":"traceutil/trace.go:171","msg":"trace[1541585948] transaction","detail":"{read_only:false; response_revision:5533; number_of_response:1; }","duration":"445.626257ms","start":"2026-10-17T11:47:08.28807Z","end":"2026-10-17T11:47:08.733696Z","steps":["trace[1541585948] 'process raft request'  (duration: 445.043444ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T11:47:08.733668Z","caller":"traceutil/trace.go:171","msg":"trace[1674490440] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:5533; }","duration":"449.277798ms","start":"2026-10-17T11:47:08.284376Z","end":"2026-10-17T11:47:08.733654Z","steps":["trace[1674490440] 'agreement among raft nodes before linearized reading'  (duration: 448.983132ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:47:08.733872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.891306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-10-17T11:47:08.733864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:47:08.284349Z","time spent":"449.503384ms","remote":"127.0.0.1:57462","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"info","ts":"2026-10-17T11:47:08.733954Z","caller":"traceutil/trace.go:171","msg":"trace[1950056173] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5534; }","duration":"269.004279ms","start":"2026-10-17T11:47:08.464936Z","end":"2026-10-17T11:47:08.73394Z","steps":["trace[1950056173] 'agreement among raft nodes before linearized reading'  (duration: 268.776933ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:47:08.733904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:47:08.288037Z","time spent":"445.76072ms","remote":"127.0.0.1:52516","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:5524 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:463 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-10-17T11:47:08.734019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.655971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-17T11:47:08.73422Z","caller":"traceutil/trace.go:171","msg":"trace[918090922] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:5534; }","duration":"182.046239ms","start":"2026-10-17T11:47:08.552148Z","end":"2026-10-17T11:47:08.734194Z","steps":["trace[918090922] 'agreement among raft nodes before linearized reading'  (duration: 181.333083ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T11:47:08.935916Z","caller":"traceutil/trace.go:171","msg":"trace[1945246280] transaction","detail":"{read_only:false; response_revision:5535; number_of_response:1; }","duration":"196.003669ms","start":"2026-10-17T11:47:08.739882Z","end":"2026-10-17T11:47:08.935886Z","steps":["trace[1945246280] 'process raft request'  (duration: 103.872855ms)","trace[1945246280] 'compare'  (duration: 91.986471ms)"],"step_count":2}
{"level":"info","ts":"2026-10-17T11:47:09.364995Z","caller":"traceutil/trace.go:171","msg":"trace[1699041984] linearizableReadLoop","detail":"{readStateIndex:5760; appliedIndex:5759; }","duration":"474.57271ms","start":"2026-10-17T11:47:08.890393Z","end":"2026-10-17T11:47:09.364966Z","steps":["trace[1699041984] 'read index received'  (duration: 450.949666ms)","trace[1699041984] 'applied index is now lower than readState.Index'  (duration: 23.621834ms)"],"step_count":2}
{"level":"info","ts":"2026-10-17T11:47:09.365133Z","caller":"traceutil/trace.go:171","msg":"trace[1794919677] transaction","detail":"{read_only:false; response_revision:5536; number_of_response:1; }","duration":"512.633434ms","start":"2026-10-17T11:47:08.852486Z","end":"2026-10-17T11:47:09.365119Z","steps":["trace[1794919677] 'process raft request'  (duration: 488.793915ms)","trace[1794919677] 'compare'  (duration: 23.320888ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-17T11:47:09.365271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:47:08.852457Z","time spent":"512.702295ms","remote":"127.0.0.1:52516","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:5489 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"info","ts":"2026-10-17T11:47:09.365737Z","caller":"traceutil/trace.go:171","msg":"trace[412489803] transaction","detail":"{read_only:false; response_revision:5537; number_of_response:1; }","duration":"474.010306ms","start":"2026-10-17T11:47:08.8917Z","end":"2026-10-17T11:47:09.36571Z","steps":["trace[412489803] 'process raft request'  (duration: 473.762971ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:47:09.365987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:47:08.891679Z","time spent":"474.169531ms","remote":"127.0.0.1:52516","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:5526 > 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-17T11:47:09.365558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"475.144242ms","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-10-17T11:47:09.366367Z","caller":"traceutil/trace.go:171","msg":"trace[1333493123] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5536; }","duration":"476.001021ms","start":"2026-10-17T11:47:08.890335Z","end":"2026-10-17T11:47:09.366336Z","steps":["trace[1333493123] 'agreement among raft nodes before linearized reading'  (duration: 474.913657ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:47:09.366423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:47:08.890313Z","time spent":"476.090163ms","remote":"127.0.0.1:52516","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-10-17T11:47:09.831727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.278806ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10906206785267264093 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:5528 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-10-17T11:47:09.832011Z","caller":"traceutil/trace.go:171","msg":"trace[2014490338] transaction","detail":"{read_only:false; response_revision:5540; number_of_response:1; }","duration":"458.685257ms","start":"2026-10-17T11:47:09.373285Z","end":"2026-10-17T11:47:09.831971Z","steps":["trace[2014490338] 'process raft request'  (duration: 225.031853ms)","trace[2014490338] 'compare'  (duration: 232.508809ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-17T11:47:09.832368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:47:09.373227Z","time spent":"458.918212ms","remote":"127.0.0.1:52516","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:5528 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-10-17T11:47:09.832515Z","caller":"traceutil/trace.go:171","msg":"trace[2802487] transaction","detail":"{read_only:false; response_revision:5541; number_of_response:1; }","duration":"262.523925ms","start":"2026-10-17T11:47:09.569964Z","end":"2026-10-17T11:47:09.832488Z","steps":["trace[2802487] 'process raft request'  (duration: 261.919361ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:47:10.236031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.038859ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-17T11:47:10.236155Z","caller":"traceutil/trace.go:171","msg":"trace[727454202] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:5541; }","duration":"118.174512ms","start":"2026-10-17T11:47:10.11796Z","end":"2026-10-17T11:47:10.236134Z","steps":["trace[727454202] 'range keys from in-memory index tree'  (duration: 118.025089ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T11:47:10.451166Z","caller":"traceutil/trace.go:171","msg":"trace[1028552912] linearizableReadLoop","detail":"{readStateIndex:5766; appliedIndex:5765; }","duration":"398.698186ms","start":"2026-10-17T11:47:10.052427Z","end":"2026-10-17T11:47:10.451125Z","steps":["trace[1028552912] 'read index received'  (duration: 398.382159ms)","trace[1028552912] 'applied index is now lower than readState.Index'  (duration: 314.467µs)"],"step_count":2}
{"level":"info","ts":"2026-10-17T11:47:10.451266Z","caller":"traceutil/trace.go:171","msg":"trace[1176375214] transaction","detail":"{read_only:false; response_revision:5542; number_of_response:1; }","duration":"604.152654ms","start":"2026-10-17T11:47:09.847062Z","end":"2026-10-17T11:47:10.451214Z","steps":["trace[1176375214] 'process raft request'  (duration: 603.842387ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:47:10.451406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.947921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-17T11:47:10.451456Z","caller":"traceutil/trace.go:171","msg":"trace[523793286] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5542; }","duration":"399.066134ms","start":"2026-10-17T11:47:10.052378Z","end":"2026-10-17T11:47:10.451444Z","steps":["trace[523793286] 'agreement among raft nodes before linearized reading'  (duration: 398.959922ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:47:10.451493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:47:10.052355Z","time spent":"399.129525ms","remote":"127.0.0.1:57540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-10-17T11:47:10.451567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:47:09.847036Z","time spent":"604.301448ms","remote":"127.0.0.1:52516","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:5532 > 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":"warn","ts":"2026-10-17T11:47:10.451662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.468024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12499"}
{"level":"info","ts":"2026-10-17T11:47:10.451794Z","caller":"traceutil/trace.go:171","msg":"trace[607761412] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5542; }","duration":"194.695169ms","start":"2026-10-17T11:47:10.257078Z","end":"2026-10-17T11:47:10.451773Z","steps":["trace[607761412] 'agreement among raft nodes before linearized reading'  (duration: 194.338491ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T11:47:10.867693Z","caller":"traceutil/trace.go:171","msg":"trace[1625615511] transaction","detail":"{read_only:false; response_revision:5543; number_of_response:1; }","duration":"101.981483ms","start":"2026-10-17T11:47:10.765686Z","end":"2026-10-17T11:47:10.867668Z","steps":["trace[1625615511] 'process raft request'  (duration: 101.822529ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:47:11.249973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.357215ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10906206785267264107 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:5533 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-10-17T11:47:11.250097Z","caller":"traceutil/trace.go:171","msg":"trace[662018764] linearizableReadLoop","detail":"{readStateIndex:5768; appliedIndex:5766; }","duration":"409.702549ms","start":"2026-10-17T11:47:10.840373Z","end":"2026-10-17T11:47:11.250076Z","steps":["trace[662018764] 'read index received'  (duration: 27.269915ms)","trace[662018764] 'applied index is now lower than readState.Index'  (duration: 382.430954ms)"],"step_count":2}
{"level":"info","ts":"2026-10-17T11:47:11.250164Z","caller":"traceutil/trace.go:171","msg":"trace[2099169284] transaction","detail":"{read_only:false; response_revision:5544; number_of_response:1; }","duration":"483.266011ms","start":"2026-10-17T11:47:10.766861Z","end":"2026-10-17T11:47:11.250127Z","steps":["trace[2099169284] 'process raft request'  (duration: 236.6331ms)","trace[2099169284] 'compare'  (duration: 246.206902ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-17T11:47:11.25031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.910858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-10-17T11:47:11.250351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.598368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-10-17T11:47:11.250372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.997695ms","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-17T11:47:11.250395Z","caller":"traceutil/trace.go:171","msg":"trace[1011758549] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5544; }","duration":"309.67523ms","start":"2026-10-17T11:47:10.940709Z","end":"2026-10-17T11:47:11.250385Z","steps":["trace[1011758549] 'agreement among raft nodes before linearized reading'  (duration: 309.482956ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T11:47:11.250398Z","caller":"traceutil/trace.go:171","msg":"trace[1065603848] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5544; }","duration":"197.070381ms","start":"2026-10-17T11:47:11.05331Z","end":"2026-10-17T11:47:11.25038Z","steps":["trace[1065603848] 'agreement among raft nodes before linearized reading'  (duration: 196.917018ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T11:47:11.25044Z","caller":"traceutil/trace.go:171","msg":"trace[346611836] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:5544; }","duration":"410.115368ms","start":"2026-10-17T11:47:10.840303Z","end":"2026-10-17T11:47:11.250418Z","steps":["trace[346611836] 'agreement among raft nodes before linearized reading'  (duration: 409.877933ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:47:11.25044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:47:10.940693Z","time spent":"309.739661ms","remote":"127.0.0.1:52516","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-10-17T11:47:11.250501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:47:10.840279Z","time spent":"410.20107ms","remote":"127.0.0.1:57462","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"warn","ts":"2026-10-17T11:47:11.25051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:47:10.766824Z","time spent":"483.463525ms","remote":"127.0.0.1:52516","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:5533 > 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":"info","ts":"2026-10-17T11:47:11.514317Z","caller":"traceutil/trace.go:171","msg":"trace[1076427868] transaction","detail":"{read_only:false; response_revision:5546; number_of_response:1; }","duration":"142.030391ms","start":"2026-10-17T11:47:11.372257Z","end":"2026-10-17T11:47:11.514287Z","steps":["trace[1076427868] 'process raft request'  (duration: 141.498639ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T11:47:11.649919Z","caller":"traceutil/trace.go:171","msg":"trace[527358438] linearizableReadLoop","detail":"{readStateIndex:5771; appliedIndex:5769; }","duration":"249.798072ms","start":"2026-10-17T11:47:11.400068Z","end":"2026-10-17T11:47:11.649866Z","steps":["trace[527358438] 'read index received'  (duration: 113.662012ms)","trace[527358438] 'applied index is now lower than readState.Index'  (duration: 136.13487ms)"],"step_count":2}
{"level":"info","ts":"2026-10-17T11:47:11.649976Z","caller":"traceutil/trace.go:171","msg":"trace[358610925] transaction","detail":"{read_only:false; response_revision:5547; number_of_response:1; }","duration":"276.411362ms","start":"2026-10-17T11:47:11.373539Z","end":"2026-10-17T11:47:11.64995Z","steps":["trace[358610925] 'process raft request'  (duration: 273.584779ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T11:47:11.650349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.250322ms","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-10-17T11:47:11.650421Z","caller":"traceutil/trace.go:171","msg":"trace[1539397734] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5547; }","duration":"250.393115ms","start":"2026-10-17T11:47:11.400011Z","end":"2026-10-17T11:47:11.650404Z","steps":["trace[1539397734] 'agreement among raft nodes before linearized reading'  (duration: 249.987666ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T11:47:49.522008Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":4234}
{"level":"info","ts":"2026-10-17T11:47:49.560657Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":4234,"took":"37.658565ms","hash":2777911408,"current-db-size-bytes":31903744,"current-db-size":"32 MB","current-db-size-in-use-bytes":7987200,"current-db-size-in-use":"8.0 MB"}
{"level":"info","ts":"2026-10-17T11:47:49.560778Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2777911408,"revision":4234,"compact-revision":2702}