{"level":"warn","ts":"2026-10-04T12:50:39.309752Z","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-04T12:50:39.30987Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.191: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.191:2380","--initial-cluster=instance=https://162.253.55.191:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.191:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.191: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-04T12:50:39.309953Z","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-04T12:50:39.309966Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.191:2380"]}
{"level":"info","ts":"2026-10-04T12:50:39.310028Z","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-04T12:50:39.311939Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.191:2379"]}
{"level":"info","ts":"2026-10-04T12:50:39.312053Z","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.191:2380"],"listen-peer-urls":["https://162.253.55.191:2380"],"advertise-client-urls":["https://162.253.55.191:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.191:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.191: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-04T12:50:39.318404Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.129913ms"}
{"level":"info","ts":"2026-10-04T12:50:39.324951Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"adb6690514c92321","cluster-id":"ee04900e3a861beb"}
{"level":"info","ts":"2026-10-04T12:50:39.325044Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adb6690514c92321 switched to configuration voters=()"}
{"level":"info","ts":"2026-10-04T12:50:39.325069Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adb6690514c92321 became follower at term 0"}
{"level":"info","ts":"2026-10-04T12:50:39.325083Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft adb6690514c92321 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-10-04T12:50:39.325091Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adb6690514c92321 became follower at term 1"}
{"level":"info","ts":"2026-10-04T12:50:39.325133Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adb6690514c92321 switched to configuration voters=(12517307684867351329)"}
{"level":"warn","ts":"2026-10-04T12:50:39.33263Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-10-04T12:50:39.334055Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-10-04T12:50:39.336727Z","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-04T12:50:39.339639Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"adb6690514c92321","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-10-04T12:50:39.340335Z","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-04T12:50:39.340474Z","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-04T12:50:39.340417Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"adb6690514c92321","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-10-04T12:50:39.340505Z","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-04T12:50:39.341296Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adb6690514c92321 switched to configuration voters=(12517307684867351329)"}
{"level":"info","ts":"2026-10-04T12:50:39.341593Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ee04900e3a861beb","local-member-id":"adb6690514c92321","added-peer-id":"adb6690514c92321","added-peer-peer-urls":["https://162.253.55.191:2380"]}
{"level":"info","ts":"2026-10-04T12:50:39.343888Z","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-04T12:50:39.344092Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.191:2380"}
{"level":"info","ts":"2026-10-04T12:50:39.344176Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.191:2380"}
{"level":"info","ts":"2026-10-04T12:50:39.344209Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"adb6690514c92321","initial-advertise-peer-urls":["https://162.253.55.191:2380"],"listen-peer-urls":["https://162.253.55.191:2380"],"advertise-client-urls":["https://162.253.55.191:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.191:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-10-04T12:50:39.344277Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-10-04T12:50:40.325714Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adb6690514c92321 is starting a new election at term 1"}
{"level":"info","ts":"2026-10-04T12:50:40.325801Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adb6690514c92321 became pre-candidate at term 1"}
{"level":"info","ts":"2026-10-04T12:50:40.325827Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adb6690514c92321 received MsgPreVoteResp from adb6690514c92321 at term 1"}
{"level":"info","ts":"2026-10-04T12:50:40.325847Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adb6690514c92321 became candidate at term 2"}
{"level":"info","ts":"2026-10-04T12:50:40.325866Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adb6690514c92321 received MsgVoteResp from adb6690514c92321 at term 2"}
{"level":"info","ts":"2026-10-04T12:50:40.325894Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adb6690514c92321 became leader at term 2"}
{"level":"info","ts":"2026-10-04T12:50:40.325906Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: adb6690514c92321 elected leader adb6690514c92321 at term 2"}
{"level":"info","ts":"2026-10-04T12:50:40.327039Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"adb6690514c92321","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.191:2379]}","request-path":"/0/members/adb6690514c92321/attributes","cluster-id":"ee04900e3a861beb","publish-timeout":"7s"}
{"level":"info","ts":"2026-10-04T12:50:40.327033Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-04T12:50:40.327113Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-10-04T12:50:40.3272Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-10-04T12:50:40.327364Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-10-04T12:50:40.32743Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-10-04T12:50:40.329128Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ee04900e3a861beb","local-member-id":"adb6690514c92321","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-04T12:50:40.329343Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-04T12:50:40.329396Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-04T12:50:40.333947Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.191:2379"}
{"level":"info","ts":"2026-10-04T12:50:40.334102Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-10-04T12:50:58.293397Z","caller":"traceutil/trace.go:171","msg":"trace[964478798] transaction","detail":"{read_only:false; response_revision:375; number_of_response:1; }","duration":"201.809511ms","start":"2026-10-04T12:50:58.091549Z","end":"2026-10-04T12:50:58.293358Z","steps":["trace[964478798] 'process raft request'  (duration: 201.592587ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T12:50:58.30034Z","caller":"traceutil/trace.go:171","msg":"trace[101155065] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"208.102798ms","start":"2026-10-04T12:50:58.0922Z","end":"2026-10-04T12:50:58.300303Z","steps":["trace[101155065] 'process raft request'  (duration: 207.835562ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T12:51:25.115257Z","caller":"traceutil/trace.go:171","msg":"trace[1871544633] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"206.45178ms","start":"2026-10-04T12:51:24.908741Z","end":"2026-10-04T12:51:25.115193Z","steps":["trace[1871544633] 'process raft request'  (duration: 205.797285ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T12:51:25.152533Z","caller":"traceutil/trace.go:171","msg":"trace[420586608] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"132.582274ms","start":"2026-10-04T12:51:25.019921Z","end":"2026-10-04T12:51:25.152503Z","steps":["trace[420586608] 'process raft request'  (duration: 132.197915ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T12:51:25.366288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.693535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-04T12:51:25.366433Z","caller":"traceutil/trace.go:171","msg":"trace[1492222072] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:587; }","duration":"131.885919ms","start":"2026-10-04T12:51:25.23452Z","end":"2026-10-04T12:51:25.366405Z","steps":["trace[1492222072] 'range keys from in-memory index tree'  (duration: 131.549421ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T12:52:09.825178Z","caller":"traceutil/trace.go:171","msg":"trace[1321487978] transaction","detail":"{read_only:false; response_revision:1160; number_of_response:1; }","duration":"180.801526ms","start":"2026-10-04T12:52:09.64435Z","end":"2026-10-04T12:52:09.825152Z","steps":["trace[1321487978] 'process raft request'  (duration: 180.598871ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T12:52:25.097774Z","caller":"traceutil/trace.go:171","msg":"trace[1651782371] transaction","detail":"{read_only:false; response_revision:1296; number_of_response:1; }","duration":"108.519738ms","start":"2026-10-04T12:52:24.989223Z","end":"2026-10-04T12:52:25.097743Z","steps":["trace[1651782371] 'process raft request'  (duration: 74.042909ms)","trace[1651782371] 'compare'  (duration: 34.367817ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T12:52:55.90278Z","caller":"traceutil/trace.go:171","msg":"trace[1583496000] transaction","detail":"{read_only:false; response_revision:1816; number_of_response:1; }","duration":"217.489035ms","start":"2026-10-04T12:52:55.685252Z","end":"2026-10-04T12:52:55.902741Z","steps":["trace[1583496000] 'process raft request'  (duration: 217.273501ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T12:53:10.726978Z","caller":"traceutil/trace.go:171","msg":"trace[1991380431] transaction","detail":"{read_only:false; response_revision:1936; number_of_response:1; }","duration":"101.849353ms","start":"2026-10-04T12:53:10.625087Z","end":"2026-10-04T12:53:10.726937Z","steps":["trace[1991380431] 'process raft request'  (duration: 101.676038ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T12:53:47.605588Z","caller":"traceutil/trace.go:171","msg":"trace[1888035282] transaction","detail":"{read_only:false; response_revision:2149; number_of_response:1; }","duration":"157.30789ms","start":"2026-10-04T12:53:47.448246Z","end":"2026-10-04T12:53:47.605554Z","steps":["trace[1888035282] 'process raft request'  (duration: 88.12472ms)","trace[1888035282] 'compare'  (duration: 68.908014ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T12:53:47.605573Z","caller":"traceutil/trace.go:171","msg":"trace[651996253] linearizableReadLoop","detail":"{readStateIndex:2231; appliedIndex:2230; }","duration":"147.680511ms","start":"2026-10-04T12:53:47.457855Z","end":"2026-10-04T12:53:47.605536Z","steps":["trace[651996253] 'read index received'  (duration: 78.43605ms)","trace[651996253] 'applied index is now lower than readState.Index'  (duration: 69.242941ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T12:53:47.605958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.083579ms","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-04T12:53:47.606053Z","caller":"traceutil/trace.go:171","msg":"trace[1408896919] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2150; }","duration":"148.230953ms","start":"2026-10-04T12:53:47.457803Z","end":"2026-10-04T12:53:47.606034Z","steps":["trace[1408896919] 'agreement among raft nodes before linearized reading'  (duration: 147.813444ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T12:53:47.907179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.615448ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2531481516851490467 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:2139 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-10-04T12:53:47.907408Z","caller":"traceutil/trace.go:171","msg":"trace[913724850] transaction","detail":"{read_only:false; response_revision:2152; number_of_response:1; }","duration":"296.403514ms","start":"2026-10-04T12:53:47.610983Z","end":"2026-10-04T12:53:47.907387Z","steps":["trace[913724850] 'process raft request'  (duration: 296.330833ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T12:53:47.907482Z","caller":"traceutil/trace.go:171","msg":"trace[1455799897] transaction","detail":"{read_only:false; response_revision:2151; number_of_response:1; }","duration":"297.10131ms","start":"2026-10-04T12:53:47.610344Z","end":"2026-10-04T12:53:47.907445Z","steps":["trace[1455799897] 'process raft request'  (duration: 137.350428ms)","trace[1455799897] 'compare'  (duration: 158.184338ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T12:54:44.068785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.388468ms","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-04T12:54:44.068859Z","caller":"traceutil/trace.go:171","msg":"trace[265005623] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2626; }","duration":"178.535161ms","start":"2026-10-04T12:54:43.89031Z","end":"2026-10-04T12:54:44.068845Z","steps":["trace[265005623] 'range keys from in-memory index tree'  (duration: 178.109061ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T12:55:17.460281Z","caller":"traceutil/trace.go:171","msg":"trace[1768896126] transaction","detail":"{read_only:false; response_revision:2828; number_of_response:1; }","duration":"163.351922ms","start":"2026-10-04T12:55:17.296892Z","end":"2026-10-04T12:55:17.460243Z","steps":["trace[1768896126] 'process raft request'  (duration: 163.127667ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T12:55:17.919969Z","caller":"traceutil/trace.go:171","msg":"trace[903632973] linearizableReadLoop","detail":"{readStateIndex:2939; appliedIndex:2938; }","duration":"145.543135ms","start":"2026-10-04T12:55:17.774394Z","end":"2026-10-04T12:55:17.919937Z","steps":["trace[903632973] 'read index received'  (duration: 145.30852ms)","trace[903632973] 'applied index is now lower than readState.Index'  (duration: 233.345µs)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T12:55:17.920274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.862922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:1853"}
{"level":"info","ts":"2026-10-04T12:55:17.920331Z","caller":"traceutil/trace.go:171","msg":"trace[1886730677] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2830; }","duration":"145.971225ms","start":"2026-10-04T12:55:17.774339Z","end":"2026-10-04T12:55:17.92031Z","steps":["trace[1886730677] 'agreement among raft nodes before linearized reading'  (duration: 145.718759ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T12:55:17.920751Z","caller":"traceutil/trace.go:171","msg":"trace[320858408] transaction","detail":"{read_only:false; response_revision:2830; number_of_response:1; }","duration":"147.943438ms","start":"2026-10-04T12:55:17.772787Z","end":"2026-10-04T12:55:17.920731Z","steps":["trace[320858408] 'process raft request'  (duration: 146.987417ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T12:58:35.108082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.104924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1988"}
{"level":"info","ts":"2026-10-04T12:58:35.108208Z","caller":"traceutil/trace.go:171","msg":"trace[755853726] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:4070; }","duration":"128.291848ms","start":"2026-10-04T12:58:34.979891Z","end":"2026-10-04T12:58:35.108183Z","steps":["trace[755853726] 'range keys from in-memory index tree'  (duration: 127.889109ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T12:58:35.108387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.149725ms","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-04T12:58:35.109049Z","caller":"traceutil/trace.go:171","msg":"trace[1457615535] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:4070; }","duration":"157.939533ms","start":"2026-10-04T12:58:34.951077Z","end":"2026-10-04T12:58:35.109016Z","steps":["trace[1457615535] 'range keys from in-memory index tree'  (duration: 156.999392ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:00:07.200546Z","caller":"traceutil/trace.go:171","msg":"trace[785874349] transaction","detail":"{read_only:false; response_revision:5113; number_of_response:1; }","duration":"103.945583ms","start":"2026-10-04T13:00:07.096571Z","end":"2026-10-04T13:00:07.200517Z","steps":["trace[785874349] 'process raft request'  (duration: 10.097662ms)","trace[785874349] 'compare'  (duration: 93.716198ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T13:00:09.080605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.958914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/monitoring/loki-memcached-chunks-cache\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-04T13:00:09.080699Z","caller":"traceutil/trace.go:171","msg":"trace[2023218693] range","detail":"{range_begin:/registry/poddisruptionbudgets/monitoring/loki-memcached-chunks-cache; range_end:; response_count:0; response_revision:5129; }","duration":"138.154887ms","start":"2026-10-04T13:00:08.94252Z","end":"2026-10-04T13:00:09.080674Z","steps":["trace[2023218693] 'range keys from in-memory index tree'  (duration: 137.843941ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:00:09.311245Z","caller":"traceutil/trace.go:171","msg":"trace[1827317734] transaction","detail":"{read_only:false; number_of_response:0; response_revision:5130; }","duration":"121.849597ms","start":"2026-10-04T13:00:09.189369Z","end":"2026-10-04T13:00:09.311218Z","steps":["trace[1827317734] 'process raft request'  (duration: 87.007909ms)","trace[1827317734] 'compare'  (duration: 34.785368ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:00:09.343758Z","caller":"traceutil/trace.go:171","msg":"trace[565692972] transaction","detail":"{read_only:false; response_revision:5131; number_of_response:1; }","duration":"134.955776ms","start":"2026-10-04T13:00:09.208728Z","end":"2026-10-04T13:00:09.343683Z","steps":["trace[565692972] 'process raft request'  (duration: 134.601999ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:00:12.007545Z","caller":"traceutil/trace.go:171","msg":"trace[1292423411] linearizableReadLoop","detail":"{readStateIndex:5505; appliedIndex:5504; }","duration":"198.723704ms","start":"2026-10-04T13:00:11.808792Z","end":"2026-10-04T13:00:12.007516Z","steps":["trace[1292423411] 'read index received'  (duration: 145.358107ms)","trace[1292423411] 'applied index is now lower than readState.Index'  (duration: 53.364627ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:00:12.00764Z","caller":"traceutil/trace.go:171","msg":"trace[325634441] transaction","detail":"{read_only:false; response_revision:5305; number_of_response:1; }","duration":"205.617757ms","start":"2026-10-04T13:00:11.801972Z","end":"2026-10-04T13:00:12.00759Z","steps":["trace[325634441] 'process raft request'  (duration: 152.050435ms)","trace[325634441] 'compare'  (duration: 53.347538ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T13:00:12.00777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.101065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/vector\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-10-04T13:00:12.007802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.955349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-fa5b58c3-2cfc-43a1-bf26-aa82833a5d6b\" ","response":"range_response_count:1 size:3721"}
{"level":"info","ts":"2026-10-04T13:00:12.007898Z","caller":"traceutil/trace.go:171","msg":"trace[89829532] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/vector; range_end:; response_count:0; response_revision:5305; }","duration":"186.234699ms","start":"2026-10-04T13:00:11.821617Z","end":"2026-10-04T13:00:12.007851Z","steps":["trace[89829532] 'agreement among raft nodes before linearized reading'  (duration: 186.078745ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:00:12.007918Z","caller":"traceutil/trace.go:171","msg":"trace[1229561094] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-fa5b58c3-2cfc-43a1-bf26-aa82833a5d6b; range_end:; response_count:1; response_revision:5305; }","duration":"199.140024ms","start":"2026-10-04T13:00:11.808748Z","end":"2026-10-04T13:00:12.007888Z","steps":["trace[1229561094] 'agreement among raft nodes before linearized reading'  (duration: 198.890909ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:00:23.10823Z","caller":"traceutil/trace.go:171","msg":"trace[2060452601] transaction","detail":"{read_only:false; response_revision:5509; number_of_response:1; }","duration":"145.213455ms","start":"2026-10-04T13:00:22.962977Z","end":"2026-10-04T13:00:23.108191Z","steps":["trace[2060452601] 'process raft request'  (duration: 69.823921ms)","trace[2060452601] 'compare'  (duration: 75.182559ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:00:26.196534Z","caller":"traceutil/trace.go:171","msg":"trace[1179937337] linearizableReadLoop","detail":"{readStateIndex:5768; appliedIndex:5767; }","duration":"109.619369ms","start":"2026-10-04T13:00:26.086893Z","end":"2026-10-04T13:00:26.196513Z","steps":["trace[1179937337] 'read index received'  (duration: 109.247561ms)","trace[1179937337] 'applied index is now lower than readState.Index'  (duration: 370.689µs)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:00:26.196573Z","caller":"traceutil/trace.go:171","msg":"trace[640617401] transaction","detail":"{read_only:false; response_revision:5559; number_of_response:1; }","duration":"154.160742ms","start":"2026-10-04T13:00:26.042384Z","end":"2026-10-04T13:00:26.196544Z","steps":["trace[640617401] 'process raft request'  (duration: 153.918656ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:00:26.196741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.838004ms","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-04T13:00:26.19678Z","caller":"traceutil/trace.go:171","msg":"trace[744292051] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5559; }","duration":"109.923406ms","start":"2026-10-04T13:00:26.086847Z","end":"2026-10-04T13:00:26.19677Z","steps":["trace[744292051] 'agreement among raft nodes before linearized reading'  (duration: 109.771683ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:00:34.568911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.051812ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2531481516851499221 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:5649 > 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-04T13:00:34.569109Z","caller":"traceutil/trace.go:171","msg":"trace[1255406766] linearizableReadLoop","detail":"{readStateIndex:5945; appliedIndex:5942; }","duration":"319.731205ms","start":"2026-10-04T13:00:34.24936Z","end":"2026-10-04T13:00:34.569091Z","steps":["trace[1255406766] 'read index received'  (duration: 43.366707ms)","trace[1255406766] 'applied index is now lower than readState.Index'  (duration: 276.363368ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:00:34.569198Z","caller":"traceutil/trace.go:171","msg":"trace[285377491] transaction","detail":"{read_only:false; response_revision:5734; number_of_response:1; }","duration":"325.296978ms","start":"2026-10-04T13:00:34.243892Z","end":"2026-10-04T13:00:34.569189Z","steps":["trace[285377491] 'process raft request'  (duration: 325.126684ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:00:34.569242Z","caller":"traceutil/trace.go:171","msg":"trace[2082063495] transaction","detail":"{read_only:false; response_revision:5733; number_of_response:1; }","duration":"325.348357ms","start":"2026-10-04T13:00:34.243861Z","end":"2026-10-04T13:00:34.569209Z","steps":["trace[2082063495] 'process raft request'  (duration: 164.904787ms)","trace[2082063495] 'compare'  (duration: 159.915849ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T13:00:34.569259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:00:34.243873Z","time spent":"325.353968ms","remote":"127.0.0.1:40706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:5648 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-10-04T13:00:34.569364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.586804ms","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":"warn","ts":"2026-10-04T13:00:34.569394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.009991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-10-04T13:00:34.569409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.080579ms","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-04T13:00:34.569463Z","caller":"traceutil/trace.go:171","msg":"trace[1846359588] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5734; }","duration":"180.728207ms","start":"2026-10-04T13:00:34.388713Z","end":"2026-10-04T13:00:34.569442Z","steps":["trace[1846359588] 'agreement among raft nodes before linearized reading'  (duration: 180.502892ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:00:34.569497Z","caller":"traceutil/trace.go:171","msg":"trace[1406023611] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5734; }","duration":"134.206461ms","start":"2026-10-04T13:00:34.435275Z","end":"2026-10-04T13:00:34.569481Z","steps":["trace[1406023611] 'agreement among raft nodes before linearized reading'  (duration: 133.985787ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:00:34.569499Z","caller":"traceutil/trace.go:171","msg":"trace[707600867] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:5734; }","duration":"320.156574ms","start":"2026-10-04T13:00:34.249318Z","end":"2026-10-04T13:00:34.569474Z","steps":["trace[707600867] 'agreement among raft nodes before linearized reading'  (duration: 319.941039ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:00:34.569407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:00:34.243842Z","time spent":"325.482971ms","remote":"127.0.0.1:40706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:5649 > 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-04T13:00:34.569563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:00:34.249303Z","time spent":"320.250596ms","remote":"127.0.0.1:40616","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":50,"response size":31,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true "}
{"level":"info","ts":"2026-10-04T13:00:40.363868Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2955}
{"level":"info","ts":"2026-10-04T13:00:40.443001Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2955,"took":"77.849148ms","hash":1664569068,"current-db-size-bytes":56639488,"current-db-size":"57 MB","current-db-size-in-use-bytes":32161792,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-10-04T13:00:40.44307Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1664569068,"revision":2955,"compact-revision":-1}
{"level":"info","ts":"2026-10-04T13:00:46.58837Z","caller":"traceutil/trace.go:171","msg":"trace[586288870] linearizableReadLoop","detail":"{readStateIndex:6131; appliedIndex:6130; }","duration":"123.798522ms","start":"2026-10-04T13:00:46.464542Z","end":"2026-10-04T13:00:46.58834Z","steps":["trace[586288870] 'read index received'  (duration: 123.547066ms)","trace[586288870] 'applied index is now lower than readState.Index'  (duration: 250.296µs)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:00:46.588409Z","caller":"traceutil/trace.go:171","msg":"trace[1770054515] transaction","detail":"{read_only:false; response_revision:5914; number_of_response:1; }","duration":"158.488607ms","start":"2026-10-04T13:00:46.429896Z","end":"2026-10-04T13:00:46.588385Z","steps":["trace[1770054515] 'process raft request'  (duration: 158.272912ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:00:46.588542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.981045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-04T13:00:46.588625Z","caller":"traceutil/trace.go:171","msg":"trace[156376682] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5914; }","duration":"124.118669ms","start":"2026-10-04T13:00:46.464486Z","end":"2026-10-04T13:00:46.588604Z","steps":["trace[156376682] 'agreement among raft nodes before linearized reading'  (duration: 123.965945ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:05:40.370701Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5855}
{"level":"info","ts":"2026-10-04T13:05:40.464944Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5855,"took":"92.342228ms","hash":2698724151,"current-db-size-bytes":56639488,"current-db-size":"57 MB","current-db-size-in-use-bytes":26697728,"current-db-size-in-use":"27 MB"}
{"level":"info","ts":"2026-10-04T13:05:40.465045Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2698724151,"revision":5855,"compact-revision":2955}
{"level":"info","ts":"2026-10-04T13:06:48.632943Z","caller":"traceutil/trace.go:171","msg":"trace[761099482] linearizableReadLoop","detail":"{readStateIndex:8928; appliedIndex:8927; }","duration":"167.541746ms","start":"2026-10-04T13:06:48.465376Z","end":"2026-10-04T13:06:48.632918Z","steps":["trace[761099482] 'read index received'  (duration: 167.311381ms)","trace[761099482] 'applied index is now lower than readState.Index'  (duration: 229.265µs)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:06:48.633014Z","caller":"traceutil/trace.go:171","msg":"trace[415384236] transaction","detail":"{read_only:false; response_revision:8624; number_of_response:1; }","duration":"288.337412ms","start":"2026-10-04T13:06:48.344632Z","end":"2026-10-04T13:06:48.632969Z","steps":["trace[415384236] 'process raft request'  (duration: 288.116307ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:06:48.633127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.73172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-04T13:06:48.633181Z","caller":"traceutil/trace.go:171","msg":"trace[989235944] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8624; }","duration":"167.832462ms","start":"2026-10-04T13:06:48.465334Z","end":"2026-10-04T13:06:48.633167Z","steps":["trace[989235944] 'agreement among raft nodes before linearized reading'  (duration: 167.744901ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:06:48.633276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.647409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"warn","ts":"2026-10-04T13:06:48.633277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.055009ms","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-04T13:06:48.633314Z","caller":"traceutil/trace.go:171","msg":"trace[1345655071] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8624; }","duration":"107.713142ms","start":"2026-10-04T13:06:48.525593Z","end":"2026-10-04T13:06:48.633306Z","steps":["trace[1345655071] 'agreement among raft nodes before linearized reading'  (duration: 107.589089ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:06:48.633285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.526756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"}
{"level":"info","ts":"2026-10-04T13:06:48.633326Z","caller":"traceutil/trace.go:171","msg":"trace[766603731] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8624; }","duration":"108.144101ms","start":"2026-10-04T13:06:48.525169Z","end":"2026-10-04T13:06:48.633313Z","steps":["trace[766603731] 'agreement among raft nodes before linearized reading'  (duration: 107.985547ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:06:48.633372Z","caller":"traceutil/trace.go:171","msg":"trace[392154159] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:8624; }","duration":"112.66611ms","start":"2026-10-04T13:06:48.520687Z","end":"2026-10-04T13:06:48.633353Z","steps":["trace[392154159] 'agreement among raft nodes before linearized reading'  (duration: 112.438795ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:06:48.633425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.798864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-10-04T13:06:48.633446Z","caller":"traceutil/trace.go:171","msg":"trace[21503467] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8624; }","duration":"108.858585ms","start":"2026-10-04T13:06:48.524582Z","end":"2026-10-04T13:06:48.63344Z","steps":["trace[21503467] 'agreement among raft nodes before linearized reading'  (duration: 108.803934ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:06:48.77634Z","caller":"traceutil/trace.go:171","msg":"trace[1309149083] transaction","detail":"{read_only:false; response_revision:8625; number_of_response:1; }","duration":"137.999842ms","start":"2026-10-04T13:06:48.638308Z","end":"2026-10-04T13:06:48.776308Z","steps":["trace[1309149083] 'process raft request'  (duration: 135.850915ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:06:48.779849Z","caller":"traceutil/trace.go:171","msg":"trace[517744811] transaction","detail":"{read_only:false; response_revision:8626; number_of_response:1; }","duration":"141.56223ms","start":"2026-10-04T13:06:48.638272Z","end":"2026-10-04T13:06:48.779835Z","steps":["trace[517744811] 'process raft request'  (duration: 141.449667ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:06:48.780178Z","caller":"traceutil/trace.go:171","msg":"trace[115039796] transaction","detail":"{read_only:false; response_revision:8627; number_of_response:1; }","duration":"141.549679ms","start":"2026-10-04T13:06:48.638607Z","end":"2026-10-04T13:06:48.780157Z","steps":["trace[115039796] 'process raft request'  (duration: 141.191992ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:06:48.780222Z","caller":"traceutil/trace.go:171","msg":"trace[449714659] linearizableReadLoop","detail":"{readStateIndex:8932; appliedIndex:8928; }","duration":"116.932412ms","start":"2026-10-04T13:06:48.66327Z","end":"2026-10-04T13:06:48.780202Z","steps":["trace[449714659] 'read index received'  (duration: 110.87329ms)","trace[449714659] 'applied index is now lower than readState.Index'  (duration: 6.058052ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:06:48.780273Z","caller":"traceutil/trace.go:171","msg":"trace[1312647496] transaction","detail":"{read_only:false; response_revision:8628; number_of_response:1; }","duration":"140.539378ms","start":"2026-10-04T13:06:48.639717Z","end":"2026-10-04T13:06:48.780256Z","steps":["trace[1312647496] 'process raft request'  (duration: 140.265441ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:06:48.780578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.773536ms","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":"warn","ts":"2026-10-04T13:06:48.780629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.338452ms","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-04T13:06:48.780645Z","caller":"traceutil/trace.go:171","msg":"trace[1536721503] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8630; }","duration":"109.865137ms","start":"2026-10-04T13:06:48.670764Z","end":"2026-10-04T13:06:48.780629Z","steps":["trace[1536721503] 'agreement among raft nodes before linearized reading'  (duration: 109.684594ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:06:48.780683Z","caller":"traceutil/trace.go:171","msg":"trace[1792491746] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8630; }","duration":"117.424202ms","start":"2026-10-04T13:06:48.663243Z","end":"2026-10-04T13:06:48.780668Z","steps":["trace[1792491746] 'agreement among raft nodes before linearized reading'  (duration: 117.259589ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:07:01.562365Z","caller":"traceutil/trace.go:171","msg":"trace[439195780] linearizableReadLoop","detail":"{readStateIndex:9001; appliedIndex:9000; }","duration":"133.913402ms","start":"2026-10-04T13:07:01.428425Z","end":"2026-10-04T13:07:01.562339Z","steps":["trace[439195780] 'read index received'  (duration: 133.448822ms)","trace[439195780] 'applied index is now lower than readState.Index'  (duration: 463.6µs)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T13:07:01.562704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.248181ms","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-04T13:07:01.562897Z","caller":"traceutil/trace.go:171","msg":"trace[962390870] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:8694; }","duration":"134.500466ms","start":"2026-10-04T13:07:01.42837Z","end":"2026-10-04T13:07:01.562871Z","steps":["trace[962390870] 'agreement among raft nodes before linearized reading'  (duration: 134.154588ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:07:01.563146Z","caller":"traceutil/trace.go:171","msg":"trace[423034917] transaction","detail":"{read_only:false; response_revision:8694; number_of_response:1; }","duration":"184.998899ms","start":"2026-10-04T13:07:01.378129Z","end":"2026-10-04T13:07:01.563128Z","steps":["trace[423034917] 'process raft request'  (duration: 183.899994ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:07:26.61255Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023db.wal"}
{"level":"info","ts":"2026-10-04T13:07:31.03774Z","caller":"traceutil/trace.go:171","msg":"trace[575270493] linearizableReadLoop","detail":"{readStateIndex:9216; appliedIndex:9215; }","duration":"179.384251ms","start":"2026-10-04T13:07:30.858335Z","end":"2026-10-04T13:07:31.037719Z","steps":["trace[575270493] 'read index received'  (duration: 179.33283ms)","trace[575270493] 'applied index is now lower than readState.Index'  (duration: 50.201µs)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:07:31.037804Z","caller":"traceutil/trace.go:171","msg":"trace[457005913] transaction","detail":"{read_only:false; response_revision:8901; number_of_response:1; }","duration":"190.687935ms","start":"2026-10-04T13:07:30.847083Z","end":"2026-10-04T13:07:31.037771Z","steps":["trace[457005913] 'process raft request'  (duration: 190.491761ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:07:31.03797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.591745ms","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-04T13:07:31.038074Z","caller":"traceutil/trace.go:171","msg":"trace[1073332431] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:8901; }","duration":"179.768808ms","start":"2026-10-04T13:07:30.858284Z","end":"2026-10-04T13:07:31.038053Z","steps":["trace[1073332431] 'agreement among raft nodes before linearized reading'  (duration: 179.534023ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:07:31.188417Z","caller":"traceutil/trace.go:171","msg":"trace[770413552] linearizableReadLoop","detail":"{readStateIndex:9218; appliedIndex:9216; }","duration":"150.533141ms","start":"2026-10-04T13:07:31.037863Z","end":"2026-10-04T13:07:31.188396Z","steps":["trace[770413552] 'read index received'  (duration: 120.581128ms)","trace[770413552] 'applied index is now lower than readState.Index'  (duration: 29.951033ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:07:31.188785Z","caller":"traceutil/trace.go:171","msg":"trace[2080888931] transaction","detail":"{read_only:false; response_revision:8903; number_of_response:1; }","duration":"171.418536ms","start":"2026-10-04T13:07:31.017347Z","end":"2026-10-04T13:07:31.188766Z","steps":["trace[2080888931] 'process raft request'  (duration: 171.000637ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:07:31.188773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.61774ms","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":"warn","ts":"2026-10-04T13:07:31.18882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.522416ms","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-04T13:07:31.188846Z","caller":"traceutil/trace.go:171","msg":"trace[460830944] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:8903; }","duration":"204.745573ms","start":"2026-10-04T13:07:30.984084Z","end":"2026-10-04T13:07:31.188829Z","steps":["trace[460830944] 'agreement among raft nodes before linearized reading'  (duration: 204.554389ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:07:31.188853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.433215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-10-04T13:07:31.188923Z","caller":"traceutil/trace.go:171","msg":"trace[1379581965] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:8903; }","duration":"159.555988ms","start":"2026-10-04T13:07:31.029353Z","end":"2026-10-04T13:07:31.188909Z","steps":["trace[1379581965] 'agreement among raft nodes before linearized reading'  (duration: 159.417765ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:07:31.188853Z","caller":"traceutil/trace.go:171","msg":"trace[845441779] transaction","detail":"{read_only:false; response_revision:8902; number_of_response:1; }","duration":"218.506231ms","start":"2026-10-04T13:07:30.970286Z","end":"2026-10-04T13:07:31.188793Z","steps":["trace[845441779] 'process raft request'  (duration: 188.112849ms)","trace[845441779] 'compare'  (duration: 29.81128ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T13:07:31.188948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.798829ms","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-04T13:07:31.188973Z","caller":"traceutil/trace.go:171","msg":"trace[733741391] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8903; }","duration":"112.86036ms","start":"2026-10-04T13:07:31.076105Z","end":"2026-10-04T13:07:31.188965Z","steps":["trace[733741391] 'agreement among raft nodes before linearized reading'  (duration: 112.789499ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:07:31.188856Z","caller":"traceutil/trace.go:171","msg":"trace[135451774] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8903; }","duration":"131.608389ms","start":"2026-10-04T13:07:31.057237Z","end":"2026-10-04T13:07:31.188845Z","steps":["trace[135451774] 'agreement among raft nodes before linearized reading'  (duration: 131.473796ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:07:31.189107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.754232ms","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-04T13:07:31.189137Z","caller":"traceutil/trace.go:171","msg":"trace[890809157] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8903; }","duration":"126.827795ms","start":"2026-10-04T13:07:31.0623Z","end":"2026-10-04T13:07:31.189128Z","steps":["trace[890809157] 'agreement among raft nodes before linearized reading'  (duration: 126.749383ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:07:31.189753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.148217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-10-04T13:07:31.189954Z","caller":"traceutil/trace.go:171","msg":"trace[248638229] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8903; }","duration":"119.267809ms","start":"2026-10-04T13:07:31.070521Z","end":"2026-10-04T13:07:31.189788Z","steps":["trace[248638229] 'agreement among raft nodes before linearized reading'  (duration: 118.525213ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:07:33.447826Z","caller":"traceutil/trace.go:171","msg":"trace[766789667] transaction","detail":"{read_only:false; response_revision:8916; number_of_response:1; }","duration":"209.100987ms","start":"2026-10-04T13:07:33.238701Z","end":"2026-10-04T13:07:33.447802Z","steps":["trace[766789667] 'process raft request'  (duration: 208.930974ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:07:33.448077Z","caller":"traceutil/trace.go:171","msg":"trace[1702579603] transaction","detail":"{read_only:false; response_revision:8917; number_of_response:1; }","duration":"209.278681ms","start":"2026-10-04T13:07:33.238766Z","end":"2026-10-04T13:07:33.448044Z","steps":["trace[1702579603] 'process raft request'  (duration: 208.998415ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:07:33.448119Z","caller":"traceutil/trace.go:171","msg":"trace[1198988628] transaction","detail":"{read_only:false; response_revision:8919; number_of_response:1; }","duration":"209.226771ms","start":"2026-10-04T13:07:33.238881Z","end":"2026-10-04T13:07:33.448108Z","steps":["trace[1198988628] 'process raft request'  (duration: 209.18986ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:07:33.448239Z","caller":"traceutil/trace.go:171","msg":"trace[1445573385] transaction","detail":"{read_only:false; response_revision:8918; number_of_response:1; }","duration":"209.357554ms","start":"2026-10-04T13:07:33.238848Z","end":"2026-10-04T13:07:33.448206Z","steps":["trace[1445573385] 'process raft request'  (duration: 209.127679ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:07:40.118225Z","caller":"traceutil/trace.go:171","msg":"trace[1589399473] transaction","detail":"{read_only:false; response_revision:8954; number_of_response:1; }","duration":"149.337225ms","start":"2026-10-04T13:07:39.968865Z","end":"2026-10-04T13:07:40.118202Z","steps":["trace[1589399473] 'process raft request'  (duration: 149.212962ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:07:45.246293Z","caller":"traceutil/trace.go:171","msg":"trace[338073481] transaction","detail":"{read_only:false; response_revision:8989; number_of_response:1; }","duration":"167.315177ms","start":"2026-10-04T13:07:45.078955Z","end":"2026-10-04T13:07:45.24627Z","steps":["trace[338073481] 'process raft request'  (duration: 167.124803ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:07:45.551358Z","caller":"traceutil/trace.go:171","msg":"trace[1647318351] transaction","detail":"{read_only:false; response_revision:8990; number_of_response:1; }","duration":"456.05389ms","start":"2026-10-04T13:07:45.095284Z","end":"2026-10-04T13:07:45.551338Z","steps":["trace[1647318351] 'process raft request'  (duration: 455.925027ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:07:45.5515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:07:45.095261Z","time spent":"456.157942ms","remote":"127.0.0.1:40706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:8965 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-10-04T13:07:45.551817Z","caller":"traceutil/trace.go:171","msg":"trace[161628759] linearizableReadLoop","detail":"{readStateIndex:9311; appliedIndex:9311; }","duration":"290.838869ms","start":"2026-10-04T13:07:45.260967Z","end":"2026-10-04T13:07:45.551806Z","steps":["trace[161628759] 'read index received'  (duration: 290.834539ms)","trace[161628759] 'applied index is now lower than readState.Index'  (duration: 3.5µs)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T13:07:45.552004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.013223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-c5cbs\" ","response":"range_response_count:1 size:4650"}
{"level":"info","ts":"2026-10-04T13:07:45.552076Z","caller":"traceutil/trace.go:171","msg":"trace[318490757] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-c5cbs; range_end:; response_count:1; response_revision:8990; }","duration":"291.145537ms","start":"2026-10-04T13:07:45.260913Z","end":"2026-10-04T13:07:45.552058Z","steps":["trace[318490757] 'agreement among raft nodes before linearized reading'  (duration: 290.943332ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:07:45.557652Z","caller":"traceutil/trace.go:171","msg":"trace[477338459] transaction","detail":"{read_only:false; response_revision:8991; number_of_response:1; }","duration":"270.406653ms","start":"2026-10-04T13:07:45.28723Z","end":"2026-10-04T13:07:45.557636Z","steps":["trace[477338459] 'process raft request'  (duration: 270.2876ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:07:45.557991Z","caller":"traceutil/trace.go:171","msg":"trace[591538153] transaction","detail":"{read_only:false; response_revision:8992; number_of_response:1; }","duration":"270.319061ms","start":"2026-10-04T13:07:45.287652Z","end":"2026-10-04T13:07:45.557971Z","steps":["trace[591538153] 'process raft request'  (duration: 269.947303ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:07:45.558154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.364134ms","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-04T13:07:45.558197Z","caller":"traceutil/trace.go:171","msg":"trace[1464050730] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8992; }","duration":"243.433685ms","start":"2026-10-04T13:07:45.314753Z","end":"2026-10-04T13:07:45.558187Z","steps":["trace[1464050730] 'agreement among raft nodes before linearized reading'  (duration: 243.337734ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:07:45.558292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.366125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/topicpermissions/\" range_end:\"/registry/rabbitmq.com/topicpermissions0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-04T13:07:45.558321Z","caller":"traceutil/trace.go:171","msg":"trace[1386271532] range","detail":"{range_begin:/registry/rabbitmq.com/topicpermissions/; range_end:/registry/rabbitmq.com/topicpermissions0; response_count:0; response_revision:8992; }","duration":"121.446578ms","start":"2026-10-04T13:07:45.436866Z","end":"2026-10-04T13:07:45.558312Z","steps":["trace[1386271532] 'agreement among raft nodes before linearized reading'  (duration: 121.399416ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:08:47.780773Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"adb6690514c92321","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-10-04T13:08:47.787385Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-10-04T13:08:47.78763Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-10-04T13:10:40.380917Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8035}
{"level":"info","ts":"2026-10-04T13:10:40.459646Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8035,"took":"75.584387ms","hash":52601670,"current-db-size-bytes":56639488,"current-db-size":"57 MB","current-db-size-in-use-bytes":28180480,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-10-04T13:10:40.459716Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":52601670,"revision":8035,"compact-revision":5855}
{"level":"info","ts":"2026-10-04T13:12:54.929481Z","caller":"traceutil/trace.go:171","msg":"trace[119686812] linearizableReadLoop","detail":"{readStateIndex:12065; appliedIndex:12064; }","duration":"110.812431ms","start":"2026-10-04T13:12:54.818638Z","end":"2026-10-04T13:12:54.92945Z","steps":["trace[119686812] 'read index received'  (duration: 84.677715ms)","trace[119686812] 'applied index is now lower than readState.Index'  (duration: 26.133306ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:12:54.929551Z","caller":"traceutil/trace.go:171","msg":"trace[1304918499] transaction","detail":"{read_only:false; response_revision:11666; number_of_response:1; }","duration":"134.721428ms","start":"2026-10-04T13:12:54.79479Z","end":"2026-10-04T13:12:54.929511Z","steps":["trace[1304918499] 'process raft request'  (duration: 108.624633ms)","trace[1304918499] 'compare'  (duration: 25.907231ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T13:12:54.929698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.039226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-bwx5f\" ","response":"range_response_count:1 size:6531"}
{"level":"info","ts":"2026-10-04T13:12:54.929736Z","caller":"traceutil/trace.go:171","msg":"trace[1772711802] range","detail":"{range_begin:/registry/pods/openstack/keepalived-bwx5f; range_end:; response_count:1; response_revision:11666; }","duration":"111.127156ms","start":"2026-10-04T13:12:54.818599Z","end":"2026-10-04T13:12:54.929727Z","steps":["trace[1772711802] 'agreement among raft nodes before linearized reading'  (duration: 110.962083ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:12:58.867993Z","caller":"traceutil/trace.go:171","msg":"trace[1156814051] transaction","detail":"{read_only:false; response_revision:11683; number_of_response:1; }","duration":"138.00717ms","start":"2026-10-04T13:12:58.72996Z","end":"2026-10-04T13:12:58.867967Z","steps":["trace[1156814051] 'process raft request'  (duration: 137.835635ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:12:58.940603Z","caller":"traceutil/trace.go:171","msg":"trace[1739703698] transaction","detail":"{read_only:false; response_revision:11685; number_of_response:1; }","duration":"155.61829ms","start":"2026-10-04T13:12:58.784952Z","end":"2026-10-04T13:12:58.940571Z","steps":["trace[1739703698] 'process raft request'  (duration: 155.5621ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:12:58.94078Z","caller":"traceutil/trace.go:171","msg":"trace[421806923] transaction","detail":"{read_only:false; response_revision:11684; number_of_response:1; }","duration":"171.285869ms","start":"2026-10-04T13:12:58.769475Z","end":"2026-10-04T13:12:58.940761Z","steps":["trace[421806923] 'process raft request'  (duration: 125.308824ms)","trace[421806923] 'compare'  (duration: 45.613797ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:12:59.378981Z","caller":"traceutil/trace.go:171","msg":"trace[1484194417] transaction","detail":"{read_only:false; response_revision:11687; number_of_response:1; }","duration":"188.440182ms","start":"2026-10-04T13:12:59.190514Z","end":"2026-10-04T13:12:59.378954Z","steps":["trace[1484194417] 'process raft request'  (duration: 188.155066ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:12:59.378931Z","caller":"traceutil/trace.go:171","msg":"trace[2016117569] linearizableReadLoop","detail":"{readStateIndex:12087; appliedIndex:12086; }","duration":"102.990921ms","start":"2026-10-04T13:12:59.27591Z","end":"2026-10-04T13:12:59.378901Z","steps":["trace[2016117569] 'read index received'  (duration: 102.683974ms)","trace[2016117569] 'applied index is now lower than readState.Index'  (duration: 305.667µs)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T13:12:59.379181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.259968ms","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-04T13:12:59.379226Z","caller":"traceutil/trace.go:171","msg":"trace[22376964] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:11687; }","duration":"103.352669ms","start":"2026-10-04T13:12:59.275863Z","end":"2026-10-04T13:12:59.379216Z","steps":["trace[22376964] 'agreement among raft nodes before linearized reading'  (duration: 103.162664ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:15:40.388153Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10443}
{"level":"info","ts":"2026-10-04T13:15:40.476093Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10443,"took":"85.126702ms","hash":309342372,"current-db-size-bytes":56639488,"current-db-size":"57 MB","current-db-size-in-use-bytes":27623424,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-10-04T13:15:40.476189Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":309342372,"revision":10443,"compact-revision":8035}
{"level":"info","ts":"2026-10-04T13:18:48.910566Z","caller":"traceutil/trace.go:171","msg":"trace[1099573322] linearizableReadLoop","detail":"{readStateIndex:14554; appliedIndex:14553; }","duration":"103.177041ms","start":"2026-10-04T13:18:48.807367Z","end":"2026-10-04T13:18:48.910544Z","steps":["trace[1099573322] 'read index received'  (duration: 103.071589ms)","trace[1099573322] 'applied index is now lower than readState.Index'  (duration: 104.422µs)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:18:48.910652Z","caller":"traceutil/trace.go:171","msg":"trace[434446790] transaction","detail":"{read_only:false; response_revision:14072; number_of_response:1; }","duration":"133.999977ms","start":"2026-10-04T13:18:48.776611Z","end":"2026-10-04T13:18:48.910611Z","steps":["trace[434446790] 'process raft request'  (duration: 133.790763ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:18:48.910934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.548209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"}
{"level":"info","ts":"2026-10-04T13:18:48.911099Z","caller":"traceutil/trace.go:171","msg":"trace[1472053039] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:14072; }","duration":"103.691452ms","start":"2026-10-04T13:18:48.807352Z","end":"2026-10-04T13:18:48.911044Z","steps":["trace[1472053039] 'agreement among raft nodes before linearized reading'  (duration: 103.300813ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:19:09.151295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.44222ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2531481516851522604 > lease_revoke:<id:2321a106f766eb51>","response":"size:29"}
{"level":"warn","ts":"2026-10-04T13:19:09.556976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.318988ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2531481516851522611 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:14177 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-10-04T13:19:09.557389Z","caller":"traceutil/trace.go:171","msg":"trace[2088507363] transaction","detail":"{read_only:false; response_revision:14185; number_of_response:1; }","duration":"209.47661ms","start":"2026-10-04T13:19:09.347874Z","end":"2026-10-04T13:19:09.55735Z","steps":["trace[2088507363] 'process raft request'  (duration: 16.686131ms)","trace[2088507363] 'compare'  (duration: 192.224927ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:19:09.557441Z","caller":"traceutil/trace.go:171","msg":"trace[966055438] transaction","detail":"{read_only:false; response_revision:14186; number_of_response:1; }","duration":"209.231045ms","start":"2026-10-04T13:19:09.348191Z","end":"2026-10-04T13:19:09.557423Z","steps":["trace[966055438] 'process raft request'  (duration: 208.880608ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:19:09.744056Z","caller":"traceutil/trace.go:171","msg":"trace[671540976] transaction","detail":"{read_only:false; response_revision:14187; number_of_response:1; }","duration":"181.940134ms","start":"2026-10-04T13:19:09.562069Z","end":"2026-10-04T13:19:09.744009Z","steps":["trace[671540976] 'process raft request'  (duration: 131.001544ms)","trace[671540976] 'compare'  (duration: 50.46702ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:19:18.504093Z","caller":"traceutil/trace.go:171","msg":"trace[1284759611] transaction","detail":"{read_only:false; response_revision:14231; number_of_response:1; }","duration":"103.330435ms","start":"2026-10-04T13:19:18.400733Z","end":"2026-10-04T13:19:18.504064Z","steps":["trace[1284759611] 'process raft request'  (duration: 103.073859ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:19:18.504432Z","caller":"traceutil/trace.go:171","msg":"trace[792732656] transaction","detail":"{read_only:false; response_revision:14232; number_of_response:1; }","duration":"103.672452ms","start":"2026-10-04T13:19:18.400747Z","end":"2026-10-04T13:19:18.50442Z","steps":["trace[792732656] 'process raft request'  (duration: 103.179391ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:19:51.078459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.477798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-bwx5f\" ","response":"range_response_count:1 size:6531"}
{"level":"info","ts":"2026-10-04T13:19:51.078593Z","caller":"traceutil/trace.go:171","msg":"trace[702986343] range","detail":"{range_begin:/registry/pods/openstack/keepalived-bwx5f; range_end:; response_count:1; response_revision:14611; }","duration":"263.676943ms","start":"2026-10-04T13:19:50.814889Z","end":"2026-10-04T13:19:51.078566Z","steps":["trace[702986343] 'range keys from in-memory index tree'  (duration: 263.224923ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:19:51.078661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.952582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"}
{"level":"warn","ts":"2026-10-04T13:19:51.078675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.943222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-448ba751-52b8-4803-bf49-32255e1962bc\" ","response":"range_response_count:1 size:3637"}
{"level":"info","ts":"2026-10-04T13:19:51.078786Z","caller":"traceutil/trace.go:171","msg":"trace[283757953] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:14611; }","duration":"217.174216ms","start":"2026-10-04T13:19:50.861589Z","end":"2026-10-04T13:19:51.078763Z","steps":["trace[283757953] 'range keys from in-memory index tree'  (duration: 216.735408ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:19:51.078834Z","caller":"traceutil/trace.go:171","msg":"trace[474808002] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-448ba751-52b8-4803-bf49-32255e1962bc; range_end:; response_count:1; response_revision:14611; }","duration":"192.163535ms","start":"2026-10-04T13:19:50.886646Z","end":"2026-10-04T13:19:51.078809Z","steps":["trace[474808002] 'range keys from in-memory index tree'  (duration: 191.706775ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:19:51.22771Z","caller":"traceutil/trace.go:171","msg":"trace[1374303551] linearizableReadLoop","detail":"{readStateIndex:15118; appliedIndex:15117; }","duration":"134.665423ms","start":"2026-10-04T13:19:51.093013Z","end":"2026-10-04T13:19:51.227679Z","steps":["trace[1374303551] 'read index received'  (duration: 134.426767ms)","trace[1374303551] 'applied index is now lower than readState.Index'  (duration: 236.996µs)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:19:51.227774Z","caller":"traceutil/trace.go:171","msg":"trace[1024971757] transaction","detail":"{read_only:false; response_revision:14612; number_of_response:1; }","duration":"136.760177ms","start":"2026-10-04T13:19:51.090974Z","end":"2026-10-04T13:19:51.227735Z","steps":["trace[1024971757] 'process raft request'  (duration: 136.504001ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:19:51.228054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.00774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-12528ad2-2b7d-434e-8d09-175ee5647753\" ","response":"range_response_count:1 size:1322"}
{"level":"info","ts":"2026-10-04T13:19:51.228185Z","caller":"traceutil/trace.go:171","msg":"trace[1976867022] range","detail":"{range_begin:/registry/persistentvolumes/pvc-12528ad2-2b7d-434e-8d09-175ee5647753; range_end:; response_count:1; response_revision:14612; }","duration":"135.206813ms","start":"2026-10-04T13:19:51.092949Z","end":"2026-10-04T13:19:51.228156Z","steps":["trace[1976867022] 'agreement among raft nodes before linearized reading'  (duration: 134.874586ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:20:40.396437Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12759}
{"level":"info","ts":"2026-10-04T13:20:40.483029Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12759,"took":"82.421912ms","hash":2478361385,"current-db-size-bytes":56639488,"current-db-size":"57 MB","current-db-size-in-use-bytes":31199232,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-10-04T13:20:40.483099Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2478361385,"revision":12759,"compact-revision":10443}
{"level":"info","ts":"2026-10-04T13:21:17.146234Z","caller":"traceutil/trace.go:171","msg":"trace[1800697381] transaction","detail":"{read_only:false; response_revision:15423; number_of_response:1; }","duration":"124.251957ms","start":"2026-10-04T13:21:17.021948Z","end":"2026-10-04T13:21:17.1462Z","steps":["trace[1800697381] 'process raft request'  (duration: 124.022722ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:21:17.146427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.624362ms","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-04T13:21:17.146532Z","caller":"traceutil/trace.go:171","msg":"trace[665021586] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:15423; }","duration":"122.806256ms","start":"2026-10-04T13:21:17.023708Z","end":"2026-10-04T13:21:17.146515Z","steps":["trace[665021586] 'agreement among raft nodes before linearized reading'  (duration: 122.580672ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:21:17.14617Z","caller":"traceutil/trace.go:171","msg":"trace[668065922] linearizableReadLoop","detail":"{readStateIndex:15952; appliedIndex:15951; }","duration":"122.416367ms","start":"2026-10-04T13:21:17.023726Z","end":"2026-10-04T13:21:17.146142Z","steps":["trace[668065922] 'read index received'  (duration: 122.374656ms)","trace[668065922] 'applied index is now lower than readState.Index'  (duration: 40.451µs)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T13:21:17.165054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.404477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/objectbucket.io/objectbuckets/\" range_end:\"/registry/objectbucket.io/objectbuckets0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-04T13:21:17.165139Z","caller":"traceutil/trace.go:171","msg":"trace[889485945] range","detail":"{range_begin:/registry/objectbucket.io/objectbuckets/; range_end:/registry/objectbucket.io/objectbuckets0; response_count:0; response_revision:15425; }","duration":"134.516399ms","start":"2026-10-04T13:21:17.030601Z","end":"2026-10-04T13:21:17.165117Z","steps":["trace[889485945] 'agreement among raft nodes before linearized reading'  (duration: 134.355106ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:21:22.379605Z","caller":"traceutil/trace.go:171","msg":"trace[984128720] transaction","detail":"{read_only:false; response_revision:15449; number_of_response:1; }","duration":"136.099384ms","start":"2026-10-04T13:21:22.243477Z","end":"2026-10-04T13:21:22.379576Z","steps":["trace[984128720] 'process raft request'  (duration: 135.928439ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:21:22.443864Z","caller":"traceutil/trace.go:171","msg":"trace[668891918] transaction","detail":"{read_only:false; response_revision:15450; number_of_response:1; }","duration":"198.242077ms","start":"2026-10-04T13:21:22.245592Z","end":"2026-10-04T13:21:22.443834Z","steps":["trace[668891918] 'process raft request'  (duration: 171.239313ms)","trace[668891918] 'compare'  (duration: 26.676297ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:25:40.40729Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15229}
{"level":"info","ts":"2026-10-04T13:25:40.511004Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15229,"took":"98.793181ms","hash":3985844004,"current-db-size-bytes":56639488,"current-db-size":"57 MB","current-db-size-in-use-bytes":31764480,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-10-04T13:25:40.511076Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3985844004,"revision":15229,"compact-revision":12759}
{"level":"info","ts":"2026-10-04T13:27:06.310181Z","caller":"traceutil/trace.go:171","msg":"trace[525750924] linearizableReadLoop","detail":"{readStateIndex:18631; appliedIndex:18630; }","duration":"107.23178ms","start":"2026-10-04T13:27:06.202928Z","end":"2026-10-04T13:27:06.31016Z","steps":["trace[525750924] 'read index received'  (duration: 61.991266ms)","trace[525750924] 'applied index is now lower than readState.Index'  (duration: 45.239064ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:27:06.310281Z","caller":"traceutil/trace.go:171","msg":"trace[996546881] transaction","detail":"{read_only:false; response_revision:18016; number_of_response:1; }","duration":"109.798245ms","start":"2026-10-04T13:27:06.200468Z","end":"2026-10-04T13:27:06.310266Z","steps":["trace[996546881] 'process raft request'  (duration: 109.197413ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:27:06.310414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.478495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:19421"}
{"level":"info","ts":"2026-10-04T13:27:06.310473Z","caller":"traceutil/trace.go:171","msg":"trace[1376422208] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:18016; }","duration":"107.559667ms","start":"2026-10-04T13:27:06.202899Z","end":"2026-10-04T13:27:06.310459Z","steps":["trace[1376422208] 'agreement among raft nodes before linearized reading'  (duration: 107.432425ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:27:12.600226Z","caller":"traceutil/trace.go:171","msg":"trace[1109450759] linearizableReadLoop","detail":"{readStateIndex:18667; appliedIndex:18666; }","duration":"200.396298ms","start":"2026-10-04T13:27:12.399817Z","end":"2026-10-04T13:27:12.600213Z","steps":["trace[1109450759] 'read index received'  (duration: 200.276825ms)","trace[1109450759] 'applied index is now lower than readState.Index'  (duration: 118.783µs)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T13:27:12.600392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.572922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-5j4n8\" ","response":"range_response_count:1 size:22133"}
{"level":"info","ts":"2026-10-04T13:27:12.600417Z","caller":"traceutil/trace.go:171","msg":"trace[505513865] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-5j4n8; range_end:; response_count:1; response_revision:18051; }","duration":"200.609462ms","start":"2026-10-04T13:27:12.399801Z","end":"2026-10-04T13:27:12.600411Z","steps":["trace[505513865] 'agreement among raft nodes before linearized reading'  (duration: 200.470819ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:27:12.600606Z","caller":"traceutil/trace.go:171","msg":"trace[1005891355] transaction","detail":"{read_only:false; response_revision:18051; number_of_response:1; }","duration":"215.602396ms","start":"2026-10-04T13:27:12.384997Z","end":"2026-10-04T13:27:12.600599Z","steps":["trace[1005891355] 'process raft request'  (duration: 215.130636ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:27:13.099673Z","caller":"traceutil/trace.go:171","msg":"trace[1504336770] transaction","detail":"{read_only:false; response_revision:18056; number_of_response:1; }","duration":"125.129516ms","start":"2026-10-04T13:27:12.974521Z","end":"2026-10-04T13:27:13.09965Z","steps":["trace[1504336770] 'process raft request'  (duration: 125.015354ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:27:13.456259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.678234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterbackups/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterbackups0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-04T13:27:13.4564Z","caller":"traceutil/trace.go:171","msg":"trace[1245374400] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterbackups/; range_end:/registry/pxc.percona.com/perconaxtradbclusterbackups0; response_count:0; response_revision:18056; }","duration":"277.877649ms","start":"2026-10-04T13:27:13.178495Z","end":"2026-10-04T13:27:13.456373Z","steps":["trace[1245374400] 'count revisions from in-memory index tree'  (duration: 277.562001ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:29:37.914131Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"adb6690514c92321","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-10-04T13:29:37.922286Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-10-04T13:29:37.922393Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-10-04T13:30:40.416106Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17427}
{"level":"info","ts":"2026-10-04T13:30:40.513108Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17427,"took":"94.818503ms","hash":1064248439,"current-db-size-bytes":56639488,"current-db-size":"57 MB","current-db-size-in-use-bytes":34545664,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-10-04T13:30:40.513171Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1064248439,"revision":17427,"compact-revision":15229}
{"level":"warn","ts":"2026-10-04T13:32:38.691636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.817525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-04T13:32:38.691731Z","caller":"traceutil/trace.go:171","msg":"trace[2017309989] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:20629; }","duration":"223.976419ms","start":"2026-10-04T13:32:38.467735Z","end":"2026-10-04T13:32:38.691712Z","steps":["trace[2017309989] 'range keys from in-memory index tree'  (duration: 223.709515ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:32:55.844525Z","caller":"traceutil/trace.go:171","msg":"trace[466424031] transaction","detail":"{read_only:false; response_revision:20713; number_of_response:1; }","duration":"231.4217ms","start":"2026-10-04T13:32:55.613073Z","end":"2026-10-04T13:32:55.844495Z","steps":["trace[466424031] 'process raft request'  (duration: 167.332431ms)","trace[466424031] 'compare'  (duration: 63.949146ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:35:40.427077Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19791}
{"level":"info","ts":"2026-10-04T13:35:40.554848Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19791,"took":"122.79165ms","hash":4001841871,"current-db-size-bytes":56639488,"current-db-size":"57 MB","current-db-size-in-use-bytes":30232576,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-10-04T13:35:40.554927Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4001841871,"revision":19791,"compact-revision":17427}
{"level":"info","ts":"2026-10-04T13:40:09.065504Z","caller":"traceutil/trace.go:171","msg":"trace[1663902304] linearizableReadLoop","detail":"{readStateIndex:26039; appliedIndex:26038; }","duration":"217.229472ms","start":"2026-10-04T13:40:08.848247Z","end":"2026-10-04T13:40:09.065476Z","steps":["trace[1663902304] 'read index received'  (duration: 217.056497ms)","trace[1663902304] 'applied index is now lower than readState.Index'  (duration: 171.365µs)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:40:09.065559Z","caller":"traceutil/trace.go:171","msg":"trace[126355135] transaction","detail":"{read_only:false; response_revision:25208; number_of_response:1; }","duration":"276.151147ms","start":"2026-10-04T13:40:08.78938Z","end":"2026-10-04T13:40:09.065531Z","steps":["trace[126355135] 'process raft request'  (duration: 275.940833ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:40:09.065706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.421485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-04T13:40:09.065801Z","caller":"traceutil/trace.go:171","msg":"trace[1618284691] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0; response_count:0; response_revision:25208; }","duration":"217.565648ms","start":"2026-10-04T13:40:08.848212Z","end":"2026-10-04T13:40:09.065778Z","steps":["trace[1618284691] 'agreement among raft nodes before linearized reading'  (duration: 217.378594ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:40:09.170847Z","caller":"traceutil/trace.go:171","msg":"trace[2138911895] linearizableReadLoop","detail":"{readStateIndex:26040; appliedIndex:26039; }","duration":"105.243983ms","start":"2026-10-04T13:40:09.06558Z","end":"2026-10-04T13:40:09.170824Z","steps":["trace[2138911895] 'read index received'  (duration: 17.437575ms)","trace[2138911895] 'applied index is now lower than readState.Index'  (duration: 87.804918ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T13:40:09.171333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.717688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/ingress-nginx/ingress-nginx-controller-wjsz9.18db54a774f9c30d\" ","response":"range_response_count:1 size:767"}
{"level":"info","ts":"2026-10-04T13:40:09.17138Z","caller":"traceutil/trace.go:171","msg":"trace[2027749523] range","detail":"{range_begin:/registry/events/ingress-nginx/ingress-nginx-controller-wjsz9.18db54a774f9c30d; range_end:; response_count:1; response_revision:25208; }","duration":"175.80273ms","start":"2026-10-04T13:40:08.995563Z","end":"2026-10-04T13:40:09.171366Z","steps":["trace[2027749523] 'agreement among raft nodes before linearized reading'  (duration: 175.645266ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:40:09.171597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.213668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"info","ts":"2026-10-04T13:40:09.171638Z","caller":"traceutil/trace.go:171","msg":"trace[38153409] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25208; }","duration":"242.275139ms","start":"2026-10-04T13:40:08.929353Z","end":"2026-10-04T13:40:09.171628Z","steps":["trace[38153409] 'agreement among raft nodes before linearized reading'  (duration: 242.182037ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:40:09.171831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.412857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2083"}
{"level":"info","ts":"2026-10-04T13:40:09.171869Z","caller":"traceutil/trace.go:171","msg":"trace[358373976] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:25208; }","duration":"318.461818ms","start":"2026-10-04T13:40:08.853396Z","end":"2026-10-04T13:40:09.171858Z","steps":["trace[358373976] 'agreement among raft nodes before linearized reading'  (duration: 318.369726ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:40:09.1719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:40:08.853389Z","time spent":"318.503018ms","remote":"127.0.0.1:40582","response type":"/etcdserverpb.KV/Range","request count":0,"request size":139,"response count":1,"response size":2107,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" "}
{"level":"warn","ts":"2026-10-04T13:40:09.352103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.599547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-3025c04f-55b0-466c-9445-f366c85fbae3\" ","response":"range_response_count:1 size:1436"}
{"level":"info","ts":"2026-10-04T13:40:09.352198Z","caller":"traceutil/trace.go:171","msg":"trace[166241406] range","detail":"{range_begin:/registry/persistentvolumes/pvc-3025c04f-55b0-466c-9445-f366c85fbae3; range_end:; response_count:1; response_revision:25209; }","duration":"176.755401ms","start":"2026-10-04T13:40:09.175429Z","end":"2026-10-04T13:40:09.352184Z","steps":["trace[166241406] 'agreement among raft nodes before linearized reading'  (duration: 176.529336ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:40:09.351903Z","caller":"traceutil/trace.go:171","msg":"trace[810716086] transaction","detail":"{read_only:false; response_revision:25209; number_of_response:1; }","duration":"177.25558ms","start":"2026-10-04T13:40:09.174626Z","end":"2026-10-04T13:40:09.351882Z","steps":["trace[810716086] 'process raft request'  (duration: 177.008385ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:40:09.351826Z","caller":"traceutil/trace.go:171","msg":"trace[811442717] linearizableReadLoop","detail":"{readStateIndex:26041; appliedIndex:26040; }","duration":"176.31594ms","start":"2026-10-04T13:40:09.175484Z","end":"2026-10-04T13:40:09.3518Z","steps":["trace[811442717] 'read index received'  (duration: 176.098256ms)","trace[811442717] 'applied index is now lower than readState.Index'  (duration: 216.714µs)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:40:09.353404Z","caller":"traceutil/trace.go:171","msg":"trace[1648138044] transaction","detail":"{read_only:false; response_revision:25210; number_of_response:1; }","duration":"176.665489ms","start":"2026-10-04T13:40:09.176715Z","end":"2026-10-04T13:40:09.35338Z","steps":["trace[1648138044] 'process raft request'  (duration: 176.526475ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:40:14.604636Z","caller":"traceutil/trace.go:171","msg":"trace[1427154059] transaction","detail":"{read_only:false; response_revision:25255; number_of_response:1; }","duration":"109.979314ms","start":"2026-10-04T13:40:14.494631Z","end":"2026-10-04T13:40:14.604611Z","steps":["trace[1427154059] 'process raft request'  (duration: 109.7855ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:40:14.605422Z","caller":"traceutil/trace.go:171","msg":"trace[1768010181] linearizableReadLoop","detail":"{readStateIndex:26090; appliedIndex:26087; }","duration":"108.301618ms","start":"2026-10-04T13:40:14.49711Z","end":"2026-10-04T13:40:14.605412Z","steps":["trace[1768010181] 'read index received'  (duration: 107.313108ms)","trace[1768010181] 'applied index is now lower than readState.Index'  (duration: 987.83µs)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T13:40:14.60557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.445422ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"}
{"level":"info","ts":"2026-10-04T13:40:14.605597Z","caller":"traceutil/trace.go:171","msg":"trace[1331995710] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25257; }","duration":"108.507753ms","start":"2026-10-04T13:40:14.497083Z","end":"2026-10-04T13:40:14.60559Z","steps":["trace[1331995710] 'agreement among raft nodes before linearized reading'  (duration: 108.368899ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:40:14.60572Z","caller":"traceutil/trace.go:171","msg":"trace[690095604] transaction","detail":"{read_only:false; response_revision:25257; number_of_response:1; }","duration":"108.639866ms","start":"2026-10-04T13:40:14.497073Z","end":"2026-10-04T13:40:14.605713Z","steps":["trace[690095604] 'process raft request'  (duration: 108.311719ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:40:14.605745Z","caller":"traceutil/trace.go:171","msg":"trace[812627618] transaction","detail":"{read_only:false; response_revision:25256; number_of_response:1; }","duration":"110.517636ms","start":"2026-10-04T13:40:14.495207Z","end":"2026-10-04T13:40:14.605724Z","steps":["trace[812627618] 'process raft request'  (duration: 110.136558ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:40:19.812909Z","caller":"traceutil/trace.go:171","msg":"trace[1455346275] transaction","detail":"{read_only:false; response_revision:25299; number_of_response:1; }","duration":"179.346316ms","start":"2026-10-04T13:40:19.633541Z","end":"2026-10-04T13:40:19.812887Z","steps":["trace[1455346275] 'process raft request'  (duration: 179.131191ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:40:20.050746Z","caller":"traceutil/trace.go:171","msg":"trace[1406858205] linearizableReadLoop","detail":"{readStateIndex:26135; appliedIndex:26132; }","duration":"328.933562ms","start":"2026-10-04T13:40:19.721749Z","end":"2026-10-04T13:40:20.050682Z","steps":["trace[1406858205] 'read index received'  (duration: 90.970085ms)","trace[1406858205] 'applied index is now lower than readState.Index'  (duration: 237.957716ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:40:20.050931Z","caller":"traceutil/trace.go:171","msg":"trace[1066780933] transaction","detail":"{read_only:false; response_revision:25301; number_of_response:1; }","duration":"337.25036ms","start":"2026-10-04T13:40:19.713615Z","end":"2026-10-04T13:40:20.050866Z","steps":["trace[1066780933] 'process raft request'  (duration: 336.938724ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:40:20.051006Z","caller":"traceutil/trace.go:171","msg":"trace[1816914201] transaction","detail":"{read_only:false; response_revision:25300; number_of_response:1; }","duration":"339.820936ms","start":"2026-10-04T13:40:19.711163Z","end":"2026-10-04T13:40:20.050984Z","steps":["trace[1816914201] 'process raft request'  (duration: 266.807477ms)","trace[1816914201] 'compare'  (duration: 72.245423ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T13:40:20.051037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:357"}
{"level":"info","ts":"2026-10-04T13:40:20.051086Z","caller":"traceutil/trace.go:171","msg":"trace[691217543] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:25301; }","duration":"329.359081ms","start":"2026-10-04T13:40:19.721712Z","end":"2026-10-04T13:40:20.051071Z","steps":["trace[691217543] 'agreement among raft nodes before linearized reading'  (duration: 329.172257ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:40:20.051111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:40:19.711119Z","time spent":"339.92628ms","remote":"127.0.0.1:40706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:25285 > 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-04T13:40:20.051111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:40:19.713601Z","time spent":"337.419635ms","remote":"127.0.0.1:40706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:25286 > 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-04T13:40:20.051162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:40:19.721699Z","time spent":"329.426233ms","remote":"127.0.0.1:40546","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":381,"request content":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" "}
{"level":"info","ts":"2026-10-04T13:40:20.296758Z","caller":"traceutil/trace.go:171","msg":"trace[118209696] transaction","detail":"{read_only:false; response_revision:25304; number_of_response:1; }","duration":"164.406225ms","start":"2026-10-04T13:40:20.132326Z","end":"2026-10-04T13:40:20.296732Z","steps":["trace[118209696] 'process raft request'  (duration: 145.696963ms)","trace[118209696] 'compare'  (duration: 18.498368ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:40:20.703105Z","caller":"traceutil/trace.go:171","msg":"trace[6642934] linearizableReadLoop","detail":"{readStateIndex:26139; appliedIndex:26138; }","duration":"277.778742ms","start":"2026-10-04T13:40:20.425303Z","end":"2026-10-04T13:40:20.703082Z","steps":["trace[6642934] 'read index received'  (duration: 277.71591ms)","trace[6642934] 'applied index is now lower than readState.Index'  (duration: 61.292µs)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:40:20.703412Z","caller":"traceutil/trace.go:171","msg":"trace[1989047524] transaction","detail":"{read_only:false; response_revision:25305; number_of_response:1; }","duration":"401.927763ms","start":"2026-10-04T13:40:20.30146Z","end":"2026-10-04T13:40:20.703388Z","steps":["trace[1989047524] 'process raft request'  (duration: 401.479133ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:40:20.703464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.12524ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/policies/\" range_end:\"/registry/rabbitmq.com/policies0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-04T13:40:20.703557Z","caller":"traceutil/trace.go:171","msg":"trace[212338716] range","detail":"{range_begin:/registry/rabbitmq.com/policies/; range_end:/registry/rabbitmq.com/policies0; response_count:0; response_revision:25305; }","duration":"278.279822ms","start":"2026-10-04T13:40:20.425257Z","end":"2026-10-04T13:40:20.703537Z","steps":["trace[212338716] 'agreement among raft nodes before linearized reading'  (duration: 278.066328ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:40:20.703563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:40:20.301439Z","time spent":"402.033854ms","remote":"127.0.0.1:40706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":515,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/cert-manager/cert-manager-controller\" mod_revision:25081 > success:<request_put:<key:\"/registry/leases/cert-manager/cert-manager-controller\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/cert-manager/cert-manager-controller\" > >"}
{"level":"info","ts":"2026-10-04T13:40:20.748776Z","caller":"traceutil/trace.go:171","msg":"trace[489425884] transaction","detail":"{read_only:false; response_revision:25306; number_of_response:1; }","duration":"121.653446ms","start":"2026-10-04T13:40:20.627097Z","end":"2026-10-04T13:40:20.74875Z","steps":["trace[489425884] 'process raft request'  (duration: 121.461172ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:40:20.749072Z","caller":"traceutil/trace.go:171","msg":"trace[310495922] transaction","detail":"{read_only:false; response_revision:25307; number_of_response:1; }","duration":"121.498262ms","start":"2026-10-04T13:40:20.627553Z","end":"2026-10-04T13:40:20.749051Z","steps":["trace[310495922] 'process raft request'  (duration: 121.138005ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:40:20.749239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.410803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-04T13:40:20.749338Z","caller":"traceutil/trace.go:171","msg":"trace[1683382868] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25308; }","duration":"283.564827ms","start":"2026-10-04T13:40:20.46575Z","end":"2026-10-04T13:40:20.749315Z","steps":["trace[1683382868] 'agreement among raft nodes before linearized reading'  (duration: 283.360003ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:40:20.74955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.484371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"}
{"level":"info","ts":"2026-10-04T13:40:20.749598Z","caller":"traceutil/trace.go:171","msg":"trace[1438649607] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25308; }","duration":"106.564811ms","start":"2026-10-04T13:40:20.643022Z","end":"2026-10-04T13:40:20.749587Z","steps":["trace[1438649607] 'agreement among raft nodes before linearized reading'  (duration: 106.419947ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:40:20.749694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.594014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-10-04T13:40:20.749785Z","caller":"traceutil/trace.go:171","msg":"trace[1248277230] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25308; }","duration":"115.711058ms","start":"2026-10-04T13:40:20.634059Z","end":"2026-10-04T13:40:20.74977Z","steps":["trace[1248277230] 'agreement among raft nodes before linearized reading'  (duration: 115.515984ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:40:20.877883Z","caller":"traceutil/trace.go:171","msg":"trace[1296883235] transaction","detail":"{read_only:false; response_revision:25309; number_of_response:1; }","duration":"123.764181ms","start":"2026-10-04T13:40:20.754094Z","end":"2026-10-04T13:40:20.877858Z","steps":["trace[1296883235] 'process raft request'  (duration: 122.072754ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:40:20.882994Z","caller":"traceutil/trace.go:171","msg":"trace[1647661432] transaction","detail":"{read_only:false; response_revision:25310; number_of_response:1; }","duration":"127.946111ms","start":"2026-10-04T13:40:20.754995Z","end":"2026-10-04T13:40:20.882941Z","steps":["trace[1647661432] 'process raft request'  (duration: 127.653365ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:40:25.246812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.707727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-04T13:40:25.246911Z","caller":"traceutil/trace.go:171","msg":"trace[190902597] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0; response_count:0; response_revision:25340; }","duration":"121.84888ms","start":"2026-10-04T13:40:25.125034Z","end":"2026-10-04T13:40:25.246882Z","steps":["trace[190902597] 'range keys from in-memory index tree'  (duration: 121.600044ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:40:25.573411Z","caller":"traceutil/trace.go:171","msg":"trace[261390779] linearizableReadLoop","detail":"{readStateIndex:26176; appliedIndex:26175; }","duration":"116.135927ms","start":"2026-10-04T13:40:25.45725Z","end":"2026-10-04T13:40:25.573386Z","steps":["trace[261390779] 'read index received'  (duration: 115.85145ms)","trace[261390779] 'applied index is now lower than readState.Index'  (duration: 283.367µs)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:40:25.573452Z","caller":"traceutil/trace.go:171","msg":"trace[272443696] transaction","detail":"{read_only:false; response_revision:25341; number_of_response:1; }","duration":"129.971575ms","start":"2026-10-04T13:40:25.443459Z","end":"2026-10-04T13:40:25.57343Z","steps":["trace[272443696] 'process raft request'  (duration: 129.75682ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:40:25.573574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.3026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-04T13:40:25.573633Z","caller":"traceutil/trace.go:171","msg":"trace[210391457] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:25341; }","duration":"116.400352ms","start":"2026-10-04T13:40:25.457204Z","end":"2026-10-04T13:40:25.573604Z","steps":["trace[210391457] 'agreement among raft nodes before linearized reading'  (duration: 116.31227ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:40:25.573646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.078586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-04T13:40:25.573693Z","caller":"traceutil/trace.go:171","msg":"trace[1310245754] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25341; }","duration":"109.128797ms","start":"2026-10-04T13:40:25.464551Z","end":"2026-10-04T13:40:25.57368Z","steps":["trace[1310245754] 'agreement among raft nodes before linearized reading'  (duration: 109.051705ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:40:25.923594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.389618ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2531481516851557304 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:25328 > 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:18"}
{"level":"info","ts":"2026-10-04T13:40:25.923726Z","caller":"traceutil/trace.go:171","msg":"trace[1608240939] transaction","detail":"{read_only:false; response_revision:25342; number_of_response:1; }","duration":"313.624324ms","start":"2026-10-04T13:40:25.610063Z","end":"2026-10-04T13:40:25.923688Z","steps":["trace[1608240939] 'process raft request'  (duration: 153.049921ms)","trace[1608240939] 'compare'  (duration: 159.890778ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:40:25.9238Z","caller":"traceutil/trace.go:171","msg":"trace[370942303] linearizableReadLoop","detail":"{readStateIndex:26177; appliedIndex:26176; }","duration":"124.826964ms","start":"2026-10-04T13:40:25.798943Z","end":"2026-10-04T13:40:25.92377Z","steps":["trace[370942303] 'read index received'  (duration: 52.881µs)","trace[370942303] 'applied index is now lower than readState.Index'  (duration: 124.770153ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T13:40:25.923915Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:40:25.610048Z","time spent":"313.767796ms","remote":"127.0.0.1:40706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:25328 > 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-04T13:40:25.924046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.08857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/cert-manager/cert-manager-cainjector\" ","response":"range_response_count:1 size:987"}
{"level":"info","ts":"2026-10-04T13:40:25.924169Z","caller":"traceutil/trace.go:171","msg":"trace[1316295699] range","detail":"{range_begin:/registry/serviceaccounts/cert-manager/cert-manager-cainjector; range_end:; response_count:1; response_revision:25343; }","duration":"125.188392ms","start":"2026-10-04T13:40:25.798899Z","end":"2026-10-04T13:40:25.924087Z","steps":["trace[1316295699] 'agreement among raft nodes before linearized reading'  (duration: 124.965277ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:40:26.278576Z","caller":"traceutil/trace.go:171","msg":"trace[1052547022] transaction","detail":"{read_only:false; response_revision:25344; number_of_response:1; }","duration":"208.604065ms","start":"2026-10-04T13:40:26.069953Z","end":"2026-10-04T13:40:26.278557Z","steps":["trace[1052547022] 'process raft request'  (duration: 208.498422ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:40:26.558808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.129398ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2531481516851557309 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:25332 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-04T13:40:26.559039Z","caller":"traceutil/trace.go:171","msg":"trace[978425528] linearizableReadLoop","detail":"{readStateIndex:26180; appliedIndex:26178; }","duration":"412.160602ms","start":"2026-10-04T13:40:26.146861Z","end":"2026-10-04T13:40:26.559021Z","steps":["trace[978425528] 'read index received'  (duration: 131.602529ms)","trace[978425528] 'applied index is now lower than readState.Index'  (duration: 280.556953ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:40:26.559147Z","caller":"traceutil/trace.go:171","msg":"trace[1617708318] transaction","detail":"{read_only:false; response_revision:25346; number_of_response:1; }","duration":"410.414644ms","start":"2026-10-04T13:40:26.148683Z","end":"2026-10-04T13:40:26.559098Z","steps":["trace[1617708318] 'process raft request'  (duration: 410.23402ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:40:26.559266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.409568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"warn","ts":"2026-10-04T13:40:26.559282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:40:26.148666Z","time spent":"410.543848ms","remote":"127.0.0.1:40706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":496,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:25333 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:440 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"info","ts":"2026-10-04T13:40:26.559309Z","caller":"traceutil/trace.go:171","msg":"trace[1017864964] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25346; }","duration":"412.48784ms","start":"2026-10-04T13:40:26.14681Z","end":"2026-10-04T13:40:26.559298Z","steps":["trace[1017864964] 'agreement among raft nodes before linearized reading'  (duration: 412.311626ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:40:26.559341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:40:26.14679Z","time spent":"412.54254ms","remote":"127.0.0.1:40706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-10-04T13:40:26.559325Z","caller":"traceutil/trace.go:171","msg":"trace[206439520] transaction","detail":"{read_only:false; response_revision:25345; number_of_response:1; }","duration":"486.247895ms","start":"2026-10-04T13:40:26.073037Z","end":"2026-10-04T13:40:26.559285Z","steps":["trace[206439520] 'process raft request'  (duration: 315.506603ms)","trace[206439520] 'compare'  (duration: 169.892533ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T13:40:26.559415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.911517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/scrapeconfigs/\" range_end:\"/registry/monitoring.coreos.com/scrapeconfigs0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-04T13:40:26.559491Z","caller":"traceutil/trace.go:171","msg":"trace[251913642] range","detail":"{range_begin:/registry/monitoring.coreos.com/scrapeconfigs/; range_end:/registry/monitoring.coreos.com/scrapeconfigs0; response_count:0; response_revision:25346; }","duration":"366.020269ms","start":"2026-10-04T13:40:26.193451Z","end":"2026-10-04T13:40:26.559471Z","steps":["trace[251913642] 'agreement among raft nodes before linearized reading'  (duration: 365.902916ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:40:26.559491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:40:26.073012Z","time spent":"486.385618ms","remote":"127.0.0.1:40706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:25332 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-10-04T13:40:26.559533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:40:26.193437Z","time spent":"366.086851ms","remote":"127.0.0.1:53610","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":30,"request content":"key:\"/registry/monitoring.coreos.com/scrapeconfigs/\" range_end:\"/registry/monitoring.coreos.com/scrapeconfigs0\" count_only:true "}
{"level":"warn","ts":"2026-10-04T13:40:26.55973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.22513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"}
{"level":"info","ts":"2026-10-04T13:40:26.559782Z","caller":"traceutil/trace.go:171","msg":"trace[840413246] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25346; }","duration":"243.306312ms","start":"2026-10-04T13:40:26.316462Z","end":"2026-10-04T13:40:26.559768Z","steps":["trace[840413246] 'agreement among raft nodes before linearized reading'  (duration: 243.137088ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:40:26.90928Z","caller":"traceutil/trace.go:171","msg":"trace[270075313] transaction","detail":"{read_only:false; response_revision:25349; number_of_response:1; }","duration":"142.431152ms","start":"2026-10-04T13:40:26.766828Z","end":"2026-10-04T13:40:26.909259Z","steps":["trace[270075313] 'process raft request'  (duration: 142.32862ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:40:27.098456Z","caller":"traceutil/trace.go:171","msg":"trace[1473775607] transaction","detail":"{read_only:false; response_revision:25350; number_of_response:1; }","duration":"327.410309ms","start":"2026-10-04T13:40:26.771022Z","end":"2026-10-04T13:40:27.098433Z","steps":["trace[1473775607] 'process raft request'  (duration: 303.582447ms)","trace[1473775607] 'compare'  (duration: 23.318521ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:40:27.098828Z","caller":"traceutil/trace.go:171","msg":"trace[501613776] linearizableReadLoop","detail":"{readStateIndex:26186; appliedIndex:26184; }","duration":"279.199134ms","start":"2026-10-04T13:40:26.819599Z","end":"2026-10-04T13:40:27.098798Z","steps":["trace[501613776] 'read index received'  (duration: 89.659878ms)","trace[501613776] 'applied index is now lower than readState.Index'  (duration: 189.536956ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:40:27.098905Z","caller":"traceutil/trace.go:171","msg":"trace[201165700] transaction","detail":"{read_only:false; response_revision:25351; number_of_response:1; }","duration":"325.027239ms","start":"2026-10-04T13:40:26.773837Z","end":"2026-10-04T13:40:27.098865Z","steps":["trace[201165700] 'process raft request'  (duration: 324.556368ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:40:27.098619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:40:26.770994Z","time spent":"327.539543ms","remote":"127.0.0.1:40706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:25337 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >"}
{"level":"warn","ts":"2026-10-04T13:40:27.099032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:40:26.773825Z","time spent":"325.134431ms","remote":"127.0.0.1:40706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:25338 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:507 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-10-04T13:40:27.099038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.423889ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/cert-manager/cert-manager\" ","response":"range_response_count:1 size:969"}
{"level":"info","ts":"2026-10-04T13:40:27.099111Z","caller":"traceutil/trace.go:171","msg":"trace[1481530384] range","detail":"{range_begin:/registry/serviceaccounts/cert-manager/cert-manager; range_end:; response_count:1; response_revision:25351; }","duration":"279.51893ms","start":"2026-10-04T13:40:26.819559Z","end":"2026-10-04T13:40:27.099077Z","steps":["trace[1481530384] 'agreement among raft nodes before linearized reading'  (duration: 279.330666ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:40:27.09912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.911519ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"warn","ts":"2026-10-04T13:40:27.099117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.778066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"}
{"level":"info","ts":"2026-10-04T13:40:27.099191Z","caller":"traceutil/trace.go:171","msg":"trace[589049999] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25351; }","duration":"187.053242ms","start":"2026-10-04T13:40:26.912125Z","end":"2026-10-04T13:40:27.099178Z","steps":["trace[589049999] 'agreement among raft nodes before linearized reading'  (duration: 186.840387ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:40:27.099212Z","caller":"traceutil/trace.go:171","msg":"trace[1024895779] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25351; }","duration":"186.901318ms","start":"2026-10-04T13:40:26.912296Z","end":"2026-10-04T13:40:27.099197Z","steps":["trace[1024895779] 'agreement among raft nodes before linearized reading'  (duration: 186.683154ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:40:27.234503Z","caller":"traceutil/trace.go:171","msg":"trace[2127423120] transaction","detail":"{read_only:false; response_revision:25352; number_of_response:1; }","duration":"131.099538ms","start":"2026-10-04T13:40:27.103366Z","end":"2026-10-04T13:40:27.234465Z","steps":["trace[2127423120] 'process raft request'  (duration: 117.407114ms)","trace[2127423120] 'compare'  (duration: 13.448879ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:40:27.523355Z","caller":"traceutil/trace.go:171","msg":"trace[951995995] transaction","detail":"{read_only:false; response_revision:25353; number_of_response:1; }","duration":"419.747535ms","start":"2026-10-04T13:40:27.103565Z","end":"2026-10-04T13:40:27.523312Z","steps":["trace[951995995] 'process raft request'  (duration: 344.691001ms)","trace[951995995] 'compare'  (duration: 74.686716ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:40:27.523461Z","caller":"traceutil/trace.go:171","msg":"trace[1034370461] transaction","detail":"{read_only:false; response_revision:25354; number_of_response:1; }","duration":"419.870818ms","start":"2026-10-04T13:40:27.103557Z","end":"2026-10-04T13:40:27.523428Z","steps":["trace[1034370461] 'process raft request'  (duration: 419.625062ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:40:27.523533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:40:27.103547Z","time spent":"419.896548ms","remote":"127.0.0.1:40706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:25340 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-10-04T13:40:27.523543Z","caller":"traceutil/trace.go:171","msg":"trace[1246904361] transaction","detail":"{read_only:false; response_revision:25355; number_of_response:1; }","duration":"391.275932ms","start":"2026-10-04T13:40:27.13225Z","end":"2026-10-04T13:40:27.523526Z","steps":["trace[1246904361] 'process raft request'  (duration: 391.025817ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:40:27.523639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:40:27.132223Z","time spent":"391.365595ms","remote":"127.0.0.1:40706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:25280 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:599 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-10-04T13:40:27.523642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:40:27.103537Z","time spent":"420.004361ms","remote":"127.0.0.1:40706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":627,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" mod_revision:25316 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" value_size:518 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" > >"}
{"level":"info","ts":"2026-10-04T13:40:27.764388Z","caller":"traceutil/trace.go:171","msg":"trace[1115408630] transaction","detail":"{read_only:false; response_revision:25356; number_of_response:1; }","duration":"182.31232ms","start":"2026-10-04T13:40:27.582008Z","end":"2026-10-04T13:40:27.76432Z","steps":["trace[1115408630] 'process raft request'  (duration: 91.977517ms)","trace[1115408630] 'compare'  (duration: 90.19269ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T13:40:28.110905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.960635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"}
{"level":"info","ts":"2026-10-04T13:40:28.110984Z","caller":"traceutil/trace.go:171","msg":"trace[2082022119] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25356; }","duration":"184.074548ms","start":"2026-10-04T13:40:27.926888Z","end":"2026-10-04T13:40:28.110963Z","steps":["trace[2082022119] 'range keys from in-memory index tree'  (duration: 183.821373ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:40:28.111397Z","caller":"traceutil/trace.go:171","msg":"trace[293526432] transaction","detail":"{read_only:false; response_revision:25357; number_of_response:1; }","duration":"183.009166ms","start":"2026-10-04T13:40:27.928359Z","end":"2026-10-04T13:40:28.111368Z","steps":["trace[293526432] 'process raft request'  (duration: 116.823873ms)","trace[293526432] 'compare'  (duration: 66.067501ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T13:40:28.392898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.385559ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2531481516851557340 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:25342 > 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:18"}
{"level":"info","ts":"2026-10-04T13:40:28.393019Z","caller":"traceutil/trace.go:171","msg":"trace[1628679119] transaction","detail":"{read_only:false; response_revision:25358; number_of_response:1; }","duration":"276.910444ms","start":"2026-10-04T13:40:28.116076Z","end":"2026-10-04T13:40:28.392986Z","steps":["trace[1628679119] 'process raft request'  (duration: 115.3549ms)","trace[1628679119] 'compare'  (duration: 161.139145ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:40:28.395707Z","caller":"traceutil/trace.go:171","msg":"trace[1390541612] transaction","detail":"{read_only:false; response_revision:25359; number_of_response:1; }","duration":"112.642503ms","start":"2026-10-04T13:40:28.283048Z","end":"2026-10-04T13:40:28.39569Z","steps":["trace[1390541612] 'process raft request'  (duration: 112.54809ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:40:28.76435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.11132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-04T13:40:28.764431Z","caller":"traceutil/trace.go:171","msg":"trace[1158102381] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:25359; }","duration":"265.278034ms","start":"2026-10-04T13:40:28.499132Z","end":"2026-10-04T13:40:28.76441Z","steps":["trace[1158102381] 'count revisions from in-memory index tree'  (duration: 264.996078ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:40:28.797907Z","caller":"traceutil/trace.go:171","msg":"trace[1112083997] transaction","detail":"{read_only:false; response_revision:25360; number_of_response:1; }","duration":"234.38194ms","start":"2026-10-04T13:40:28.563496Z","end":"2026-10-04T13:40:28.797878Z","steps":["trace[1112083997] 'process raft request'  (duration: 234.206496ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:40:28.840401Z","caller":"traceutil/trace.go:171","msg":"trace[1230283230] linearizableReadLoop","detail":"{readStateIndex:26196; appliedIndex:26194; }","duration":"262.498713ms","start":"2026-10-04T13:40:28.577878Z","end":"2026-10-04T13:40:28.840377Z","steps":["trace[1230283230] 'read index received'  (duration: 219.832546ms)","trace[1230283230] 'applied index is now lower than readState.Index'  (duration: 42.665097ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:40:28.840505Z","caller":"traceutil/trace.go:171","msg":"trace[131456162] transaction","detail":"{read_only:false; response_revision:25361; number_of_response:1; }","duration":"275.466023ms","start":"2026-10-04T13:40:28.565029Z","end":"2026-10-04T13:40:28.840495Z","steps":["trace[131456162] 'process raft request'  (duration: 275.223057ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:40:28.840766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.447913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"warn","ts":"2026-10-04T13:40:28.840779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.877692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"}
{"level":"info","ts":"2026-10-04T13:40:28.840843Z","caller":"traceutil/trace.go:171","msg":"trace[305788860] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25361; }","duration":"262.564455ms","start":"2026-10-04T13:40:28.578261Z","end":"2026-10-04T13:40:28.840825Z","steps":["trace[305788860] 'agreement among raft nodes before linearized reading'  (duration: 262.3152ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:40:28.840855Z","caller":"traceutil/trace.go:171","msg":"trace[1269026260] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25361; }","duration":"263.023775ms","start":"2026-10-04T13:40:28.577813Z","end":"2026-10-04T13:40:28.840837Z","steps":["trace[1269026260] 'agreement among raft nodes before linearized reading'  (duration: 262.806761ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:40:29.026375Z","caller":"traceutil/trace.go:171","msg":"trace[1647689869] transaction","detail":"{read_only:false; response_revision:25362; number_of_response:1; }","duration":"180.89602ms","start":"2026-10-04T13:40:28.845442Z","end":"2026-10-04T13:40:29.026338Z","steps":["trace[1647689869] 'process raft request'  (duration: 117.411735ms)","trace[1647689869] 'compare'  (duration: 63.154337ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:40:29.02855Z","caller":"traceutil/trace.go:171","msg":"trace[1862039321] linearizableReadLoop","detail":"{readStateIndex:26198; appliedIndex:26196; }","duration":"133.00848ms","start":"2026-10-04T13:40:28.89552Z","end":"2026-10-04T13:40:29.028528Z","steps":["trace[1862039321] 'read index received'  (duration: 67.266227ms)","trace[1862039321] 'applied index is now lower than readState.Index'  (duration: 65.741193ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:40:29.028606Z","caller":"traceutil/trace.go:171","msg":"trace[1300112116] transaction","detail":"{read_only:false; response_revision:25363; number_of_response:1; }","duration":"182.653717ms","start":"2026-10-04T13:40:28.845923Z","end":"2026-10-04T13:40:29.028577Z","steps":["trace[1300112116] 'process raft request'  (duration: 182.444752ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:40:29.028683Z","caller":"traceutil/trace.go:171","msg":"trace[1653724572] transaction","detail":"{read_only:false; response_revision:25364; number_of_response:1; }","duration":"112.05412ms","start":"2026-10-04T13:40:28.916606Z","end":"2026-10-04T13:40:29.02866Z","steps":["trace[1653724572] 'process raft request'  (duration: 111.881156ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:40:29.028702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.166683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/podmonitors/\" range_end:\"/registry/monitoring.coreos.com/podmonitors0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-10-04T13:40:29.028746Z","caller":"traceutil/trace.go:171","msg":"trace[481057653] range","detail":"{range_begin:/registry/monitoring.coreos.com/podmonitors/; range_end:/registry/monitoring.coreos.com/podmonitors0; response_count:0; response_revision:25364; }","duration":"133.270726ms","start":"2026-10-04T13:40:28.895462Z","end":"2026-10-04T13:40:29.028733Z","steps":["trace[481057653] 'agreement among raft nodes before linearized reading'  (duration: 133.151042ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:40:29.20089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.600225ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2531481516851557352 > lease_revoke:<id:2321a106f76772d3>","response":"size:30"}
{"level":"info","ts":"2026-10-04T13:40:29.252536Z","caller":"traceutil/trace.go:171","msg":"trace[1788819694] transaction","detail":"{read_only:false; response_revision:25366; number_of_response:1; }","duration":"147.155675ms","start":"2026-10-04T13:40:29.105352Z","end":"2026-10-04T13:40:29.252508Z","steps":["trace[1788819694] 'process raft request'  (duration: 147.003461ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:40:29.577982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.551686ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2531481516851557358 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:25352 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-04T13:40:29.578315Z","caller":"traceutil/trace.go:171","msg":"trace[321818694] transaction","detail":"{read_only:false; response_revision:25367; number_of_response:1; }","duration":"320.811598ms","start":"2026-10-04T13:40:29.257406Z","end":"2026-10-04T13:40:29.578217Z","steps":["trace[321818694] 'process raft request'  (duration: 63.909484ms)","trace[321818694] 'compare'  (duration: 256.110717ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T13:40:29.578525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:40:29.257379Z","time spent":"321.043062ms","remote":"127.0.0.1:40706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:25352 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-10-04T13:40:29.768196Z","caller":"traceutil/trace.go:171","msg":"trace[1555488723] transaction","detail":"{read_only:false; response_revision:25369; number_of_response:1; }","duration":"185.306054ms","start":"2026-10-04T13:40:29.582863Z","end":"2026-10-04T13:40:29.768169Z","steps":["trace[1555488723] 'process raft request'  (duration: 135.304859ms)","trace[1555488723] 'compare'  (duration: 49.865432ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T13:40:30.147044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.249065ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2531481516851557363 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:25356 > 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:18"}
{"level":"info","ts":"2026-10-04T13:40:30.147165Z","caller":"traceutil/trace.go:171","msg":"trace[1397129266] linearizableReadLoop","detail":"{readStateIndex:26206; appliedIndex:26205; }","duration":"273.068141ms","start":"2026-10-04T13:40:29.874056Z","end":"2026-10-04T13:40:30.147124Z","steps":["trace[1397129266] 'read index received'  (duration: 12.554489ms)","trace[1397129266] 'applied index is now lower than readState.Index'  (duration: 260.512472ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:40:30.147252Z","caller":"traceutil/trace.go:171","msg":"trace[1053775445] transaction","detail":"{read_only:false; response_revision:25370; number_of_response:1; }","duration":"373.00066ms","start":"2026-10-04T13:40:29.774215Z","end":"2026-10-04T13:40:30.147216Z","steps":["trace[1053775445] 'process raft request'  (duration: 112.496419ms)","trace[1053775445] 'compare'  (duration: 260.078922ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T13:40:30.147336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.277206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:1854"}
{"level":"info","ts":"2026-10-04T13:40:30.147368Z","caller":"traceutil/trace.go:171","msg":"trace[571221536] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25370; }","duration":"273.306917ms","start":"2026-10-04T13:40:29.874049Z","end":"2026-10-04T13:40:30.147356Z","steps":["trace[571221536] 'agreement among raft nodes before linearized reading'  (duration: 273.165383ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:40:30.147419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:40:29.774195Z","time spent":"373.131473ms","remote":"127.0.0.1:40706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:25356 > 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-04T13:40:30.61832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.682658ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2531481516851557364 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:25357 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-04T13:40:30.618438Z","caller":"traceutil/trace.go:171","msg":"trace[824273252] linearizableReadLoop","detail":"{readStateIndex:26207; appliedIndex:26206; }","duration":"471.229622ms","start":"2026-10-04T13:40:30.147188Z","end":"2026-10-04T13:40:30.618417Z","steps":["trace[824273252] 'read index received'  (duration: 335.34472ms)","trace[824273252] 'applied index is now lower than readState.Index'  (duration: 135.883032ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:40:30.618466Z","caller":"traceutil/trace.go:171","msg":"trace[600514840] transaction","detail":"{read_only:false; response_revision:25371; number_of_response:1; }","duration":"502.100126ms","start":"2026-10-04T13:40:30.116336Z","end":"2026-10-04T13:40:30.618436Z","steps":["trace[600514840] 'process raft request'  (duration: 366.185143ms)","trace[600514840] 'compare'  (duration: 135.437352ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T13:40:30.618623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:40:30.11631Z","time spent":"502.227698ms","remote":"127.0.0.1:40706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:25357 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-10-04T13:40:30.618708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"726.300397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/coredns\" ","response":"range_response_count:1 size:180"}
{"level":"info","ts":"2026-10-04T13:40:30.618785Z","caller":"traceutil/trace.go:171","msg":"trace[893736472] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/coredns; range_end:; response_count:1; response_revision:25371; }","duration":"726.409658ms","start":"2026-10-04T13:40:29.892361Z","end":"2026-10-04T13:40:30.618771Z","steps":["trace[893736472] 'agreement among raft nodes before linearized reading'  (duration: 726.289226ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:40:30.618623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"529.992736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"warn","ts":"2026-10-04T13:40:30.618832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:40:29.892341Z","time spent":"726.481361ms","remote":"127.0.0.1:40618","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":204,"request content":"key:\"/registry/serviceaccounts/kube-system/coredns\" "}
{"level":"info","ts":"2026-10-04T13:40:30.618856Z","caller":"traceutil/trace.go:171","msg":"trace[39419641] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:25371; }","duration":"530.266032ms","start":"2026-10-04T13:40:30.088574Z","end":"2026-10-04T13:40:30.61884Z","steps":["trace[39419641] 'agreement among raft nodes before linearized reading'  (duration: 529.931625ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:40:30.618902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:40:30.088554Z","time spent":"530.330882ms","remote":"127.0.0.1:40974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":60,"response size":32,"request content":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true "}
{"level":"info","ts":"2026-10-04T13:40:30.630996Z","caller":"traceutil/trace.go:171","msg":"trace[670769494] transaction","detail":"{read_only:false; response_revision:25372; number_of_response:1; }","duration":"230.141868ms","start":"2026-10-04T13:40:30.400542Z","end":"2026-10-04T13:40:30.630684Z","steps":["trace[670769494] 'process raft request'  (duration: 229.963704ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:40:30.654917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.384453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"}
{"level":"info","ts":"2026-10-04T13:40:30.655069Z","caller":"traceutil/trace.go:171","msg":"trace[1472129752] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25373; }","duration":"257.584489ms","start":"2026-10-04T13:40:30.39746Z","end":"2026-10-04T13:40:30.655044Z","steps":["trace[1472129752] 'agreement among raft nodes before linearized reading'  (duration: 257.279832ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:40:30.655493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.445755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-04T13:40:30.655775Z","caller":"traceutil/trace.go:171","msg":"trace[1122267002] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25373; }","duration":"190.728381ms","start":"2026-10-04T13:40:30.465033Z","end":"2026-10-04T13:40:30.655761Z","steps":["trace[1122267002] 'agreement among raft nodes before linearized reading'  (duration: 190.416494ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:40:30.655114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"504.750533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-93020325-be2d-4a33-a9b1-fc591d7d8968\" ","response":"range_response_count:1 size:1304"}
{"level":"info","ts":"2026-10-04T13:40:30.655961Z","caller":"traceutil/trace.go:171","msg":"trace[243370814] range","detail":"{range_begin:/registry/persistentvolumes/pvc-93020325-be2d-4a33-a9b1-fc591d7d8968; range_end:; response_count:1; response_revision:25373; }","duration":"505.621552ms","start":"2026-10-04T13:40:30.150306Z","end":"2026-10-04T13:40:30.655927Z","steps":["trace[243370814] 'agreement among raft nodes before linearized reading'  (duration: 504.655721ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:40:30.656054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:40:30.15029Z","time spent":"505.728634ms","remote":"127.0.0.1:40578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":1328,"request content":"key:\"/registry/persistentvolumes/pvc-93020325-be2d-4a33-a9b1-fc591d7d8968\" "}
{"level":"warn","ts":"2026-10-04T13:40:30.967747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.158646ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2531481516851557372 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:25358 > 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:18"}
{"level":"info","ts":"2026-10-04T13:40:30.968122Z","caller":"traceutil/trace.go:171","msg":"trace[463810750] transaction","detail":"{read_only:false; response_revision:25375; number_of_response:1; }","duration":"163.777721ms","start":"2026-10-04T13:40:30.804319Z","end":"2026-10-04T13:40:30.968096Z","steps":["trace[463810750] 'process raft request'  (duration: 163.652419ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:40:30.968116Z","caller":"traceutil/trace.go:171","msg":"trace[819266860] transaction","detail":"{read_only:false; response_revision:25374; number_of_response:1; }","duration":"307.345269ms","start":"2026-10-04T13:40:30.660737Z","end":"2026-10-04T13:40:30.968082Z","steps":["trace[819266860] 'process raft request'  (duration: 57.709642ms)","trace[819266860] 'compare'  (duration: 248.931752ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T13:40:30.968472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:40:30.66072Z","time spent":"307.630415ms","remote":"127.0.0.1:40706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:25358 > 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-04T13:40:31.142893Z","caller":"traceutil/trace.go:171","msg":"trace[1151526028] linearizableReadLoop","detail":"{readStateIndex:26212; appliedIndex:26211; }","duration":"111.63692ms","start":"2026-10-04T13:40:31.031227Z","end":"2026-10-04T13:40:31.142864Z","steps":["trace[1151526028] 'read index received'  (duration: 111.375914ms)","trace[1151526028] 'applied index is now lower than readState.Index'  (duration: 259.806µs)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:40:31.143001Z","caller":"traceutil/trace.go:171","msg":"trace[714554066] transaction","detail":"{read_only:false; response_revision:25376; number_of_response:1; }","duration":"295.644217ms","start":"2026-10-04T13:40:30.847315Z","end":"2026-10-04T13:40:31.142959Z","steps":["trace[714554066] 'process raft request'  (duration: 295.35398ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:40:31.143192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.927146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"info","ts":"2026-10-04T13:40:31.143276Z","caller":"traceutil/trace.go:171","msg":"trace[2121997295] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25376; }","duration":"112.049579ms","start":"2026-10-04T13:40:31.031207Z","end":"2026-10-04T13:40:31.143257Z","steps":["trace[2121997295] 'agreement among raft nodes before linearized reading'  (duration: 111.779603ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:40:31.175636Z","caller":"traceutil/trace.go:171","msg":"trace[466512181] transaction","detail":"{read_only:false; response_revision:25377; number_of_response:1; }","duration":"142.244699ms","start":"2026-10-04T13:40:31.033357Z","end":"2026-10-04T13:40:31.175602Z","steps":["trace[466512181] 'process raft request'  (duration: 142.036105ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:40:31.175813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.722028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"}
{"level":"info","ts":"2026-10-04T13:40:31.175921Z","caller":"traceutil/trace.go:171","msg":"trace[1331316536] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25377; }","duration":"142.932394ms","start":"2026-10-04T13:40:31.032966Z","end":"2026-10-04T13:40:31.175898Z","steps":["trace[1331316536] 'agreement among raft nodes before linearized reading'  (duration: 142.615536ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:40:31.506354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.063737ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2531481516851557377 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:25362 > 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:18"}
{"level":"info","ts":"2026-10-04T13:40:31.506566Z","caller":"traceutil/trace.go:171","msg":"trace[1187488349] transaction","detail":"{read_only:false; response_revision:25379; number_of_response:1; }","duration":"325.866057ms","start":"2026-10-04T13:40:31.180679Z","end":"2026-10-04T13:40:31.506545Z","steps":["trace[1187488349] 'process raft request'  (duration: 325.776765ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:40:31.506608Z","caller":"traceutil/trace.go:171","msg":"trace[2077379067] transaction","detail":"{read_only:false; response_revision:25378; number_of_response:1; }","duration":"357.1762ms","start":"2026-10-04T13:40:31.1494Z","end":"2026-10-04T13:40:31.506576Z","steps":["trace[2077379067] 'process raft request'  (duration: 166.802407ms)","trace[2077379067] 'compare'  (duration: 189.913243ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T13:40:31.506742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:40:31.149377Z","time spent":"357.285352ms","remote":"127.0.0.1:40706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:25362 > 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-04T13:40:31.506669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:40:31.180653Z","time spent":"325.952169ms","remote":"127.0.0.1:40706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:25363 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:429 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-10-04T13:40:31.507135Z","caller":"traceutil/trace.go:171","msg":"trace[645104866] transaction","detail":"{read_only:false; response_revision:25380; number_of_response:1; }","duration":"296.701739ms","start":"2026-10-04T13:40:31.210412Z","end":"2026-10-04T13:40:31.507114Z","steps":["trace[645104866] 'process raft request'  (duration: 296.095536ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:40:31.507323Z","caller":"traceutil/trace.go:171","msg":"trace[491827455] linearizableReadLoop","detail":"{readStateIndex:26217; appliedIndex:26213; }","duration":"236.76743ms","start":"2026-10-04T13:40:31.270524Z","end":"2026-10-04T13:40:31.507292Z","steps":["trace[491827455] 'read index received'  (duration: 45.764484ms)","trace[491827455] 'applied index is now lower than readState.Index'  (duration: 191.001766ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T13:40:31.507504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.964285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/domains/\" range_end:\"/registry/openstack.k-orc.cloud/domains0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-04T13:40:31.507544Z","caller":"traceutil/trace.go:171","msg":"trace[586956781] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/domains/; range_end:/registry/openstack.k-orc.cloud/domains0; response_count:0; response_revision:25381; }","duration":"237.063768ms","start":"2026-10-04T13:40:31.270466Z","end":"2026-10-04T13:40:31.50753Z","steps":["trace[586956781] 'agreement among raft nodes before linearized reading'  (duration: 236.970766ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:40:31.507895Z","caller":"traceutil/trace.go:171","msg":"trace[1999582993] transaction","detail":"{read_only:false; response_revision:25381; number_of_response:1; }","duration":"249.459234ms","start":"2026-10-04T13:40:31.257855Z","end":"2026-10-04T13:40:31.507314Z","steps":["trace[1999582993] 'process raft request'  (duration: 249.188948ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:40:31.762168Z","caller":"traceutil/trace.go:171","msg":"trace[1010210875] linearizableReadLoop","detail":"{readStateIndex:26218; appliedIndex:26217; }","duration":"172.477809ms","start":"2026-10-04T13:40:31.589649Z","end":"2026-10-04T13:40:31.762127Z","steps":["trace[1010210875] 'read index received'  (duration: 172.293485ms)","trace[1010210875] 'applied index is now lower than readState.Index'  (duration: 183.464µs)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:40:31.762239Z","caller":"traceutil/trace.go:171","msg":"trace[1962012483] transaction","detail":"{read_only:false; response_revision:25382; number_of_response:1; }","duration":"174.956911ms","start":"2026-10-04T13:40:31.587239Z","end":"2026-10-04T13:40:31.762196Z","steps":["trace[1962012483] 'process raft request'  (duration: 174.752887ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:40:31.762293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.630692ms","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:8"}
{"level":"info","ts":"2026-10-04T13:40:31.762328Z","caller":"traceutil/trace.go:171","msg":"trace[408598269] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:25382; }","duration":"172.724773ms","start":"2026-10-04T13:40:31.589593Z","end":"2026-10-04T13:40:31.762318Z","steps":["trace[408598269] 'agreement among raft nodes before linearized reading'  (duration: 172.638372ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:40:37.79158Z","caller":"traceutil/trace.go:171","msg":"trace[862570956] transaction","detail":"{read_only:false; response_revision:25425; number_of_response:1; }","duration":"255.257018ms","start":"2026-10-04T13:40:37.536298Z","end":"2026-10-04T13:40:37.791555Z","steps":["trace[862570956] 'process raft request'  (duration: 255.071465ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:40:37.803974Z","caller":"traceutil/trace.go:171","msg":"trace[51714177] linearizableReadLoop","detail":"{readStateIndex:26264; appliedIndex:26261; }","duration":"258.194501ms","start":"2026-10-04T13:40:37.54575Z","end":"2026-10-04T13:40:37.803945Z","steps":["trace[51714177] 'read index received'  (duration: 245.707183ms)","trace[51714177] 'applied index is now lower than readState.Index'  (duration: 12.486118ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:40:37.80402Z","caller":"traceutil/trace.go:171","msg":"trace[998451359] transaction","detail":"{read_only:false; response_revision:25426; number_of_response:1; }","duration":"267.294087ms","start":"2026-10-04T13:40:37.536697Z","end":"2026-10-04T13:40:37.803991Z","steps":["trace[998451359] 'process raft request'  (duration: 267.008391ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:40:37.804117Z","caller":"traceutil/trace.go:171","msg":"trace[274856573] transaction","detail":"{read_only:false; response_revision:25427; number_of_response:1; }","duration":"262.884033ms","start":"2026-10-04T13:40:37.541217Z","end":"2026-10-04T13:40:37.804101Z","steps":["trace[274856573] 'process raft request'  (duration: 262.674759ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:40:37.804672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.909417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"warn","ts":"2026-10-04T13:40:37.80471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.883987ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/clusters/\" range_end:\"/registry/cluster.x-k8s.io/clusters0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-04T13:40:37.804724Z","caller":"traceutil/trace.go:171","msg":"trace[2146160400] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25427; }","duration":"259.02733ms","start":"2026-10-04T13:40:37.545684Z","end":"2026-10-04T13:40:37.804711Z","steps":["trace[2146160400] 'agreement among raft nodes before linearized reading'  (duration: 258.764574ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:40:37.804699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.10616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"}
{"level":"info","ts":"2026-10-04T13:40:37.804756Z","caller":"traceutil/trace.go:171","msg":"trace[8307620] range","detail":"{range_begin:/registry/cluster.x-k8s.io/clusters/; range_end:/registry/cluster.x-k8s.io/clusters0; response_count:0; response_revision:25427; }","duration":"225.967048ms","start":"2026-10-04T13:40:37.578775Z","end":"2026-10-04T13:40:37.804742Z","steps":["trace[8307620] 'agreement among raft nodes before linearized reading'  (duration: 225.884426ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:40:37.804844Z","caller":"traceutil/trace.go:171","msg":"trace[535595042] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25427; }","duration":"258.280464ms","start":"2026-10-04T13:40:37.546516Z","end":"2026-10-04T13:40:37.804797Z","steps":["trace[535595042] 'agreement among raft nodes before linearized reading'  (duration: 257.863074ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:40:38.247266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.650044ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2531481516851557498 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:25416 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-04T13:40:38.247372Z","caller":"traceutil/trace.go:171","msg":"trace[1799196225] transaction","detail":"{read_only:false; response_revision:25428; number_of_response:1; }","duration":"437.293142ms","start":"2026-10-04T13:40:37.810056Z","end":"2026-10-04T13:40:38.24735Z","steps":["trace[1799196225] 'process raft request'  (duration: 283.472714ms)","trace[1799196225] 'compare'  (duration: 153.504571ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T13:40:38.247746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:40:37.810025Z","time spent":"437.377524ms","remote":"127.0.0.1:40706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:25416 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-10-04T13:40:38.818144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.593928ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2531481516851557499 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:25414 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-04T13:40:38.818507Z","caller":"traceutil/trace.go:171","msg":"trace[482149265] linearizableReadLoop","detail":"{readStateIndex:26269; appliedIndex:26264; }","duration":"842.320201ms","start":"2026-10-04T13:40:37.976165Z","end":"2026-10-04T13:40:38.818485Z","steps":["trace[482149265] 'read index received'  (duration: 117.378624ms)","trace[482149265] 'applied index is now lower than readState.Index'  (duration: 724.940106ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:40:38.818495Z","caller":"traceutil/trace.go:171","msg":"trace[1293609169] transaction","detail":"{read_only:false; response_revision:25430; number_of_response:1; }","duration":"1.007404541s","start":"2026-10-04T13:40:37.81105Z","end":"2026-10-04T13:40:38.818455Z","steps":["trace[1293609169] 'process raft request'  (duration: 1.007224376s)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:40:38.818575Z","caller":"traceutil/trace.go:171","msg":"trace[482657463] transaction","detail":"{read_only:false; response_revision:25431; number_of_response:1; }","duration":"1.005768335s","start":"2026-10-04T13:40:37.812777Z","end":"2026-10-04T13:40:38.818546Z","steps":["trace[482657463] 'process raft request'  (duration: 1.005601712s)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:40:38.818708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:40:37.811024Z","time spent":"1.007570103s","remote":"127.0.0.1:40706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:25417 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-10-04T13:40:38.818611Z","caller":"traceutil/trace.go:171","msg":"trace[1798517270] transaction","detail":"{read_only:false; response_revision:25432; number_of_response:1; }","duration":"897.20146ms","start":"2026-10-04T13:40:37.921396Z","end":"2026-10-04T13:40:38.818597Z","steps":["trace[1798517270] 'process raft request'  (duration: 897.034937ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:40:38.818777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"842.631438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"}
{"level":"info","ts":"2026-10-04T13:40:38.818832Z","caller":"traceutil/trace.go:171","msg":"trace[816437811] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25432; }","duration":"842.730569ms","start":"2026-10-04T13:40:37.976079Z","end":"2026-10-04T13:40:38.818809Z","steps":["trace[816437811] 'agreement among raft nodes before linearized reading'  (duration: 842.551515ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:40:38.818833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:40:37.921364Z","time spent":"897.435916ms","remote":"127.0.0.1:40706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:25355 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-10-04T13:40:38.818878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:40:37.97605Z","time spent":"842.817311ms","remote":"127.0.0.1:40612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12238,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"warn","ts":"2026-10-04T13:40:38.818762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:40:37.812746Z","time spent":"1.005901928s","remote":"127.0.0.1:40706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:25413 > 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-04T13:40:38.81966Z","caller":"traceutil/trace.go:171","msg":"trace[1168222387] transaction","detail":"{read_only:false; response_revision:25429; number_of_response:1; }","duration":"1.008728388s","start":"2026-10-04T13:40:37.810325Z","end":"2026-10-04T13:40:38.819053Z","steps":["trace[1168222387] 'process raft request'  (duration: 764.115859ms)","trace[1168222387] 'compare'  (duration: 242.635386ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T13:40:38.819756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:40:37.810305Z","time spent":"1.009401483s","remote":"127.0.0.1:40706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:25414 > 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-04T13:40:38.829775Z","caller":"traceutil/trace.go:171","msg":"trace[817218486] transaction","detail":"{read_only:false; response_revision:25433; number_of_response:1; }","duration":"668.888891ms","start":"2026-10-04T13:40:38.16086Z","end":"2026-10-04T13:40:38.829749Z","steps":["trace[817218486] 'process raft request'  (duration: 668.773859ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:40:38.82986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:40:38.160834Z","time spent":"668.979144ms","remote":"127.0.0.1:40706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:25373 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:415 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"info","ts":"2026-10-04T13:40:38.949774Z","caller":"traceutil/trace.go:171","msg":"trace[2122888714] linearizableReadLoop","detail":"{readStateIndex:26272; appliedIndex:26269; }","duration":"131.192512ms","start":"2026-10-04T13:40:38.818558Z","end":"2026-10-04T13:40:38.94975Z","steps":["trace[2122888714] 'read index received'  (duration: 11.103749ms)","trace[2122888714] 'applied index is now lower than readState.Index'  (duration: 120.087552ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:40:38.94981Z","caller":"traceutil/trace.go:171","msg":"trace[178128911] transaction","detail":"{read_only:false; response_revision:25434; number_of_response:1; }","duration":"294.228546ms","start":"2026-10-04T13:40:38.655546Z","end":"2026-10-04T13:40:38.949775Z","steps":["trace[178128911] 'process raft request'  (duration: 293.999411ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:40:38.949931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.996515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-04T13:40:38.949992Z","caller":"traceutil/trace.go:171","msg":"trace[339863664] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25435; }","duration":"483.119648ms","start":"2026-10-04T13:40:38.466858Z","end":"2026-10-04T13:40:38.949978Z","steps":["trace[339863664] 'agreement among raft nodes before linearized reading'  (duration: 483.003655ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:40:38.950006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"638.168142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:9"}
{"level":"warn","ts":"2026-10-04T13:40:38.950034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:40:38.466831Z","time spent":"483.19501ms","remote":"127.0.0.1:40438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-10-04T13:40:38.950039Z","caller":"traceutil/trace.go:171","msg":"trace[2060009716] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:25435; }","duration":"638.258864ms","start":"2026-10-04T13:40:38.31177Z","end":"2026-10-04T13:40:38.950029Z","steps":["trace[2060009716] 'agreement among raft nodes before linearized reading'  (duration: 638.094519ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:40:38.950141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.147744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"}
{"level":"warn","ts":"2026-10-04T13:40:38.950189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"761.150586ms","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-04T13:40:38.950188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:40:38.311749Z","time spent":"638.387536ms","remote":"127.0.0.1:40482","response type":"/etcdserverpb.KV/Range","request count":0,"request size":120,"response count":141,"response size":33,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true "}
{"level":"warn","ts":"2026-10-04T13:40:38.950193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.212633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-10-04T13:40:38.950231Z","caller":"traceutil/trace.go:171","msg":"trace[896252767] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25435; }","duration":"127.249327ms","start":"2026-10-04T13:40:38.822965Z","end":"2026-10-04T13:40:38.950214Z","steps":["trace[896252767] 'agreement among raft nodes before linearized reading'  (duration: 127.029622ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:40:38.95027Z","caller":"traceutil/trace.go:171","msg":"trace[1160667029] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:25435; }","duration":"418.377376ms","start":"2026-10-04T13:40:38.531879Z","end":"2026-10-04T13:40:38.950257Z","steps":["trace[1160667029] 'agreement among raft nodes before linearized reading'  (duration: 418.189721ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:40:38.950322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:40:38.531855Z","time spent":"418.450527ms","remote":"127.0.0.1:40916","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":19,"response size":32,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "}
{"level":"info","ts":"2026-10-04T13:40:38.950229Z","caller":"traceutil/trace.go:171","msg":"trace[1526057497] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25435; }","duration":"761.223688ms","start":"2026-10-04T13:40:38.188994Z","end":"2026-10-04T13:40:38.950218Z","steps":["trace[1526057497] 'agreement among raft nodes before linearized reading'  (duration: 761.068934ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:40:38.950401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:40:38.188977Z","time spent":"761.396151ms","remote":"127.0.0.1:40706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-10-04T13:40:38.950405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.939802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephcosidrivers/\" range_end:\"/registry/ceph.rook.io/cephcosidrivers0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-04T13:40:38.950271Z","caller":"traceutil/trace.go:171","msg":"trace[1642286212] transaction","detail":"{read_only:false; response_revision:25435; number_of_response:1; }","duration":"292.486229ms","start":"2026-10-04T13:40:38.657618Z","end":"2026-10-04T13:40:38.950104Z","steps":["trace[1642286212] 'process raft request'  (duration: 292.08331ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:40:38.950507Z","caller":"traceutil/trace.go:171","msg":"trace[288989000] range","detail":"{range_begin:/registry/ceph.rook.io/cephcosidrivers/; range_end:/registry/ceph.rook.io/cephcosidrivers0; response_count:0; response_revision:25435; }","duration":"109.073066ms","start":"2026-10-04T13:40:38.841413Z","end":"2026-10-04T13:40:38.950486Z","steps":["trace[288989000] 'agreement among raft nodes before linearized reading'  (duration: 108.774149ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:40:40.439695Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":22024}
{"level":"info","ts":"2026-10-04T13:40:40.554284Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":22024,"took":"110.858023ms","hash":3499789001,"current-db-size-bytes":56639488,"current-db-size":"57 MB","current-db-size-in-use-bytes":44929024,"current-db-size-in-use":"45 MB"}
{"level":"info","ts":"2026-10-04T13:40:40.554345Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3499789001,"revision":22024,"compact-revision":19791}
{"level":"info","ts":"2026-10-04T13:40:41.409982Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-00000000000066c5.wal"}
{"level":"warn","ts":"2026-10-04T13:40:43.23421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.641577ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2531481516851557742 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:25448 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-04T13:40:43.23447Z","caller":"traceutil/trace.go:171","msg":"trace[571300975] linearizableReadLoop","detail":"{readStateIndex:26362; appliedIndex:26357; }","duration":"259.419648ms","start":"2026-10-04T13:40:42.975036Z","end":"2026-10-04T13:40:43.234455Z","steps":["trace[571300975] 'read index received'  (duration: 16.502055ms)","trace[571300975] 'applied index is now lower than readState.Index'  (duration: 242.916623ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:40:43.234937Z","caller":"traceutil/trace.go:171","msg":"trace[662529737] transaction","detail":"{read_only:false; response_revision:25521; number_of_response:1; }","duration":"272.432777ms","start":"2026-10-04T13:40:42.96248Z","end":"2026-10-04T13:40:43.234913Z","steps":["trace[662529737] 'process raft request'  (duration: 271.913386ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:40:43.234955Z","caller":"traceutil/trace.go:171","msg":"trace[47605294] transaction","detail":"{read_only:false; response_revision:25518; number_of_response:1; }","duration":"366.160643ms","start":"2026-10-04T13:40:42.86876Z","end":"2026-10-04T13:40:43.234921Z","steps":["trace[47605294] 'process raft request'  (duration: 122.682438ms)","trace[47605294] 'compare'  (duration: 242.531424ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:40:43.234961Z","caller":"traceutil/trace.go:171","msg":"trace[1733994222] transaction","detail":"{read_only:false; response_revision:25519; number_of_response:1; }","duration":"365.025858ms","start":"2026-10-04T13:40:42.869893Z","end":"2026-10-04T13:40:43.234919Z","steps":["trace[1733994222] 'process raft request'  (duration: 364.411045ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:40:43.234985Z","caller":"traceutil/trace.go:171","msg":"trace[31021272] transaction","detail":"{read_only:false; response_revision:25522; number_of_response:1; }","duration":"271.61609ms","start":"2026-10-04T13:40:42.963332Z","end":"2026-10-04T13:40:43.234948Z","steps":["trace[31021272] 'process raft request'  (duration: 271.083819ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:40:43.235005Z","caller":"traceutil/trace.go:171","msg":"trace[819372698] transaction","detail":"{read_only:false; response_revision:25520; number_of_response:1; }","duration":"363.423514ms","start":"2026-10-04T13:40:42.871534Z","end":"2026-10-04T13:40:43.234958Z","steps":["trace[819372698] 'process raft request'  (duration: 362.825311ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:40:43.235091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:40:42.868739Z","time spent":"366.264835ms","remote":"127.0.0.1:40706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:25448 > 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-04T13:40:43.235107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:40:42.869876Z","time spent":"365.153021ms","remote":"127.0.0.1:40706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:25447 > 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-04T13:40:43.235183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.109542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"warn","ts":"2026-10-04T13:40:43.23522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:40:42.871523Z","time spent":"363.562747ms","remote":"127.0.0.1:40706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:25446 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-10-04T13:40:43.235257Z","caller":"traceutil/trace.go:171","msg":"trace[650875043] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25522; }","duration":"260.251796ms","start":"2026-10-04T13:40:42.974983Z","end":"2026-10-04T13:40:43.235235Z","steps":["trace[650875043] 'agreement among raft nodes before linearized reading'  (duration: 259.957329ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:40:43.313677Z","caller":"traceutil/trace.go:171","msg":"trace[2017201474] transaction","detail":"{read_only:false; response_revision:25523; number_of_response:1; }","duration":"305.024899ms","start":"2026-10-04T13:40:43.008627Z","end":"2026-10-04T13:40:43.313651Z","steps":["trace[2017201474] 'process raft request'  (duration: 304.863555ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:40:43.313816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:40:43.00861Z","time spent":"305.13586ms","remote":"127.0.0.1:40706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":496,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:25452 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:440 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"info","ts":"2026-10-04T13:40:43.325986Z","caller":"traceutil/trace.go:171","msg":"trace[592356723] transaction","detail":"{read_only:false; response_revision:25524; number_of_response:1; }","duration":"131.536158ms","start":"2026-10-04T13:40:43.194423Z","end":"2026-10-04T13:40:43.325959Z","steps":["trace[592356723] 'process raft request'  (duration: 131.356614ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:40:43.326386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.430989ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"}
{"level":"info","ts":"2026-10-04T13:40:43.326468Z","caller":"traceutil/trace.go:171","msg":"trace[867028219] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25526; }","duration":"307.551933ms","start":"2026-10-04T13:40:43.018897Z","end":"2026-10-04T13:40:43.326449Z","steps":["trace[867028219] 'agreement among raft nodes before linearized reading'  (duration: 307.3937ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:40:43.326507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:40:43.018883Z","time spent":"307.615174ms","remote":"127.0.0.1:40706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":581,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"info","ts":"2026-10-04T13:40:45.926612Z","caller":"traceutil/trace.go:171","msg":"trace[1879084259] transaction","detail":"{read_only:false; response_revision:25545; number_of_response:1; }","duration":"101.916181ms","start":"2026-10-04T13:40:45.824658Z","end":"2026-10-04T13:40:45.926575Z","steps":["trace[1879084259] 'process raft request'  (duration: 101.676686ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:40:49.245659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.923732ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2531481516851557876 > lease_revoke:<id:2321a106f7677434>","response":"size:30"}
{"level":"info","ts":"2026-10-04T13:40:49.24594Z","caller":"traceutil/trace.go:171","msg":"trace[1192132926] linearizableReadLoop","detail":"{readStateIndex:26422; appliedIndex:26421; }","duration":"184.557548ms","start":"2026-10-04T13:40:49.061357Z","end":"2026-10-04T13:40:49.245915Z","steps":["trace[1192132926] 'read index received'  (duration: 62.405612ms)","trace[1192132926] 'applied index is now lower than readState.Index'  (duration: 122.150666ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T13:40:49.246434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.073659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-04T13:40:49.246486Z","caller":"traceutil/trace.go:171","msg":"trace[318016519] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:25579; }","duration":"185.176372ms","start":"2026-10-04T13:40:49.061295Z","end":"2026-10-04T13:40:49.246472Z","steps":["trace[318016519] 'agreement among raft nodes before linearized reading'  (duration: 185.085539ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:40:49.249322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.635641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"}
{"level":"info","ts":"2026-10-04T13:40:49.249385Z","caller":"traceutil/trace.go:171","msg":"trace[1683648087] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25580; }","duration":"104.740833ms","start":"2026-10-04T13:40:49.144628Z","end":"2026-10-04T13:40:49.249369Z","steps":["trace[1683648087] 'agreement among raft nodes before linearized reading'  (duration: 102.261039ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:40:49.249438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.643227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-04T13:40:49.250535Z","caller":"traceutil/trace.go:171","msg":"trace[524752225] range","detail":"{range_begin:/registry/ipam.cluster.x-k8s.io/ipaddressclaims/; range_end:/registry/ipam.cluster.x-k8s.io/ipaddressclaims0; response_count:0; response_revision:25580; }","duration":"108.823571ms","start":"2026-10-04T13:40:49.14072Z","end":"2026-10-04T13:40:49.249543Z","steps":["trace[524752225] 'agreement among raft nodes before linearized reading'  (duration: 106.118692ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:41:14.16113Z","caller":"traceutil/trace.go:171","msg":"trace[1842918363] transaction","detail":"{read_only:false; response_revision:25793; number_of_response:1; }","duration":"152.301224ms","start":"2026-10-04T13:41:14.008797Z","end":"2026-10-04T13:41:14.161098Z","steps":["trace[1842918363] 'process raft request'  (duration: 112.611321ms)","trace[1842918363] 'compare'  (duration: 39.584152ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:41:14.21336Z","caller":"traceutil/trace.go:171","msg":"trace[1244075837] transaction","detail":"{read_only:false; response_revision:25795; number_of_response:1; }","duration":"200.00035ms","start":"2026-10-04T13:41:14.01334Z","end":"2026-10-04T13:41:14.213341Z","steps":["trace[1244075837] 'process raft request'  (duration: 199.952189ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:41:14.213463Z","caller":"traceutil/trace.go:171","msg":"trace[173214056] transaction","detail":"{read_only:false; response_revision:25794; number_of_response:1; }","duration":"202.31939ms","start":"2026-10-04T13:41:14.011111Z","end":"2026-10-04T13:41:14.213431Z","steps":["trace[173214056] 'process raft request'  (duration: 202.004953ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:41:14.661485Z","caller":"traceutil/trace.go:171","msg":"trace[1364915514] transaction","detail":"{read_only:false; response_revision:25796; number_of_response:1; }","duration":"134.925231ms","start":"2026-10-04T13:41:14.526505Z","end":"2026-10-04T13:41:14.66143Z","steps":["trace[1364915514] 'process raft request'  (duration: 134.754738ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:41:14.876055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.798399ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-04T13:41:14.876277Z","caller":"traceutil/trace.go:171","msg":"trace[290246807] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:25796; }","duration":"116.037244ms","start":"2026-10-04T13:41:14.760211Z","end":"2026-10-04T13:41:14.876248Z","steps":["trace[290246807] 'range keys from in-memory index tree'  (duration: 115.778319ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:41:15.561134Z","caller":"traceutil/trace.go:171","msg":"trace[535465213] linearizableReadLoop","detail":"{readStateIndex:26647; appliedIndex:26646; }","duration":"149.455733ms","start":"2026-10-04T13:41:15.411654Z","end":"2026-10-04T13:41:15.561109Z","steps":["trace[535465213] 'read index received'  (duration: 143.111378ms)","trace[535465213] 'applied index is now lower than readState.Index'  (duration: 6.343445ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:41:15.561264Z","caller":"traceutil/trace.go:171","msg":"trace[1411440275] transaction","detail":"{read_only:false; response_revision:25799; number_of_response:1; }","duration":"151.778214ms","start":"2026-10-04T13:41:15.409447Z","end":"2026-10-04T13:41:15.561226Z","steps":["trace[1411440275] 'process raft request'  (duration: 145.11159ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:41:15.56145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.964086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"}
{"level":"info","ts":"2026-10-04T13:41:15.561519Z","caller":"traceutil/trace.go:171","msg":"trace[1612049634] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25799; }","duration":"151.097529ms","start":"2026-10-04T13:41:15.410402Z","end":"2026-10-04T13:41:15.561499Z","steps":["trace[1612049634] 'agreement among raft nodes before linearized reading'  (duration: 150.855864ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:41:15.789146Z","caller":"traceutil/trace.go:171","msg":"trace[835749845] transaction","detail":"{read_only:false; response_revision:25800; number_of_response:1; }","duration":"355.619857ms","start":"2026-10-04T13:41:15.433498Z","end":"2026-10-04T13:41:15.789118Z","steps":["trace[835749845] 'process raft request'  (duration: 355.409742ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:41:15.789338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:41:15.433467Z","time spent":"355.78381ms","remote":"127.0.0.1:40706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:25789 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"info","ts":"2026-10-04T13:41:15.789382Z","caller":"traceutil/trace.go:171","msg":"trace[1719017044] linearizableReadLoop","detail":"{readStateIndex:26649; appliedIndex:26647; }","duration":"228.098554ms","start":"2026-10-04T13:41:15.561235Z","end":"2026-10-04T13:41:15.789334Z","steps":["trace[1719017044] 'read index received'  (duration: 227.700436ms)","trace[1719017044] 'applied index is now lower than readState.Index'  (duration: 396.488µs)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T13:41:15.789543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.90057ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-04T13:41:15.789586Z","caller":"traceutil/trace.go:171","msg":"trace[1174438181] range","detail":"{range_begin:/registry/services/specs/magnum-system/; range_end:/registry/services/specs/magnum-system0; response_count:0; response_revision:25801; }","duration":"373.988402ms","start":"2026-10-04T13:41:15.415585Z","end":"2026-10-04T13:41:15.789573Z","steps":["trace[1174438181] 'agreement among raft nodes before linearized reading'  (duration: 373.88557ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:41:15.789561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.792637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"}
{"level":"warn","ts":"2026-10-04T13:41:15.78962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:41:15.415572Z","time spent":"374.038083ms","remote":"127.0.0.1:40616","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":30,"request content":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" "}
{"level":"info","ts":"2026-10-04T13:41:15.789659Z","caller":"traceutil/trace.go:171","msg":"trace[2109490315] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25801; }","duration":"373.91598ms","start":"2026-10-04T13:41:15.415718Z","end":"2026-10-04T13:41:15.789634Z","steps":["trace[2109490315] 'agreement among raft nodes before linearized reading'  (duration: 373.672785ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:41:15.789721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:41:15.415709Z","time spent":"373.996821ms","remote":"127.0.0.1:40706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-10-04T13:41:15.78983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.661397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"info","ts":"2026-10-04T13:41:15.789859Z","caller":"traceutil/trace.go:171","msg":"trace[1290447658] transaction","detail":"{read_only:false; response_revision:25801; number_of_response:1; }","duration":"334.029031ms","start":"2026-10-04T13:41:15.455811Z","end":"2026-10-04T13:41:15.78984Z","steps":["trace[1290447658] 'process raft request'  (duration: 333.253664ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:41:15.789875Z","caller":"traceutil/trace.go:171","msg":"trace[970189354] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25801; }","duration":"375.732179ms","start":"2026-10-04T13:41:15.414131Z","end":"2026-10-04T13:41:15.789864Z","steps":["trace[970189354] 'agreement among raft nodes before linearized reading'  (duration: 375.570576ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:41:15.789922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:41:15.414118Z","time spent":"375.798091ms","remote":"127.0.0.1:40706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":506,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-10-04T13:41:15.789559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.848959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"info","ts":"2026-10-04T13:41:15.789975Z","caller":"traceutil/trace.go:171","msg":"trace[619255592] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25801; }","duration":"315.318391ms","start":"2026-10-04T13:41:15.474643Z","end":"2026-10-04T13:41:15.789961Z","steps":["trace[619255592] 'agreement among raft nodes before linearized reading'  (duration: 314.714467ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:41:15.789974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.146458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-10-04T13:41:15.789998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:41:15.455781Z","time spent":"334.134764ms","remote":"127.0.0.1:40706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:25790 > 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-04T13:41:15.790019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:41:15.474623Z","time spent":"315.384171ms","remote":"127.0.0.1:40706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-10-04T13:41:15.79003Z","caller":"traceutil/trace.go:171","msg":"trace[1371905752] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25801; }","duration":"323.25103ms","start":"2026-10-04T13:41:15.466762Z","end":"2026-10-04T13:41:15.790013Z","steps":["trace[1371905752] 'agreement among raft nodes before linearized reading'  (duration: 323.169229ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:41:15.790067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:41:15.466704Z","time spent":"323.352412ms","remote":"127.0.0.1:40438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-10-04T13:41:16.01629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.371289ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2531481516851558438 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:25786 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-04T13:41:16.016492Z","caller":"traceutil/trace.go:171","msg":"trace[1873812142] transaction","detail":"{read_only:false; response_revision:25802; number_of_response:1; }","duration":"450.050486ms","start":"2026-10-04T13:41:15.566412Z","end":"2026-10-04T13:41:16.016462Z","steps":["trace[1873812142] 'process raft request'  (duration: 301.428751ms)","trace[1873812142] 'compare'  (duration: 148.051972ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:41:16.016574Z","caller":"traceutil/trace.go:171","msg":"trace[1807096309] transaction","detail":"{read_only:false; response_revision:25805; number_of_response:1; }","duration":"220.701427ms","start":"2026-10-04T13:41:15.795856Z","end":"2026-10-04T13:41:16.016557Z","steps":["trace[1807096309] 'process raft request'  (duration: 220.661805ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:41:16.016625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:41:15.566386Z","time spent":"450.163379ms","remote":"127.0.0.1:40706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:25786 > 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-04T13:41:16.016814Z","caller":"traceutil/trace.go:171","msg":"trace[1712611592] transaction","detail":"{read_only:false; response_revision:25804; number_of_response:1; }","duration":"221.296358ms","start":"2026-10-04T13:41:15.795508Z","end":"2026-10-04T13:41:16.016804Z","steps":["trace[1712611592] 'process raft request'  (duration: 220.968451ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:41:16.016824Z","caller":"traceutil/trace.go:171","msg":"trace[1434772868] transaction","detail":"{read_only:false; response_revision:25803; number_of_response:1; }","duration":"221.871652ms","start":"2026-10-04T13:41:15.794924Z","end":"2026-10-04T13:41:16.016796Z","steps":["trace[1434772868] 'process raft request'  (duration: 221.464372ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:41:16.016863Z","caller":"traceutil/trace.go:171","msg":"trace[1919418440] linearizableReadLoop","detail":"{readStateIndex:26650; appliedIndex:26649; }","duration":"227.356098ms","start":"2026-10-04T13:41:15.789449Z","end":"2026-10-04T13:41:16.016805Z","steps":["trace[1919418440] 'read index received'  (duration: 78.398126ms)","trace[1919418440] 'applied index is now lower than readState.Index'  (duration: 148.952192ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T13:41:16.017097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.902811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/magnum-system/\" range_end:\"/registry/endpointslices/magnum-system0\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-04T13:41:16.017133Z","caller":"traceutil/trace.go:171","msg":"trace[194654076] range","detail":"{range_begin:/registry/endpointslices/magnum-system/; range_end:/registry/endpointslices/magnum-system0; response_count:0; response_revision:25805; }","duration":"221.986723ms","start":"2026-10-04T13:41:15.795137Z","end":"2026-10-04T13:41:16.017124Z","steps":["trace[194654076] 'agreement among raft nodes before linearized reading'  (duration: 221.895021ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:41:16.017108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.915079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/openstack/default\" ","response":"range_response_count:1 size:176"}
{"level":"warn","ts":"2026-10-04T13:41:16.01713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.202443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-04T13:41:16.017208Z","caller":"traceutil/trace.go:171","msg":"trace[115604293] range","detail":"{range_begin:/registry/serviceaccounts/openstack/default; range_end:; response_count:1; response_revision:25805; }","duration":"154.045992ms","start":"2026-10-04T13:41:15.863122Z","end":"2026-10-04T13:41:16.017168Z","steps":["trace[115604293] 'agreement among raft nodes before linearized reading'  (duration: 153.90239ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:41:16.017216Z","caller":"traceutil/trace.go:171","msg":"trace[255871882] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25805; }","duration":"225.338705ms","start":"2026-10-04T13:41:15.791861Z","end":"2026-10-04T13:41:16.0172Z","steps":["trace[255871882] 'agreement among raft nodes before linearized reading'  (duration: 225.166852ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:41:16.01716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.403472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"}
{"level":"info","ts":"2026-10-04T13:41:16.0173Z","caller":"traceutil/trace.go:171","msg":"trace[970611154] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25805; }","duration":"309.551155ms","start":"2026-10-04T13:41:15.707718Z","end":"2026-10-04T13:41:16.017269Z","steps":["trace[970611154] 'agreement among raft nodes before linearized reading'  (duration: 309.206308ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:41:16.017368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:41:15.707662Z","time spent":"309.689559ms","remote":"127.0.0.1:40706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":582,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"info","ts":"2026-10-04T13:41:16.194424Z","caller":"traceutil/trace.go:171","msg":"trace[72233812] linearizableReadLoop","detail":"{readStateIndex:26654; appliedIndex:26653; }","duration":"156.248039ms","start":"2026-10-04T13:41:16.038146Z","end":"2026-10-04T13:41:16.194394Z","steps":["trace[72233812] 'read index received'  (duration: 156.110597ms)","trace[72233812] 'applied index is now lower than readState.Index'  (duration: 136.192µs)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:41:16.19447Z","caller":"traceutil/trace.go:171","msg":"trace[2036296403] transaction","detail":"{read_only:false; response_revision:25806; number_of_response:1; }","duration":"172.890438ms","start":"2026-10-04T13:41:16.021551Z","end":"2026-10-04T13:41:16.194441Z","steps":["trace[2036296403] 'process raft request'  (duration: 172.668593ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:41:16.194578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.400183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/magnum-system/\" range_end:\"/registry/endpointslices/magnum-system0\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-04T13:41:16.194624Z","caller":"traceutil/trace.go:171","msg":"trace[1999576911] range","detail":"{range_begin:/registry/endpointslices/magnum-system/; range_end:/registry/endpointslices/magnum-system0; response_count:0; response_revision:25806; }","duration":"156.517145ms","start":"2026-10-04T13:41:16.038094Z","end":"2026-10-04T13:41:16.194611Z","steps":["trace[1999576911] 'agreement among raft nodes before linearized reading'  (duration: 156.404663ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:41:16.336993Z","caller":"traceutil/trace.go:171","msg":"trace[1542437677] transaction","detail":"{read_only:false; response_revision:25807; number_of_response:1; }","duration":"169.951243ms","start":"2026-10-04T13:41:16.167016Z","end":"2026-10-04T13:41:16.336967Z","steps":["trace[1542437677] 'process raft request'  (duration: 169.79618ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:41:16.371329Z","caller":"traceutil/trace.go:171","msg":"trace[1633362062] transaction","detail":"{read_only:false; response_revision:25808; number_of_response:1; }","duration":"153.017279ms","start":"2026-10-04T13:41:16.218291Z","end":"2026-10-04T13:41:16.371308Z","steps":["trace[1633362062] 'process raft request'  (duration: 152.879117ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:41:19.188639Z","caller":"traceutil/trace.go:171","msg":"trace[2083263631] linearizableReadLoop","detail":"{readStateIndex:26674; appliedIndex:26673; }","duration":"111.771013ms","start":"2026-10-04T13:41:19.076833Z","end":"2026-10-04T13:41:19.188604Z","steps":["trace[2083263631] 'read index received'  (duration: 20.534921ms)","trace[2083263631] 'applied index is now lower than readState.Index'  (duration: 91.233602ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T13:41:19.188779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.917477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstores/\" range_end:\"/registry/ceph.rook.io/cephobjectstores0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-10-04T13:41:19.18882Z","caller":"traceutil/trace.go:171","msg":"trace[1413924247] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstores/; range_end:/registry/ceph.rook.io/cephobjectstores0; response_count:0; response_revision:25825; }","duration":"112.029638ms","start":"2026-10-04T13:41:19.076777Z","end":"2026-10-04T13:41:19.188806Z","steps":["trace[1413924247] 'agreement among raft nodes before linearized reading'  (duration: 111.930707ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:41:23.98574Z","caller":"traceutil/trace.go:171","msg":"trace[1787659451] transaction","detail":"{read_only:false; response_revision:25862; number_of_response:1; }","duration":"106.583263ms","start":"2026-10-04T13:41:23.879139Z","end":"2026-10-04T13:41:23.985723Z","steps":["trace[1787659451] 'process raft request'  (duration: 101.751958ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:41:24.185578Z","caller":"traceutil/trace.go:171","msg":"trace[338580607] transaction","detail":"{read_only:false; response_revision:25863; number_of_response:1; }","duration":"125.013938ms","start":"2026-10-04T13:41:24.060534Z","end":"2026-10-04T13:41:24.185548Z","steps":["trace[338580607] 'process raft request'  (duration: 68.305978ms)","trace[338580607] 'compare'  (duration: 56.577427ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:41:24.197621Z","caller":"traceutil/trace.go:171","msg":"trace[951271277] transaction","detail":"{read_only:false; response_revision:25864; number_of_response:1; }","duration":"134.39815ms","start":"2026-10-04T13:41:24.063205Z","end":"2026-10-04T13:41:24.197603Z","steps":["trace[951271277] 'process raft request'  (duration: 133.864008ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:41:24.197736Z","caller":"traceutil/trace.go:171","msg":"trace[1649624950] transaction","detail":"{read_only:false; response_revision:25865; number_of_response:1; }","duration":"134.500612ms","start":"2026-10-04T13:41:24.063229Z","end":"2026-10-04T13:41:24.19773Z","steps":["trace[1649624950] 'process raft request'  (duration: 133.93618ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:41:24.197813Z","caller":"traceutil/trace.go:171","msg":"trace[502854236] transaction","detail":"{read_only:false; response_revision:25866; number_of_response:1; }","duration":"134.549254ms","start":"2026-10-04T13:41:24.063258Z","end":"2026-10-04T13:41:24.197807Z","steps":["trace[502854236] 'process raft request'  (duration: 133.94584ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:41:24.197888Z","caller":"traceutil/trace.go:171","msg":"trace[1333439007] transaction","detail":"{read_only:false; response_revision:25867; number_of_response:1; }","duration":"134.551393ms","start":"2026-10-04T13:41:24.063329Z","end":"2026-10-04T13:41:24.19788Z","steps":["trace[1333439007] 'process raft request'  (duration: 133.907109ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:41:24.420296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.059579ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2531481516851558587 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:25851 > 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\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-04T13:41:24.42041Z","caller":"traceutil/trace.go:171","msg":"trace[309402921] transaction","detail":"{read_only:false; response_revision:25868; number_of_response:1; }","duration":"187.161514ms","start":"2026-10-04T13:41:24.233229Z","end":"2026-10-04T13:41:24.420391Z","steps":["trace[309402921] 'process raft request'  (duration: 68.926873ms)","trace[309402921] 'compare'  (duration: 117.816543ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:41:29.941003Z","caller":"traceutil/trace.go:171","msg":"trace[16384465] transaction","detail":"{read_only:false; response_revision:25902; number_of_response:1; }","duration":"106.436239ms","start":"2026-10-04T13:41:29.834549Z","end":"2026-10-04T13:41:29.940985Z","steps":["trace[16384465] 'process raft request'  (duration: 106.322576ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:41:29.942443Z","caller":"traceutil/trace.go:171","msg":"trace[1453854274] transaction","detail":"{read_only:false; response_revision:25903; number_of_response:1; }","duration":"104.416256ms","start":"2026-10-04T13:41:29.838004Z","end":"2026-10-04T13:41:29.94242Z","steps":["trace[1453854274] 'process raft request'  (duration: 104.312474ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:41:35.899788Z","caller":"traceutil/trace.go:171","msg":"trace[294863469] transaction","detail":"{read_only:false; response_revision:25947; number_of_response:1; }","duration":"136.856033ms","start":"2026-10-04T13:41:35.762907Z","end":"2026-10-04T13:41:35.899763Z","steps":["trace[294863469] 'process raft request'  (duration: 136.690849ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:41:36.067294Z","caller":"traceutil/trace.go:171","msg":"trace[1529850534] transaction","detail":"{read_only:false; response_revision:25948; number_of_response:1; }","duration":"109.801241ms","start":"2026-10-04T13:41:35.957467Z","end":"2026-10-04T13:41:36.067268Z","steps":["trace[1529850534] 'process raft request'  (duration: 46.271095ms)","trace[1529850534] 'compare'  (duration: 63.26531ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:41:36.067504Z","caller":"traceutil/trace.go:171","msg":"trace[1211347006] transaction","detail":"{read_only:false; response_revision:25949; number_of_response:1; }","duration":"107.168305ms","start":"2026-10-04T13:41:35.960304Z","end":"2026-10-04T13:41:36.067473Z","steps":["trace[1211347006] 'process raft request'  (duration: 106.867308ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:41:36.391005Z","caller":"traceutil/trace.go:171","msg":"trace[1313248985] transaction","detail":"{read_only:false; response_revision:25950; number_of_response:1; }","duration":"126.07705ms","start":"2026-10-04T13:41:36.264905Z","end":"2026-10-04T13:41:36.390982Z","steps":["trace[1313248985] 'process raft request'  (duration: 125.935237ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:41:36.394901Z","caller":"traceutil/trace.go:171","msg":"trace[81638690] linearizableReadLoop","detail":"{readStateIndex:26803; appliedIndex:26801; }","duration":"126.327626ms","start":"2026-10-04T13:41:36.268544Z","end":"2026-10-04T13:41:36.394872Z","steps":["trace[81638690] 'read index received'  (duration: 122.387982ms)","trace[81638690] 'applied index is now lower than readState.Index'  (duration: 3.938254ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:41:36.395038Z","caller":"traceutil/trace.go:171","msg":"trace[2110933545] transaction","detail":"{read_only:false; response_revision:25951; number_of_response:1; }","duration":"130.064886ms","start":"2026-10-04T13:41:36.264942Z","end":"2026-10-04T13:41:36.395007Z","steps":["trace[2110933545] 'process raft request'  (duration: 129.600166ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:41:36.395337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.758335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/magnum-system/\" range_end:\"/registry/endpointslices/magnum-system0\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-04T13:41:36.395432Z","caller":"traceutil/trace.go:171","msg":"trace[896370722] range","detail":"{range_begin:/registry/endpointslices/magnum-system/; range_end:/registry/endpointslices/magnum-system0; response_count:0; response_revision:25951; }","duration":"126.873977ms","start":"2026-10-04T13:41:36.268539Z","end":"2026-10-04T13:41:36.395413Z","steps":["trace[896370722] 'agreement among raft nodes before linearized reading'  (duration: 126.474609ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:41:36.395539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.181368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-10-04T13:41:36.395615Z","caller":"traceutil/trace.go:171","msg":"trace[1954286052] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25951; }","duration":"116.306741ms","start":"2026-10-04T13:41:36.279289Z","end":"2026-10-04T13:41:36.395596Z","steps":["trace[1954286052] 'agreement among raft nodes before linearized reading'  (duration: 115.80392ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:41:36.396283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.419633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-10-04T13:41:36.396346Z","caller":"traceutil/trace.go:171","msg":"trace[234090875] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25951; }","duration":"123.513516ms","start":"2026-10-04T13:41:36.272814Z","end":"2026-10-04T13:41:36.396328Z","steps":["trace[234090875] 'agreement among raft nodes before linearized reading'  (duration: 122.215038ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:41:36.579146Z","caller":"traceutil/trace.go:171","msg":"trace[454094504] linearizableReadLoop","detail":"{readStateIndex:26805; appliedIndex:26803; }","duration":"177.613489ms","start":"2026-10-04T13:41:36.401512Z","end":"2026-10-04T13:41:36.579126Z","steps":["trace[454094504] 'read index received'  (duration: 54.756168ms)","trace[454094504] 'applied index is now lower than readState.Index'  (duration: 122.856161ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T13:41:36.579313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.783353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/magnum-system/\" range_end:\"/registry/endpointslices/magnum-system0\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-04T13:41:36.579352Z","caller":"traceutil/trace.go:171","msg":"trace[956125687] range","detail":"{range_begin:/registry/endpointslices/magnum-system/; range_end:/registry/endpointslices/magnum-system0; response_count:0; response_revision:25953; }","duration":"177.878424ms","start":"2026-10-04T13:41:36.401463Z","end":"2026-10-04T13:41:36.579342Z","steps":["trace[956125687] 'agreement among raft nodes before linearized reading'  (duration: 177.779542ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:41:36.57963Z","caller":"traceutil/trace.go:171","msg":"trace[1888683224] transaction","detail":"{read_only:false; response_revision:25953; number_of_response:1; }","duration":"178.56754ms","start":"2026-10-04T13:41:36.401048Z","end":"2026-10-04T13:41:36.579616Z","steps":["trace[1888683224] 'process raft request'  (duration: 177.953267ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:41:36.626262Z","caller":"traceutil/trace.go:171","msg":"trace[2070752541] transaction","detail":"{read_only:false; response_revision:25954; number_of_response:1; }","duration":"125.901617ms","start":"2026-10-04T13:41:36.500343Z","end":"2026-10-04T13:41:36.626245Z","steps":["trace[2070752541] 'process raft request'  (duration: 125.752104ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:41:36.626447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.094432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-04T13:41:36.626844Z","caller":"traceutil/trace.go:171","msg":"trace[1464952576] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25955; }","duration":"160.534182ms","start":"2026-10-04T13:41:36.466296Z","end":"2026-10-04T13:41:36.62683Z","steps":["trace[1464952576] 'agreement among raft nodes before linearized reading'  (duration: 160.095802ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:41:36.626668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.012416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"}
{"level":"info","ts":"2026-10-04T13:41:36.626987Z","caller":"traceutil/trace.go:171","msg":"trace[1893882086] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25955; }","duration":"157.340293ms","start":"2026-10-04T13:41:36.469614Z","end":"2026-10-04T13:41:36.626954Z","steps":["trace[1893882086] 'agreement among raft nodes before linearized reading'  (duration: 156.891653ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:41:36.848761Z","caller":"traceutil/trace.go:171","msg":"trace[1819723196] transaction","detail":"{read_only:false; response_revision:25956; number_of_response:1; }","duration":"126.991861ms","start":"2026-10-04T13:41:36.721742Z","end":"2026-10-04T13:41:36.848734Z","steps":["trace[1819723196] 'process raft request'  (duration: 56.699429ms)","trace[1819723196] 'compare'  (duration: 69.541536ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:42:00.749527Z","caller":"traceutil/trace.go:171","msg":"trace[1387311355] transaction","detail":"{read_only:false; response_revision:26278; number_of_response:1; }","duration":"128.86249ms","start":"2026-10-04T13:42:00.620634Z","end":"2026-10-04T13:42:00.749497Z","steps":["trace[1387311355] 'process raft request'  (duration: 128.745108ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:42:00.749726Z","caller":"traceutil/trace.go:171","msg":"trace[486393904] transaction","detail":"{read_only:false; response_revision:26277; number_of_response:1; }","duration":"130.74243ms","start":"2026-10-04T13:42:00.618947Z","end":"2026-10-04T13:42:00.749689Z","steps":["trace[486393904] 'process raft request'  (duration: 39.765995ms)","trace[486393904] 'compare'  (duration: 90.384963ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:42:00.834916Z","caller":"traceutil/trace.go:171","msg":"trace[564436948] transaction","detail":"{read_only:false; response_revision:26279; number_of_response:1; }","duration":"154.307438ms","start":"2026-10-04T13:42:00.680588Z","end":"2026-10-04T13:42:00.834895Z","steps":["trace[564436948] 'process raft request'  (duration: 154.112054ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:42:00.835236Z","caller":"traceutil/trace.go:171","msg":"trace[1355244329] transaction","detail":"{read_only:false; response_revision:26280; number_of_response:1; }","duration":"106.911658ms","start":"2026-10-04T13:42:00.728285Z","end":"2026-10-04T13:42:00.835197Z","steps":["trace[1355244329] 'process raft request'  (duration: 106.569881ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:42:00.835425Z","caller":"traceutil/trace.go:171","msg":"trace[2125781326] linearizableReadLoop","detail":"{readStateIndex:27138; appliedIndex:27135; }","duration":"143.060876ms","start":"2026-10-04T13:42:00.692353Z","end":"2026-10-04T13:42:00.835413Z","steps":["trace[2125781326] 'read index received'  (duration: 47.564272ms)","trace[2125781326] 'applied index is now lower than readState.Index'  (duration: 95.495564ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:42:00.835523Z","caller":"traceutil/trace.go:171","msg":"trace[173470345] transaction","detail":"{read_only:false; response_revision:26281; number_of_response:1; }","duration":"102.506904ms","start":"2026-10-04T13:42:00.733003Z","end":"2026-10-04T13:42:00.83551Z","steps":["trace[173470345] 'process raft request'  (duration: 102.126276ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:42:00.835691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.119108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/bindings/\" range_end:\"/registry/rabbitmq.com/bindings0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-04T13:42:00.835758Z","caller":"traceutil/trace.go:171","msg":"trace[447159744] range","detail":"{range_begin:/registry/rabbitmq.com/bindings/; range_end:/registry/rabbitmq.com/bindings0; response_count:0; response_revision:26281; }","duration":"137.24718ms","start":"2026-10-04T13:42:00.698493Z","end":"2026-10-04T13:42:00.83574Z","steps":["trace[447159744] 'agreement among raft nodes before linearized reading'  (duration: 137.128948ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:42:00.835806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.434644ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"info","ts":"2026-10-04T13:42:00.835889Z","caller":"traceutil/trace.go:171","msg":"trace[701328682] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26281; }","duration":"143.555637ms","start":"2026-10-04T13:42:00.692314Z","end":"2026-10-04T13:42:00.83587Z","steps":["trace[701328682] 'agreement among raft nodes before linearized reading'  (duration: 143.359453ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:42:00.976505Z","caller":"traceutil/trace.go:171","msg":"trace[1420552786] transaction","detail":"{read_only:false; response_revision:26282; number_of_response:1; }","duration":"136.525835ms","start":"2026-10-04T13:42:00.839952Z","end":"2026-10-04T13:42:00.976477Z","steps":["trace[1420552786] 'process raft request'  (duration: 136.321261ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:43:17.351103Z","caller":"traceutil/trace.go:171","msg":"trace[479124781] linearizableReadLoop","detail":"{readStateIndex:27806; appliedIndex:27804; }","duration":"132.672983ms","start":"2026-10-04T13:43:17.2184Z","end":"2026-10-04T13:43:17.351073Z","steps":["trace[479124781] 'read index received'  (duration: 48.81155ms)","trace[479124781] 'applied index is now lower than readState.Index'  (duration: 83.860193ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:43:17.351388Z","caller":"traceutil/trace.go:171","msg":"trace[1711479782] transaction","detail":"{read_only:false; response_revision:26931; number_of_response:1; }","duration":"140.777197ms","start":"2026-10-04T13:43:17.210574Z","end":"2026-10-04T13:43:17.351352Z","steps":["trace[1711479782] 'process raft request'  (duration: 113.01912ms)","trace[1711479782] 'compare'  (duration: 27.330037ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T13:43:17.351441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.0226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-10-04T13:43:17.351507Z","caller":"traceutil/trace.go:171","msg":"trace[167912309] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26931; }","duration":"133.135513ms","start":"2026-10-04T13:43:17.218355Z","end":"2026-10-04T13:43:17.351491Z","steps":["trace[167912309] 'agreement among raft nodes before linearized reading'  (duration: 132.938239ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:43:39.645794Z","caller":"traceutil/trace.go:171","msg":"trace[1078504701] transaction","detail":"{read_only:false; response_revision:27138; number_of_response:1; }","duration":"160.800138ms","start":"2026-10-04T13:43:39.484968Z","end":"2026-10-04T13:43:39.645768Z","steps":["trace[1078504701] 'process raft request'  (duration: 73.150583ms)","trace[1078504701] 'compare'  (duration: 87.556742ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:43:40.202427Z","caller":"traceutil/trace.go:171","msg":"trace[1619666841] transaction","detail":"{read_only:false; response_revision:27139; number_of_response:1; }","duration":"480.45447ms","start":"2026-10-04T13:43:39.721929Z","end":"2026-10-04T13:43:40.202383Z","steps":["trace[1619666841] 'process raft request'  (duration: 475.458712ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:43:40.202516Z","caller":"traceutil/trace.go:171","msg":"trace[1544168436] linearizableReadLoop","detail":"{readStateIndex:28019; appliedIndex:28018; }","duration":"419.464888ms","start":"2026-10-04T13:43:39.783004Z","end":"2026-10-04T13:43:40.202469Z","steps":["trace[1544168436] 'read index received'  (duration: 414.295007ms)","trace[1544168436] 'applied index is now lower than readState.Index'  (duration: 5.166481ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:43:40.202555Z","caller":"traceutil/trace.go:171","msg":"trace[373270077] transaction","detail":"{read_only:false; response_revision:27140; number_of_response:1; }","duration":"108.181066ms","start":"2026-10-04T13:43:40.094343Z","end":"2026-10-04T13:43:40.202524Z","steps":["trace[373270077] 'process raft request'  (duration: 108.036993ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:40.202599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:43:39.721912Z","time spent":"480.599973ms","remote":"127.0.0.1:40706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:27124 > 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-04T13:43:40.202735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.955949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-user\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-10-04T13:43:40.202758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.017567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-user\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-04T13:43:40.202783Z","caller":"traceutil/trace.go:171","msg":"trace[2135935744] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-user; range_end:; response_count:0; response_revision:27141; }","duration":"386.057471ms","start":"2026-10-04T13:43:39.816714Z","end":"2026-10-04T13:43:40.202771Z","steps":["trace[2135935744] 'agreement among raft nodes before linearized reading'  (duration: 385.940878ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:40.202822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.098161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-user\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-10-04T13:43:40.202825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:43:39.816704Z","time spent":"386.112871ms","remote":"127.0.0.1:40674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":0,"response size":30,"request content":"key:\"/registry/jobs/openstack/manila-ks-user\" "}
{"level":"info","ts":"2026-10-04T13:43:40.202828Z","caller":"traceutil/trace.go:171","msg":"trace[1119220434] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-user; range_end:; response_count:0; response_revision:27141; }","duration":"225.162181ms","start":"2026-10-04T13:43:39.977648Z","end":"2026-10-04T13:43:40.20281Z","steps":["trace[1119220434] 'agreement among raft nodes before linearized reading'  (duration: 225.016357ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:43:40.202865Z","caller":"traceutil/trace.go:171","msg":"trace[318687243] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-user; range_end:; response_count:0; response_revision:27141; }","duration":"226.173553ms","start":"2026-10-04T13:43:39.976681Z","end":"2026-10-04T13:43:40.202855Z","steps":["trace[318687243] 'agreement among raft nodes before linearized reading'  (duration: 226.103361ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:40.202898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.500097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-endpoints\" ","response":"range_response_count:1 size:21431"}
{"level":"warn","ts":"2026-10-04T13:43:40.202926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.694349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-glance-server-0\" ","response":"range_response_count:1 size:1858"}
{"level":"warn","ts":"2026-10-04T13:43:40.202991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.95858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"}
{"level":"info","ts":"2026-10-04T13:43:40.202993Z","caller":"traceutil/trace.go:171","msg":"trace[130688598] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-endpoints; range_end:; response_count:1; response_revision:27141; }","duration":"383.585188ms","start":"2026-10-04T13:43:39.819373Z","end":"2026-10-04T13:43:40.202958Z","steps":["trace[130688598] 'agreement among raft nodes before linearized reading'  (duration: 383.386394ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:40.203056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:43:39.819352Z","time spent":"383.69103ms","remote":"127.0.0.1:40674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":21455,"request content":"key:\"/registry/jobs/openstack/manila-ks-endpoints\" "}
{"level":"info","ts":"2026-10-04T13:43:40.203061Z","caller":"traceutil/trace.go:171","msg":"trace[1487161332] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-glance-server-0; range_end:; response_count:1; response_revision:27141; }","duration":"382.865581ms","start":"2026-10-04T13:43:39.820149Z","end":"2026-10-04T13:43:40.203015Z","steps":["trace[1487161332] 'agreement among raft nodes before linearized reading'  (duration: 382.594515ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:40.203062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.09692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-endpoints\" ","response":"range_response_count:1 size:21431"}
{"level":"info","ts":"2026-10-04T13:43:40.203113Z","caller":"traceutil/trace.go:171","msg":"trace[1200772987] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-endpoints; range_end:; response_count:1; response_revision:27141; }","duration":"212.177693ms","start":"2026-10-04T13:43:39.990922Z","end":"2026-10-04T13:43:40.2031Z","steps":["trace[1200772987] 'agreement among raft nodes before linearized reading'  (duration: 212.033239ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:40.203106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:43:39.820123Z","time spent":"382.971734ms","remote":"127.0.0.1:40582","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":1,"response size":1882,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-glance-server-0\" "}
{"level":"warn","ts":"2026-10-04T13:43:40.203143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.959897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-endpoints\" ","response":"range_response_count:1 size:21431"}
{"level":"info","ts":"2026-10-04T13:43:40.203237Z","caller":"traceutil/trace.go:171","msg":"trace[67492998] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-endpoints; range_end:; response_count:1; response_revision:27141; }","duration":"212.063169ms","start":"2026-10-04T13:43:39.991136Z","end":"2026-10-04T13:43:40.203199Z","steps":["trace[67492998] 'agreement among raft nodes before linearized reading'  (duration: 211.767072ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:40.203148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.045385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-10-04T13:43:40.203312Z","caller":"traceutil/trace.go:171","msg":"trace[2006428124] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:27141; }","duration":"420.073903ms","start":"2026-10-04T13:43:39.78296Z","end":"2026-10-04T13:43:40.203033Z","steps":["trace[2006428124] 'agreement among raft nodes before linearized reading'  (duration: 419.672875ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:40.203387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:43:39.782939Z","time spent":"420.429689ms","remote":"127.0.0.1:40706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":582,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"info","ts":"2026-10-04T13:43:40.203564Z","caller":"traceutil/trace.go:171","msg":"trace[384855139] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:27141; }","duration":"270.260691ms","start":"2026-10-04T13:43:39.933049Z","end":"2026-10-04T13:43:40.20331Z","steps":["trace[384855139] 'agreement among raft nodes before linearized reading'  (duration: 269.801051ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:45:40.448486Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25445}
{"level":"info","ts":"2026-10-04T13:45:40.625433Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25445,"took":"173.617779ms","hash":2392758181,"current-db-size-bytes":58343424,"current-db-size":"58 MB","current-db-size-in-use-bytes":36139008,"current-db-size-in-use":"36 MB"}
{"level":"info","ts":"2026-10-04T13:45:40.625506Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2392758181,"revision":25445,"compact-revision":22024}
{"level":"info","ts":"2026-10-04T13:47:09.030158Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"adb6690514c92321","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-10-04T13:47:09.038566Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003}
{"level":"info","ts":"2026-10-04T13:47:09.038658Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}
{"level":"info","ts":"2026-10-04T13:50:40.456534Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28405}
{"level":"info","ts":"2026-10-04T13:50:40.611351Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28405,"took":"150.004741ms","hash":3707429460,"current-db-size-bytes":58343424,"current-db-size":"58 MB","current-db-size-in-use-bytes":31576064,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-10-04T13:50:40.611448Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3707429460,"revision":28405,"compact-revision":25445}
{"level":"info","ts":"2026-10-04T13:55:40.467164Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30648}
{"level":"info","ts":"2026-10-04T13:55:40.591611Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30648,"took":"120.084857ms","hash":3169416573,"current-db-size-bytes":58343424,"current-db-size":"58 MB","current-db-size-in-use-bytes":32591872,"current-db-size-in-use":"33 MB"}
{"level":"info","ts":"2026-10-04T13:55:40.591674Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3169416573,"revision":30648,"compact-revision":28405}
{"level":"info","ts":"2026-10-04T14:00:40.474213Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32911}
{"level":"info","ts":"2026-10-04T14:00:40.649016Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32911,"took":"170.650033ms","hash":1994773415,"current-db-size-bytes":59387904,"current-db-size":"59 MB","current-db-size-in-use-bytes":31772672,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-10-04T14:00:40.649088Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1994773415,"revision":32911,"compact-revision":30648}
{"level":"info","ts":"2026-10-04T14:05:40.484754Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35202}
{"level":"info","ts":"2026-10-04T14:05:40.668066Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35202,"took":"179.40658ms","hash":2967042140,"current-db-size-bytes":59826176,"current-db-size":"60 MB","current-db-size-in-use-bytes":33828864,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-10-04T14:05:40.668133Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2967042140,"revision":35202,"compact-revision":32911}
{"level":"info","ts":"2026-10-04T14:08:27.201409Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"adb6690514c92321","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-10-04T14:08:27.208728Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004}
{"level":"info","ts":"2026-10-04T14:08:27.208852Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004}
{"level":"info","ts":"2026-10-04T14:10:40.490704Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37530}
{"level":"info","ts":"2026-10-04T14:10:40.629112Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37530,"took":"133.794561ms","hash":132732126,"current-db-size-bytes":60252160,"current-db-size":"60 MB","current-db-size-in-use-bytes":33497088,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-10-04T14:10:40.629181Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":132732126,"revision":37530,"compact-revision":35202}