{"level":"warn","ts":"2026-07-02T00:16:08.314648Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-02T00:16:08.314841Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.109: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.109:2380","--initial-cluster=instance=https://199.204.45.109:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.109:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.109: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-07-02T00:16:08.314978Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-02T00:16:08.315021Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.109:2380"]} {"level":"info","ts":"2026-07-02T00:16:08.315074Z","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-07-02T00:16:08.316023Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"]} {"level":"info","ts":"2026-07-02T00:16:08.316159Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.109:2380"],"listen-peer-urls":["https://199.204.45.109:2380"],"advertise-client-urls":["https://199.204.45.109:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.109: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-07-02T00:16:08.319715Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.240087ms"} {"level":"info","ts":"2026-07-02T00:16:08.332516Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d71a1778b31d4ce","cluster-id":"aaca35652fabf9b2"} {"level":"info","ts":"2026-07-02T00:16:08.332637Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=()"} {"level":"info","ts":"2026-07-02T00:16:08.332697Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became follower at term 0"} {"level":"info","ts":"2026-07-02T00:16:08.332709Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d71a1778b31d4ce [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-02T00:16:08.332757Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became follower at term 1"} {"level":"info","ts":"2026-07-02T00:16:08.332835Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=(968732929669846222)"} {"level":"warn","ts":"2026-07-02T00:16:08.340821Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-02T00:16:08.342027Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-02T00:16:08.343172Z","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-07-02T00:16:08.345215Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d71a1778b31d4ce","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-02T00:16:08.345453Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d71a1778b31d4ce","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-02T00:16:08.345564Z","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-07-02T00:16:08.346314Z","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-07-02T00:16:08.346378Z","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-07-02T00:16:08.347207Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=(968732929669846222)"} {"level":"info","ts":"2026-07-02T00:16:08.347428Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"aaca35652fabf9b2","local-member-id":"d71a1778b31d4ce","added-peer-id":"d71a1778b31d4ce","added-peer-peer-urls":["https://199.204.45.109:2380"]} {"level":"info","ts":"2026-07-02T00:16:08.350465Z","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-07-02T00:16:08.350587Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.109:2380"} {"level":"info","ts":"2026-07-02T00:16:08.350637Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.109:2380"} {"level":"info","ts":"2026-07-02T00:16:08.350815Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d71a1778b31d4ce","initial-advertise-peer-urls":["https://199.204.45.109:2380"],"listen-peer-urls":["https://199.204.45.109:2380"],"advertise-client-urls":["https://199.204.45.109:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-02T00:16:08.350873Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-02T00:16:08.833357Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce is starting a new election at term 1"} {"level":"info","ts":"2026-07-02T00:16:08.833552Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became pre-candidate at term 1"} {"level":"info","ts":"2026-07-02T00:16:08.833631Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce received MsgPreVoteResp from d71a1778b31d4ce at term 1"} {"level":"info","ts":"2026-07-02T00:16:08.833696Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became candidate at term 2"} {"level":"info","ts":"2026-07-02T00:16:08.833738Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce received MsgVoteResp from d71a1778b31d4ce at term 2"} {"level":"info","ts":"2026-07-02T00:16:08.833816Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became leader at term 2"} {"level":"info","ts":"2026-07-02T00:16:08.833859Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d71a1778b31d4ce elected leader d71a1778b31d4ce at term 2"} {"level":"info","ts":"2026-07-02T00:16:08.835149Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-02T00:16:08.836019Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-02T00:16:08.836012Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d71a1778b31d4ce","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.109:2379]}","request-path":"/0/members/d71a1778b31d4ce/attributes","cluster-id":"aaca35652fabf9b2","publish-timeout":"7s"} {"level":"info","ts":"2026-07-02T00:16:08.83646Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-02T00:16:08.836544Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-02T00:16:08.836715Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"aaca35652fabf9b2","local-member-id":"d71a1778b31d4ce","cluster-version":"3.5"} {"level":"info","ts":"2026-07-02T00:16:08.836837Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-02T00:16:08.836927Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-02T00:16:08.837971Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-02T00:16:08.841133Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-02T00:16:08.844117Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.109:2379"} {"level":"info","ts":"2026-07-02T00:16:48.836876Z","caller":"traceutil/trace.go:171","msg":"trace[699060034] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"122.918555ms","start":"2026-07-02T00:16:48.71393Z","end":"2026-07-02T00:16:48.836848Z","steps":["trace[699060034] 'process raft request' (duration: 122.724043ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:16:48.84487Z","caller":"traceutil/trace.go:171","msg":"trace[1822796208] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"130.636408ms","start":"2026-07-02T00:16:48.714215Z","end":"2026-07-02T00:16:48.844851Z","steps":["trace[1822796208] 'process raft request' (duration: 130.032663ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:16:48.845076Z","caller":"traceutil/trace.go:171","msg":"trace[1673570485] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"130.705297ms","start":"2026-07-02T00:16:48.714362Z","end":"2026-07-02T00:16:48.845067Z","steps":["trace[1673570485] 'process raft request' (duration: 129.950901ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:16:48.845173Z","caller":"traceutil/trace.go:171","msg":"trace[1375553934] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"117.612421ms","start":"2026-07-02T00:16:48.727489Z","end":"2026-07-02T00:16:48.845102Z","steps":["trace[1375553934] 'process raft request' (duration: 116.971805ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:16:48.845183Z","caller":"traceutil/trace.go:171","msg":"trace[381918894] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"118.340746ms","start":"2026-07-02T00:16:48.726806Z","end":"2026-07-02T00:16:48.845147Z","steps":["trace[381918894] 'process raft request' (duration: 117.60221ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:16:48.845225Z","caller":"traceutil/trace.go:171","msg":"trace[472585484] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"110.265919ms","start":"2026-07-02T00:16:48.734953Z","end":"2026-07-02T00:16:48.845219Z","steps":["trace[472585484] 'process raft request' (duration: 109.641295ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:16:48.845269Z","caller":"traceutil/trace.go:171","msg":"trace[250986510] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"121.531422ms","start":"2026-07-02T00:16:48.723728Z","end":"2026-07-02T00:16:48.845259Z","steps":["trace[250986510] 'process raft request' (duration: 120.618985ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:16:48.845338Z","caller":"traceutil/trace.go:171","msg":"trace[1494169574] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"118.030273ms","start":"2026-07-02T00:16:48.727297Z","end":"2026-07-02T00:16:48.845327Z","steps":["trace[1494169574] 'process raft request' (duration: 117.136376ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:16:48.845195Z","caller":"traceutil/trace.go:171","msg":"trace[1138905028] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"113.134143ms","start":"2026-07-02T00:16:48.732047Z","end":"2026-07-02T00:16:48.845181Z","steps":["trace[1138905028] 'process raft request' (duration: 112.467618ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:16:48.845173Z","caller":"traceutil/trace.go:171","msg":"trace[7342472] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"118.440067ms","start":"2026-07-02T00:16:48.726699Z","end":"2026-07-02T00:16:48.845139Z","steps":["trace[7342472] 'process raft request' (duration: 117.679491ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:16:55.183056Z","caller":"traceutil/trace.go:171","msg":"trace[2114354595] linearizableReadLoop","detail":"{readStateIndex:661; appliedIndex:660; }","duration":"227.956402ms","start":"2026-07-02T00:16:54.955076Z","end":"2026-07-02T00:16:55.183032Z","steps":["trace[2114354595] 'read index received' (duration: 188.146413ms)","trace[2114354595] 'applied index is now lower than readState.Index' (duration: 39.809099ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:16:55.183205Z","caller":"traceutil/trace.go:171","msg":"trace[179295645] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"259.513228ms","start":"2026-07-02T00:16:54.923621Z","end":"2026-07-02T00:16:55.183134Z","steps":["trace[179295645] 'process raft request' (duration: 219.65877ms)","trace[179295645] 'compare' (duration: 39.621207ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T00:16:55.183415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.620668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-07-02T00:16:55.183409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.309504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-rtjrb\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-07-02T00:16:55.183497Z","caller":"traceutil/trace.go:171","msg":"trace[61949022] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:636; }","duration":"141.77292ms","start":"2026-07-02T00:16:55.041714Z","end":"2026-07-02T00:16:55.183487Z","steps":["trace[61949022] 'agreement among raft nodes before linearized reading' (duration: 141.530328ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:16:55.183531Z","caller":"traceutil/trace.go:171","msg":"trace[1529486421] range","detail":"{range_begin:/registry/pods/kube-system/cilium-rtjrb; range_end:; response_count:1; response_revision:636; }","duration":"228.450995ms","start":"2026-07-02T00:16:54.955061Z","end":"2026-07-02T00:16:55.183512Z","steps":["trace[1529486421] 'agreement among raft nodes before linearized reading' (duration: 228.101123ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:16:55.183674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.667612ms","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-07-02T00:16:55.183738Z","caller":"traceutil/trace.go:171","msg":"trace[390348428] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:636; }","duration":"203.780863ms","start":"2026-07-02T00:16:54.979941Z","end":"2026-07-02T00:16:55.183722Z","steps":["trace[390348428] 'agreement among raft nodes before linearized reading' (duration: 203.324159ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:16:55.183831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.714339ms","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-07-02T00:16:55.18393Z","caller":"traceutil/trace.go:171","msg":"trace[1862230384] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:636; }","duration":"204.84698ms","start":"2026-07-02T00:16:54.979045Z","end":"2026-07-02T00:16:55.183892Z","steps":["trace[1862230384] 'agreement among raft nodes before linearized reading' (duration: 204.190925ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:16:55.667411Z","caller":"traceutil/trace.go:171","msg":"trace[1905357421] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"470.403788ms","start":"2026-07-02T00:16:55.196955Z","end":"2026-07-02T00:16:55.667358Z","steps":["trace[1905357421] 'process raft request' (duration: 469.845653ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:16:55.668541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:16:55.196938Z","time spent":"470.575029ms","remote":"127.0.0.1:44508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T00:18:27.340445Z","caller":"traceutil/trace.go:171","msg":"trace[68705208] linearizableReadLoop","detail":"{readStateIndex:1938; appliedIndex:1937; }","duration":"135.073297ms","start":"2026-07-02T00:18:27.205341Z","end":"2026-07-02T00:18:27.340414Z","steps":["trace[68705208] 'read index received' (duration: 134.928294ms)","trace[68705208] 'applied index is now lower than readState.Index' (duration: 144.003µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:18:27.340963Z","caller":"traceutil/trace.go:171","msg":"trace[701312937] transaction","detail":"{read_only:false; response_revision:1861; number_of_response:1; }","duration":"159.579071ms","start":"2026-07-02T00:18:27.181349Z","end":"2026-07-02T00:18:27.340928Z","steps":["trace[701312937] 'process raft request' (duration: 158.831026ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:18:27.341484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.128988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"warn","ts":"2026-07-02T00:18:27.341508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.115286ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T00:18:27.341722Z","caller":"traceutil/trace.go:171","msg":"trace[1996420613] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1861; }","duration":"120.369341ms","start":"2026-07-02T00:18:27.221322Z","end":"2026-07-02T00:18:27.341692Z","steps":["trace[1996420613] 'agreement among raft nodes before linearized reading' (duration: 120.100945ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:18:27.341555Z","caller":"traceutil/trace.go:171","msg":"trace[2116330415] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1861; }","duration":"136.21457ms","start":"2026-07-02T00:18:27.205303Z","end":"2026-07-02T00:18:27.341518Z","steps":["trace[2116330415] 'agreement among raft nodes before linearized reading' (duration: 136.048047ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:18:27.342098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.276129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-07-02T00:18:27.342234Z","caller":"traceutil/trace.go:171","msg":"trace[2107782853] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1861; }","duration":"106.480743ms","start":"2026-07-02T00:18:27.235733Z","end":"2026-07-02T00:18:27.342214Z","steps":["trace[2107782853] 'agreement among raft nodes before linearized reading' (duration: 105.85811ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:18:27.644137Z","caller":"traceutil/trace.go:171","msg":"trace[1784545606] linearizableReadLoop","detail":"{readStateIndex:1939; appliedIndex:1938; }","duration":"180.467581ms","start":"2026-07-02T00:18:27.463646Z","end":"2026-07-02T00:18:27.644114Z","steps":["trace[1784545606] 'read index received' (duration: 106.666577ms)","trace[1784545606] 'applied index is now lower than readState.Index' (duration: 73.799254ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:18:27.644173Z","caller":"traceutil/trace.go:171","msg":"trace[139418290] transaction","detail":"{read_only:false; response_revision:1862; number_of_response:1; }","duration":"295.409424ms","start":"2026-07-02T00:18:27.348731Z","end":"2026-07-02T00:18:27.644141Z","steps":["trace[139418290] 'process raft request' (duration: 221.566519ms)","trace[139418290] 'compare' (duration: 73.521019ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T00:18:27.644397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.732707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-db81e216-04c1-492b-b8eb-7be11dfdbacb\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-07-02T00:18:27.644479Z","caller":"traceutil/trace.go:171","msg":"trace[1376019645] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-db81e216-04c1-492b-b8eb-7be11dfdbacb; range_end:; response_count:1; response_revision:1862; }","duration":"180.85588ms","start":"2026-07-02T00:18:27.463602Z","end":"2026-07-02T00:18:27.644458Z","steps":["trace[1376019645] 'agreement among raft nodes before linearized reading' (duration: 180.624795ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:18:27.81408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.624743ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-07-02T00:18:27.814424Z","caller":"traceutil/trace.go:171","msg":"trace[1766907537] linearizableReadLoop","detail":"{readStateIndex:1941; appliedIndex:1939; }","duration":"170.197465ms","start":"2026-07-02T00:18:27.644207Z","end":"2026-07-02T00:18:27.814405Z","steps":["trace[1766907537] 'read index received' (duration: 4.325608ms)","trace[1766907537] 'applied index is now lower than readState.Index' (duration: 165.870407ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:18:27.814543Z","caller":"traceutil/trace.go:171","msg":"trace[2104122029] transaction","detail":"{read_only:false; response_revision:1863; number_of_response:1; }","duration":"232.656622ms","start":"2026-07-02T00:18:27.581826Z","end":"2026-07-02T00:18:27.814482Z","steps":["trace[2104122029] 'process raft request' (duration: 232.390197ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:18:27.814826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.214697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-db81e216-04c1-492b-b8eb-7be11dfdbacb\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-07-02T00:18:27.814884Z","caller":"traceutil/trace.go:171","msg":"trace[461636219] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-db81e216-04c1-492b-b8eb-7be11dfdbacb; range_end:; response_count:1; response_revision:1863; }","duration":"270.319509ms","start":"2026-07-02T00:18:27.54454Z","end":"2026-07-02T00:18:27.814859Z","steps":["trace[461636219] 'agreement among raft nodes before linearized reading' (duration: 269.949842ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:18:27.872584Z","caller":"traceutil/trace.go:171","msg":"trace[550765252] transaction","detail":"{read_only:false; response_revision:1864; number_of_response:1; }","duration":"219.372144ms","start":"2026-07-02T00:18:27.653189Z","end":"2026-07-02T00:18:27.872561Z","steps":["trace[550765252] 'process raft request' (duration: 218.963046ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:18:27.872739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.627809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-07-02T00:18:27.872902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.533247ms","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-07-02T00:18:27.872818Z","caller":"traceutil/trace.go:171","msg":"trace[619303383] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1864; }","duration":"133.759412ms","start":"2026-07-02T00:18:27.739044Z","end":"2026-07-02T00:18:27.872804Z","steps":["trace[619303383] 'agreement among raft nodes before linearized reading' (duration: 133.544817ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:18:27.872992Z","caller":"traceutil/trace.go:171","msg":"trace[1149122982] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1864; }","duration":"210.675959ms","start":"2026-07-02T00:18:27.662295Z","end":"2026-07-02T00:18:27.872971Z","steps":["trace[1149122982] 'agreement among raft nodes before linearized reading' (duration: 210.391773ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:18:27.873358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.120489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-02T00:18:27.873463Z","caller":"traceutil/trace.go:171","msg":"trace[2132485441] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1864; }","duration":"213.346473ms","start":"2026-07-02T00:18:27.660104Z","end":"2026-07-02T00:18:27.873451Z","steps":["trace[2132485441] 'agreement among raft nodes before linearized reading' (duration: 212.416655ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:18:41.061126Z","caller":"traceutil/trace.go:171","msg":"trace[730955309] transaction","detail":"{read_only:false; response_revision:1977; number_of_response:1; }","duration":"145.809853ms","start":"2026-07-02T00:18:40.915283Z","end":"2026-07-02T00:18:41.061093Z","steps":["trace[730955309] 'process raft request' (duration: 145.61773ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:18:52.751725Z","caller":"traceutil/trace.go:171","msg":"trace[1406336499] transaction","detail":"{read_only:false; response_revision:2053; number_of_response:1; }","duration":"102.935008ms","start":"2026-07-02T00:18:52.648758Z","end":"2026-07-02T00:18:52.751693Z","steps":["trace[1406336499] 'process raft request' (duration: 102.754745ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:18:58.097165Z","caller":"traceutil/trace.go:171","msg":"trace[651685888] transaction","detail":"{read_only:false; response_revision:2085; number_of_response:1; }","duration":"118.302509ms","start":"2026-07-02T00:18:57.978835Z","end":"2026-07-02T00:18:58.097138Z","steps":["trace[651685888] 'process raft request' (duration: 117.290064ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:18:58.263952Z","caller":"traceutil/trace.go:171","msg":"trace[1591242734] transaction","detail":"{read_only:false; response_revision:2086; number_of_response:1; }","duration":"161.082669ms","start":"2026-07-02T00:18:58.102837Z","end":"2026-07-02T00:18:58.26392Z","steps":["trace[1591242734] 'process raft request' (duration: 160.818555ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:18:58.26429Z","caller":"traceutil/trace.go:171","msg":"trace[2003757106] transaction","detail":"{read_only:false; response_revision:2087; number_of_response:1; }","duration":"161.425944ms","start":"2026-07-02T00:18:58.102822Z","end":"2026-07-02T00:18:58.264248Z","steps":["trace[2003757106] 'process raft request' (duration: 161.049218ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:18:58.27113Z","caller":"traceutil/trace.go:171","msg":"trace[124331406] transaction","detail":"{read_only:false; response_revision:2088; number_of_response:1; }","duration":"167.358888ms","start":"2026-07-02T00:18:58.103748Z","end":"2026-07-02T00:18:58.271106Z","steps":["trace[124331406] 'process raft request' (duration: 166.744738ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:18:59.770775Z","caller":"traceutil/trace.go:171","msg":"trace[697392892] linearizableReadLoop","detail":"{readStateIndex:2177; appliedIndex:2176; }","duration":"186.364192ms","start":"2026-07-02T00:18:59.584383Z","end":"2026-07-02T00:18:59.770748Z","steps":["trace[697392892] 'read index received' (duration: 186.116239ms)","trace[697392892] 'applied index is now lower than readState.Index' (duration: 246.693µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:18:59.770835Z","caller":"traceutil/trace.go:171","msg":"trace[128323808] transaction","detail":"{read_only:false; response_revision:2092; number_of_response:1; }","duration":"235.072263ms","start":"2026-07-02T00:18:59.535729Z","end":"2026-07-02T00:18:59.770801Z","steps":["trace[128323808] 'process raft request' (duration: 234.85593ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:18:59.771039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.623306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-07-02T00:18:59.771071Z","caller":"traceutil/trace.go:171","msg":"trace[2044941466] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2092; }","duration":"186.705687ms","start":"2026-07-02T00:18:59.584355Z","end":"2026-07-02T00:18:59.77106Z","steps":["trace[2044941466] 'agreement among raft nodes before linearized reading' (duration: 186.489224ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:18:59.971624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.28736ms","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-07-02T00:18:59.97172Z","caller":"traceutil/trace.go:171","msg":"trace[954806898] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2092; }","duration":"155.455501ms","start":"2026-07-02T00:18:59.816243Z","end":"2026-07-02T00:18:59.971698Z","steps":["trace[954806898] 'range keys from in-memory index tree' (duration: 155.033755ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:18:59.971732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.556797ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T00:18:59.971862Z","caller":"traceutil/trace.go:171","msg":"trace[1447908584] transaction","detail":"{read_only:false; response_revision:2093; number_of_response:1; }","duration":"138.659746ms","start":"2026-07-02T00:18:59.833178Z","end":"2026-07-02T00:18:59.971838Z","steps":["trace[1447908584] 'process raft request' (duration: 14.882625ms)","trace[1447908584] 'compare' (duration: 123.382385ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:19:00.236022Z","caller":"traceutil/trace.go:171","msg":"trace[1363554069] transaction","detail":"{read_only:false; response_revision:2095; number_of_response:1; }","duration":"131.669022ms","start":"2026-07-02T00:19:00.104331Z","end":"2026-07-02T00:19:00.236Z","steps":["trace[1363554069] 'process raft request' (duration: 99.81306ms)","trace[1363554069] 'compare' (duration: 31.484017ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T00:19:36.685986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.500284ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T00:19:36.686481Z","caller":"traceutil/trace.go:171","msg":"trace[667229768] transaction","detail":"{read_only:false; response_revision:2296; number_of_response:1; }","duration":"207.57896ms","start":"2026-07-02T00:19:36.478878Z","end":"2026-07-02T00:19:36.686457Z","steps":["trace[667229768] 'process raft request' (duration: 207.216624ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:19:36.686705Z","caller":"traceutil/trace.go:171","msg":"trace[1401815078] transaction","detail":"{read_only:false; response_revision:2297; number_of_response:1; }","duration":"203.915502ms","start":"2026-07-02T00:19:36.48278Z","end":"2026-07-02T00:19:36.686695Z","steps":["trace[1401815078] 'process raft request' (duration: 203.360624ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:19:36.686539Z","caller":"traceutil/trace.go:171","msg":"trace[1721245750] transaction","detail":"{read_only:false; response_revision:2295; number_of_response:1; }","duration":"207.949164ms","start":"2026-07-02T00:19:36.478541Z","end":"2026-07-02T00:19:36.68649Z","steps":["trace[1721245750] 'process raft request' (duration: 88.825291ms)","trace[1721245750] 'compare' (duration: 118.352883ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:19:40.82428Z","caller":"traceutil/trace.go:171","msg":"trace[1985725265] transaction","detail":"{read_only:false; response_revision:2324; number_of_response:1; }","duration":"102.035949ms","start":"2026-07-02T00:19:40.722213Z","end":"2026-07-02T00:19:40.824249Z","steps":["trace[1985725265] 'process raft request' (duration: 101.989819ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:19:40.824284Z","caller":"traceutil/trace.go:171","msg":"trace[1908859658] transaction","detail":"{read_only:false; response_revision:2323; number_of_response:1; }","duration":"102.673007ms","start":"2026-07-02T00:19:40.721587Z","end":"2026-07-02T00:19:40.82426Z","steps":["trace[1908859658] 'process raft request' (duration: 55.844761ms)","trace[1908859658] 'compare' (duration: 46.652554ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:19:42.938075Z","caller":"traceutil/trace.go:171","msg":"trace[131093379] transaction","detail":"{read_only:false; response_revision:2333; number_of_response:1; }","duration":"105.467781ms","start":"2026-07-02T00:19:42.832567Z","end":"2026-07-02T00:19:42.938035Z","steps":["trace[131093379] 'process raft request' (duration: 39.025812ms)","trace[131093379] 'compare' (duration: 66.264127ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:19:43.016793Z","caller":"traceutil/trace.go:171","msg":"trace[1254135693] transaction","detail":"{read_only:false; response_revision:2334; number_of_response:1; }","duration":"184.137113ms","start":"2026-07-02T00:19:42.832618Z","end":"2026-07-02T00:19:43.016755Z","steps":["trace[1254135693] 'process raft request' (duration: 183.963781ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:19:45.227721Z","caller":"traceutil/trace.go:171","msg":"trace[892769651] transaction","detail":"{read_only:false; response_revision:2345; number_of_response:1; }","duration":"115.330508ms","start":"2026-07-02T00:19:45.112348Z","end":"2026-07-02T00:19:45.227679Z","steps":["trace[892769651] 'process raft request' (duration: 92.332341ms)","trace[892769651] 'compare' (duration: 22.807714ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T00:19:51.744236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.535227ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T00:19:51.74439Z","caller":"traceutil/trace.go:171","msg":"trace[1807188714] transaction","detail":"{read_only:false; response_revision:2377; number_of_response:1; }","duration":"168.483723ms","start":"2026-07-02T00:19:51.575882Z","end":"2026-07-02T00:19:51.744365Z","steps":["trace[1807188714] 'process raft request' (duration: 39.681133ms)","trace[1807188714] 'compare' (duration: 128.378115ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:19:51.778548Z","caller":"traceutil/trace.go:171","msg":"trace[43590248] linearizableReadLoop","detail":"{readStateIndex:2474; appliedIndex:2473; }","duration":"128.100791ms","start":"2026-07-02T00:19:51.650431Z","end":"2026-07-02T00:19:51.778532Z","steps":["trace[43590248] 'read index received' (duration: 127.902409ms)","trace[43590248] 'applied index is now lower than readState.Index' (duration: 196.992µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:19:51.778637Z","caller":"traceutil/trace.go:171","msg":"trace[507119273] transaction","detail":"{read_only:false; response_revision:2378; number_of_response:1; }","duration":"196.854909ms","start":"2026-07-02T00:19:51.581746Z","end":"2026-07-02T00:19:51.778601Z","steps":["trace[507119273] 'process raft request' (duration: 196.688547ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:19:51.778743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.314793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5428"} {"level":"info","ts":"2026-07-02T00:19:51.778787Z","caller":"traceutil/trace.go:171","msg":"trace[1243644145] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2378; }","duration":"128.403535ms","start":"2026-07-02T00:19:51.650373Z","end":"2026-07-02T00:19:51.778777Z","steps":["trace[1243644145] 'agreement among raft nodes before linearized reading' (duration: 128.216293ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:19:53.051475Z","caller":"traceutil/trace.go:171","msg":"trace[1325784608] transaction","detail":"{read_only:false; response_revision:2384; number_of_response:1; }","duration":"130.954347ms","start":"2026-07-02T00:19:52.920486Z","end":"2026-07-02T00:19:53.051441Z","steps":["trace[1325784608] 'process raft request' (duration: 130.705964ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:20:11.360278Z","caller":"traceutil/trace.go:171","msg":"trace[1248738172] linearizableReadLoop","detail":"{readStateIndex:2679; appliedIndex:2678; }","duration":"140.232579ms","start":"2026-07-02T00:20:11.220014Z","end":"2026-07-02T00:20:11.360246Z","steps":["trace[1248738172] 'read index received' (duration: 140.013667ms)","trace[1248738172] 'applied index is now lower than readState.Index' (duration: 217.422µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:20:11.360373Z","caller":"traceutil/trace.go:171","msg":"trace[2086817985] transaction","detail":"{read_only:false; response_revision:2578; number_of_response:1; }","duration":"180.915823ms","start":"2026-07-02T00:20:11.179408Z","end":"2026-07-02T00:20:11.360324Z","steps":["trace[2086817985] 'process raft request' (duration: 180.64505ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:20:11.360499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.463392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T00:20:11.360545Z","caller":"traceutil/trace.go:171","msg":"trace[306554415] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2578; }","duration":"140.562513ms","start":"2026-07-02T00:20:11.219968Z","end":"2026-07-02T00:20:11.360531Z","steps":["trace[306554415] 'agreement among raft nodes before linearized reading' (duration: 140.466612ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:20:11.36061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.40497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-07-02T00:20:11.360665Z","caller":"traceutil/trace.go:171","msg":"trace[15870205] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2578; }","duration":"132.508281ms","start":"2026-07-02T00:20:11.228144Z","end":"2026-07-02T00:20:11.360652Z","steps":["trace[15870205] 'agreement among raft nodes before linearized reading' (duration: 132.329039ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:20:44.351047Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15334368741816706136,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-02T00:20:44.673911Z","caller":"traceutil/trace.go:171","msg":"trace[2063169478] transaction","detail":"{read_only:false; response_revision:2758; number_of_response:1; }","duration":"857.631854ms","start":"2026-07-02T00:20:43.816212Z","end":"2026-07-02T00:20:44.673844Z","steps":["trace[2063169478] 'process raft request' (duration: 757.278985ms)","trace[2063169478] 'compare' (duration: 99.641432ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T00:20:44.674261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:20:43.816186Z","time spent":"857.798635ms","remote":"127.0.0.1:44606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T00:20:44.695617Z","caller":"traceutil/trace.go:171","msg":"trace[1403122040] linearizableReadLoop","detail":"{readStateIndex:2868; appliedIndex:2866; }","duration":"844.634566ms","start":"2026-07-02T00:20:43.850954Z","end":"2026-07-02T00:20:44.695588Z","steps":["trace[1403122040] 'read index received' (duration: 722.521418ms)","trace[1403122040] 'applied index is now lower than readState.Index' (duration: 122.111228ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:20:44.695673Z","caller":"traceutil/trace.go:171","msg":"trace[898816745] transaction","detail":"{read_only:false; response_revision:2759; number_of_response:1; }","duration":"680.771043ms","start":"2026-07-02T00:20:44.014887Z","end":"2026-07-02T00:20:44.695658Z","steps":["trace[898816745] 'process raft request' (duration: 680.512781ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:20:44.695728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:20:44.014853Z","time spent":"680.849145ms","remote":"127.0.0.1:44606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T00:20:44.695955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"598.148323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-07-02T00:20:44.696002Z","caller":"traceutil/trace.go:171","msg":"trace[968390470] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2759; }","duration":"598.291924ms","start":"2026-07-02T00:20:44.097699Z","end":"2026-07-02T00:20:44.695991Z","steps":["trace[968390470] 'agreement among raft nodes before linearized reading' (duration: 598.063241ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:20:44.696014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.189944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-02T00:20:44.696013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.253535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18be510e579427de\" ","response":"range_response_count:1 size:781"} {"level":"warn","ts":"2026-07-02T00:20:44.696043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:20:44.097681Z","time spent":"598.352724ms","remote":"127.0.0.1:44606","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-02T00:20:44.696113Z","caller":"traceutil/trace.go:171","msg":"trace[545214144] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18be510e579427de; range_end:; response_count:1; response_revision:2759; }","duration":"167.400036ms","start":"2026-07-02T00:20:44.528677Z","end":"2026-07-02T00:20:44.696077Z","steps":["trace[545214144] 'agreement among raft nodes before linearized reading' (duration: 167.119304ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:20:44.696117Z","caller":"traceutil/trace.go:171","msg":"trace[635705364] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2759; }","duration":"473.286804ms","start":"2026-07-02T00:20:44.222782Z","end":"2026-07-02T00:20:44.696069Z","steps":["trace[635705364] 'agreement among raft nodes before linearized reading' (duration: 473.095032ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:20:44.696093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"845.120991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"warn","ts":"2026-07-02T00:20:44.696168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:20:44.22277Z","time spent":"473.386595ms","remote":"127.0.0.1:44338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-02T00:20:44.696226Z","caller":"traceutil/trace.go:171","msg":"trace[1776566983] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2759; }","duration":"845.281143ms","start":"2026-07-02T00:20:43.850888Z","end":"2026-07-02T00:20:44.69617Z","steps":["trace[1776566983] 'agreement among raft nodes before linearized reading' (duration: 844.834949ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:20:44.69628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:20:43.85086Z","time spent":"845.408414ms","remote":"127.0.0.1:44508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12239,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-07-02T00:20:44.696891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.294069ms","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-07-02T00:20:44.696966Z","caller":"traceutil/trace.go:171","msg":"trace[1840600416] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:2759; }","duration":"391.431619ms","start":"2026-07-02T00:20:44.305516Z","end":"2026-07-02T00:20:44.696947Z","steps":["trace[1840600416] 'agreement among raft nodes before linearized reading' (duration: 391.275488ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:20:44.697382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:20:44.305487Z","time spent":"391.849864ms","remote":"127.0.0.1:59006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":30,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-07-02T00:20:45.224231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.056581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T00:20:45.224331Z","caller":"traceutil/trace.go:171","msg":"trace[142933890] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2761; }","duration":"424.199393ms","start":"2026-07-02T00:20:44.800102Z","end":"2026-07-02T00:20:45.224301Z","steps":["trace[142933890] 'range keys from in-memory index tree' (duration: 423.972091ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:20:45.224405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:20:44.80008Z","time spent":"424.307344ms","remote":"127.0.0.1:44762","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":28,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"warn","ts":"2026-07-02T00:20:45.224945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.127045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-07-02T00:20:45.224999Z","caller":"traceutil/trace.go:171","msg":"trace[926205955] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2761; }","duration":"394.221696ms","start":"2026-07-02T00:20:44.83076Z","end":"2026-07-02T00:20:45.224982Z","steps":["trace[926205955] 'range keys from in-memory index tree' (duration: 393.892403ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:20:45.225034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:20:44.830738Z","time spent":"394.287047ms","remote":"127.0.0.1:44606","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":577,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-07-02T00:20:45.225722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.295876ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T00:20:45.2258Z","caller":"traceutil/trace.go:171","msg":"trace[1260860192] linearizableReadLoop","detail":"{readStateIndex:2871; appliedIndex:2870; }","duration":"224.532255ms","start":"2026-07-02T00:20:45.001256Z","end":"2026-07-02T00:20:45.225788Z","steps":["trace[1260860192] 'read index received' (duration: 58.751µs)","trace[1260860192] 'applied index is now lower than readState.Index' (duration: 224.472204ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T00:20:45.225904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.648936ms","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-07-02T00:20:45.225934Z","caller":"traceutil/trace.go:171","msg":"trace[581405500] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2762; }","duration":"224.727207ms","start":"2026-07-02T00:20:45.001198Z","end":"2026-07-02T00:20:45.225926Z","steps":["trace[581405500] 'agreement among raft nodes before linearized reading' (duration: 224.632867ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:20:45.226313Z","caller":"traceutil/trace.go:171","msg":"trace[1070027927] transaction","detail":"{read_only:false; response_revision:2762; number_of_response:1; }","duration":"349.011668ms","start":"2026-07-02T00:20:44.876983Z","end":"2026-07-02T00:20:45.225995Z","steps":["trace[1070027927] 'process raft request' (duration: 63.350338ms)","trace[1070027927] 'compare' (duration: 283.521477ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T00:20:45.226619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:20:44.876952Z","time spent":"349.488403ms","remote":"127.0.0.1:44606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T00:20:45.270477Z","caller":"traceutil/trace.go:171","msg":"trace[427387962] transaction","detail":"{read_only:false; response_revision:2763; number_of_response:1; }","duration":"113.635097ms","start":"2026-07-02T00:20:45.156822Z","end":"2026-07-02T00:20:45.270457Z","steps":["trace[427387962] 'process raft request' (duration: 113.412804ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:20:45.364386Z","caller":"traceutil/trace.go:171","msg":"trace[43695459] transaction","detail":"{read_only:false; response_revision:2764; number_of_response:1; }","duration":"131.874419ms","start":"2026-07-02T00:20:45.232478Z","end":"2026-07-02T00:20:45.364352Z","steps":["trace[43695459] 'process raft request' (duration: 106.662053ms)","trace[43695459] 'compare' (duration: 24.68951ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:20:45.364439Z","caller":"traceutil/trace.go:171","msg":"trace[1023213525] transaction","detail":"{read_only:false; response_revision:2765; number_of_response:1; }","duration":"131.838918ms","start":"2026-07-02T00:20:45.232552Z","end":"2026-07-02T00:20:45.36439Z","steps":["trace[1023213525] 'process raft request' (duration: 131.420893ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:20:45.364494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.105344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T00:20:45.364747Z","caller":"traceutil/trace.go:171","msg":"trace[1872993501] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2765; }","duration":"136.382307ms","start":"2026-07-02T00:20:45.228347Z","end":"2026-07-02T00:20:45.36473Z","steps":["trace[1872993501] 'agreement among raft nodes before linearized reading' (duration: 136.107144ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:24:34.422595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.399568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"warn","ts":"2026-07-02T00:24:34.422677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.875136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-zrz4c\" ","response":"range_response_count:1 size:9757"} {"level":"info","ts":"2026-07-02T00:24:34.422807Z","caller":"traceutil/trace.go:171","msg":"trace[754596576] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-zrz4c; range_end:; response_count:1; response_revision:4662; }","duration":"129.051958ms","start":"2026-07-02T00:24:34.293732Z","end":"2026-07-02T00:24:34.422784Z","steps":["trace[754596576] 'range keys from in-memory index tree' (duration: 128.540031ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:24:34.422684Z","caller":"traceutil/trace.go:171","msg":"trace[1842376147] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4662; }","duration":"128.53349ms","start":"2026-07-02T00:24:34.294131Z","end":"2026-07-02T00:24:34.422665Z","steps":["trace[1842376147] 'range keys from in-memory index tree' (duration: 127.971131ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:24:34.423873Z","caller":"traceutil/trace.go:171","msg":"trace[1484336669] transaction","detail":"{read_only:false; response_revision:4663; number_of_response:1; }","duration":"128.838355ms","start":"2026-07-02T00:24:34.295016Z","end":"2026-07-02T00:24:34.423855Z","steps":["trace[1484336669] 'process raft request' (duration: 128.739453ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:24:34.425295Z","caller":"traceutil/trace.go:171","msg":"trace[1543293245] transaction","detail":"{read_only:false; response_revision:4664; number_of_response:1; }","duration":"119.591108ms","start":"2026-07-02T00:24:34.305686Z","end":"2026-07-02T00:24:34.425277Z","steps":["trace[1543293245] 'process raft request' (duration: 119.463746ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:24:39.950773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.265758ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-02T00:24:39.950922Z","caller":"traceutil/trace.go:171","msg":"trace[1379708851] linearizableReadLoop","detail":"{readStateIndex:4955; appliedIndex:4954; }","duration":"272.887277ms","start":"2026-07-02T00:24:39.678018Z","end":"2026-07-02T00:24:39.950905Z","steps":["trace[1379708851] 'read index received' (duration: 130.008342ms)","trace[1379708851] 'applied index is now lower than readState.Index' (duration: 142.877365ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:24:39.951014Z","caller":"traceutil/trace.go:171","msg":"trace[1746614574] transaction","detail":"{read_only:false; response_revision:4769; number_of_response:1; }","duration":"275.817003ms","start":"2026-07-02T00:24:39.675181Z","end":"2026-07-02T00:24:39.950998Z","steps":["trace[1746614574] 'process raft request' (duration: 132.858598ms)","trace[1746614574] 'compare' (duration: 140.857262ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T00:24:39.95133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.290534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T00:24:39.951415Z","caller":"traceutil/trace.go:171","msg":"trace[1911605551] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:4769; }","duration":"273.398745ms","start":"2026-07-02T00:24:39.677996Z","end":"2026-07-02T00:24:39.951395Z","steps":["trace[1911605551] 'agreement among raft nodes before linearized reading' (duration: 273.224542ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:24:40.333259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.371999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T00:24:40.333441Z","caller":"traceutil/trace.go:171","msg":"trace[1666153536] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4774; }","duration":"110.578413ms","start":"2026-07-02T00:24:40.222842Z","end":"2026-07-02T00:24:40.33342Z","steps":["trace[1666153536] 'range keys from in-memory index tree' (duration: 110.255807ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:24:40.472263Z","caller":"traceutil/trace.go:171","msg":"trace[1377524859] transaction","detail":"{read_only:false; response_revision:4776; number_of_response:1; }","duration":"104.185573ms","start":"2026-07-02T00:24:40.368032Z","end":"2026-07-02T00:24:40.472218Z","steps":["trace[1377524859] 'process raft request' (duration: 103.535963ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:24:40.60257Z","caller":"traceutil/trace.go:171","msg":"trace[1549329004] transaction","detail":"{read_only:false; response_revision:4779; number_of_response:1; }","duration":"120.885155ms","start":"2026-07-02T00:24:40.481643Z","end":"2026-07-02T00:24:40.602528Z","steps":["trace[1549329004] 'process raft request' (duration: 120.712152ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:24:40.602586Z","caller":"traceutil/trace.go:171","msg":"trace[146537516] transaction","detail":"{read_only:false; response_revision:4780; number_of_response:1; }","duration":"120.813843ms","start":"2026-07-02T00:24:40.481746Z","end":"2026-07-02T00:24:40.602559Z","steps":["trace[146537516] 'process raft request' (duration: 120.681241ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:24:40.602554Z","caller":"traceutil/trace.go:171","msg":"trace[461626908] transaction","detail":"{read_only:false; response_revision:4778; number_of_response:1; }","duration":"121.131088ms","start":"2026-07-02T00:24:40.481356Z","end":"2026-07-02T00:24:40.602487Z","steps":["trace[461626908] 'process raft request' (duration: 112.640565ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:24:40.602801Z","caller":"traceutil/trace.go:171","msg":"trace[623621206] linearizableReadLoop","detail":"{readStateIndex:4966; appliedIndex:4962; }","duration":"116.954623ms","start":"2026-07-02T00:24:40.485811Z","end":"2026-07-02T00:24:40.602765Z","steps":["trace[623621206] 'read index received' (duration: 11.771344ms)","trace[623621206] 'applied index is now lower than readState.Index' (duration: 105.181409ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T00:24:40.603072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.233307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-07-02T00:24:40.603128Z","caller":"traceutil/trace.go:171","msg":"trace[1995257721] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4781; }","duration":"117.34956ms","start":"2026-07-02T00:24:40.485764Z","end":"2026-07-02T00:24:40.603114Z","steps":["trace[1995257721] 'agreement among raft nodes before linearized reading' (duration: 117.122996ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:24:40.603262Z","caller":"traceutil/trace.go:171","msg":"trace[2143252316] transaction","detail":"{read_only:false; response_revision:4781; number_of_response:1; }","duration":"106.335926ms","start":"2026-07-02T00:24:40.496886Z","end":"2026-07-02T00:24:40.603222Z","steps":["trace[2143252316] 'process raft request' (duration: 105.585374ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:26:09.207452Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2890} {"level":"info","ts":"2026-07-02T00:26:09.280964Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2890,"took":"71.995265ms","hash":910111861,"current-db-size-bytes":52629504,"current-db-size":"53 MB","current-db-size-in-use-bytes":29257728,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-07-02T00:26:09.281041Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":910111861,"revision":2890,"compact-revision":-1} {"level":"info","ts":"2026-07-02T00:31:09.213624Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5567} {"level":"info","ts":"2026-07-02T00:31:09.301943Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5567,"took":"86.505978ms","hash":690922596,"current-db-size-bytes":52629504,"current-db-size":"53 MB","current-db-size-in-use-bytes":18399232,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-07-02T00:31:09.302081Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":690922596,"revision":5567,"compact-revision":2890}