{"level":"warn","ts":"2026-08-16T12:51:09.177962Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-08-16T12:51:09.178054Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.238:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.238:2380","--initial-cluster=instance=https://199.204.45.238:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.238:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.238: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-08-16T12:51:09.178114Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-08-16T12:51:09.178122Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.238:2380"]}
{"level":"info","ts":"2026-08-16T12:51:09.178137Z","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-08-16T12:51:09.178734Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.238:2379"]}
{"level":"info","ts":"2026-08-16T12:51:09.178805Z","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://199.204.45.238:2380"],"listen-peer-urls":["https://199.204.45.238:2380"],"advertise-client-urls":["https://199.204.45.238:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.238:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.238: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-08-16T12:51:09.182321Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.312437ms"}
{"level":"info","ts":"2026-08-16T12:51:09.187391Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d7dbc9f5893cc1f6","cluster-id":"823d1d08ab21430c"}
{"level":"info","ts":"2026-08-16T12:51:09.187512Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 switched to configuration voters=()"}
{"level":"info","ts":"2026-08-16T12:51:09.187573Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became follower at term 0"}
{"level":"info","ts":"2026-08-16T12:51:09.187589Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d7dbc9f5893cc1f6 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-08-16T12:51:09.187606Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became follower at term 1"}
{"level":"info","ts":"2026-08-16T12:51:09.187659Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 switched to configuration voters=(15554247794460770806)"}
{"level":"warn","ts":"2026-08-16T12:51:09.192862Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-08-16T12:51:09.1945Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-08-16T12:51:09.195615Z","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-08-16T12:51:09.198546Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d7dbc9f5893cc1f6","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-08-16T12:51:09.198788Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d7dbc9f5893cc1f6","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-08-16T12:51:09.198851Z","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-08-16T12:51:09.198988Z","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-08-16T12:51:09.199007Z","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-08-16T12:51:09.20146Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 switched to configuration voters=(15554247794460770806)"}
{"level":"info","ts":"2026-08-16T12:51:09.201635Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"823d1d08ab21430c","local-member-id":"d7dbc9f5893cc1f6","added-peer-id":"d7dbc9f5893cc1f6","added-peer-peer-urls":["https://199.204.45.238:2380"]}
{"level":"info","ts":"2026-08-16T12:51:09.203736Z","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-08-16T12:51:09.20389Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.238:2380"}
{"level":"info","ts":"2026-08-16T12:51:09.204043Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.238:2380"}
{"level":"info","ts":"2026-08-16T12:51:09.203939Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d7dbc9f5893cc1f6","initial-advertise-peer-urls":["https://199.204.45.238:2380"],"listen-peer-urls":["https://199.204.45.238:2380"],"advertise-client-urls":["https://199.204.45.238:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.238:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-08-16T12:51:09.203976Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-08-16T12:51:09.688677Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 is starting a new election at term 1"}
{"level":"info","ts":"2026-08-16T12:51:09.68873Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became pre-candidate at term 1"}
{"level":"info","ts":"2026-08-16T12:51:09.688761Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 received MsgPreVoteResp from d7dbc9f5893cc1f6 at term 1"}
{"level":"info","ts":"2026-08-16T12:51:09.688773Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became candidate at term 2"}
{"level":"info","ts":"2026-08-16T12:51:09.688783Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 received MsgVoteResp from d7dbc9f5893cc1f6 at term 2"}
{"level":"info","ts":"2026-08-16T12:51:09.688791Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became leader at term 2"}
{"level":"info","ts":"2026-08-16T12:51:09.688799Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d7dbc9f5893cc1f6 elected leader d7dbc9f5893cc1f6 at term 2"}
{"level":"info","ts":"2026-08-16T12:51:09.696752Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-16T12:51:09.701049Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d7dbc9f5893cc1f6","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.238:2379]}","request-path":"/0/members/d7dbc9f5893cc1f6/attributes","cluster-id":"823d1d08ab21430c","publish-timeout":"7s"}
{"level":"info","ts":"2026-08-16T12:51:09.701151Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-08-16T12:51:09.701358Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-08-16T12:51:09.701398Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-08-16T12:51:09.701265Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-08-16T12:51:09.703209Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-08-16T12:51:09.705112Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.238:2379"}
{"level":"info","ts":"2026-08-16T12:51:09.705158Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"823d1d08ab21430c","local-member-id":"d7dbc9f5893cc1f6","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-16T12:51:09.708855Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-16T12:51:09.708912Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-16T12:51:51.850118Z","caller":"traceutil/trace.go:171","msg":"trace[898008812] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"120.897919ms","start":"2026-08-16T12:51:51.729179Z","end":"2026-08-16T12:51:51.850077Z","steps":["trace[898008812] 'process raft request'  (duration: 120.609293ms)"],"step_count":1}
{"level":"info","ts":"2026-08-16T12:51:52.089262Z","caller":"traceutil/trace.go:171","msg":"trace[1605895725] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"221.260261ms","start":"2026-08-16T12:51:51.867955Z","end":"2026-08-16T12:51:52.089215Z","steps":["trace[1605895725] 'process raft request'  (duration: 164.892254ms)","trace[1605895725] 'compare'  (duration: 56.141211ms)"],"step_count":2}
{"level":"info","ts":"2026-08-16T12:51:52.08937Z","caller":"traceutil/trace.go:171","msg":"trace[2042187468] linearizableReadLoop","detail":"{readStateIndex:630; appliedIndex:628; }","duration":"160.963585ms","start":"2026-08-16T12:51:51.928385Z","end":"2026-08-16T12:51:52.089349Z","steps":["trace[2042187468] 'read index received'  (duration: 104.482735ms)","trace[2042187468] 'applied index is now lower than readState.Index'  (duration: 56.47881ms)"],"step_count":2}
{"level":"info","ts":"2026-08-16T12:51:52.089514Z","caller":"traceutil/trace.go:171","msg":"trace[652622223] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"198.12541ms","start":"2026-08-16T12:51:51.891367Z","end":"2026-08-16T12:51:52.089492Z","steps":["trace[652622223] 'process raft request'  (duration: 197.788153ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-16T12:51:52.092529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.128008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-16T12:51:52.092628Z","caller":"traceutil/trace.go:171","msg":"trace[1650193767] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:609; }","duration":"164.267442ms","start":"2026-08-16T12:51:51.928345Z","end":"2026-08-16T12:51:52.092613Z","steps":["trace[1650193767] 'agreement among raft nodes before linearized reading'  (duration: 161.062747ms)"],"step_count":1}
{"level":"info","ts":"2026-08-16T12:51:52.55384Z","caller":"traceutil/trace.go:171","msg":"trace[601250272] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"304.325179ms","start":"2026-08-16T12:51:52.249451Z","end":"2026-08-16T12:51:52.553776Z","steps":["trace[601250272] 'process raft request'  (duration: 303.677617ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-16T12:51:52.554411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-16T12:51:52.249412Z","time spent":"304.546114ms","remote":"127.0.0.1:35622","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" mod_revision:605 > success:<request_put:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" value_size:1036201 >> failure:<request_range:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" > >"}
{"level":"warn","ts":"2026-08-16T12:52:07.00795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.144656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-9lp9d\" ","response":"range_response_count:1 size:3965"}
{"level":"info","ts":"2026-08-16T12:52:07.008048Z","caller":"traceutil/trace.go:171","msg":"trace[816034569] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-9lp9d; range_end:; response_count:1; response_revision:765; }","duration":"157.306639ms","start":"2026-08-16T12:52:06.850716Z","end":"2026-08-16T12:52:07.008022Z","steps":["trace[816034569] 'range keys from in-memory index tree'  (duration: 156.389151ms)"],"step_count":1}
{"level":"info","ts":"2026-08-16T12:53:18.845841Z","caller":"traceutil/trace.go:171","msg":"trace[106258432] transaction","detail":"{read_only:false; response_revision:1826; number_of_response:1; }","duration":"257.690878ms","start":"2026-08-16T12:53:18.588102Z","end":"2026-08-16T12:53:18.845793Z","steps":["trace[106258432] 'process raft request'  (duration: 257.377411ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-16T12:53:18.846249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.283143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-25879532-02ec-4eed-baa1-c444124b097e\" ","response":"range_response_count:1 size:3627"}
{"level":"info","ts":"2026-08-16T12:53:18.846345Z","caller":"traceutil/trace.go:171","msg":"trace[324806671] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-25879532-02ec-4eed-baa1-c444124b097e; range_end:; response_count:1; response_revision:1826; }","duration":"167.433546ms","start":"2026-08-16T12:53:18.678892Z","end":"2026-08-16T12:53:18.846325Z","steps":["trace[324806671] 'agreement among raft nodes before linearized reading'  (duration: 167.174931ms)"],"step_count":1}
{"level":"info","ts":"2026-08-16T12:53:18.846017Z","caller":"traceutil/trace.go:171","msg":"trace[1369476618] linearizableReadLoop","detail":"{readStateIndex:1894; appliedIndex:1893; }","duration":"167.000998ms","start":"2026-08-16T12:53:18.678949Z","end":"2026-08-16T12:53:18.84595Z","steps":["trace[1369476618] 'read index received'  (duration: 166.382446ms)","trace[1369476618] 'applied index is now lower than readState.Index'  (duration: 615.012µs)"],"step_count":2}
{"level":"warn","ts":"2026-08-16T12:53:18.846939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.017351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"}
{"level":"info","ts":"2026-08-16T12:53:18.847003Z","caller":"traceutil/trace.go:171","msg":"trace[1413716371] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1826; }","duration":"128.117004ms","start":"2026-08-16T12:53:18.718862Z","end":"2026-08-16T12:53:18.846979Z","steps":["trace[1413716371] 'agreement among raft nodes before linearized reading'  (duration: 127.900079ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-16T12:53:19.355359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.482216ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13976534461089517976 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:1798 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:462 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-16T12:53:19.355517Z","caller":"traceutil/trace.go:171","msg":"trace[740377352] linearizableReadLoop","detail":"{readStateIndex:1896; appliedIndex:1895; }","duration":"122.583611ms","start":"2026-08-16T12:53:19.232908Z","end":"2026-08-16T12:53:19.355492Z","steps":["trace[740377352] 'read index received'  (duration: 4.596934ms)","trace[740377352] 'applied index is now lower than readState.Index'  (duration: 117.985237ms)"],"step_count":2}
{"level":"info","ts":"2026-08-16T12:53:19.355597Z","caller":"traceutil/trace.go:171","msg":"trace[1069845109] transaction","detail":"{read_only:false; response_revision:1828; number_of_response:1; }","duration":"181.376571ms","start":"2026-08-16T12:53:19.174176Z","end":"2026-08-16T12:53:19.355552Z","steps":["trace[1069845109] 'process raft request'  (duration: 63.353974ms)","trace[1069845109] 'compare'  (duration: 117.257332ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-16T12:53:19.355716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.811516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-25879532-02ec-4eed-baa1-c444124b097e\" ","response":"range_response_count:1 size:3627"}
{"level":"info","ts":"2026-08-16T12:53:19.355759Z","caller":"traceutil/trace.go:171","msg":"trace[1549702212] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-25879532-02ec-4eed-baa1-c444124b097e; range_end:; response_count:1; response_revision:1828; }","duration":"122.886987ms","start":"2026-08-16T12:53:19.23286Z","end":"2026-08-16T12:53:19.355747Z","steps":["trace[1549702212] 'agreement among raft nodes before linearized reading'  (duration: 122.693923ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-16T12:54:08.560116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.064552ms","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-08-16T12:54:08.56021Z","caller":"traceutil/trace.go:171","msg":"trace[719480460] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2142; }","duration":"239.203784ms","start":"2026-08-16T12:54:08.320986Z","end":"2026-08-16T12:54:08.56019Z","steps":["trace[719480460] 'range keys from in-memory index tree'  (duration: 238.874587ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-16T12:54:08.560231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.14113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-08-16T12:54:08.560317Z","caller":"traceutil/trace.go:171","msg":"trace[1375208649] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2142; }","duration":"232.284924ms","start":"2026-08-16T12:54:08.328012Z","end":"2026-08-16T12:54:08.560297Z","steps":["trace[1375208649] 'range keys from in-memory index tree'  (duration: 231.906205ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-16T12:54:08.812113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.938885ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13976534461089518723 > lease_revoke:<id:41f6a00aa03f13b2>","response":"size:29"}
{"level":"info","ts":"2026-08-16T12:54:08.81272Z","caller":"traceutil/trace.go:171","msg":"trace[174551967] transaction","detail":"{read_only:false; response_revision:2143; number_of_response:1; }","duration":"248.139737ms","start":"2026-08-16T12:54:08.56456Z","end":"2026-08-16T12:54:08.8127Z","steps":["trace[174551967] 'process raft request'  (duration: 247.743498ms)"],"step_count":1}
{"level":"info","ts":"2026-08-16T12:54:08.830729Z","caller":"traceutil/trace.go:171","msg":"trace[1414305172] transaction","detail":"{read_only:false; response_revision:2144; number_of_response:1; }","duration":"264.646842ms","start":"2026-08-16T12:54:08.565999Z","end":"2026-08-16T12:54:08.830646Z","steps":["trace[1414305172] 'process raft request'  (duration: 247.141587ms)","trace[1414305172] 'compare'  (duration: 17.343822ms)"],"step_count":2}
{"level":"info","ts":"2026-08-16T12:55:22.649353Z","caller":"traceutil/trace.go:171","msg":"trace[1493707733] transaction","detail":"{read_only:false; response_revision:2740; number_of_response:1; }","duration":"116.610494ms","start":"2026-08-16T12:55:22.532715Z","end":"2026-08-16T12:55:22.649325Z","steps":["trace[1493707733] 'process raft request'  (duration: 116.42636ms)"],"step_count":1}
{"level":"info","ts":"2026-08-16T12:55:22.722069Z","caller":"traceutil/trace.go:171","msg":"trace[574443102] transaction","detail":"{read_only:false; response_revision:2741; number_of_response:1; }","duration":"186.484366ms","start":"2026-08-16T12:55:22.535556Z","end":"2026-08-16T12:55:22.722041Z","steps":["trace[574443102] 'process raft request'  (duration: 186.312833ms)"],"step_count":1}
{"level":"info","ts":"2026-08-16T12:59:13.530896Z","caller":"traceutil/trace.go:171","msg":"trace[256994345] transaction","detail":"{read_only:false; response_revision:4792; number_of_response:1; }","duration":"112.574699ms","start":"2026-08-16T12:59:13.418293Z","end":"2026-08-16T12:59:13.530868Z","steps":["trace[256994345] 'process raft request'  (duration: 112.432536ms)"],"step_count":1}
{"level":"info","ts":"2026-08-16T12:59:13.574812Z","caller":"traceutil/trace.go:171","msg":"trace[1986936240] transaction","detail":"{read_only:false; response_revision:4794; number_of_response:1; }","duration":"139.084611ms","start":"2026-08-16T12:59:13.435704Z","end":"2026-08-16T12:59:13.574789Z","steps":["trace[1986936240] 'process raft request'  (duration: 139.03444ms)"],"step_count":1}
{"level":"info","ts":"2026-08-16T12:59:13.575117Z","caller":"traceutil/trace.go:171","msg":"trace[539232399] transaction","detail":"{read_only:false; response_revision:4793; number_of_response:1; }","duration":"139.452099ms","start":"2026-08-16T12:59:13.435652Z","end":"2026-08-16T12:59:13.575104Z","steps":["trace[539232399] 'process raft request'  (duration: 113.377056ms)","trace[539232399] 'compare'  (duration: 25.607363ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-16T12:59:17.884781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.427403ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13976534461089525486 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:4902 > 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-08-16T12:59:17.884953Z","caller":"traceutil/trace.go:171","msg":"trace[446634986] linearizableReadLoop","detail":"{readStateIndex:5129; appliedIndex:5128; }","duration":"225.755971ms","start":"2026-08-16T12:59:17.659173Z","end":"2026-08-16T12:59:17.884929Z","steps":["trace[446634986] 'read index received'  (duration: 24.939659ms)","trace[446634986] 'applied index is now lower than readState.Index'  (duration: 200.814502ms)"],"step_count":2}
{"level":"info","ts":"2026-08-16T12:59:17.885081Z","caller":"traceutil/trace.go:171","msg":"trace[187682350] transaction","detail":"{read_only:false; response_revision:4944; number_of_response:1; }","duration":"291.505754ms","start":"2026-08-16T12:59:17.593561Z","end":"2026-08-16T12:59:17.885067Z","steps":["trace[187682350] 'process raft request'  (duration: 90.640291ms)","trace[187682350] 'compare'  (duration: 200.237579ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-16T12:59:17.885251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.044759ms","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-08-16T12:59:17.885299Z","caller":"traceutil/trace.go:171","msg":"trace[255793688] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4944; }","duration":"115.145672ms","start":"2026-08-16T12:59:17.770138Z","end":"2026-08-16T12:59:17.885284Z","steps":["trace[255793688] 'agreement among raft nodes before linearized reading'  (duration: 114.973479ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-16T12:59:17.885409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.218641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/storage-loki-0.18cc4a9530c572cd\" ","response":"range_response_count:1 size:943"}
{"level":"info","ts":"2026-08-16T12:59:17.885518Z","caller":"traceutil/trace.go:171","msg":"trace[1827467517] range","detail":"{range_begin:/registry/events/monitoring/storage-loki-0.18cc4a9530c572cd; range_end:; response_count:1; response_revision:4944; }","duration":"226.412494ms","start":"2026-08-16T12:59:17.659073Z","end":"2026-08-16T12:59:17.885485Z","steps":["trace[1827467517] 'agreement among raft nodes before linearized reading'  (duration: 226.159009ms)"],"step_count":1}
{"level":"info","ts":"2026-08-16T12:59:18.397523Z","caller":"traceutil/trace.go:171","msg":"trace[1645069287] linearizableReadLoop","detail":"{readStateIndex:5135; appliedIndex:5134; }","duration":"104.27615ms","start":"2026-08-16T12:59:18.293219Z","end":"2026-08-16T12:59:18.397495Z","steps":["trace[1645069287] 'read index received'  (duration: 20.867807ms)","trace[1645069287] 'applied index is now lower than readState.Index'  (duration: 83.406773ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-16T12:59:18.397752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.514125ms","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-08-16T12:59:18.397797Z","caller":"traceutil/trace.go:171","msg":"trace[311098768] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4949; }","duration":"104.618547ms","start":"2026-08-16T12:59:18.293168Z","end":"2026-08-16T12:59:18.397786Z","steps":["trace[311098768] 'agreement among raft nodes before linearized reading'  (duration: 104.438394ms)"],"step_count":1}
{"level":"info","ts":"2026-08-16T12:59:29.332628Z","caller":"traceutil/trace.go:171","msg":"trace[1362679372] transaction","detail":"{read_only:false; response_revision:5175; number_of_response:1; }","duration":"128.132097ms","start":"2026-08-16T12:59:29.204433Z","end":"2026-08-16T12:59:29.332565Z","steps":["trace[1362679372] 'process raft request'  (duration: 41.411836ms)","trace[1362679372] 'compare'  (duration: 86.503947ms)"],"step_count":2}
{"level":"info","ts":"2026-08-16T12:59:29.332739Z","caller":"traceutil/trace.go:171","msg":"trace[1760051017] transaction","detail":"{read_only:false; response_revision:5177; number_of_response:1; }","duration":"124.934301ms","start":"2026-08-16T12:59:29.20776Z","end":"2026-08-16T12:59:29.332694Z","steps":["trace[1760051017] 'process raft request'  (duration: 124.805948ms)"],"step_count":1}
{"level":"info","ts":"2026-08-16T12:59:29.332937Z","caller":"traceutil/trace.go:171","msg":"trace[1583681994] transaction","detail":"{read_only:false; response_revision:5176; number_of_response:1; }","duration":"127.197358ms","start":"2026-08-16T12:59:29.205687Z","end":"2026-08-16T12:59:29.332885Z","steps":["trace[1583681994] 'process raft request'  (duration: 126.81715ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-16T12:59:29.333362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.877313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:128624"}
{"level":"info","ts":"2026-08-16T12:59:29.333436Z","caller":"traceutil/trace.go:171","msg":"trace[883057917] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:5177; }","duration":"129.011405ms","start":"2026-08-16T12:59:29.204408Z","end":"2026-08-16T12:59:29.333419Z","steps":["trace[883057917] 'agreement among raft nodes before linearized reading'  (duration: 128.703349ms)"],"step_count":1}
{"level":"info","ts":"2026-08-16T12:59:29.332979Z","caller":"traceutil/trace.go:171","msg":"trace[829877041] linearizableReadLoop","detail":"{readStateIndex:5368; appliedIndex:5367; }","duration":"128.444704ms","start":"2026-08-16T12:59:29.204456Z","end":"2026-08-16T12:59:29.332901Z","steps":["trace[829877041] 'read index received'  (duration: 105.203µs)","trace[829877041] 'applied index is now lower than readState.Index'  (duration: 128.334841ms)"],"step_count":2}
{"level":"info","ts":"2026-08-16T12:59:29.904006Z","caller":"traceutil/trace.go:171","msg":"trace[1899666066] linearizableReadLoop","detail":"{readStateIndex:5380; appliedIndex:5379; }","duration":"244.386391ms","start":"2026-08-16T12:59:29.659599Z","end":"2026-08-16T12:59:29.903986Z","steps":["trace[1899666066] 'read index received'  (duration: 244.193757ms)","trace[1899666066] 'applied index is now lower than readState.Index'  (duration: 191.994µs)"],"step_count":2}
{"level":"warn","ts":"2026-08-16T12:59:29.904161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.645247ms","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-08-16T12:59:29.904203Z","caller":"traceutil/trace.go:171","msg":"trace[1225308034] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:5187; }","duration":"152.753219ms","start":"2026-08-16T12:59:29.751437Z","end":"2026-08-16T12:59:29.904191Z","steps":["trace[1225308034] 'agreement among raft nodes before linearized reading'  (duration: 152.664967ms)"],"step_count":1}
{"level":"info","ts":"2026-08-16T12:59:29.90418Z","caller":"traceutil/trace.go:171","msg":"trace[1758726990] transaction","detail":"{read_only:false; response_revision:5187; number_of_response:1; }","duration":"299.003537ms","start":"2026-08-16T12:59:29.605152Z","end":"2026-08-16T12:59:29.904156Z","steps":["trace[1758726990] 'process raft request'  (duration: 298.66335ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-16T12:59:29.904282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.657877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-08-16T12:59:29.904377Z","caller":"traceutil/trace.go:171","msg":"trace[1132616724] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5187; }","duration":"244.772909ms","start":"2026-08-16T12:59:29.65956Z","end":"2026-08-16T12:59:29.904333Z","steps":["trace[1132616724] 'agreement among raft nodes before linearized reading'  (duration: 244.547484ms)"],"step_count":1}
{"level":"info","ts":"2026-08-16T12:59:38.213984Z","caller":"traceutil/trace.go:171","msg":"trace[27396587] linearizableReadLoop","detail":"{readStateIndex:5574; appliedIndex:5572; }","duration":"179.562227ms","start":"2026-08-16T12:59:38.03439Z","end":"2026-08-16T12:59:38.213953Z","steps":["trace[27396587] 'read index received'  (duration: 4.657985ms)","trace[27396587] 'applied index is now lower than readState.Index'  (duration: 174.902912ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-16T12:59:38.214312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.891315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-08-16T12:59:38.214318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.744813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-tqg8t\" ","response":"range_response_count:1 size:6524"}
{"level":"info","ts":"2026-08-16T12:59:38.214404Z","caller":"traceutil/trace.go:171","msg":"trace[427525194] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5377; }","duration":"180.038927ms","start":"2026-08-16T12:59:38.034345Z","end":"2026-08-16T12:59:38.214383Z","steps":["trace[427525194] 'agreement among raft nodes before linearized reading'  (duration: 179.751661ms)"],"step_count":1}
{"level":"info","ts":"2026-08-16T12:59:38.214414Z","caller":"traceutil/trace.go:171","msg":"trace[1436276643] range","detail":"{range_begin:/registry/pods/openstack/keepalived-tqg8t; range_end:; response_count:1; response_revision:5377; }","duration":"113.910887ms","start":"2026-08-16T12:59:38.100487Z","end":"2026-08-16T12:59:38.214398Z","steps":["trace[1436276643] 'agreement among raft nodes before linearized reading'  (duration: 113.6523ms)"],"step_count":1}
{"level":"info","ts":"2026-08-16T12:59:38.21473Z","caller":"traceutil/trace.go:171","msg":"trace[132482255] transaction","detail":"{read_only:false; response_revision:5377; number_of_response:1; }","duration":"196.722087ms","start":"2026-08-16T12:59:38.017363Z","end":"2026-08-16T12:59:38.214085Z","steps":["trace[132482255] 'process raft request'  (duration: 109.657089ms)","trace[132482255] 'compare'  (duration: 86.756482ms)"],"step_count":2}
{"level":"info","ts":"2026-08-16T12:59:47.568571Z","caller":"traceutil/trace.go:171","msg":"trace[1406261083] transaction","detail":"{read_only:false; response_revision:5490; number_of_response:1; }","duration":"125.893602ms","start":"2026-08-16T12:59:47.442649Z","end":"2026-08-16T12:59:47.568543Z","steps":["trace[1406261083] 'process raft request'  (duration: 106.192619ms)","trace[1406261083] 'compare'  (duration: 19.431838ms)"],"step_count":2}
{"level":"info","ts":"2026-08-16T12:59:47.568985Z","caller":"traceutil/trace.go:171","msg":"trace[1841727738] transaction","detail":"{read_only:false; response_revision:5491; number_of_response:1; }","duration":"126.081406ms","start":"2026-08-16T12:59:47.442892Z","end":"2026-08-16T12:59:47.568974Z","steps":["trace[1841727738] 'process raft request'  (duration: 125.579366ms)"],"step_count":1}
{"level":"info","ts":"2026-08-16T12:59:47.569181Z","caller":"traceutil/trace.go:171","msg":"trace[1998081058] linearizableReadLoop","detail":"{readStateIndex:5692; appliedIndex:5688; }","duration":"118.371088ms","start":"2026-08-16T12:59:47.450759Z","end":"2026-08-16T12:59:47.56913Z","steps":["trace[1998081058] 'read index received'  (duration: 41.269612ms)","trace[1998081058] 'applied index is now lower than readState.Index'  (duration: 77.099776ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-16T12:59:47.570163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.360357ms","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":"info","ts":"2026-08-16T12:59:47.570287Z","caller":"traceutil/trace.go:171","msg":"trace[1348622968] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5492; }","duration":"119.544441ms","start":"2026-08-16T12:59:47.450714Z","end":"2026-08-16T12:59:47.570258Z","steps":["trace[1348622968] 'agreement among raft nodes before linearized reading'  (duration: 118.615693ms)"],"step_count":1}
{"level":"info","ts":"2026-08-16T12:59:47.570813Z","caller":"traceutil/trace.go:171","msg":"trace[772903233] transaction","detail":"{read_only:false; response_revision:5492; number_of_response:1; }","duration":"127.727609ms","start":"2026-08-16T12:59:47.443001Z","end":"2026-08-16T12:59:47.570729Z","steps":["trace[772903233] 'process raft request'  (duration: 125.813869ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-16T13:01:00.455815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.807015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-16T13:01:00.455887Z","caller":"traceutil/trace.go:171","msg":"trace[244321230] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:6093; }","duration":"254.945827ms","start":"2026-08-16T13:01:00.200926Z","end":"2026-08-16T13:01:00.455871Z","steps":["trace[244321230] 'count revisions from in-memory index tree'  (duration: 254.675782ms)"],"step_count":1}
{"level":"info","ts":"2026-08-16T13:01:00.457318Z","caller":"traceutil/trace.go:171","msg":"trace[332586683] transaction","detail":"{read_only:false; response_revision:6094; number_of_response:1; }","duration":"167.440411ms","start":"2026-08-16T13:01:00.289842Z","end":"2026-08-16T13:01:00.457283Z","steps":["trace[332586683] 'process raft request'  (duration: 167.250407ms)"],"step_count":1}
{"level":"info","ts":"2026-08-16T13:01:09.867978Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2998}
{"level":"info","ts":"2026-08-16T13:01:09.938753Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2998,"took":"68.888056ms","hash":3920460878,"current-db-size-bytes":59170816,"current-db-size":"59 MB","current-db-size-in-use-bytes":34615296,"current-db-size-in-use":"35 MB"}
{"level":"info","ts":"2026-08-16T13:01:09.938809Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3920460878,"revision":2998,"compact-revision":-1}
{"level":"warn","ts":"2026-08-16T13:05:32.435348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.704667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-tqg8t\" ","response":"range_response_count:1 size:6524"}
{"level":"info","ts":"2026-08-16T13:05:32.435433Z","caller":"traceutil/trace.go:171","msg":"trace[1588621486] range","detail":"{range_begin:/registry/pods/openstack/keepalived-tqg8t; range_end:; response_count:1; response_revision:8112; }","duration":"125.83741ms","start":"2026-08-16T13:05:32.309579Z","end":"2026-08-16T13:05:32.435416Z","steps":["trace[1588621486] 'range keys from in-memory index tree'  (duration: 125.509593ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-16T13:05:32.435391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.469326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"warn","ts":"2026-08-16T13:05:32.435426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.76047ms","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-08-16T13:05:32.435508Z","caller":"traceutil/trace.go:171","msg":"trace[27362986] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8112; }","duration":"135.628599ms","start":"2026-08-16T13:05:32.299856Z","end":"2026-08-16T13:05:32.435485Z","steps":["trace[27362986] 'range keys from in-memory index tree'  (duration: 135.293862ms)"],"step_count":1}
{"level":"info","ts":"2026-08-16T13:05:32.435541Z","caller":"traceutil/trace.go:171","msg":"trace[358552084] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8112; }","duration":"129.905203ms","start":"2026-08-16T13:05:32.30562Z","end":"2026-08-16T13:05:32.435525Z","steps":["trace[358552084] 'range keys from in-memory index tree'  (duration: 129.490204ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-16T13:05:32.43576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.262848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-08-16T13:05:32.436008Z","caller":"traceutil/trace.go:171","msg":"trace[678755328] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:8112; }","duration":"197.413112ms","start":"2026-08-16T13:05:32.238419Z","end":"2026-08-16T13:05:32.435832Z","steps":["trace[678755328] 'count revisions from in-memory index tree'  (duration: 197.162687ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-16T13:05:43.725705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.359554ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13976534461089533915 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:8156 > 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:16"}
{"level":"info","ts":"2026-08-16T13:05:43.725862Z","caller":"traceutil/trace.go:171","msg":"trace[275235206] transaction","detail":"{read_only:false; response_revision:8169; number_of_response:1; }","duration":"178.096858ms","start":"2026-08-16T13:05:43.547741Z","end":"2026-08-16T13:05:43.725838Z","steps":["trace[275235206] 'process raft request'  (duration: 21.497579ms)","trace[275235206] 'compare'  (duration: 156.239191ms)"],"step_count":2}
{"level":"info","ts":"2026-08-16T13:05:43.725931Z","caller":"traceutil/trace.go:171","msg":"trace[240493773] transaction","detail":"{read_only:false; response_revision:8170; number_of_response:1; }","duration":"144.824398ms","start":"2026-08-16T13:05:43.581083Z","end":"2026-08-16T13:05:43.725907Z","steps":["trace[240493773] 'process raft request'  (duration: 144.747436ms)"],"step_count":1}
{"level":"info","ts":"2026-08-16T13:05:43.725931Z","caller":"traceutil/trace.go:171","msg":"trace[1454910841] linearizableReadLoop","detail":"{readStateIndex:8456; appliedIndex:8455; }","duration":"173.189808ms","start":"2026-08-16T13:05:43.552699Z","end":"2026-08-16T13:05:43.725889Z","steps":["trace[1454910841] 'read index received'  (duration: 16.495047ms)","trace[1454910841] 'applied index is now lower than readState.Index'  (duration: 156.691911ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-16T13:05:43.72619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.465103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"}
{"level":"info","ts":"2026-08-16T13:05:43.726235Z","caller":"traceutil/trace.go:171","msg":"trace[2021054799] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8170; }","duration":"173.546954ms","start":"2026-08-16T13:05:43.552677Z","end":"2026-08-16T13:05:43.726224Z","steps":["trace[2021054799] 'agreement among raft nodes before linearized reading'  (duration: 173.32989ms)"],"step_count":1}
{"level":"info","ts":"2026-08-16T13:05:44.006953Z","caller":"traceutil/trace.go:171","msg":"trace[1440193246] linearizableReadLoop","detail":"{readStateIndex:8458; appliedIndex:8457; }","duration":"195.631026ms","start":"2026-08-16T13:05:43.811294Z","end":"2026-08-16T13:05:44.006925Z","steps":["trace[1440193246] 'read index received'  (duration: 168.673175ms)","trace[1440193246] 'applied index is now lower than readState.Index'  (duration: 26.956921ms)"],"step_count":2}
{"level":"info","ts":"2026-08-16T13:05:44.007024Z","caller":"traceutil/trace.go:171","msg":"trace[292778723] transaction","detail":"{read_only:false; response_revision:8171; number_of_response:1; }","duration":"203.056077ms","start":"2026-08-16T13:05:43.803915Z","end":"2026-08-16T13:05:44.006971Z","steps":["trace[292778723] 'process raft request'  (duration: 175.990034ms)","trace[292778723] 'compare'  (duration: 26.90825ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-16T13:05:44.007234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.053563ms","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-08-16T13:05:44.007282Z","caller":"traceutil/trace.go:171","msg":"trace[1347172703] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8171; }","duration":"169.139434ms","start":"2026-08-16T13:05:43.838131Z","end":"2026-08-16T13:05:44.00727Z","steps":["trace[1347172703] 'agreement among raft nodes before linearized reading'  (duration: 168.94157ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-16T13:05:44.007279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.953162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5683"}
{"level":"info","ts":"2026-08-16T13:05:44.007366Z","caller":"traceutil/trace.go:171","msg":"trace[764139398] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:8171; }","duration":"196.084194ms","start":"2026-08-16T13:05:43.811257Z","end":"2026-08-16T13:05:44.007341Z","steps":["trace[764139398] 'agreement among raft nodes before linearized reading'  (duration: 195.778708ms)"],"step_count":1}
{"level":"info","ts":"2026-08-16T13:06:09.879268Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6146}
{"level":"info","ts":"2026-08-16T13:06:09.973091Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6146,"took":"91.669892ms","hash":3067268960,"current-db-size-bytes":59170816,"current-db-size":"59 MB","current-db-size-in-use-bytes":22982656,"current-db-size-in-use":"23 MB"}
{"level":"info","ts":"2026-08-16T13:06:09.973181Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3067268960,"revision":6146,"compact-revision":2998}
{"level":"info","ts":"2026-08-16T13:06:12.085723Z","caller":"traceutil/trace.go:171","msg":"trace[20903567] linearizableReadLoop","detail":"{readStateIndex:8670; appliedIndex:8669; }","duration":"136.730782ms","start":"2026-08-16T13:06:11.948973Z","end":"2026-08-16T13:06:12.085704Z","steps":["trace[20903567] 'read index received'  (duration: 136.564729ms)","trace[20903567] 'applied index is now lower than readState.Index'  (duration: 165.523µs)"],"step_count":2}
{"level":"warn","ts":"2026-08-16T13:06:12.085889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.899426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"}
{"level":"info","ts":"2026-08-16T13:06:12.085918Z","caller":"traceutil/trace.go:171","msg":"trace[193549968] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8374; }","duration":"136.967888ms","start":"2026-08-16T13:06:11.948942Z","end":"2026-08-16T13:06:12.085909Z","steps":["trace[193549968] 'agreement among raft nodes before linearized reading'  (duration: 136.846595ms)"],"step_count":1}
{"level":"info","ts":"2026-08-16T13:06:12.086213Z","caller":"traceutil/trace.go:171","msg":"trace[893227658] transaction","detail":"{read_only:false; response_revision:8374; number_of_response:1; }","duration":"265.538032ms","start":"2026-08-16T13:06:11.820667Z","end":"2026-08-16T13:06:12.086205Z","steps":["trace[893227658] 'process raft request'  (duration: 264.91619ms)"],"step_count":1}
{"level":"info","ts":"2026-08-16T13:06:12.292634Z","caller":"traceutil/trace.go:171","msg":"trace[1995005386] linearizableReadLoop","detail":"{readStateIndex:8672; appliedIndex:8670; }","duration":"148.381401ms","start":"2026-08-16T13:06:12.144232Z","end":"2026-08-16T13:06:12.292613Z","steps":["trace[1995005386] 'read index received'  (duration: 145.468661ms)","trace[1995005386] 'applied index is now lower than readState.Index'  (duration: 2.91141ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-16T13:06:12.292863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.576855ms","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-08-16T13:06:12.292914Z","caller":"traceutil/trace.go:171","msg":"trace[244083813] transaction","detail":"{read_only:false; response_revision:8375; number_of_response:1; }","duration":"202.881383ms","start":"2026-08-16T13:06:12.090004Z","end":"2026-08-16T13:06:12.292886Z","steps":["trace[244083813] 'process raft request'  (duration: 199.681208ms)"],"step_count":1}
{"level":"info","ts":"2026-08-16T13:06:12.293153Z","caller":"traceutil/trace.go:171","msg":"trace[1800482216] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:8376; }","duration":"148.740698ms","start":"2026-08-16T13:06:12.144196Z","end":"2026-08-16T13:06:12.292937Z","steps":["trace[1800482216] 'agreement among raft nodes before linearized reading'  (duration: 148.578115ms)"],"step_count":1}
{"level":"info","ts":"2026-08-16T13:06:12.29335Z","caller":"traceutil/trace.go:171","msg":"trace[250148501] transaction","detail":"{read_only:false; response_revision:8376; number_of_response:1; }","duration":"191.247146ms","start":"2026-08-16T13:06:12.10209Z","end":"2026-08-16T13:06:12.293337Z","steps":["trace[250148501] 'process raft request'  (duration: 190.45859ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-16T13:06:12.292914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.43161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-08-16T13:06:12.293517Z","caller":"traceutil/trace.go:171","msg":"trace[1846257667] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8376; }","duration":"144.051322ms","start":"2026-08-16T13:06:12.149454Z","end":"2026-08-16T13:06:12.293505Z","steps":["trace[1846257667] 'agreement among raft nodes before linearized reading'  (duration: 143.378928ms)"],"step_count":1}
{"level":"info","ts":"2026-08-16T13:06:24.105245Z","caller":"traceutil/trace.go:171","msg":"trace[2058880810] linearizableReadLoop","detail":"{readStateIndex:8784; appliedIndex:8783; }","duration":"107.539087ms","start":"2026-08-16T13:06:23.997671Z","end":"2026-08-16T13:06:24.10521Z","steps":["trace[2058880810] 'read index received'  (duration: 107.348503ms)","trace[2058880810] 'applied index is now lower than readState.Index'  (duration: 189.464µs)"],"step_count":2}
{"level":"info","ts":"2026-08-16T13:06:24.105343Z","caller":"traceutil/trace.go:171","msg":"trace[1762812235] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8481; }","duration":"151.022614ms","start":"2026-08-16T13:06:23.954284Z","end":"2026-08-16T13:06:24.105306Z","steps":["trace[1762812235] 'process raft request'  (duration: 150.762149ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-16T13:06:24.105459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.775362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-wshtj\" ","response":"range_response_count:1 size:4653"}
{"level":"info","ts":"2026-08-16T13:06:24.105506Z","caller":"traceutil/trace.go:171","msg":"trace[573068067] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-wshtj; range_end:; response_count:1; response_revision:8481; }","duration":"107.841023ms","start":"2026-08-16T13:06:23.997655Z","end":"2026-08-16T13:06:24.105496Z","steps":["trace[573068067] 'agreement among raft nodes before linearized reading'  (duration: 107.67077ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-16T13:06:24.563157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.745489ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13976534461089534947 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:8460 > 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:16"}
{"level":"info","ts":"2026-08-16T13:06:24.563339Z","caller":"traceutil/trace.go:171","msg":"trace[1958440862] transaction","detail":"{read_only:false; response_revision:8485; number_of_response:1; }","duration":"130.368162ms","start":"2026-08-16T13:06:24.432951Z","end":"2026-08-16T13:06:24.563319Z","steps":["trace[1958440862] 'process raft request'  (duration: 24.341538ms)","trace[1958440862] 'compare'  (duration: 105.531374ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-16T13:06:24.791593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.426131ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13976534461089534950 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:8462 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-16T13:06:24.791729Z","caller":"traceutil/trace.go:171","msg":"trace[562171006] transaction","detail":"{read_only:false; response_revision:8486; number_of_response:1; }","duration":"222.482784ms","start":"2026-08-16T13:06:24.569227Z","end":"2026-08-16T13:06:24.79171Z","steps":["trace[562171006] 'process raft request'  (duration: 120.836038ms)","trace[562171006] 'compare'  (duration: 101.134185ms)"],"step_count":2}
{"level":"info","ts":"2026-08-16T13:06:24.840326Z","caller":"traceutil/trace.go:171","msg":"trace[841931824] transaction","detail":"{read_only:false; response_revision:8487; number_of_response:1; }","duration":"268.497414ms","start":"2026-08-16T13:06:24.571793Z","end":"2026-08-16T13:06:24.840291Z","steps":["trace[841931824] 'process raft request'  (duration: 268.25568ms)"],"step_count":1}
{"level":"info","ts":"2026-08-16T13:06:24.840346Z","caller":"traceutil/trace.go:171","msg":"trace[1022639655] transaction","detail":"{read_only:false; response_revision:8488; number_of_response:1; }","duration":"268.405782ms","start":"2026-08-16T13:06:24.571909Z","end":"2026-08-16T13:06:24.840314Z","steps":["trace[1022639655] 'process raft request'  (duration: 268.282989ms)"],"step_count":1}
{"level":"info","ts":"2026-08-16T13:06:24.841109Z","caller":"traceutil/trace.go:171","msg":"trace[378277319] transaction","detail":"{read_only:false; response_revision:8489; number_of_response:1; }","duration":"243.024034ms","start":"2026-08-16T13:06:24.598063Z","end":"2026-08-16T13:06:24.841087Z","steps":["trace[378277319] 'process raft request'  (duration: 242.178766ms)"],"step_count":1}
{"level":"info","ts":"2026-08-16T13:06:24.84122Z","caller":"traceutil/trace.go:171","msg":"trace[388867627] linearizableReadLoop","detail":"{readStateIndex:8791; appliedIndex:8788; }","duration":"243.155536ms","start":"2026-08-16T13:06:24.598021Z","end":"2026-08-16T13:06:24.841176Z","steps":["trace[388867627] 'read index received'  (duration: 92.05829ms)","trace[388867627] 'applied index is now lower than readState.Index'  (duration: 151.096046ms)"],"step_count":2}
{"level":"info","ts":"2026-08-16T13:06:24.841519Z","caller":"traceutil/trace.go:171","msg":"trace[166302908] transaction","detail":"{read_only:false; response_revision:8490; number_of_response:1; }","duration":"235.283806ms","start":"2026-08-16T13:06:24.606217Z","end":"2026-08-16T13:06:24.841501Z","steps":["trace[166302908] 'process raft request'  (duration: 234.786606ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-16T13:06:24.841532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.501514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-wshtj\" ","response":"range_response_count:1 size:4653"}
{"level":"info","ts":"2026-08-16T13:06:24.841625Z","caller":"traceutil/trace.go:171","msg":"trace[89531766] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-wshtj; range_end:; response_count:1; response_revision:8490; }","duration":"243.604996ms","start":"2026-08-16T13:06:24.597989Z","end":"2026-08-16T13:06:24.841594Z","steps":["trace[89531766] 'agreement among raft nodes before linearized reading'  (duration: 243.406612ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-16T13:06:24.841814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.432217ms","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-08-16T13:06:24.841848Z","caller":"traceutil/trace.go:171","msg":"trace[1004269602] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8490; }","duration":"112.507947ms","start":"2026-08-16T13:06:24.729332Z","end":"2026-08-16T13:06:24.841839Z","steps":["trace[1004269602] 'agreement among raft nodes before linearized reading'  (duration: 112.412836ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-16T13:06:24.841951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.695093ms","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-08-16T13:06:24.841994Z","caller":"traceutil/trace.go:171","msg":"trace[1848612138] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8490; }","duration":"114.767464ms","start":"2026-08-16T13:06:24.727215Z","end":"2026-08-16T13:06:24.841983Z","steps":["trace[1848612138] 'agreement among raft nodes before linearized reading'  (duration: 114.5467ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-16T13:06:24.842322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.159153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"}
{"level":"info","ts":"2026-08-16T13:06:24.842365Z","caller":"traceutil/trace.go:171","msg":"trace[1008813627] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8490; }","duration":"139.202054ms","start":"2026-08-16T13:06:24.703152Z","end":"2026-08-16T13:06:24.842354Z","steps":["trace[1008813627] 'agreement among raft nodes before linearized reading'  (duration: 138.547041ms)"],"step_count":1}
{"level":"info","ts":"2026-08-16T13:07:14.133133Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002440.wal"}
{"level":"info","ts":"2026-08-16T13:07:37.276312Z","caller":"traceutil/trace.go:171","msg":"trace[110829556] transaction","detail":"{read_only:false; response_revision:9211; number_of_response:1; }","duration":"138.836588ms","start":"2026-08-16T13:07:37.13744Z","end":"2026-08-16T13:07:37.276276Z","steps":["trace[110829556] 'process raft request'  (duration: 138.607784ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-16T13:07:37.309292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.338639ms","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-08-16T13:07:37.309384Z","caller":"traceutil/trace.go:171","msg":"trace[2029871825] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:9212; }","duration":"122.483592ms","start":"2026-08-16T13:07:37.18688Z","end":"2026-08-16T13:07:37.309363Z","steps":["trace[2029871825] 'agreement among raft nodes before linearized reading'  (duration: 122.232117ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-16T13:07:37.309383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.822114ms","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-08-16T13:07:37.309509Z","caller":"traceutil/trace.go:171","msg":"trace[1489191613] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:9212; }","duration":"111.005579ms","start":"2026-08-16T13:07:37.19848Z","end":"2026-08-16T13:07:37.309485Z","steps":["trace[1489191613] 'agreement among raft nodes before linearized reading'  (duration: 110.738343ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-16T13:07:37.309417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.250138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-08-16T13:07:37.309674Z","caller":"traceutil/trace.go:171","msg":"trace[1442058099] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:9212; }","duration":"121.522694ms","start":"2026-08-16T13:07:37.188132Z","end":"2026-08-16T13:07:37.309655Z","steps":["trace[1442058099] 'agreement among raft nodes before linearized reading'  (duration: 121.141416ms)"],"step_count":1}
{"level":"info","ts":"2026-08-16T13:07:37.415218Z","caller":"traceutil/trace.go:171","msg":"trace[479940528] transaction","detail":"{read_only:false; response_revision:9213; number_of_response:1; }","duration":"133.482858ms","start":"2026-08-16T13:07:37.281706Z","end":"2026-08-16T13:07:37.415189Z","steps":["trace[479940528] 'process raft request'  (duration: 75.661687ms)","trace[479940528] 'compare'  (duration: 57.645777ms)"],"step_count":2}
{"level":"info","ts":"2026-08-16T13:07:37.415602Z","caller":"traceutil/trace.go:171","msg":"trace[1628141683] transaction","detail":"{read_only:false; response_revision:9214; number_of_response:1; }","duration":"102.182468ms","start":"2026-08-16T13:07:37.313394Z","end":"2026-08-16T13:07:37.415576Z","steps":["trace[1628141683] 'process raft request'  (duration: 101.748609ms)"],"step_count":1}
{"level":"info","ts":"2026-08-16T13:07:37.415873Z","caller":"traceutil/trace.go:171","msg":"trace[409318056] transaction","detail":"{read_only:false; response_revision:9216; number_of_response:1; }","duration":"101.096266ms","start":"2026-08-16T13:07:37.31476Z","end":"2026-08-16T13:07:37.415857Z","steps":["trace[409318056] 'process raft request'  (duration: 100.933193ms)"],"step_count":1}
{"level":"info","ts":"2026-08-16T13:07:37.415963Z","caller":"traceutil/trace.go:171","msg":"trace[1830342524] transaction","detail":"{read_only:false; response_revision:9215; number_of_response:1; }","duration":"101.669909ms","start":"2026-08-16T13:07:37.31428Z","end":"2026-08-16T13:07:37.41595Z","steps":["trace[1830342524] 'process raft request'  (duration: 101.193389ms)"],"step_count":1}
{"level":"info","ts":"2026-08-16T13:08:41.724253Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"d7dbc9f5893cc1f6","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-08-16T13:08:41.731867Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-08-16T13:08:41.731968Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-08-16T13:11:09.885248Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8364}
{"level":"info","ts":"2026-08-16T13:11:09.967278Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8364,"took":"79.83242ms","hash":1518822336,"current-db-size-bytes":59170816,"current-db-size":"59 MB","current-db-size-in-use-bytes":26718208,"current-db-size-in-use":"27 MB"}
{"level":"info","ts":"2026-08-16T13:11:09.967357Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1518822336,"revision":8364,"compact-revision":6146}
{"level":"info","ts":"2026-08-16T13:11:13.159596Z","caller":"traceutil/trace.go:171","msg":"trace[1002500034] linearizableReadLoop","detail":"{readStateIndex:11394; appliedIndex:11393; }","duration":"128.953353ms","start":"2026-08-16T13:11:13.030613Z","end":"2026-08-16T13:11:13.159567Z","steps":["trace[1002500034] 'read index received'  (duration: 75.864149ms)","trace[1002500034] 'applied index is now lower than readState.Index'  (duration: 53.087494ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-16T13:11:13.159802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.530934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-16T13:11:13.15984Z","caller":"traceutil/trace.go:171","msg":"trace[47982642] range","detail":"{range_begin:/registry/jobs/openstack/cinder-rabbit-init; range_end:; response_count:0; response_revision:11018; }","duration":"128.610775ms","start":"2026-08-16T13:11:13.03122Z","end":"2026-08-16T13:11:13.159831Z","steps":["trace[47982642] 'agreement among raft nodes before linearized reading'  (duration: 128.514953ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-16T13:11:13.159953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.134126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-storage-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-16T13:11:13.160044Z","caller":"traceutil/trace.go:171","msg":"trace[998982931] range","detail":"{range_begin:/registry/jobs/openstack/cinder-storage-init; range_end:; response_count:0; response_revision:11018; }","duration":"129.460203ms","start":"2026-08-16T13:11:13.030563Z","end":"2026-08-16T13:11:13.160024Z","steps":["trace[998982931] 'agreement among raft nodes before linearized reading'  (duration: 129.123876ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-16T13:11:13.160305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.997823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-endpoints\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-16T13:11:13.160359Z","caller":"traceutil/trace.go:171","msg":"trace[48906949] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-endpoints; range_end:; response_count:0; response_revision:11018; }","duration":"129.072605ms","start":"2026-08-16T13:11:13.031273Z","end":"2026-08-16T13:11:13.160346Z","steps":["trace[48906949] 'agreement among raft nodes before linearized reading'  (duration: 128.994533ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-16T13:11:13.160522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.615634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-db-sync\" ","response":"range_response_count:1 size:5079"}
{"level":"info","ts":"2026-08-16T13:11:13.160664Z","caller":"traceutil/trace.go:171","msg":"trace[237916136] range","detail":"{range_begin:/registry/jobs/openstack/cinder-db-sync; range_end:; response_count:1; response_revision:11018; }","duration":"125.783328ms","start":"2026-08-16T13:11:13.034857Z","end":"2026-08-16T13:11:13.16064Z","steps":["trace[237916136] 'agreement among raft nodes before linearized reading'  (duration: 125.512153ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-16T13:11:13.160424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.925962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-user\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-16T13:11:13.160947Z","caller":"traceutil/trace.go:171","msg":"trace[1134001294] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-user; range_end:; response_count:0; response_revision:11018; }","duration":"129.575216ms","start":"2026-08-16T13:11:13.031353Z","end":"2026-08-16T13:11:13.160928Z","steps":["trace[1134001294] 'agreement among raft nodes before linearized reading'  (duration: 128.793699ms)"],"step_count":1}
{"level":"info","ts":"2026-08-16T13:11:13.310486Z","caller":"traceutil/trace.go:171","msg":"trace[2082395284] linearizableReadLoop","detail":"{readStateIndex:11396; appliedIndex:11395; }","duration":"101.770957ms","start":"2026-08-16T13:11:13.208689Z","end":"2026-08-16T13:11:13.31046Z","steps":["trace[2082395284] 'read index received'  (duration: 74.523111ms)","trace[2082395284] 'applied index is now lower than readState.Index'  (duration: 27.246436ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-16T13:11:13.310797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.091333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"}
{"level":"info","ts":"2026-08-16T13:11:13.310809Z","caller":"traceutil/trace.go:171","msg":"trace[1645108629] transaction","detail":"{read_only:false; response_revision:11020; number_of_response:1; }","duration":"113.253132ms","start":"2026-08-16T13:11:13.197349Z","end":"2026-08-16T13:11:13.310602Z","steps":["trace[1645108629] 'process raft request'  (duration: 85.924104ms)","trace[1645108629] 'compare'  (duration: 26.93278ms)"],"step_count":2}
{"level":"info","ts":"2026-08-16T13:11:13.310842Z","caller":"traceutil/trace.go:171","msg":"trace[838416674] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:11020; }","duration":"102.186165ms","start":"2026-08-16T13:11:13.208645Z","end":"2026-08-16T13:11:13.310831Z","steps":["trace[838416674] 'agreement among raft nodes before linearized reading'  (duration: 101.90835ms)"],"step_count":1}
{"level":"info","ts":"2026-08-16T13:16:09.892176Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":11000}
{"level":"info","ts":"2026-08-16T13:16:09.96736Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":11000,"took":"72.369346ms","hash":3974437628,"current-db-size-bytes":59170816,"current-db-size":"59 MB","current-db-size-in-use-bytes":27672576,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-08-16T13:16:09.967441Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3974437628,"revision":11000,"compact-revision":8364}
{"level":"info","ts":"2026-08-16T13:17:40.225426Z","caller":"traceutil/trace.go:171","msg":"trace[1536186023] transaction","detail":"{read_only:false; response_revision:13625; number_of_response:1; }","duration":"203.142964ms","start":"2026-08-16T13:17:40.022169Z","end":"2026-08-16T13:17:40.225312Z","steps":["trace[1536186023] 'process raft request'  (duration: 202.809867ms)"],"step_count":1}
{"level":"info","ts":"2026-08-16T13:17:40.42335Z","caller":"traceutil/trace.go:171","msg":"trace[165594976] transaction","detail":"{read_only:false; response_revision:13626; number_of_response:1; }","duration":"193.777513ms","start":"2026-08-16T13:17:40.229548Z","end":"2026-08-16T13:17:40.423326Z","steps":["trace[165594976] 'process raft request'  (duration: 193.61449ms)"],"step_count":1}
{"level":"info","ts":"2026-08-16T13:17:40.425011Z","caller":"traceutil/trace.go:171","msg":"trace[431801597] linearizableReadLoop","detail":"{readStateIndex:14094; appliedIndex:14092; }","duration":"126.282596ms","start":"2026-08-16T13:17:40.298711Z","end":"2026-08-16T13:17:40.424993Z","steps":["trace[431801597] 'read index received'  (duration: 124.465869ms)","trace[431801597] 'applied index is now lower than readState.Index'  (duration: 1.815627ms)"],"step_count":2}
{"level":"info","ts":"2026-08-16T13:17:40.425134Z","caller":"traceutil/trace.go:171","msg":"trace[69121512] transaction","detail":"{read_only:false; response_revision:13627; number_of_response:1; }","duration":"159.990283ms","start":"2026-08-16T13:17:40.265108Z","end":"2026-08-16T13:17:40.425098Z","steps":["trace[69121512] 'process raft request'  (duration: 159.785719ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-16T13:17:40.425224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.49457ms","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-08-16T13:17:40.425458Z","caller":"traceutil/trace.go:171","msg":"trace[129527701] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:13627; }","duration":"126.742025ms","start":"2026-08-16T13:17:40.298649Z","end":"2026-08-16T13:17:40.425391Z","steps":["trace[129527701] 'agreement among raft nodes before linearized reading'  (duration: 126.448789ms)"],"step_count":1}
{"level":"info","ts":"2026-08-16T13:21:09.900751Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":13030}
{"level":"info","ts":"2026-08-16T13:21:09.986437Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":13030,"took":"82.736499ms","hash":1829597373,"current-db-size-bytes":59170816,"current-db-size":"59 MB","current-db-size-in-use-bytes":31514624,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-08-16T13:21:09.986503Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1829597373,"revision":13030,"compact-revision":11000}
{"level":"info","ts":"2026-08-16T13:24:58.819636Z","caller":"traceutil/trace.go:171","msg":"trace[696882873] linearizableReadLoop","detail":"{readStateIndex:17973; appliedIndex:17972; }","duration":"180.071624ms","start":"2026-08-16T13:24:58.63954Z","end":"2026-08-16T13:24:58.819611Z","steps":["trace[696882873] 'read index received'  (duration: 179.819699ms)","trace[696882873] 'applied index is now lower than readState.Index'  (duration: 251.095µs)"],"step_count":2}
{"level":"warn","ts":"2026-08-16T13:24:58.82Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.435402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"warn","ts":"2026-08-16T13:24:58.82005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.856228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-16T13:24:58.820064Z","caller":"traceutil/trace.go:171","msg":"trace[403482423] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:17386; }","duration":"180.512003ms","start":"2026-08-16T13:24:58.639537Z","end":"2026-08-16T13:24:58.820049Z","steps":["trace[403482423] 'agreement among raft nodes before linearized reading'  (duration: 180.308759ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-16T13:24:58.820075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.046314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-08-16T13:24:58.820098Z","caller":"traceutil/trace.go:171","msg":"trace[651747858] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:17386; }","duration":"173.95876ms","start":"2026-08-16T13:24:58.646125Z","end":"2026-08-16T13:24:58.820084Z","steps":["trace[651747858] 'agreement among raft nodes before linearized reading'  (duration: 173.845607ms)"],"step_count":1}
{"level":"info","ts":"2026-08-16T13:24:58.820127Z","caller":"traceutil/trace.go:171","msg":"trace[166082314] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:17386; }","duration":"180.109965ms","start":"2026-08-16T13:24:58.640003Z","end":"2026-08-16T13:24:58.820113Z","steps":["trace[166082314] 'agreement among raft nodes before linearized reading'  (duration: 179.932122ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-16T13:24:58.820262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.465932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-08-16T13:24:58.820354Z","caller":"traceutil/trace.go:171","msg":"trace[1864314347] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:17386; }","duration":"178.577575ms","start":"2026-08-16T13:24:58.641755Z","end":"2026-08-16T13:24:58.820332Z","steps":["trace[1864314347] 'agreement among raft nodes before linearized reading'  (duration: 178.187557ms)"],"step_count":1}
{"level":"info","ts":"2026-08-16T13:24:58.820406Z","caller":"traceutil/trace.go:171","msg":"trace[578590734] transaction","detail":"{read_only:false; response_revision:17386; number_of_response:1; }","duration":"182.053186ms","start":"2026-08-16T13:24:58.637825Z","end":"2026-08-16T13:24:58.819878Z","steps":["trace[578590734] 'process raft request'  (duration: 181.451874ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-16T13:25:04.263621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.760615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-08-16T13:25:04.263712Z","caller":"traceutil/trace.go:171","msg":"trace[1737349945] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:17437; }","duration":"123.900018ms","start":"2026-08-16T13:25:04.139794Z","end":"2026-08-16T13:25:04.263694Z","steps":["trace[1737349945] 'count revisions from in-memory index tree'  (duration: 123.674294ms)"],"step_count":1}
{"level":"info","ts":"2026-08-16T13:25:04.54057Z","caller":"traceutil/trace.go:171","msg":"trace[1315857166] transaction","detail":"{read_only:false; response_revision:17438; number_of_response:1; }","duration":"239.267232ms","start":"2026-08-16T13:25:04.301273Z","end":"2026-08-16T13:25:04.54054Z","steps":["trace[1315857166] 'process raft request'  (duration: 239.107048ms)"],"step_count":1}
{"level":"info","ts":"2026-08-16T13:25:04.542144Z","caller":"traceutil/trace.go:171","msg":"trace[513668302] transaction","detail":"{read_only:false; response_revision:17439; number_of_response:1; }","duration":"208.388053ms","start":"2026-08-16T13:25:04.333744Z","end":"2026-08-16T13:25:04.542132Z","steps":["trace[513668302] 'process raft request'  (duration: 207.763721ms)"],"step_count":1}
{"level":"info","ts":"2026-08-16T13:25:04.800526Z","caller":"traceutil/trace.go:171","msg":"trace[615705384] transaction","detail":"{read_only:false; response_revision:17442; number_of_response:1; }","duration":"133.513545ms","start":"2026-08-16T13:25:04.666979Z","end":"2026-08-16T13:25:04.800493Z","steps":["trace[615705384] 'process raft request'  (duration: 132.7816ms)"],"step_count":1}
{"level":"info","ts":"2026-08-16T13:26:09.907187Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15603}
{"level":"info","ts":"2026-08-16T13:26:10.01103Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15603,"took":"98.767655ms","hash":1916875382,"current-db-size-bytes":59170816,"current-db-size":"59 MB","current-db-size-in-use-bytes":34324480,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-08-16T13:26:10.011136Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1916875382,"revision":15603,"compact-revision":13030}
{"level":"info","ts":"2026-08-16T13:28:49.913374Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"d7dbc9f5893cc1f6","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-08-16T13:28:49.917655Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-08-16T13:28:49.917771Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-08-16T13:29:41.972025Z","caller":"traceutil/trace.go:171","msg":"trace[293149804] transaction","detail":"{read_only:false; response_revision:19629; number_of_response:1; }","duration":"110.997276ms","start":"2026-08-16T13:29:41.860996Z","end":"2026-08-16T13:29:41.971993Z","steps":["trace[293149804] 'process raft request'  (duration: 110.706139ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-16T13:29:48.424993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.676757ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13976534461089569376 > lease_revoke:<id:41f6a00aa03fd98e>","response":"size:30"}
{"level":"info","ts":"2026-08-16T13:29:48.425119Z","caller":"traceutil/trace.go:171","msg":"trace[1599044963] linearizableReadLoop","detail":"{readStateIndex:20324; appliedIndex:20323; }","duration":"281.756243ms","start":"2026-08-16T13:29:48.143344Z","end":"2026-08-16T13:29:48.4251Z","steps":["trace[1599044963] 'read index received'  (duration: 8.882802ms)","trace[1599044963] 'applied index is now lower than readState.Index'  (duration: 272.872051ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-16T13:29:48.425268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.911917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-08-16T13:29:48.425354Z","caller":"traceutil/trace.go:171","msg":"trace[132427692] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:19661; }","duration":"282.037999ms","start":"2026-08-16T13:29:48.143296Z","end":"2026-08-16T13:29:48.425334Z","steps":["trace[132427692] 'agreement among raft nodes before linearized reading'  (duration: 281.894816ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-16T13:29:48.425325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.439544ms","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-08-16T13:29:48.425428Z","caller":"traceutil/trace.go:171","msg":"trace[435178942] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:19661; }","duration":"277.603548ms","start":"2026-08-16T13:29:48.147804Z","end":"2026-08-16T13:29:48.425408Z","steps":["trace[435178942] 'agreement among raft nodes before linearized reading'  (duration: 277.424414ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-16T13:29:48.425737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.128711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"info","ts":"2026-08-16T13:29:48.425784Z","caller":"traceutil/trace.go:171","msg":"trace[1098093460] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:19661; }","duration":"262.230013ms","start":"2026-08-16T13:29:48.163539Z","end":"2026-08-16T13:29:48.425769Z","steps":["trace[1098093460] 'agreement among raft nodes before linearized reading'  (duration: 262.08934ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-16T13:29:48.425926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.507855ms","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-08-16T13:29:48.425971Z","caller":"traceutil/trace.go:171","msg":"trace[939234922] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:19661; }","duration":"205.585637ms","start":"2026-08-16T13:29:48.220373Z","end":"2026-08-16T13:29:48.425958Z","steps":["trace[939234922] 'agreement among raft nodes before linearized reading'  (duration: 205.428624ms)"],"step_count":1}
{"level":"info","ts":"2026-08-16T13:29:48.561646Z","caller":"traceutil/trace.go:171","msg":"trace[1332223099] transaction","detail":"{read_only:false; response_revision:19662; number_of_response:1; }","duration":"131.131367ms","start":"2026-08-16T13:29:48.43048Z","end":"2026-08-16T13:29:48.561612Z","steps":["trace[1332223099] 'process raft request'  (duration: 130.881802ms)"],"step_count":1}
{"level":"info","ts":"2026-08-16T13:29:48.692794Z","caller":"traceutil/trace.go:171","msg":"trace[1585016791] transaction","detail":"{read_only:false; response_revision:19663; number_of_response:1; }","duration":"261.52738ms","start":"2026-08-16T13:29:48.431246Z","end":"2026-08-16T13:29:48.692774Z","steps":["trace[1585016791] 'process raft request'  (duration: 253.772102ms)"],"step_count":1}
{"level":"info","ts":"2026-08-16T13:29:48.693108Z","caller":"traceutil/trace.go:171","msg":"trace[641185732] transaction","detail":"{read_only:false; response_revision:19664; number_of_response:1; }","duration":"261.643622ms","start":"2026-08-16T13:29:48.43144Z","end":"2026-08-16T13:29:48.693084Z","steps":["trace[641185732] 'process raft request'  (duration: 261.298875ms)"],"step_count":1}
{"level":"info","ts":"2026-08-16T13:29:48.69331Z","caller":"traceutil/trace.go:171","msg":"trace[1973028805] transaction","detail":"{read_only:false; response_revision:19666; number_of_response:1; }","duration":"246.736508ms","start":"2026-08-16T13:29:48.446559Z","end":"2026-08-16T13:29:48.693295Z","steps":["trace[1973028805] 'process raft request'  (duration: 246.500223ms)"],"step_count":1}
{"level":"info","ts":"2026-08-16T13:29:48.693344Z","caller":"traceutil/trace.go:171","msg":"trace[740576061] transaction","detail":"{read_only:false; response_revision:19665; number_of_response:1; }","duration":"254.614018ms","start":"2026-08-16T13:29:48.438704Z","end":"2026-08-16T13:29:48.693318Z","steps":["trace[740576061] 'process raft request'  (duration: 254.258001ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-16T13:29:48.984389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.429847ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13976534461089569385 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:19616 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-16T13:29:48.984658Z","caller":"traceutil/trace.go:171","msg":"trace[377365364] transaction","detail":"{read_only:false; response_revision:19667; number_of_response:1; }","duration":"200.026074ms","start":"2026-08-16T13:29:48.784541Z","end":"2026-08-16T13:29:48.984567Z","steps":["trace[377365364] 'process raft request'  (duration: 61.330962ms)","trace[377365364] 'compare'  (duration: 138.276754ms)"],"step_count":2}
{"level":"info","ts":"2026-08-16T13:29:49.175287Z","caller":"traceutil/trace.go:171","msg":"trace[1638610732] transaction","detail":"{read_only:false; response_revision:19668; number_of_response:1; }","duration":"116.576781ms","start":"2026-08-16T13:29:49.058679Z","end":"2026-08-16T13:29:49.175256Z","steps":["trace[1638610732] 'process raft request'  (duration: 116.392227ms)"],"step_count":1}
{"level":"info","ts":"2026-08-16T13:31:09.917063Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":18169}
{"level":"info","ts":"2026-08-16T13:31:10.024925Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":18169,"took":"104.163057ms","hash":1219323257,"current-db-size-bytes":59170816,"current-db-size":"59 MB","current-db-size-in-use-bytes":30474240,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-08-16T13:31:10.024995Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1219323257,"revision":18169,"compact-revision":15603}
{"level":"info","ts":"2026-08-16T13:33:28.198136Z","caller":"traceutil/trace.go:171","msg":"trace[1066761467] linearizableReadLoop","detail":"{readStateIndex:22764; appliedIndex:22762; }","duration":"271.012333ms","start":"2026-08-16T13:33:27.927068Z","end":"2026-08-16T13:33:28.19808Z","steps":["trace[1066761467] 'read index received'  (duration: 225.370082ms)","trace[1066761467] 'applied index is now lower than readState.Index'  (duration: 45.640201ms)"],"step_count":2}
{"level":"info","ts":"2026-08-16T13:33:28.198356Z","caller":"traceutil/trace.go:171","msg":"trace[1709272430] transaction","detail":"{read_only:false; response_revision:22032; number_of_response:1; }","duration":"248.962013ms","start":"2026-08-16T13:33:27.949375Z","end":"2026-08-16T13:33:28.198337Z","steps":["trace[1709272430] 'process raft request'  (duration: 248.655177ms)"],"step_count":1}
{"level":"info","ts":"2026-08-16T13:33:28.198138Z","caller":"traceutil/trace.go:171","msg":"trace[1968965806] transaction","detail":"{read_only:false; response_revision:22030; number_of_response:1; }","duration":"310.144983ms","start":"2026-08-16T13:33:27.887909Z","end":"2026-08-16T13:33:28.198054Z","steps":["trace[1968965806] 'process raft request'  (duration: 264.522352ms)","trace[1968965806] 'compare'  (duration: 45.337215ms)"],"step_count":2}
{"level":"info","ts":"2026-08-16T13:33:28.198732Z","caller":"traceutil/trace.go:171","msg":"trace[1252056653] transaction","detail":"{read_only:false; response_revision:22033; number_of_response:1; }","duration":"151.626256ms","start":"2026-08-16T13:33:28.046977Z","end":"2026-08-16T13:33:28.198603Z","steps":["trace[1252056653] 'process raft request'  (duration: 151.215157ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-16T13:33:28.198409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.329409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-16T13:33:28.199104Z","caller":"traceutil/trace.go:171","msg":"trace[1706492817] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:22032; }","duration":"272.085724ms","start":"2026-08-16T13:33:27.927005Z","end":"2026-08-16T13:33:28.199091Z","steps":["trace[1706492817] 'agreement among raft nodes before linearized reading'  (duration: 271.239557ms)"],"step_count":1}
{"level":"info","ts":"2026-08-16T13:33:28.198287Z","caller":"traceutil/trace.go:171","msg":"trace[784207263] transaction","detail":"{read_only:false; response_revision:22031; number_of_response:1; }","duration":"309.788165ms","start":"2026-08-16T13:33:27.888312Z","end":"2026-08-16T13:33:28.1981Z","steps":["trace[784207263] 'process raft request'  (duration: 309.637862ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-16T13:33:28.198881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-16T13:33:27.887887Z","time spent":"310.855876ms","remote":"127.0.0.1:35814","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:21977 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-08-16T13:33:28.199779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-16T13:33:27.888287Z","time spent":"311.181283ms","remote":"127.0.0.1:35814","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:21980 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-08-16T13:33:28.200126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.335989ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:561"}
{"level":"info","ts":"2026-08-16T13:33:28.200215Z","caller":"traceutil/trace.go:171","msg":"trace[1579342018] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:22033; }","duration":"245.472692ms","start":"2026-08-16T13:33:27.954714Z","end":"2026-08-16T13:33:28.200187Z","steps":["trace[1579342018] 'agreement among raft nodes before linearized reading'  (duration: 245.139086ms)"],"step_count":1}
{"level":"info","ts":"2026-08-16T13:36:09.923278Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20433}
{"level":"info","ts":"2026-08-16T13:36:10.031666Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20433,"took":"103.195517ms","hash":2792011070,"current-db-size-bytes":59170816,"current-db-size":"59 MB","current-db-size-in-use-bytes":43556864,"current-db-size-in-use":"44 MB"}
{"level":"info","ts":"2026-08-16T13:36:10.03174Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2792011070,"revision":20433,"compact-revision":18169}
{"level":"info","ts":"2026-08-16T13:41:09.930207Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23554}
{"level":"info","ts":"2026-08-16T13:41:10.060395Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23554,"took":"125.785238ms","hash":1891583689,"current-db-size-bytes":59170816,"current-db-size":"59 MB","current-db-size-in-use-bytes":30089216,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-08-16T13:41:10.060475Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1891583689,"revision":23554,"compact-revision":20433}