{"level":"warn","ts":"2026-08-13T00:55:48.700165Z","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-13T00:55:48.700287Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.182: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.182:2380","--initial-cluster=instance=https://199.204.45.182:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.182:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.182: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-13T00:55:48.700363Z","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-13T00:55:48.700377Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.182:2380"]} {"level":"info","ts":"2026-08-13T00:55:48.700398Z","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-13T00:55:48.701171Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.182:2379"]} {"level":"info","ts":"2026-08-13T00:55:48.701254Z","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.182:2380"],"listen-peer-urls":["https://199.204.45.182:2380"],"advertise-client-urls":["https://199.204.45.182:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.182:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.182: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-13T00:55:48.707153Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.965634ms"} {"level":"info","ts":"2026-08-13T00:55:48.716253Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e44ae1545340c14b","cluster-id":"7284b69afd367451"} {"level":"info","ts":"2026-08-13T00:55:48.716316Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e44ae1545340c14b switched to configuration voters=()"} {"level":"info","ts":"2026-08-13T00:55:48.716335Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e44ae1545340c14b became follower at term 0"} {"level":"info","ts":"2026-08-13T00:55:48.716347Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e44ae1545340c14b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-13T00:55:48.71636Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e44ae1545340c14b became follower at term 1"} {"level":"info","ts":"2026-08-13T00:55:48.716394Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e44ae1545340c14b switched to configuration voters=(16450208341214413131)"} {"level":"warn","ts":"2026-08-13T00:55:48.728697Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-13T00:55:48.730237Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-13T00:55:48.73209Z","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-13T00:55:48.734628Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e44ae1545340c14b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-13T00:55:48.734771Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e44ae1545340c14b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-13T00:55:48.734882Z","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-13T00:55:48.734932Z","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-13T00:55:48.734965Z","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-13T00:55:48.737261Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e44ae1545340c14b switched to configuration voters=(16450208341214413131)"} {"level":"info","ts":"2026-08-13T00:55:48.737786Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"7284b69afd367451","local-member-id":"e44ae1545340c14b","added-peer-id":"e44ae1545340c14b","added-peer-peer-urls":["https://199.204.45.182:2380"]} {"level":"info","ts":"2026-08-13T00:55:48.740231Z","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-13T00:55:48.74033Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.182:2380"} {"level":"info","ts":"2026-08-13T00:55:48.74037Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.182:2380"} {"level":"info","ts":"2026-08-13T00:55:48.740683Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e44ae1545340c14b","initial-advertise-peer-urls":["https://199.204.45.182:2380"],"listen-peer-urls":["https://199.204.45.182:2380"],"advertise-client-urls":["https://199.204.45.182:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.182:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-13T00:55:48.740711Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-13T00:55:49.316788Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e44ae1545340c14b is starting a new election at term 1"} {"level":"info","ts":"2026-08-13T00:55:49.316877Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e44ae1545340c14b became pre-candidate at term 1"} {"level":"info","ts":"2026-08-13T00:55:49.316906Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e44ae1545340c14b received MsgPreVoteResp from e44ae1545340c14b at term 1"} {"level":"info","ts":"2026-08-13T00:55:49.317003Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e44ae1545340c14b became candidate at term 2"} {"level":"info","ts":"2026-08-13T00:55:49.317028Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e44ae1545340c14b received MsgVoteResp from e44ae1545340c14b at term 2"} {"level":"info","ts":"2026-08-13T00:55:49.317044Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e44ae1545340c14b became leader at term 2"} {"level":"info","ts":"2026-08-13T00:55:49.317068Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e44ae1545340c14b elected leader e44ae1545340c14b at term 2"} {"level":"info","ts":"2026-08-13T00:55:49.317979Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e44ae1545340c14b","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.182:2379]}","request-path":"/0/members/e44ae1545340c14b/attributes","cluster-id":"7284b69afd367451","publish-timeout":"7s"} {"level":"info","ts":"2026-08-13T00:55:49.317991Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-13T00:55:49.317999Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-13T00:55:49.318107Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-13T00:55:49.31836Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-13T00:55:49.318393Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-13T00:55:49.318931Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"7284b69afd367451","local-member-id":"e44ae1545340c14b","cluster-version":"3.5"} {"level":"info","ts":"2026-08-13T00:55:49.319106Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-13T00:55:49.31915Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-13T00:55:49.322138Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-13T00:55:49.322301Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.182:2379"} {"level":"info","ts":"2026-08-13T00:56:09.172715Z","caller":"traceutil/trace.go:171","msg":"trace[1241973561] transaction","detail":"{read_only:false; response_revision:383; number_of_response:1; }","duration":"173.530707ms","start":"2026-08-13T00:56:08.999155Z","end":"2026-08-13T00:56:09.172685Z","steps":["trace[1241973561] 'process raft request' (duration: 173.370843ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:56:14.799335Z","caller":"traceutil/trace.go:171","msg":"trace[681584594] transaction","detail":"{read_only:false; response_revision:427; number_of_response:1; }","duration":"156.396782ms","start":"2026-08-13T00:56:14.642913Z","end":"2026-08-13T00:56:14.799309Z","steps":["trace[681584594] 'process raft request' (duration: 156.221868ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:56:25.223119Z","caller":"traceutil/trace.go:171","msg":"trace[311571778] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"283.275641ms","start":"2026-08-13T00:56:24.939808Z","end":"2026-08-13T00:56:25.223084Z","steps":["trace[311571778] 'process raft request' (duration: 283.043815ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:56:25.229585Z","caller":"traceutil/trace.go:171","msg":"trace[1155601725] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"287.54367ms","start":"2026-08-13T00:56:24.942015Z","end":"2026-08-13T00:56:25.229559Z","steps":["trace[1155601725] 'process raft request' (duration: 287.265822ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:56:25.229679Z","caller":"traceutil/trace.go:171","msg":"trace[2094384060] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"276.860163ms","start":"2026-08-13T00:56:24.952776Z","end":"2026-08-13T00:56:25.229636Z","steps":["trace[2094384060] 'process raft request' (duration: 276.74046ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:56:25.229738Z","caller":"traceutil/trace.go:171","msg":"trace[192940067] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"276.127406ms","start":"2026-08-13T00:56:24.953551Z","end":"2026-08-13T00:56:25.229679Z","steps":["trace[192940067] 'process raft request' (duration: 276.017934ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:56:25.229881Z","caller":"traceutil/trace.go:171","msg":"trace[438190590] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"275.576234ms","start":"2026-08-13T00:56:24.954268Z","end":"2026-08-13T00:56:25.229844Z","steps":["trace[438190590] 'process raft request' (duration: 275.348599ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:56:25.229923Z","caller":"traceutil/trace.go:171","msg":"trace[2102099170] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"274.11957ms","start":"2026-08-13T00:56:24.955783Z","end":"2026-08-13T00:56:25.229903Z","steps":["trace[2102099170] 'process raft request' (duration: 273.879824ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:56:25.230026Z","caller":"traceutil/trace.go:171","msg":"trace[1343301424] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"269.415322ms","start":"2026-08-13T00:56:24.960597Z","end":"2026-08-13T00:56:25.230012Z","steps":["trace[1343301424] 'process raft request' (duration: 269.128336ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:56:25.230156Z","caller":"traceutil/trace.go:171","msg":"trace[787781531] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"279.666408ms","start":"2026-08-13T00:56:24.950211Z","end":"2026-08-13T00:56:25.229878Z","steps":["trace[787781531] 'process raft request' (duration: 279.242567ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:56:25.230227Z","caller":"traceutil/trace.go:171","msg":"trace[16815838] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"254.883766ms","start":"2026-08-13T00:56:24.975331Z","end":"2026-08-13T00:56:25.230215Z","steps":["trace[16815838] 'process raft request' (duration: 254.552138ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:56:25.230411Z","caller":"traceutil/trace.go:171","msg":"trace[1697729273] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"236.090511ms","start":"2026-08-13T00:56:24.994239Z","end":"2026-08-13T00:56:25.230329Z","steps":["trace[1697729273] 'process raft request' (duration: 235.732823ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:56:25.230722Z","caller":"traceutil/trace.go:171","msg":"trace[477829827] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"217.930953ms","start":"2026-08-13T00:56:25.012771Z","end":"2026-08-13T00:56:25.230702Z","steps":["trace[477829827] 'process raft request' (duration: 217.642126ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:56:31.193466Z","caller":"traceutil/trace.go:171","msg":"trace[1779659619] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"151.917588ms","start":"2026-08-13T00:56:31.041521Z","end":"2026-08-13T00:56:31.193439Z","steps":["trace[1779659619] 'process raft request' (duration: 150.153558ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:56:31.228582Z","caller":"traceutil/trace.go:171","msg":"trace[712852500] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"175.975624ms","start":"2026-08-13T00:56:31.052578Z","end":"2026-08-13T00:56:31.228554Z","steps":["trace[712852500] 'process raft request' (duration: 175.839731ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:56:31.691068Z","caller":"traceutil/trace.go:171","msg":"trace[1083878356] linearizableReadLoop","detail":"{readStateIndex:617; appliedIndex:616; }","duration":"418.883842ms","start":"2026-08-13T00:56:31.272155Z","end":"2026-08-13T00:56:31.691039Z","steps":["trace[1083878356] 'read index received' (duration: 418.662307ms)","trace[1083878356] 'applied index is now lower than readState.Index' (duration: 220.275µs)"],"step_count":2} {"level":"info","ts":"2026-08-13T00:56:31.691141Z","caller":"traceutil/trace.go:171","msg":"trace[2094101355] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"432.484646ms","start":"2026-08-13T00:56:31.258624Z","end":"2026-08-13T00:56:31.691108Z","steps":["trace[2094101355] 'process raft request' (duration: 432.252111ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T00:56:31.691376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.161059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-08-13T00:56:31.691445Z","caller":"traceutil/trace.go:171","msg":"trace[1872830950] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:591; }","duration":"419.306991ms","start":"2026-08-13T00:56:31.272127Z","end":"2026-08-13T00:56:31.691434Z","steps":["trace[1872830950] 'agreement among raft nodes before linearized reading' (duration: 419.050525ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T00:56:31.691486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T00:56:31.272114Z","time spent":"419.363753ms","remote":"127.0.0.1:37782","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-13T00:56:31.691645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T00:56:31.258592Z","time spent":"432.610499ms","remote":"127.0.0.1:38040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-13T00:56:32.461156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"511.143423ms","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-13T00:56:32.46123Z","caller":"traceutil/trace.go:171","msg":"trace[189414762] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:593; }","duration":"511.230035ms","start":"2026-08-13T00:56:31.949984Z","end":"2026-08-13T00:56:32.461214Z","steps":["trace[189414762] 'range keys from in-memory index tree' (duration: 511.00125ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T00:56:32.461273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T00:56:31.949922Z","time spent":"511.344337ms","remote":"127.0.0.1:37782","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-08-13T00:56:32.46231Z","caller":"traceutil/trace.go:171","msg":"trace[977159321] linearizableReadLoop","detail":"{readStateIndex:620; appliedIndex:619; }","duration":"317.067791ms","start":"2026-08-13T00:56:32.145227Z","end":"2026-08-13T00:56:32.462295Z","steps":["trace[977159321] 'read index received' (duration: 310.308405ms)","trace[977159321] 'applied index is now lower than readState.Index' (duration: 6.758476ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T00:56:32.462399Z","caller":"traceutil/trace.go:171","msg":"trace[1247058760] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"360.75906ms","start":"2026-08-13T00:56:32.101606Z","end":"2026-08-13T00:56:32.462365Z","steps":["trace[1247058760] 'process raft request' (duration: 354.223619ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T00:56:32.462538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.941628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.182\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-13T00:56:32.462582Z","caller":"traceutil/trace.go:171","msg":"trace[1954050656] range","detail":"{range_begin:/registry/masterleases/199.204.45.182; range_end:; response_count:1; response_revision:594; }","duration":"194.02799ms","start":"2026-08-13T00:56:32.26854Z","end":"2026-08-13T00:56:32.462568Z","steps":["trace[1954050656] 'agreement among raft nodes before linearized reading' (duration: 193.884777ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T00:56:32.46264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.406669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-08-13T00:56:32.462722Z","caller":"traceutil/trace.go:171","msg":"trace[869132229] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:594; }","duration":"317.498502ms","start":"2026-08-13T00:56:32.145206Z","end":"2026-08-13T00:56:32.462705Z","steps":["trace[869132229] 'agreement among raft nodes before linearized reading' (duration: 317.168394ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T00:56:32.462755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T00:56:32.145145Z","time spent":"317.600884ms","remote":"127.0.0.1:37782","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-13T00:56:32.462831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T00:56:32.101574Z","time spent":"360.914223ms","remote":"127.0.0.1:37634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T00:56:52.540227Z","caller":"traceutil/trace.go:171","msg":"trace[922240963] transaction","detail":"{read_only:false; response_revision:763; number_of_response:1; }","duration":"401.610954ms","start":"2026-08-13T00:56:52.138592Z","end":"2026-08-13T00:56:52.540203Z","steps":["trace[922240963] 'process raft request' (duration: 401.44996ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T00:56:52.540403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T00:56:52.138567Z","time spent":"401.745827ms","remote":"127.0.0.1:37722","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4025,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T00:56:52.541256Z","caller":"traceutil/trace.go:171","msg":"trace[1706842476] linearizableReadLoop","detail":"{readStateIndex:795; appliedIndex:794; }","duration":"270.858785ms","start":"2026-08-13T00:56:52.270364Z","end":"2026-08-13T00:56:52.541222Z","steps":["trace[1706842476] 'read index received' (duration: 269.813461ms)","trace[1706842476] 'applied index is now lower than readState.Index' (duration: 1.043433ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T00:56:52.541571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.523682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-13T00:56:52.541576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.180832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.182\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-13T00:56:52.54167Z","caller":"traceutil/trace.go:171","msg":"trace[546842667] range","detail":"{range_begin:/registry/masterleases/199.204.45.182; range_end:; response_count:1; response_revision:764; }","duration":"271.329895ms","start":"2026-08-13T00:56:52.270326Z","end":"2026-08-13T00:56:52.541655Z","steps":["trace[546842667] 'agreement among raft nodes before linearized reading' (duration: 271.046299ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:56:52.541696Z","caller":"traceutil/trace.go:171","msg":"trace[1056287864] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:764; }","duration":"149.665076ms","start":"2026-08-13T00:56:52.391956Z","end":"2026-08-13T00:56:52.541621Z","steps":["trace[1056287864] 'agreement among raft nodes before linearized reading' (duration: 149.497012ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:56:52.541931Z","caller":"traceutil/trace.go:171","msg":"trace[1535765806] transaction","detail":"{read_only:false; response_revision:764; number_of_response:1; }","duration":"396.517667ms","start":"2026-08-13T00:56:52.144809Z","end":"2026-08-13T00:56:52.541327Z","steps":["trace[1535765806] 'process raft request' (duration: 396.22834ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T00:56:52.54271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T00:56:52.144781Z","time spent":"397.866307ms","remote":"127.0.0.1:37782","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-13T00:58:06.691254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.003253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e6c0f3e3-e3a2-49c0-a3af-617f497dd0ec\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-08-13T00:58:06.691365Z","caller":"traceutil/trace.go:171","msg":"trace[312774391] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-e6c0f3e3-e3a2-49c0-a3af-617f497dd0ec; range_end:; response_count:1; response_revision:1820; }","duration":"163.181258ms","start":"2026-08-13T00:58:06.528154Z","end":"2026-08-13T00:58:06.691335Z","steps":["trace[312774391] 'range keys from in-memory index tree' (duration: 162.737197ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T00:58:06.691352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.145642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e6c0f3e3-e3a2-49c0-a3af-617f497dd0ec\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-08-13T00:58:06.691461Z","caller":"traceutil/trace.go:171","msg":"trace[364589419] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-e6c0f3e3-e3a2-49c0-a3af-617f497dd0ec; range_end:; response_count:1; response_revision:1820; }","duration":"311.341747ms","start":"2026-08-13T00:58:06.380091Z","end":"2026-08-13T00:58:06.691433Z","steps":["trace[364589419] 'range keys from in-memory index tree' (duration: 310.888846ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T00:58:06.691512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T00:58:06.380065Z","time spent":"311.435998ms","remote":"127.0.0.1:37722","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3650,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e6c0f3e3-e3a2-49c0-a3af-617f497dd0ec\" "} {"level":"info","ts":"2026-08-13T00:58:50.662406Z","caller":"traceutil/trace.go:171","msg":"trace[781330568] transaction","detail":"{read_only:false; response_revision:2117; number_of_response:1; }","duration":"108.537168ms","start":"2026-08-13T00:58:50.553836Z","end":"2026-08-13T00:58:50.662373Z","steps":["trace[781330568] 'process raft request' (duration: 81.005869ms)","trace[781330568] 'compare' (duration: 27.392566ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T00:58:51.205121Z","caller":"traceutil/trace.go:171","msg":"trace[155649216] linearizableReadLoop","detail":"{readStateIndex:2201; appliedIndex:2200; }","duration":"106.785809ms","start":"2026-08-13T00:58:51.098313Z","end":"2026-08-13T00:58:51.205098Z","steps":["trace[155649216] 'read index received' (duration: 106.570974ms)","trace[155649216] 'applied index is now lower than readState.Index' (duration: 214.025µs)"],"step_count":2} {"level":"info","ts":"2026-08-13T00:58:51.205214Z","caller":"traceutil/trace.go:171","msg":"trace[828590197] transaction","detail":"{read_only:false; response_revision:2118; number_of_response:1; }","duration":"206.280389ms","start":"2026-08-13T00:58:50.998896Z","end":"2026-08-13T00:58:51.205176Z","steps":["trace[828590197] 'process raft request' (duration: 206.040193ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T00:58:51.205316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.991443ms","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-13T00:58:51.205359Z","caller":"traceutil/trace.go:171","msg":"trace[98510123] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2118; }","duration":"107.089575ms","start":"2026-08-13T00:58:51.098257Z","end":"2026-08-13T00:58:51.205346Z","steps":["trace[98510123] 'agreement among raft nodes before linearized reading' (duration: 106.932892ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:58:51.451451Z","caller":"traceutil/trace.go:171","msg":"trace[1890708094] transaction","detail":"{read_only:false; response_revision:2120; number_of_response:1; }","duration":"212.744558ms","start":"2026-08-13T00:58:51.23868Z","end":"2026-08-13T00:58:51.451425Z","steps":["trace[1890708094] 'process raft request' (duration: 212.690787ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:58:51.451487Z","caller":"traceutil/trace.go:171","msg":"trace[50985843] transaction","detail":"{read_only:false; response_revision:2119; number_of_response:1; }","duration":"214.320695ms","start":"2026-08-13T00:58:51.237125Z","end":"2026-08-13T00:58:51.451446Z","steps":["trace[50985843] 'process raft request' (duration: 195.284333ms)","trace[50985843] 'compare' (duration: 18.797096ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T00:58:56.745462Z","caller":"traceutil/trace.go:171","msg":"trace[1295872486] transaction","detail":"{read_only:false; response_revision:2147; number_of_response:1; }","duration":"194.873013ms","start":"2026-08-13T00:58:56.550537Z","end":"2026-08-13T00:58:56.74541Z","steps":["trace[1295872486] 'process raft request' (duration: 194.587697ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:59:45.95267Z","caller":"traceutil/trace.go:171","msg":"trace[407654620] linearizableReadLoop","detail":"{readStateIndex:2686; appliedIndex:2685; }","duration":"258.40183ms","start":"2026-08-13T00:59:45.694245Z","end":"2026-08-13T00:59:45.952647Z","steps":["trace[407654620] 'read index received' (duration: 258.316108ms)","trace[407654620] 'applied index is now lower than readState.Index' (duration: 82.121µs)"],"step_count":2} {"level":"info","ts":"2026-08-13T00:59:45.952795Z","caller":"traceutil/trace.go:171","msg":"trace[1329016989] transaction","detail":"{read_only:false; response_revision:2585; number_of_response:1; }","duration":"260.453557ms","start":"2026-08-13T00:59:45.692298Z","end":"2026-08-13T00:59:45.952752Z","steps":["trace[1329016989] 'process raft request' (duration: 260.199631ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T00:59:45.952916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.653195ms","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-13T00:59:45.953098Z","caller":"traceutil/trace.go:171","msg":"trace[1358129808] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2585; }","duration":"258.88532ms","start":"2026-08-13T00:59:45.694197Z","end":"2026-08-13T00:59:45.953082Z","steps":["trace[1358129808] 'agreement among raft nodes before linearized reading' (duration: 258.572063ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:59:45.97472Z","caller":"traceutil/trace.go:171","msg":"trace[1585717066] transaction","detail":"{read_only:false; response_revision:2586; number_of_response:1; }","duration":"184.009132ms","start":"2026-08-13T00:59:45.790673Z","end":"2026-08-13T00:59:45.974682Z","steps":["trace[1585717066] 'process raft request' (duration: 183.660844ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T00:59:45.974863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.558366ms","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-13T00:59:45.974919Z","caller":"traceutil/trace.go:171","msg":"trace[1024787680] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2586; }","duration":"113.709189ms","start":"2026-08-13T00:59:45.861196Z","end":"2026-08-13T00:59:45.974905Z","steps":["trace[1024787680] 'agreement among raft nodes before linearized reading' (duration: 113.392562ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:00:19.801017Z","caller":"traceutil/trace.go:171","msg":"trace[1638141255] transaction","detail":"{read_only:false; response_revision:2791; number_of_response:1; }","duration":"138.300728ms","start":"2026-08-13T01:00:19.662692Z","end":"2026-08-13T01:00:19.800993Z","steps":["trace[1638141255] 'process raft request' (duration: 138.161945ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:00:20.451143Z","caller":"traceutil/trace.go:171","msg":"trace[208246724] transaction","detail":"{read_only:false; response_revision:2793; number_of_response:1; }","duration":"264.6685ms","start":"2026-08-13T01:00:20.186435Z","end":"2026-08-13T01:00:20.451103Z","steps":["trace[208246724] 'process raft request' (duration: 169.390449ms)","trace[208246724] 'compare' (duration: 94.952274ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T01:00:20.45117Z","caller":"traceutil/trace.go:171","msg":"trace[561788044] transaction","detail":"{read_only:false; response_revision:2794; number_of_response:1; }","duration":"264.6623ms","start":"2026-08-13T01:00:20.186477Z","end":"2026-08-13T01:00:20.451139Z","steps":["trace[561788044] 'process raft request' (duration: 264.453595ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:00:20.451579Z","caller":"traceutil/trace.go:171","msg":"trace[720658292] linearizableReadLoop","detail":"{readStateIndex:2904; appliedIndex:2901; }","duration":"179.220138ms","start":"2026-08-13T01:00:20.272322Z","end":"2026-08-13T01:00:20.451543Z","steps":["trace[720658292] 'read index received' (duration: 83.464116ms)","trace[720658292] 'applied index is now lower than readState.Index' (duration: 95.754122ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T01:00:20.451682Z","caller":"traceutil/trace.go:171","msg":"trace[2108094844] transaction","detail":"{read_only:false; response_revision:2795; number_of_response:1; }","duration":"265.119941ms","start":"2026-08-13T01:00:20.186546Z","end":"2026-08-13T01:00:20.451666Z","steps":["trace[2108094844] 'process raft request' (duration: 264.540098ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:00:20.451831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.473905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-13T01:00:20.451892Z","caller":"traceutil/trace.go:171","msg":"trace[1658071306] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:2796; }","duration":"179.608128ms","start":"2026-08-13T01:00:20.272263Z","end":"2026-08-13T01:00:20.451872Z","steps":["trace[1658071306] 'agreement among raft nodes before linearized reading' (duration: 179.428244ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:00:20.45197Z","caller":"traceutil/trace.go:171","msg":"trace[1430873419] transaction","detail":"{read_only:false; response_revision:2796; number_of_response:1; }","duration":"157.181397ms","start":"2026-08-13T01:00:20.294752Z","end":"2026-08-13T01:00:20.451933Z","steps":["trace[1430873419] 'process raft request' (duration: 156.655195ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:02:41.018764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.840476ms","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-13T01:02:41.018872Z","caller":"traceutil/trace.go:171","msg":"trace[503537303] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:3735; }","duration":"236.04351ms","start":"2026-08-13T01:02:40.782806Z","end":"2026-08-13T01:02:41.018849Z","steps":["trace[503537303] 'count revisions from in-memory index tree' (duration: 235.682792ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:02:41.01903Z","caller":"traceutil/trace.go:171","msg":"trace[887815115] transaction","detail":"{read_only:false; response_revision:3736; number_of_response:1; }","duration":"108.454214ms","start":"2026-08-13T01:02:40.910555Z","end":"2026-08-13T01:02:41.01901Z","steps":["trace[887815115] 'process raft request' (duration: 107.701287ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:04:06.057871Z","caller":"traceutil/trace.go:171","msg":"trace[563008647] transaction","detail":"{read_only:false; response_revision:4759; number_of_response:1; }","duration":"126.469628ms","start":"2026-08-13T01:04:05.931373Z","end":"2026-08-13T01:04:06.057843Z","steps":["trace[563008647] 'process raft request' (duration: 122.961757ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:04:11.578114Z","caller":"traceutil/trace.go:171","msg":"trace[953463915] transaction","detail":"{read_only:false; number_of_response:0; response_revision:4936; }","duration":"104.880609ms","start":"2026-08-13T01:04:11.473208Z","end":"2026-08-13T01:04:11.578089Z","steps":["trace[953463915] 'process raft request' (duration: 58.550476ms)","trace[953463915] 'compare' (duration: 46.20191ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T01:04:23.47153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.562504ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-13T01:04:23.471627Z","caller":"traceutil/trace.go:171","msg":"trace[1002895432] transaction","detail":"{read_only:false; response_revision:5193; number_of_response:1; }","duration":"415.284805ms","start":"2026-08-13T01:04:23.056329Z","end":"2026-08-13T01:04:23.471614Z","steps":["trace[1002895432] 'process raft request' (duration: 236.464075ms)","trace[1002895432] 'compare' (duration: 178.467072ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T01:04:23.471684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:04:23.056294Z","time spent":"415.368287ms","remote":"127.0.0.1:37782","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T01:04:23.531981Z","caller":"traceutil/trace.go:171","msg":"trace[1439462479] transaction","detail":"{read_only:false; response_revision:5194; number_of_response:1; }","duration":"453.854729ms","start":"2026-08-13T01:04:23.078099Z","end":"2026-08-13T01:04:23.531954Z","steps":["trace[1439462479] 'process raft request' (duration: 453.724356ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:04:23.532165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:04:23.078076Z","time spent":"453.983511ms","remote":"127.0.0.1:37782","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-08-13T01:04:23.537384Z","caller":"traceutil/trace.go:171","msg":"trace[1486035541] transaction","detail":"{read_only:false; response_revision:5195; number_of_response:1; }","duration":"141.26307ms","start":"2026-08-13T01:04:23.396103Z","end":"2026-08-13T01:04:23.537366Z","steps":["trace[1486035541] 'process raft request' (duration: 140.747978ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:04:23.93279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.912996ms","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-13T01:04:23.932885Z","caller":"traceutil/trace.go:171","msg":"trace[1986001077] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5205; }","duration":"256.052028ms","start":"2026-08-13T01:04:23.676813Z","end":"2026-08-13T01:04:23.932865Z","steps":["trace[1986001077] 'range keys from in-memory index tree' (duration: 255.658799ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:04:23.932959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.51069ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-13T01:04:23.933247Z","caller":"traceutil/trace.go:171","msg":"trace[755093344] transaction","detail":"{read_only:false; response_revision:5209; number_of_response:1; }","duration":"159.601746ms","start":"2026-08-13T01:04:23.773627Z","end":"2026-08-13T01:04:23.933229Z","steps":["trace[755093344] 'process raft request' (duration: 159.557505ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:04:23.933326Z","caller":"traceutil/trace.go:171","msg":"trace[218270772] transaction","detail":"{read_only:false; response_revision:5206; number_of_response:1; }","duration":"256.270653ms","start":"2026-08-13T01:04:23.677036Z","end":"2026-08-13T01:04:23.933307Z","steps":["trace[218270772] 'process raft request' (duration: 62.334193ms)","trace[218270772] 'compare' (duration: 193.347267ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T01:04:23.933348Z","caller":"traceutil/trace.go:171","msg":"trace[239603163] transaction","detail":"{read_only:false; response_revision:5207; number_of_response:1; }","duration":"256.269023ms","start":"2026-08-13T01:04:23.67704Z","end":"2026-08-13T01:04:23.933309Z","steps":["trace[239603163] 'process raft request' (duration: 256.038048ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:04:23.933527Z","caller":"traceutil/trace.go:171","msg":"trace[1862017398] transaction","detail":"{read_only:false; response_revision:5208; number_of_response:1; }","duration":"250.018649ms","start":"2026-08-13T01:04:23.683498Z","end":"2026-08-13T01:04:23.933516Z","steps":["trace[1862017398] 'process raft request' (duration: 249.650491ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:04:24.10874Z","caller":"traceutil/trace.go:171","msg":"trace[842448500] transaction","detail":"{read_only:false; response_revision:5212; number_of_response:1; }","duration":"125.500136ms","start":"2026-08-13T01:04:23.983217Z","end":"2026-08-13T01:04:24.108717Z","steps":["trace[842448500] 'process raft request' (duration: 117.577983ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:04:24.703937Z","caller":"traceutil/trace.go:171","msg":"trace[820118881] transaction","detail":"{read_only:false; response_revision:5217; number_of_response:1; }","duration":"156.224966ms","start":"2026-08-13T01:04:24.547665Z","end":"2026-08-13T01:04:24.70389Z","steps":["trace[820118881] 'process raft request' (duration: 152.897509ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:04:24.704071Z","caller":"traceutil/trace.go:171","msg":"trace[1414644109] transaction","detail":"{read_only:false; response_revision:5218; number_of_response:1; }","duration":"155.680384ms","start":"2026-08-13T01:04:24.54835Z","end":"2026-08-13T01:04:24.704031Z","steps":["trace[1414644109] 'process raft request' (duration: 155.438449ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:04:24.704277Z","caller":"traceutil/trace.go:171","msg":"trace[267943418] transaction","detail":"{read_only:false; response_revision:5219; number_of_response:1; }","duration":"155.197743ms","start":"2026-08-13T01:04:24.549047Z","end":"2026-08-13T01:04:24.704245Z","steps":["trace[267943418] 'process raft request' (duration: 154.796374ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:04:24.704416Z","caller":"traceutil/trace.go:171","msg":"trace[520974336] transaction","detail":"{read_only:false; response_revision:5220; number_of_response:1; }","duration":"155.308777ms","start":"2026-08-13T01:04:24.54909Z","end":"2026-08-13T01:04:24.704398Z","steps":["trace[520974336] 'process raft request' (duration: 155.085221ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:04:24.704679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.736975ms","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-08-13T01:04:24.704742Z","caller":"traceutil/trace.go:171","msg":"trace[1750414958] 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:5220; }","duration":"151.847377ms","start":"2026-08-13T01:04:24.552876Z","end":"2026-08-13T01:04:24.704724Z","steps":["trace[1750414958] 'agreement among raft nodes before linearized reading' (duration: 151.598282ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:04:24.704413Z","caller":"traceutil/trace.go:171","msg":"trace[934493681] linearizableReadLoop","detail":"{readStateIndex:5417; appliedIndex:5412; }","duration":"151.457208ms","start":"2026-08-13T01:04:24.552923Z","end":"2026-08-13T01:04:24.704381Z","steps":["trace[934493681] 'read index received' (duration: 3.874791ms)","trace[934493681] 'applied index is now lower than readState.Index' (duration: 147.580567ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T01:04:24.704962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.172776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T01:04:24.705006Z","caller":"traceutil/trace.go:171","msg":"trace[7998871] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5220; }","duration":"102.262518ms","start":"2026-08-13T01:04:24.60273Z","end":"2026-08-13T01:04:24.704993Z","steps":["trace[7998871] 'agreement among raft nodes before linearized reading' (duration: 102.176316ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:04:32.109172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.671847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-08-13T01:04:32.109219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.065547ms","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-13T01:04:32.10926Z","caller":"traceutil/trace.go:171","msg":"trace[282170782] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5375; }","duration":"140.7957ms","start":"2026-08-13T01:04:31.968442Z","end":"2026-08-13T01:04:32.109238Z","steps":["trace[282170782] 'range keys from in-memory index tree' (duration: 140.501123ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:04:32.109318Z","caller":"traceutil/trace.go:171","msg":"trace[1257278875] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5375; }","duration":"141.2186ms","start":"2026-08-13T01:04:31.968076Z","end":"2026-08-13T01:04:32.109294Z","steps":["trace[1257278875] 'range keys from in-memory index tree' (duration: 140.877183ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:04:32.109355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.931799ms","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-13T01:04:32.10946Z","caller":"traceutil/trace.go:171","msg":"trace[229013665] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5375; }","duration":"124.089633ms","start":"2026-08-13T01:04:31.985346Z","end":"2026-08-13T01:04:32.109436Z","steps":["trace[229013665] 'range keys from in-memory index tree' (duration: 123.719145ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:04:43.525722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.410614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:529"} {"level":"info","ts":"2026-08-13T01:04:43.525823Z","caller":"traceutil/trace.go:171","msg":"trace[227267375] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:5548; }","duration":"284.534417ms","start":"2026-08-13T01:04:43.241269Z","end":"2026-08-13T01:04:43.525804Z","steps":["trace[227267375] 'range keys from in-memory index tree' (duration: 284.1857ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:04:43.859877Z","caller":"traceutil/trace.go:171","msg":"trace[913490272] transaction","detail":"{read_only:false; response_revision:5549; number_of_response:1; }","duration":"329.318686ms","start":"2026-08-13T01:04:43.530532Z","end":"2026-08-13T01:04:43.859851Z","steps":["trace[913490272] 'process raft request' (duration: 329.149902ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:04:43.860039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:04:43.530501Z","time spent":"329.453419ms","remote":"127.0.0.1:37782","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":514,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T01:04:43.926396Z","caller":"traceutil/trace.go:171","msg":"trace[211944346] transaction","detail":"{read_only:false; response_revision:5550; number_of_response:1; }","duration":"320.283267ms","start":"2026-08-13T01:04:43.60609Z","end":"2026-08-13T01:04:43.926373Z","steps":["trace[211944346] 'process raft request' (duration: 320.120153ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:04:43.926548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:04:43.606066Z","time spent":"320.404729ms","remote":"127.0.0.1:37782","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T01:04:43.926614Z","caller":"traceutil/trace.go:171","msg":"trace[2096008091] transaction","detail":"{read_only:false; response_revision:5551; number_of_response:1; }","duration":"320.404979ms","start":"2026-08-13T01:04:43.606184Z","end":"2026-08-13T01:04:43.926589Z","steps":["trace[2096008091] 'process raft request' (duration: 320.148614ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:04:43.926698Z","caller":"traceutil/trace.go:171","msg":"trace[1519465355] transaction","detail":"{read_only:false; response_revision:5552; number_of_response:1; }","duration":"164.580785ms","start":"2026-08-13T01:04:43.762078Z","end":"2026-08-13T01:04:43.926659Z","steps":["trace[1519465355] 'process raft request' (duration: 164.450642ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:04:43.926626Z","caller":"traceutil/trace.go:171","msg":"trace[142515798] linearizableReadLoop","detail":"{readStateIndex:5754; appliedIndex:5751; }","duration":"315.71741ms","start":"2026-08-13T01:04:43.610886Z","end":"2026-08-13T01:04:43.926603Z","steps":["trace[142515798] 'read index received' (duration: 248.785118ms)","trace[142515798] 'applied index is now lower than readState.Index' (duration: 66.931192ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T01:04:43.926761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:04:43.606153Z","time spent":"320.534992ms","remote":"127.0.0.1:37782","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-13T01:04:43.926772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.876013ms","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-13T01:04:43.926819Z","caller":"traceutil/trace.go:171","msg":"trace[768751010] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5552; }","duration":"315.943535ms","start":"2026-08-13T01:04:43.610861Z","end":"2026-08-13T01:04:43.926804Z","steps":["trace[768751010] 'agreement among raft nodes before linearized reading' (duration: 315.806112ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:04:43.926858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:04:43.610852Z","time spent":"315.992206ms","remote":"127.0.0.1:37782","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"info","ts":"2026-08-13T01:04:44.06297Z","caller":"traceutil/trace.go:171","msg":"trace[274496774] transaction","detail":"{read_only:false; response_revision:5555; number_of_response:1; }","duration":"107.501292ms","start":"2026-08-13T01:04:43.95541Z","end":"2026-08-13T01:04:44.062912Z","steps":["trace[274496774] 'process raft request' (duration: 102.540807ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:05:22.902207Z","caller":"traceutil/trace.go:171","msg":"trace[2108393847] transaction","detail":"{read_only:false; response_revision:5904; number_of_response:1; }","duration":"107.622026ms","start":"2026-08-13T01:05:22.794553Z","end":"2026-08-13T01:05:22.902175Z","steps":["trace[2108393847] 'process raft request' (duration: 107.35023ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:05:49.344812Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2954} {"level":"info","ts":"2026-08-13T01:05:49.417663Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2954,"took":"71.392905ms","hash":1477536254,"current-db-size-bytes":58118144,"current-db-size":"58 MB","current-db-size-in-use-bytes":34476032,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-08-13T01:05:49.417738Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1477536254,"revision":2954,"compact-revision":-1} {"level":"info","ts":"2026-08-13T01:10:27.414621Z","caller":"traceutil/trace.go:171","msg":"trace[243705830] transaction","detail":"{read_only:false; response_revision:8174; number_of_response:1; }","duration":"260.68212ms","start":"2026-08-13T01:10:27.153916Z","end":"2026-08-13T01:10:27.414598Z","steps":["trace[243705830] 'process raft request' (duration: 260.518007ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:10:27.435865Z","caller":"traceutil/trace.go:171","msg":"trace[1175997626] transaction","detail":"{read_only:false; response_revision:8176; number_of_response:1; }","duration":"243.648875ms","start":"2026-08-13T01:10:27.192199Z","end":"2026-08-13T01:10:27.435848Z","steps":["trace[1175997626] 'process raft request' (duration: 243.617204ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:10:27.435928Z","caller":"traceutil/trace.go:171","msg":"trace[466315908] transaction","detail":"{read_only:false; response_revision:8175; number_of_response:1; }","duration":"244.157597ms","start":"2026-08-13T01:10:27.19175Z","end":"2026-08-13T01:10:27.435907Z","steps":["trace[466315908] 'process raft request' (duration: 243.961453ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:10:40.066709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.441699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-13T01:10:40.066819Z","caller":"traceutil/trace.go:171","msg":"trace[294164916] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:8239; }","duration":"233.601902ms","start":"2026-08-13T01:10:39.833196Z","end":"2026-08-13T01:10:40.066797Z","steps":["trace[294164916] 'count revisions from in-memory index tree' (duration: 233.356047ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:10:40.06736Z","caller":"traceutil/trace.go:171","msg":"trace[1739411079] transaction","detail":"{read_only:false; response_revision:8240; number_of_response:1; }","duration":"150.659147ms","start":"2026-08-13T01:10:39.916623Z","end":"2026-08-13T01:10:40.067282Z","steps":["trace[1739411079] 'process raft request' (duration: 52.59398ms)","trace[1739411079] 'compare' (duration: 97.558385ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T01:10:41.719618Z","caller":"traceutil/trace.go:171","msg":"trace[1582530976] transaction","detail":"{read_only:false; response_revision:8248; number_of_response:1; }","duration":"239.403127ms","start":"2026-08-13T01:10:41.480187Z","end":"2026-08-13T01:10:41.71959Z","steps":["trace[1582530976] 'process raft request' (duration: 239.247064ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:10:41.724207Z","caller":"traceutil/trace.go:171","msg":"trace[243898668] linearizableReadLoop","detail":"{readStateIndex:8541; appliedIndex:8539; }","duration":"174.629403ms","start":"2026-08-13T01:10:41.549554Z","end":"2026-08-13T01:10:41.724184Z","steps":["trace[243898668] 'read index received' (duration: 170.073228ms)","trace[243898668] 'applied index is now lower than readState.Index' (duration: 4.555325ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T01:10:41.724272Z","caller":"traceutil/trace.go:171","msg":"trace[144282394] transaction","detail":"{read_only:false; response_revision:8249; number_of_response:1; }","duration":"230.322786ms","start":"2026-08-13T01:10:41.493908Z","end":"2026-08-13T01:10:41.72423Z","steps":["trace[144282394] 'process raft request' (duration: 230.102461ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:10:41.724387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.819557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T01:10:41.724432Z","caller":"traceutil/trace.go:171","msg":"trace[396127495] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8250; }","duration":"174.884109ms","start":"2026-08-13T01:10:41.549537Z","end":"2026-08-13T01:10:41.724421Z","steps":["trace[396127495] 'agreement among raft nodes before linearized reading' (duration: 174.768716ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:10:41.724436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.044239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T01:10:41.724285Z","caller":"traceutil/trace.go:171","msg":"trace[2130842482] transaction","detail":"{read_only:false; response_revision:8250; number_of_response:1; }","duration":"223.295482ms","start":"2026-08-13T01:10:41.500964Z","end":"2026-08-13T01:10:41.724259Z","steps":["trace[2130842482] 'process raft request' (duration: 223.179009ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:10:41.724514Z","caller":"traceutil/trace.go:171","msg":"trace[1468738916] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8250; }","duration":"121.173393ms","start":"2026-08-13T01:10:41.603321Z","end":"2026-08-13T01:10:41.724495Z","steps":["trace[1468738916] 'agreement among raft nodes before linearized reading' (duration: 121.043649ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:10:49.351463Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6124} {"level":"info","ts":"2026-08-13T01:10:49.452519Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6124,"took":"99.453358ms","hash":3539500373,"current-db-size-bytes":58118144,"current-db-size":"58 MB","current-db-size-in-use-bytes":23343104,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-08-13T01:10:49.452599Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3539500373,"revision":6124,"compact-revision":2954} {"level":"info","ts":"2026-08-13T01:11:08.659296Z","caller":"traceutil/trace.go:171","msg":"trace[1020217669] linearizableReadLoop","detail":"{readStateIndex:8747; appliedIndex:8746; }","duration":"321.212975ms","start":"2026-08-13T01:11:08.338058Z","end":"2026-08-13T01:11:08.659271Z","steps":["trace[1020217669] 'read index received' (duration: 321.050331ms)","trace[1020217669] 'applied index is now lower than readState.Index' (duration: 162.004µs)"],"step_count":2} {"level":"info","ts":"2026-08-13T01:11:08.65971Z","caller":"traceutil/trace.go:171","msg":"trace[73974787] transaction","detail":"{read_only:false; response_revision:8446; number_of_response:1; }","duration":"450.937007ms","start":"2026-08-13T01:11:08.20876Z","end":"2026-08-13T01:11:08.659697Z","steps":["trace[73974787] 'process raft request' (duration: 450.397573ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:11:08.660019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.336775ms","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-13T01:11:08.660063Z","caller":"traceutil/trace.go:171","msg":"trace[980671511] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8446; }","duration":"301.394626ms","start":"2026-08-13T01:11:08.35866Z","end":"2026-08-13T01:11:08.660055Z","steps":["trace[980671511] 'agreement among raft nodes before linearized reading' (duration: 301.273673ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:11:08.660151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:11:08.358654Z","time spent":"301.488479ms","remote":"127.0.0.1:37782","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-13T01:11:08.660415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.353962ms","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-13T01:11:08.660444Z","caller":"traceutil/trace.go:171","msg":"trace[286120842] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8446; }","duration":"322.408054ms","start":"2026-08-13T01:11:08.338027Z","end":"2026-08-13T01:11:08.660435Z","steps":["trace[286120842] 'agreement among raft nodes before linearized reading' (duration: 322.336562ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:11:08.660527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:11:08.338016Z","time spent":"322.504365ms","remote":"127.0.0.1:37782","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-08-13T01:11:08.660913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.168716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T01:11:08.660946Z","caller":"traceutil/trace.go:171","msg":"trace[1567288927] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:8446; }","duration":"259.213727ms","start":"2026-08-13T01:11:08.401724Z","end":"2026-08-13T01:11:08.660938Z","steps":["trace[1567288927] 'agreement among raft nodes before linearized reading' (duration: 259.167156ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:11:08.661022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:11:08.208752Z","time spent":"450.988298ms","remote":"127.0.0.1:37782","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-13T01:11:08.661505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.071858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/scrapeconfigs/\" range_end:\"/registry/monitoring.coreos.com/scrapeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T01:11:08.661536Z","caller":"traceutil/trace.go:171","msg":"trace[121388046] range","detail":"{range_begin:/registry/monitoring.coreos.com/scrapeconfigs/; range_end:/registry/monitoring.coreos.com/scrapeconfigs0; response_count:0; response_revision:8446; }","duration":"270.11622ms","start":"2026-08-13T01:11:08.391412Z","end":"2026-08-13T01:11:08.661528Z","steps":["trace[121388046] 'agreement among raft nodes before linearized reading' (duration: 270.061838ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:11:08.661688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.366444ms","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-13T01:11:08.661711Z","caller":"traceutil/trace.go:171","msg":"trace[790161688] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8446; }","duration":"282.400845ms","start":"2026-08-13T01:11:08.379305Z","end":"2026-08-13T01:11:08.661705Z","steps":["trace[790161688] 'agreement among raft nodes before linearized reading' (duration: 282.336963ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:11:20.835887Z","caller":"traceutil/trace.go:171","msg":"trace[1807632416] linearizableReadLoop","detail":"{readStateIndex:8857; appliedIndex:8856; }","duration":"125.250877ms","start":"2026-08-13T01:11:20.710614Z","end":"2026-08-13T01:11:20.835864Z","steps":["trace[1807632416] 'read index received' (duration: 125.080474ms)","trace[1807632416] 'applied index is now lower than readState.Index' (duration: 169.063µs)"],"step_count":2} {"level":"info","ts":"2026-08-13T01:11:20.835991Z","caller":"traceutil/trace.go:171","msg":"trace[1496922879] transaction","detail":"{read_only:false; response_revision:8551; number_of_response:1; }","duration":"168.791048ms","start":"2026-08-13T01:11:20.667167Z","end":"2026-08-13T01:11:20.835958Z","steps":["trace[1496922879] 'process raft request' (duration: 168.541592ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:11:20.836062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.430521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T01:11:20.836153Z","caller":"traceutil/trace.go:171","msg":"trace[831899654] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:8551; }","duration":"125.578765ms","start":"2026-08-13T01:11:20.710556Z","end":"2026-08-13T01:11:20.836135Z","steps":["trace[831899654] 'agreement among raft nodes before linearized reading' (duration: 125.425611ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:11:20.836172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.223424ms","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-13T01:11:20.836236Z","caller":"traceutil/trace.go:171","msg":"trace[1143834030] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8551; }","duration":"115.343517ms","start":"2026-08-13T01:11:20.720877Z","end":"2026-08-13T01:11:20.83622Z","steps":["trace[1143834030] 'agreement among raft nodes before linearized reading' (duration: 115.142382ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:11:21.013121Z","caller":"traceutil/trace.go:171","msg":"trace[1215484460] transaction","detail":"{read_only:false; response_revision:8552; number_of_response:1; }","duration":"171.308286ms","start":"2026-08-13T01:11:20.841791Z","end":"2026-08-13T01:11:21.013099Z","steps":["trace[1215484460] 'process raft request' (duration: 167.921238ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:11:21.038416Z","caller":"traceutil/trace.go:171","msg":"trace[1209405206] transaction","detail":"{read_only:false; response_revision:8556; number_of_response:1; }","duration":"195.655341ms","start":"2026-08-13T01:11:20.842744Z","end":"2026-08-13T01:11:21.038399Z","steps":["trace[1209405206] 'process raft request' (duration: 195.536229ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:11:21.03849Z","caller":"traceutil/trace.go:171","msg":"trace[481554865] transaction","detail":"{read_only:false; response_revision:8555; number_of_response:1; }","duration":"196.345017ms","start":"2026-08-13T01:11:20.842132Z","end":"2026-08-13T01:11:21.038477Z","steps":["trace[481554865] 'process raft request' (duration: 196.112942ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:11:21.038464Z","caller":"traceutil/trace.go:171","msg":"trace[664011159] transaction","detail":"{read_only:false; response_revision:8554; number_of_response:1; }","duration":"196.614603ms","start":"2026-08-13T01:11:20.841818Z","end":"2026-08-13T01:11:21.038433Z","steps":["trace[664011159] 'process raft request' (duration: 196.374948ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:11:21.038521Z","caller":"traceutil/trace.go:171","msg":"trace[71864978] linearizableReadLoop","detail":"{readStateIndex:8859; appliedIndex:8857; }","duration":"196.676825ms","start":"2026-08-13T01:11:20.841829Z","end":"2026-08-13T01:11:21.038506Z","steps":["trace[71864978] 'read index received' (duration: 167.903357ms)","trace[71864978] 'applied index is now lower than readState.Index' (duration: 28.772528ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T01:11:21.038393Z","caller":"traceutil/trace.go:171","msg":"trace[709965781] transaction","detail":"{read_only:false; response_revision:8553; number_of_response:1; }","duration":"196.547201ms","start":"2026-08-13T01:11:20.84181Z","end":"2026-08-13T01:11:21.038357Z","steps":["trace[709965781] 'process raft request' (duration: 196.242674ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:11:21.038795Z","caller":"traceutil/trace.go:171","msg":"trace[2102116180] transaction","detail":"{read_only:false; response_revision:8557; number_of_response:1; }","duration":"195.312592ms","start":"2026-08-13T01:11:20.843427Z","end":"2026-08-13T01:11:21.03874Z","steps":["trace[2102116180] 'process raft request' (duration: 194.931753ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:11:21.038856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.998322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-qg5lh\" ","response":"range_response_count:1 size:4648"} {"level":"info","ts":"2026-08-13T01:11:21.038891Z","caller":"traceutil/trace.go:171","msg":"trace[663640273] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-qg5lh; range_end:; response_count:1; response_revision:8558; }","duration":"197.091234ms","start":"2026-08-13T01:11:20.84179Z","end":"2026-08-13T01:11:21.038881Z","steps":["trace[663640273] 'agreement among raft nodes before linearized reading' (duration: 196.947401ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:11:21.039247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.670202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:26 size:228464"} {"level":"info","ts":"2026-08-13T01:11:21.039319Z","caller":"traceutil/trace.go:171","msg":"trace[945704820] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:26; response_revision:8558; }","duration":"195.767294ms","start":"2026-08-13T01:11:20.843534Z","end":"2026-08-13T01:11:21.039301Z","steps":["trace[945704820] 'agreement among raft nodes before linearized reading' (duration: 195.147609ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:11:21.994203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.784607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secrettemplates/\" range_end:\"/registry/secretgen.carvel.dev/secrettemplates0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-13T01:11:21.994274Z","caller":"traceutil/trace.go:171","msg":"trace[499582499] transaction","detail":"{read_only:false; response_revision:8562; number_of_response:1; }","duration":"116.727219ms","start":"2026-08-13T01:11:21.877515Z","end":"2026-08-13T01:11:21.994242Z","steps":["trace[499582499] 'process raft request' (duration: 116.461972ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:11:21.99431Z","caller":"traceutil/trace.go:171","msg":"trace[1008509191] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secrettemplates/; range_end:/registry/secretgen.carvel.dev/secrettemplates0; response_count:0; response_revision:8561; }","duration":"230.950691ms","start":"2026-08-13T01:11:21.763337Z","end":"2026-08-13T01:11:21.994288Z","steps":["trace[1008509191] 'count revisions from in-memory index tree' (duration: 230.700904ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:11:22.0031Z","caller":"traceutil/trace.go:171","msg":"trace[372501478] transaction","detail":"{read_only:false; response_revision:8563; number_of_response:1; }","duration":"112.590585ms","start":"2026-08-13T01:11:21.890486Z","end":"2026-08-13T01:11:22.003076Z","steps":["trace[372501478] 'process raft request' (duration: 112.3715ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:11:22.003267Z","caller":"traceutil/trace.go:171","msg":"trace[941543873] transaction","detail":"{read_only:false; response_revision:8564; number_of_response:1; }","duration":"111.686282ms","start":"2026-08-13T01:11:21.891561Z","end":"2026-08-13T01:11:22.003247Z","steps":["trace[941543873] 'process raft request' (duration: 111.468027ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:11:22.1793Z","caller":"traceutil/trace.go:171","msg":"trace[970280726] transaction","detail":"{read_only:false; response_revision:8565; number_of_response:1; }","duration":"100.81725ms","start":"2026-08-13T01:11:22.078454Z","end":"2026-08-13T01:11:22.179271Z","steps":["trace[970280726] 'process raft request' (duration: 47.160844ms)","trace[970280726] 'compare' (duration: 53.530153ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T01:11:22.456781Z","caller":"traceutil/trace.go:171","msg":"trace[1335500200] transaction","detail":"{read_only:false; response_revision:8567; number_of_response:1; }","duration":"119.257629ms","start":"2026-08-13T01:11:22.337484Z","end":"2026-08-13T01:11:22.456742Z","steps":["trace[1335500200] 'process raft request' (duration: 62.128772ms)","trace[1335500200] 'compare' (duration: 56.967423ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T01:11:37.904678Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002375.wal"} {"level":"info","ts":"2026-08-13T01:12:34.404116Z","caller":"traceutil/trace.go:171","msg":"trace[423286098] transaction","detail":"{read_only:false; response_revision:9293; number_of_response:1; }","duration":"130.883777ms","start":"2026-08-13T01:12:34.273205Z","end":"2026-08-13T01:12:34.404089Z","steps":["trace[423286098] 'process raft request' (duration: 130.678843ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:12:34.404457Z","caller":"traceutil/trace.go:171","msg":"trace[1922572376] transaction","detail":"{read_only:false; response_revision:9294; number_of_response:1; }","duration":"130.748585ms","start":"2026-08-13T01:12:34.273669Z","end":"2026-08-13T01:12:34.404418Z","steps":["trace[1922572376] 'process raft request' (duration: 130.373805ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:13:24.818139Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e44ae1545340c14b","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-08-13T01:13:24.824603Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-08-13T01:13:24.824792Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-08-13T01:15:49.358295Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8298} {"level":"info","ts":"2026-08-13T01:15:49.435058Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8298,"took":"74.991611ms","hash":1689651077,"current-db-size-bytes":58118144,"current-db-size":"58 MB","current-db-size-in-use-bytes":26595328,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-08-13T01:15:49.435171Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1689651077,"revision":8298,"compact-revision":6124} {"level":"info","ts":"2026-08-13T01:15:54.548475Z","caller":"traceutil/trace.go:171","msg":"trace[561851396] transaction","detail":"{read_only:false; response_revision:11006; number_of_response:1; }","duration":"113.104656ms","start":"2026-08-13T01:15:54.435343Z","end":"2026-08-13T01:15:54.548447Z","steps":["trace[561851396] 'process raft request' (duration: 113.009674ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:15:54.548733Z","caller":"traceutil/trace.go:171","msg":"trace[1247480443] linearizableReadLoop","detail":"{readStateIndex:11383; appliedIndex:11379; }","duration":"112.299957ms","start":"2026-08-13T01:15:54.436402Z","end":"2026-08-13T01:15:54.548702Z","steps":["trace[1247480443] 'read index received' (duration: 70.988628ms)","trace[1247480443] 'applied index is now lower than readState.Index' (duration: 41.309729ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T01:15:54.548784Z","caller":"traceutil/trace.go:171","msg":"trace[880158078] transaction","detail":"{read_only:false; response_revision:11007; number_of_response:1; }","duration":"113.332171ms","start":"2026-08-13T01:15:54.43544Z","end":"2026-08-13T01:15:54.548772Z","steps":["trace[880158078] 'process raft request' (duration: 112.962643ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:15:54.548825Z","caller":"traceutil/trace.go:171","msg":"trace[1213072096] transaction","detail":"{read_only:false; response_revision:11005; number_of_response:1; }","duration":"114.284883ms","start":"2026-08-13T01:15:54.434382Z","end":"2026-08-13T01:15:54.548667Z","steps":["trace[1213072096] 'process raft request' (duration: 113.789731ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:15:54.549019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.595903ms","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":"warn","ts":"2026-08-13T01:15:54.549093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.449014ms","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-13T01:15:54.549102Z","caller":"traceutil/trace.go:171","msg":"trace[493110915] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:11007; }","duration":"112.729317ms","start":"2026-08-13T01:15:54.436354Z","end":"2026-08-13T01:15:54.549083Z","steps":["trace[493110915] 'agreement among raft nodes before linearized reading' (duration: 112.480551ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:15:54.549136Z","caller":"traceutil/trace.go:171","msg":"trace[945627119] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:11007; }","duration":"107.516826ms","start":"2026-08-13T01:15:54.441607Z","end":"2026-08-13T01:15:54.549124Z","steps":["trace[945627119] 'agreement among raft nodes before linearized reading' (duration: 107.308731ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:16:08.420233Z","caller":"traceutil/trace.go:171","msg":"trace[1790292340] transaction","detail":"{read_only:false; response_revision:11083; number_of_response:1; }","duration":"200.744878ms","start":"2026-08-13T01:16:08.219449Z","end":"2026-08-13T01:16:08.420193Z","steps":["trace[1790292340] 'process raft request' (duration: 200.518973ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:20:49.364671Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10977} {"level":"info","ts":"2026-08-13T01:20:49.445066Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10977,"took":"77.923088ms","hash":177907114,"current-db-size-bytes":58118144,"current-db-size":"58 MB","current-db-size-in-use-bytes":27619328,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-08-13T01:20:49.445141Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":177907114,"revision":10977,"compact-revision":8298} {"level":"info","ts":"2026-08-13T01:22:00.474921Z","caller":"traceutil/trace.go:171","msg":"trace[420932936] transaction","detail":"{read_only:false; response_revision:13488; number_of_response:1; }","duration":"159.783047ms","start":"2026-08-13T01:22:00.315118Z","end":"2026-08-13T01:22:00.474901Z","steps":["trace[420932936] 'process raft request' (duration: 159.538571ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:22:36.714605Z","caller":"traceutil/trace.go:171","msg":"trace[1292072575] transaction","detail":"{read_only:false; response_revision:13695; number_of_response:1; }","duration":"106.489761ms","start":"2026-08-13T01:22:36.60809Z","end":"2026-08-13T01:22:36.71458Z","steps":["trace[1292072575] 'process raft request' (duration: 106.355318ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:22:37.138459Z","caller":"traceutil/trace.go:171","msg":"trace[843508425] transaction","detail":"{read_only:false; response_revision:13698; number_of_response:1; }","duration":"413.39663ms","start":"2026-08-13T01:22:36.725033Z","end":"2026-08-13T01:22:37.138429Z","steps":["trace[843508425] 'process raft request' (duration: 413.239257ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:22:37.138613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:22:36.725011Z","time spent":"413.524134ms","remote":"127.0.0.1:37782","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T01:22:37.171377Z","caller":"traceutil/trace.go:171","msg":"trace[726326289] transaction","detail":"{read_only:false; response_revision:13701; number_of_response:1; }","duration":"440.257384ms","start":"2026-08-13T01:22:36.731093Z","end":"2026-08-13T01:22:37.17135Z","steps":["trace[726326289] 'process raft request' (duration: 440.173783ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:22:37.171394Z","caller":"traceutil/trace.go:171","msg":"trace[1633723654] transaction","detail":"{read_only:false; response_revision:13700; number_of_response:1; }","duration":"440.353937ms","start":"2026-08-13T01:22:36.731014Z","end":"2026-08-13T01:22:37.171368Z","steps":["trace[1633723654] 'process raft request' (duration: 440.211924ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:22:37.171397Z","caller":"traceutil/trace.go:171","msg":"trace[905576223] transaction","detail":"{read_only:false; response_revision:13699; number_of_response:1; }","duration":"440.422829ms","start":"2026-08-13T01:22:36.730931Z","end":"2026-08-13T01:22:37.171354Z","steps":["trace[905576223] 'process raft request' (duration: 440.163863ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:22:37.171536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:22:36.730986Z","time spent":"440.471809ms","remote":"127.0.0.1:37782","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-13T01:22:37.171534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:22:36.731061Z","time spent":"440.391748ms","remote":"127.0.0.1:37782","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-13T01:22:37.171575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:22:36.730908Z","time spent":"440.574792ms","remote":"127.0.0.1:37782","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T01:22:37.171649Z","caller":"traceutil/trace.go:171","msg":"trace[808631308] linearizableReadLoop","detail":"{readStateIndex:14173; appliedIndex:14168; }","duration":"427.803246ms","start":"2026-08-13T01:22:36.743746Z","end":"2026-08-13T01:22:37.171549Z","steps":["trace[808631308] 'read index received' (duration: 394.555165ms)","trace[808631308] 'applied index is now lower than readState.Index' (duration: 33.246871ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T01:22:37.171664Z","caller":"traceutil/trace.go:171","msg":"trace[1324696640] transaction","detail":"{read_only:false; response_revision:13702; number_of_response:1; }","duration":"440.53456ms","start":"2026-08-13T01:22:36.731118Z","end":"2026-08-13T01:22:37.171653Z","steps":["trace[1324696640] 'process raft request' (duration: 440.192543ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:22:37.171794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:22:36.731091Z","time spent":"440.672544ms","remote":"127.0.0.1:37782","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-13T01:22:37.171895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.131447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:356"} {"level":"info","ts":"2026-08-13T01:22:37.171972Z","caller":"traceutil/trace.go:171","msg":"trace[1140568216] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:13702; }","duration":"373.245199ms","start":"2026-08-13T01:22:36.798712Z","end":"2026-08-13T01:22:37.171957Z","steps":["trace[1140568216] 'agreement among raft nodes before linearized reading' (duration: 373.090966ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:22:37.172036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:22:36.798688Z","time spent":"373.332932ms","remote":"127.0.0.1:37644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":379,"request content":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" "} {"level":"warn","ts":"2026-08-13T01:22:37.172558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.796908ms","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-13T01:22:37.172621Z","caller":"traceutil/trace.go:171","msg":"trace[722438002] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:13702; }","duration":"428.916471ms","start":"2026-08-13T01:22:36.743687Z","end":"2026-08-13T01:22:37.172604Z","steps":["trace[722438002] 'agreement among raft nodes before linearized reading' (duration: 427.99184ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:22:37.172721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:22:36.743674Z","time spent":"428.982652ms","remote":"127.0.0.1:37782","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"info","ts":"2026-08-13T01:22:37.558159Z","caller":"traceutil/trace.go:171","msg":"trace[821158562] linearizableReadLoop","detail":"{readStateIndex:14174; appliedIndex:14173; }","duration":"280.516018ms","start":"2026-08-13T01:22:37.277622Z","end":"2026-08-13T01:22:37.558138Z","steps":["trace[821158562] 'read index received' (duration: 279.858973ms)","trace[821158562] 'applied index is now lower than readState.Index' (duration: 656.095µs)"],"step_count":2} {"level":"info","ts":"2026-08-13T01:22:37.558184Z","caller":"traceutil/trace.go:171","msg":"trace[912475834] transaction","detail":"{read_only:false; response_revision:13703; number_of_response:1; }","duration":"381.408169ms","start":"2026-08-13T01:22:37.176757Z","end":"2026-08-13T01:22:37.558166Z","steps":["trace[912475834] 'process raft request' (duration: 380.708133ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:22:37.558295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.654171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-13T01:22:37.55839Z","caller":"traceutil/trace.go:171","msg":"trace[1543977532] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:13703; }","duration":"280.756544ms","start":"2026-08-13T01:22:37.277606Z","end":"2026-08-13T01:22:37.558362Z","steps":["trace[1543977532] 'agreement among raft nodes before linearized reading' (duration: 280.60312ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:22:37.558647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:22:37.176731Z","time spent":"381.618753ms","remote":"127.0.0.1:37782","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T01:24:17.194281Z","caller":"traceutil/trace.go:171","msg":"trace[1355932759] transaction","detail":"{read_only:false; response_revision:14772; number_of_response:1; }","duration":"117.709921ms","start":"2026-08-13T01:24:17.076542Z","end":"2026-08-13T01:24:17.194252Z","steps":["trace[1355932759] 'process raft request' (duration: 117.599098ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:24:17.194302Z","caller":"traceutil/trace.go:171","msg":"trace[938115446] transaction","detail":"{read_only:false; response_revision:14771; number_of_response:1; }","duration":"120.053566ms","start":"2026-08-13T01:24:17.074222Z","end":"2026-08-13T01:24:17.194276Z","steps":["trace[938115446] 'process raft request' (duration: 73.27359ms)","trace[938115446] 'compare' (duration: 46.463488ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T01:24:18.402256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.416429ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-08-13T01:24:18.402502Z","caller":"traceutil/trace.go:171","msg":"trace[1464597035] linearizableReadLoop","detail":"{readStateIndex:15288; appliedIndex:15286; }","duration":"525.44167ms","start":"2026-08-13T01:24:17.877041Z","end":"2026-08-13T01:24:18.402483Z","steps":["trace[1464597035] 'read index received' (duration: 94.087912ms)","trace[1464597035] 'applied index is now lower than readState.Index' (duration: 431.352658ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T01:24:18.402517Z","caller":"traceutil/trace.go:171","msg":"trace[520732782] transaction","detail":"{read_only:false; response_revision:14779; number_of_response:1; }","duration":"545.705591ms","start":"2026-08-13T01:24:17.856797Z","end":"2026-08-13T01:24:18.402503Z","steps":["trace[520732782] 'process raft request' (duration: 545.563028ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:24:18.402621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:24:17.856771Z","time spent":"545.778603ms","remote":"127.0.0.1:37782","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-13T01:24:18.402738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"525.626834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T01:24:18.40323Z","caller":"traceutil/trace.go:171","msg":"trace[1170764357] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:14779; }","duration":"525.915051ms","start":"2026-08-13T01:24:17.877013Z","end":"2026-08-13T01:24:18.402928Z","steps":["trace[1170764357] 'agreement among raft nodes before linearized reading' (duration: 525.523732ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:24:18.403314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:24:17.877Z","time spent":"526.295769ms","remote":"127.0.0.1:37756","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" "} {"level":"warn","ts":"2026-08-13T01:24:18.417265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"540.12664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-user\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T01:24:18.417319Z","caller":"traceutil/trace.go:171","msg":"trace[524791426] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:14780; }","duration":"540.228363ms","start":"2026-08-13T01:24:17.877076Z","end":"2026-08-13T01:24:18.417305Z","steps":["trace[524791426] 'agreement among raft nodes before linearized reading' (duration: 540.131701ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:24:18.417352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:24:17.877049Z","time spent":"540.294524ms","remote":"127.0.0.1:37756","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/openstack/nova-ks-user\" "} {"level":"warn","ts":"2026-08-13T01:24:18.418274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"540.594272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T01:24:18.418334Z","caller":"traceutil/trace.go:171","msg":"trace[940100261] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:14780; }","duration":"540.679795ms","start":"2026-08-13T01:24:17.877639Z","end":"2026-08-13T01:24:18.418319Z","steps":["trace[940100261] 'agreement among raft nodes before linearized reading' (duration: 540.579612ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:24:18.418355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.696173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"} {"level":"warn","ts":"2026-08-13T01:24:18.418373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:24:17.877627Z","time spent":"540.736676ms","remote":"127.0.0.1:37756","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/openstack/nova-rabbit-init\" "} {"level":"info","ts":"2026-08-13T01:24:18.418347Z","caller":"traceutil/trace.go:171","msg":"trace[753085110] transaction","detail":"{read_only:false; response_revision:14780; number_of_response:1; }","duration":"366.439472ms","start":"2026-08-13T01:24:18.051874Z","end":"2026-08-13T01:24:18.418314Z","steps":["trace[753085110] 'process raft request' (duration: 365.180863ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:24:18.418447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.738374ms","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":"warn","ts":"2026-08-13T01:24:18.418332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.265418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T01:24:18.418548Z","caller":"traceutil/trace.go:171","msg":"trace[1859554927] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:14780; }","duration":"277.894457ms","start":"2026-08-13T01:24:18.14063Z","end":"2026-08-13T01:24:18.418524Z","steps":["trace[1859554927] 'agreement among raft nodes before linearized reading' (duration: 277.614261ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:24:18.418573Z","caller":"traceutil/trace.go:171","msg":"trace[468946317] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:14780; }","duration":"197.561384ms","start":"2026-08-13T01:24:18.221004Z","end":"2026-08-13T01:24:18.418566Z","steps":["trace[468946317] 'agreement among raft nodes before linearized reading' (duration: 197.268688ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:24:18.418394Z","caller":"traceutil/trace.go:171","msg":"trace[1733873741] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:14780; }","duration":"196.799476ms","start":"2026-08-13T01:24:18.221585Z","end":"2026-08-13T01:24:18.418385Z","steps":["trace[1733873741] 'agreement among raft nodes before linearized reading' (duration: 196.666493ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:24:18.41857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:24:18.051847Z","time spent":"366.637756ms","remote":"127.0.0.1:37782","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-13T01:24:18.418494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"536.408816ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"} {"level":"info","ts":"2026-08-13T01:24:18.419043Z","caller":"traceutil/trace.go:171","msg":"trace[608544312] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:14780; }","duration":"536.973509ms","start":"2026-08-13T01:24:17.882046Z","end":"2026-08-13T01:24:18.419019Z","steps":["trace[608544312] 'agreement among raft nodes before linearized reading' (duration: 536.14881ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:24:18.419149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:24:17.882035Z","time spent":"537.090451ms","remote":"127.0.0.1:37756","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":5546,"request content":"key:\"/registry/jobs/openstack/nova-db-sync\" "} {"level":"warn","ts":"2026-08-13T01:24:18.419624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.69981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"} {"level":"info","ts":"2026-08-13T01:24:18.419755Z","caller":"traceutil/trace.go:171","msg":"trace[2055976729] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:14780; }","duration":"198.880104ms","start":"2026-08-13T01:24:18.220853Z","end":"2026-08-13T01:24:18.419733Z","steps":["trace[2055976729] 'agreement among raft nodes before linearized reading' (duration: 196.383546ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:25:49.371663Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12990} {"level":"info","ts":"2026-08-13T01:25:49.449832Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12990,"took":"75.353119ms","hash":1196974732,"current-db-size-bytes":58118144,"current-db-size":"58 MB","current-db-size-in-use-bytes":30453760,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-08-13T01:25:49.449913Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1196974732,"revision":12990,"compact-revision":10977} {"level":"warn","ts":"2026-08-13T01:29:43.431635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.198053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-rzljj\" ","response":"range_response_count:1 size:22133"} {"level":"info","ts":"2026-08-13T01:29:43.431717Z","caller":"traceutil/trace.go:171","msg":"trace[901993569] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-rzljj; range_end:; response_count:1; response_revision:17236; }","duration":"159.332216ms","start":"2026-08-13T01:29:43.272368Z","end":"2026-08-13T01:29:43.4317Z","steps":["trace[901993569] 'range keys from in-memory index tree' (duration: 159.02467ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:29:43.432258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.332128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzonegroups/\" range_end:\"/registry/ceph.rook.io/cephobjectzonegroups0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-13T01:29:43.432322Z","caller":"traceutil/trace.go:171","msg":"trace[657677112] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzonegroups/; range_end:/registry/ceph.rook.io/cephobjectzonegroups0; response_count:0; response_revision:17236; }","duration":"125.43913ms","start":"2026-08-13T01:29:43.306869Z","end":"2026-08-13T01:29:43.432308Z","steps":["trace[657677112] 'count revisions from in-memory index tree' (duration: 125.223644ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:29:43.775954Z","caller":"traceutil/trace.go:171","msg":"trace[834432017] transaction","detail":"{read_only:false; response_revision:17237; number_of_response:1; }","duration":"338.862603ms","start":"2026-08-13T01:29:43.437069Z","end":"2026-08-13T01:29:43.775932Z","steps":["trace[834432017] 'process raft request' (duration: 338.718149ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:29:43.776094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:29:43.437037Z","time spent":"338.985876ms","remote":"127.0.0.1:37782","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T01:29:43.974888Z","caller":"traceutil/trace.go:171","msg":"trace[17172100] transaction","detail":"{read_only:false; response_revision:17239; number_of_response:1; }","duration":"537.291567ms","start":"2026-08-13T01:29:43.437556Z","end":"2026-08-13T01:29:43.974848Z","steps":["trace[17172100] 'process raft request' (duration: 537.168685ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:29:43.975085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:29:43.437548Z","time spent":"537.468601ms","remote":"127.0.0.1:37782","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T01:29:43.97509Z","caller":"traceutil/trace.go:171","msg":"trace[1285139261] linearizableReadLoop","detail":"{readStateIndex:17829; appliedIndex:17825; }","duration":"533.691703ms","start":"2026-08-13T01:29:43.441382Z","end":"2026-08-13T01:29:43.975074Z","steps":["trace[1285139261] 'read index received' (duration: 334.542172ms)","trace[1285139261] 'applied index is now lower than readState.Index' (duration: 199.148541ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T01:29:43.975205Z","caller":"traceutil/trace.go:171","msg":"trace[1507777143] transaction","detail":"{read_only:false; response_revision:17240; number_of_response:1; }","duration":"537.603854ms","start":"2026-08-13T01:29:43.43759Z","end":"2026-08-13T01:29:43.975193Z","steps":["trace[1507777143] 'process raft request' (duration: 537.223166ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:29:43.975263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:29:43.437586Z","time spent":"537.646105ms","remote":"127.0.0.1:37782","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T01:29:43.975437Z","caller":"traceutil/trace.go:171","msg":"trace[96646586] transaction","detail":"{read_only:false; response_revision:17241; number_of_response:1; }","duration":"537.674246ms","start":"2026-08-13T01:29:43.437738Z","end":"2026-08-13T01:29:43.975412Z","steps":["trace[96646586] 'process raft request' (duration: 537.265647ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:29:43.975494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:29:43.437733Z","time spent":"537.733368ms","remote":"127.0.0.1:37782","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-13T01:29:43.975855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"534.468001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:94 size:946103"} {"level":"info","ts":"2026-08-13T01:29:43.975889Z","caller":"traceutil/trace.go:171","msg":"trace[1122332962] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:94; response_revision:17241; }","duration":"534.537203ms","start":"2026-08-13T01:29:43.441343Z","end":"2026-08-13T01:29:43.97588Z","steps":["trace[1122332962] 'agreement among raft nodes before linearized reading' (duration: 533.793206ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:29:43.975911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:29:43.441326Z","time spent":"534.579235ms","remote":"127.0.0.1:37722","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":94,"response size":946126,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "} {"level":"info","ts":"2026-08-13T01:29:43.978523Z","caller":"traceutil/trace.go:171","msg":"trace[938574495] transaction","detail":"{read_only:false; response_revision:17238; number_of_response:1; }","duration":"541.020623ms","start":"2026-08-13T01:29:43.437483Z","end":"2026-08-13T01:29:43.978504Z","steps":["trace[938574495] 'process raft request' (duration: 522.77437ms)","trace[938574495] 'compare' (duration: 14.274731ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T01:29:43.978614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:29:43.437462Z","time spent":"541.097865ms","remote":"127.0.0.1:37782","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T01:30:49.378879Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15373} {"level":"info","ts":"2026-08-13T01:30:49.475602Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15373,"took":"93.948731ms","hash":161789694,"current-db-size-bytes":58118144,"current-db-size":"58 MB","current-db-size-in-use-bytes":33628160,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-08-13T01:30:49.475683Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":161789694,"revision":15373,"compact-revision":12990} {"level":"info","ts":"2026-08-13T01:33:51.25428Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e44ae1545340c14b","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-08-13T01:33:51.25858Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-08-13T01:33:51.258674Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-08-13T01:34:59.727845Z","caller":"traceutil/trace.go:171","msg":"trace[1078028482] linearizableReadLoop","detail":"{readStateIndex:20393; appliedIndex:20392; }","duration":"192.474987ms","start":"2026-08-13T01:34:59.535339Z","end":"2026-08-13T01:34:59.727814Z","steps":["trace[1078028482] 'read index received' (duration: 192.272992ms)","trace[1078028482] 'applied index is now lower than readState.Index' (duration: 200.765µs)"],"step_count":2} {"level":"info","ts":"2026-08-13T01:34:59.728003Z","caller":"traceutil/trace.go:171","msg":"trace[409420740] transaction","detail":"{read_only:false; response_revision:19722; number_of_response:1; }","duration":"328.077041ms","start":"2026-08-13T01:34:59.399862Z","end":"2026-08-13T01:34:59.727939Z","steps":["trace[409420740] 'process raft request' (duration: 327.784114ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:34:59.728105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.761295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-08-13T01:34:59.728146Z","caller":"traceutil/trace.go:171","msg":"trace[591303715] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:19722; }","duration":"192.849786ms","start":"2026-08-13T01:34:59.535284Z","end":"2026-08-13T01:34:59.728134Z","steps":["trace[591303715] 'agreement among raft nodes before linearized reading' (duration: 192.701932ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:34:59.728252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:34:59.399837Z","time spent":"328.271616ms","remote":"127.0.0.1:37782","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T01:34:59.942045Z","caller":"traceutil/trace.go:171","msg":"trace[739039194] transaction","detail":"{read_only:false; response_revision:19723; number_of_response:1; }","duration":"382.605441ms","start":"2026-08-13T01:34:59.559391Z","end":"2026-08-13T01:34:59.941997Z","steps":["trace[739039194] 'process raft request' (duration: 325.982313ms)","trace[739039194] 'compare' (duration: 56.312231ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T01:34:59.942108Z","caller":"traceutil/trace.go:171","msg":"trace[342868685] transaction","detail":"{read_only:false; response_revision:19725; number_of_response:1; }","duration":"312.519312ms","start":"2026-08-13T01:34:59.629551Z","end":"2026-08-13T01:34:59.942071Z","steps":["trace[342868685] 'process raft request' (duration: 312.43164ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:34:59.942169Z","caller":"traceutil/trace.go:171","msg":"trace[729381561] linearizableReadLoop","detail":"{readStateIndex:20396; appliedIndex:20393; }","duration":"214.198479ms","start":"2026-08-13T01:34:59.72796Z","end":"2026-08-13T01:34:59.942159Z","steps":["trace[729381561] 'read index received' (duration: 157.456558ms)","trace[729381561] 'applied index is now lower than readState.Index' (duration: 56.741021ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T01:34:59.94212Z","caller":"traceutil/trace.go:171","msg":"trace[2029296962] transaction","detail":"{read_only:false; response_revision:19727; number_of_response:1; }","duration":"171.943093ms","start":"2026-08-13T01:34:59.77016Z","end":"2026-08-13T01:34:59.942103Z","steps":["trace[2029296962] 'process raft request' (duration: 171.902702ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:34:59.942091Z","caller":"traceutil/trace.go:171","msg":"trace[1523489311] transaction","detail":"{read_only:false; response_revision:19724; number_of_response:1; }","duration":"317.22774ms","start":"2026-08-13T01:34:59.624812Z","end":"2026-08-13T01:34:59.94204Z","steps":["trace[1523489311] 'process raft request' (duration: 317.117798ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:34:59.942266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:34:59.559374Z","time spent":"382.773625ms","remote":"127.0.0.1:37782","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-13T01:34:59.942378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.212957ms","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-13T01:34:59.942421Z","caller":"traceutil/trace.go:171","msg":"trace[871331127] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:19727; }","duration":"371.32338ms","start":"2026-08-13T01:34:59.571088Z","end":"2026-08-13T01:34:59.942412Z","steps":["trace[871331127] 'agreement among raft nodes before linearized reading' (duration: 371.073604ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:34:59.942395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:34:59.624793Z","time spent":"317.516116ms","remote":"127.0.0.1:37782","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-13T01:34:59.94245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.735353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"warn","ts":"2026-08-13T01:34:59.942381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.377311ms","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-13T01:34:59.942458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:34:59.629537Z","time spent":"312.629404ms","remote":"127.0.0.1:37782","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T01:34:59.94248Z","caller":"traceutil/trace.go:171","msg":"trace[1696768505] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:19727; }","duration":"371.545444ms","start":"2026-08-13T01:34:59.570928Z","end":"2026-08-13T01:34:59.942474Z","steps":["trace[1696768505] 'agreement among raft nodes before linearized reading' (duration: 371.314879ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:34:59.94245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:34:59.57106Z","time spent":"371.38399ms","remote":"127.0.0.1:37782","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-13T01:34:59.942502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:34:59.570918Z","time spent":"371.579185ms","remote":"127.0.0.1:37782","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-08-13T01:34:59.942479Z","caller":"traceutil/trace.go:171","msg":"trace[1085484950] transaction","detail":"{read_only:false; response_revision:19726; number_of_response:1; }","duration":"210.614437ms","start":"2026-08-13T01:34:59.731842Z","end":"2026-08-13T01:34:59.942457Z","steps":["trace[1085484950] 'process raft request' (duration: 210.182767ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:34:59.942475Z","caller":"traceutil/trace.go:171","msg":"trace[1556842890] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:19727; }","duration":"379.782975ms","start":"2026-08-13T01:34:59.562685Z","end":"2026-08-13T01:34:59.942468Z","steps":["trace[1556842890] 'agreement among raft nodes before linearized reading' (duration: 379.717003ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:34:59.942551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:34:59.562675Z","time spent":"379.869097ms","remote":"127.0.0.1:37782","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-08-13T01:35:03.952682Z","caller":"traceutil/trace.go:171","msg":"trace[2141230752] transaction","detail":"{read_only:false; response_revision:19760; number_of_response:1; }","duration":"205.945649ms","start":"2026-08-13T01:35:03.746709Z","end":"2026-08-13T01:35:03.952655Z","steps":["trace[2141230752] 'process raft request' (duration: 205.716444ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:35:04.285216Z","caller":"traceutil/trace.go:171","msg":"trace[754369476] transaction","detail":"{read_only:false; response_revision:19763; number_of_response:1; }","duration":"324.685783ms","start":"2026-08-13T01:35:03.960481Z","end":"2026-08-13T01:35:04.285167Z","steps":["trace[754369476] 'process raft request' (duration: 324.655282ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:35:04.285214Z","caller":"traceutil/trace.go:171","msg":"trace[1268333845] linearizableReadLoop","detail":"{readStateIndex:20435; appliedIndex:20435; }","duration":"315.10881ms","start":"2026-08-13T01:35:03.970066Z","end":"2026-08-13T01:35:04.285175Z","steps":["trace[1268333845] 'read index received' (duration: 315.09081ms)","trace[1268333845] 'applied index is now lower than readState.Index' (duration: 15.33µs)"],"step_count":2} {"level":"warn","ts":"2026-08-13T01:35:04.285334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:35:03.960473Z","time spent":"324.792645ms","remote":"127.0.0.1:37782","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-13T01:35:04.28549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.281344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-08-13T01:35:04.28553Z","caller":"traceutil/trace.go:171","msg":"trace[807513414] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:19763; }","duration":"318.369766ms","start":"2026-08-13T01:35:03.967145Z","end":"2026-08-13T01:35:04.285515Z","steps":["trace[807513414] 'agreement among raft nodes before linearized reading' (duration: 318.176451ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:35:04.285561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:35:03.967126Z","time spent":"318.428078ms","remote":"127.0.0.1:37782","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":581,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"info","ts":"2026-08-13T01:35:04.285593Z","caller":"traceutil/trace.go:171","msg":"trace[480665881] transaction","detail":"{read_only:false; response_revision:19762; number_of_response:1; }","duration":"325.239486ms","start":"2026-08-13T01:35:03.960347Z","end":"2026-08-13T01:35:04.285586Z","steps":["trace[480665881] 'process raft request' (duration: 324.620881ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:35:04.285622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:35:03.960329Z","time spent":"325.277097ms","remote":"127.0.0.1:37782","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-13T01:35:04.285736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.859995ms","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-13T01:35:04.285755Z","caller":"traceutil/trace.go:171","msg":"trace[1031295079] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:19763; }","duration":"320.890665ms","start":"2026-08-13T01:35:03.964857Z","end":"2026-08-13T01:35:04.285748Z","steps":["trace[1031295079] 'agreement among raft nodes before linearized reading' (duration: 320.810763ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:35:04.285769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:35:03.964851Z","time spent":"320.914645ms","remote":"127.0.0.1:37782","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-13T01:35:04.285829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.187175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-08-13T01:35:04.285852Z","caller":"traceutil/trace.go:171","msg":"trace[900246279] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:19763; }","duration":"322.224585ms","start":"2026-08-13T01:35:03.96362Z","end":"2026-08-13T01:35:04.285845Z","steps":["trace[900246279] 'agreement among raft nodes before linearized reading' (duration: 322.157724ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:35:04.285871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:35:03.963612Z","time spent":"322.254606ms","remote":"127.0.0.1:37782","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-13T01:35:04.285883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.982987ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-08-13T01:35:04.285898Z","caller":"traceutil/trace.go:171","msg":"trace[243737265] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:19763; }","duration":"320.997957ms","start":"2026-08-13T01:35:03.964896Z","end":"2026-08-13T01:35:04.285894Z","steps":["trace[243737265] 'agreement among raft nodes before linearized reading' (duration: 320.942856ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:35:04.28591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:35:03.964881Z","time spent":"321.026099ms","remote":"127.0.0.1:37782","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-08-13T01:35:04.426334Z","caller":"traceutil/trace.go:171","msg":"trace[113513389] transaction","detail":"{read_only:false; response_revision:19764; number_of_response:1; }","duration":"452.604759ms","start":"2026-08-13T01:35:03.9737Z","end":"2026-08-13T01:35:04.426305Z","steps":["trace[113513389] 'process raft request' (duration: 442.371942ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:35:04.426486Z","caller":"traceutil/trace.go:171","msg":"trace[979213163] linearizableReadLoop","detail":"{readStateIndex:20437; appliedIndex:20435; }","duration":"141.163072ms","start":"2026-08-13T01:35:04.28529Z","end":"2026-08-13T01:35:04.426453Z","steps":["trace[979213163] 'read index received' (duration: 130.797782ms)","trace[979213163] 'applied index is now lower than readState.Index' (duration: 10.36195ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T01:35:04.426519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:35:03.973681Z","time spent":"452.738891ms","remote":"127.0.0.1:37782","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-13T01:35:04.426722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.301553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"info","ts":"2026-08-13T01:35:04.426698Z","caller":"traceutil/trace.go:171","msg":"trace[586158373] transaction","detail":"{read_only:false; response_revision:19765; number_of_response:1; }","duration":"378.472815ms","start":"2026-08-13T01:35:04.048188Z","end":"2026-08-13T01:35:04.426661Z","steps":["trace[586158373] 'process raft request' (duration: 378.047665ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:35:04.426755Z","caller":"traceutil/trace.go:171","msg":"trace[935403588] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:19765; }","duration":"208.355994ms","start":"2026-08-13T01:35:04.218388Z","end":"2026-08-13T01:35:04.426744Z","steps":["trace[935403588] 'agreement among raft nodes before linearized reading' (duration: 208.165059ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:35:04.426875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:35:04.04816Z","time spent":"378.610458ms","remote":"127.0.0.1:37782","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T01:35:04.499024Z","caller":"traceutil/trace.go:171","msg":"trace[1332771821] transaction","detail":"{read_only:false; response_revision:19766; number_of_response:1; }","duration":"208.056528ms","start":"2026-08-13T01:35:04.29092Z","end":"2026-08-13T01:35:04.498977Z","steps":["trace[1332771821] 'process raft request' (duration: 207.762741ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:35:04.499037Z","caller":"traceutil/trace.go:171","msg":"trace[1315207387] transaction","detail":"{read_only:false; response_revision:19767; number_of_response:1; }","duration":"207.971296ms","start":"2026-08-13T01:35:04.291024Z","end":"2026-08-13T01:35:04.498995Z","steps":["trace[1315207387] 'process raft request' (duration: 207.820933ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:35:04.499017Z","caller":"traceutil/trace.go:171","msg":"trace[1229224126] transaction","detail":"{read_only:false; response_revision:19768; number_of_response:1; }","duration":"207.946806ms","start":"2026-08-13T01:35:04.291042Z","end":"2026-08-13T01:35:04.498988Z","steps":["trace[1229224126] 'process raft request' (duration: 207.839574ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:35:04.499303Z","caller":"traceutil/trace.go:171","msg":"trace[466233389] transaction","detail":"{read_only:false; response_revision:19769; number_of_response:1; }","duration":"208.224452ms","start":"2026-08-13T01:35:04.291049Z","end":"2026-08-13T01:35:04.499274Z","steps":["trace[466233389] 'process raft request' (duration: 207.876764ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:35:04.691313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.259499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-13T01:35:04.691394Z","caller":"traceutil/trace.go:171","msg":"trace[263519081] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:19769; }","duration":"120.399132ms","start":"2026-08-13T01:35:04.570969Z","end":"2026-08-13T01:35:04.691368Z","steps":["trace[263519081] 'range keys from in-memory index tree' (duration: 120.156137ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:35:08.545416Z","caller":"traceutil/trace.go:171","msg":"trace[626521928] transaction","detail":"{read_only:false; response_revision:19787; number_of_response:1; }","duration":"248.459731ms","start":"2026-08-13T01:35:08.296933Z","end":"2026-08-13T01:35:08.545393Z","steps":["trace[626521928] 'process raft request' (duration: 248.290378ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:35:08.569719Z","caller":"traceutil/trace.go:171","msg":"trace[295498988] linearizableReadLoop","detail":"{readStateIndex:20461; appliedIndex:20459; }","duration":"181.524884ms","start":"2026-08-13T01:35:08.388172Z","end":"2026-08-13T01:35:08.569697Z","steps":["trace[295498988] 'read index received' (duration: 157.084239ms)","trace[295498988] 'applied index is now lower than readState.Index' (duration: 24.439485ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T01:35:08.569796Z","caller":"traceutil/trace.go:171","msg":"trace[252098620] transaction","detail":"{read_only:false; response_revision:19788; number_of_response:1; }","duration":"270.134662ms","start":"2026-08-13T01:35:08.299611Z","end":"2026-08-13T01:35:08.569746Z","steps":["trace[252098620] 'process raft request' (duration: 269.972509ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:35:08.569914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.699399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-08-13T01:35:08.569956Z","caller":"traceutil/trace.go:171","msg":"trace[1512955070] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:19788; }","duration":"181.804911ms","start":"2026-08-13T01:35:08.38814Z","end":"2026-08-13T01:35:08.569945Z","steps":["trace[1512955070] 'agreement among raft nodes before linearized reading' (duration: 181.696708ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:35:08.569982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.803846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-08-13T01:35:08.570017Z","caller":"traceutil/trace.go:171","msg":"trace[242297537] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:19788; }","duration":"128.887638ms","start":"2026-08-13T01:35:08.44112Z","end":"2026-08-13T01:35:08.570008Z","steps":["trace[242297537] 'agreement among raft nodes before linearized reading' (duration: 128.736265ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:35:08.978886Z","caller":"traceutil/trace.go:171","msg":"trace[248964619] transaction","detail":"{read_only:false; response_revision:19790; number_of_response:1; }","duration":"403.825381ms","start":"2026-08-13T01:35:08.575029Z","end":"2026-08-13T01:35:08.978855Z","steps":["trace[248964619] 'process raft request' (duration: 403.3622ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:35:08.979137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:35:08.574998Z","time spent":"404.035736ms","remote":"127.0.0.1:37782","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T01:35:08.979279Z","caller":"traceutil/trace.go:171","msg":"trace[1910077329] transaction","detail":"{read_only:false; response_revision:19791; number_of_response:1; }","duration":"403.983775ms","start":"2026-08-13T01:35:08.575269Z","end":"2026-08-13T01:35:08.979252Z","steps":["trace[1910077329] 'process raft request' (duration: 403.511364ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:35:08.97944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:35:08.575245Z","time spent":"404.111917ms","remote":"127.0.0.1:37782","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T01:35:08.97976Z","caller":"traceutil/trace.go:171","msg":"trace[1490562137] transaction","detail":"{read_only:false; response_revision:19792; number_of_response:1; }","duration":"403.986585ms","start":"2026-08-13T01:35:08.575761Z","end":"2026-08-13T01:35:08.979748Z","steps":["trace[1490562137] 'process raft request' (duration: 403.397621ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:35:08.979835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:35:08.575749Z","time spent":"404.046586ms","remote":"127.0.0.1:37782","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T01:35:08.980022Z","caller":"traceutil/trace.go:171","msg":"trace[894875546] transaction","detail":"{read_only:false; response_revision:19793; number_of_response:1; }","duration":"403.989385ms","start":"2026-08-13T01:35:08.576023Z","end":"2026-08-13T01:35:08.980012Z","steps":["trace[894875546] 'process raft request' (duration: 403.679538ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:35:08.980092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:35:08.575989Z","time spent":"404.072066ms","remote":"127.0.0.1:37782","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T01:35:49.387041Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17980} {"level":"info","ts":"2026-08-13T01:35:49.501353Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17980,"took":"111.514177ms","hash":333185809,"current-db-size-bytes":58118144,"current-db-size":"58 MB","current-db-size-in-use-bytes":29261824,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-08-13T01:35:49.501414Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":333185809,"revision":17980,"compact-revision":15373} {"level":"info","ts":"2026-08-13T01:39:06.953621Z","caller":"traceutil/trace.go:171","msg":"trace[14272099] transaction","detail":"{read_only:false; response_revision:22230; number_of_response:1; }","duration":"158.369359ms","start":"2026-08-13T01:39:06.795218Z","end":"2026-08-13T01:39:06.953588Z","steps":["trace[14272099] 'process raft request' (duration: 157.911288ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:39:06.964447Z","caller":"traceutil/trace.go:171","msg":"trace[2104472127] transaction","detail":"{read_only:false; response_revision:22231; number_of_response:1; }","duration":"114.979437ms","start":"2026-08-13T01:39:06.849447Z","end":"2026-08-13T01:39:06.964426Z","steps":["trace[2104472127] 'process raft request' (duration: 114.850184ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:39:06.96459Z","caller":"traceutil/trace.go:171","msg":"trace[1472723737] transaction","detail":"{read_only:false; response_revision:22232; number_of_response:1; }","duration":"112.275234ms","start":"2026-08-13T01:39:06.852281Z","end":"2026-08-13T01:39:06.964557Z","steps":["trace[1472723737] 'process raft request' (duration: 112.111161ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:39:07.476666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.373198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1866"} {"level":"info","ts":"2026-08-13T01:39:07.476745Z","caller":"traceutil/trace.go:171","msg":"trace[1459963220] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:22232; }","duration":"476.49569ms","start":"2026-08-13T01:39:07.000229Z","end":"2026-08-13T01:39:07.476724Z","steps":["trace[1459963220] 'range keys from in-memory index tree' (duration: 476.166953ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:39:07.47679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:39:07.000212Z","time spent":"476.564312ms","remote":"127.0.0.1:37702","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1889,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "} {"level":"warn","ts":"2026-08-13T01:39:07.476771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.246905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-08-13T01:39:07.476857Z","caller":"traceutil/trace.go:171","msg":"trace[245720149] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:22232; }","duration":"267.3925ms","start":"2026-08-13T01:39:07.209442Z","end":"2026-08-13T01:39:07.476835Z","steps":["trace[245720149] 'range keys from in-memory index tree' (duration: 266.999469ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:40:29.192114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.386133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-13T01:40:29.192252Z","caller":"traceutil/trace.go:171","msg":"trace[1918404186] range","detail":"{range_begin:/registry/jobs/openstack/magnum-ks-user; range_end:; response_count:0; response_revision:23136; }","duration":"288.576468ms","start":"2026-08-13T01:40:28.90365Z","end":"2026-08-13T01:40:29.192227Z","steps":["trace[1918404186] 'range keys from in-memory index tree' (duration: 288.287132ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:40:29.192245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.394724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-db-sync\" ","response":"range_response_count:1 size:5082"} {"level":"warn","ts":"2026-08-13T01:40:29.19222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.191989ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-ks-endpoints\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-08-13T01:40:29.192295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.298682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-domain-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-13T01:40:29.192328Z","caller":"traceutil/trace.go:171","msg":"trace[1560341021] range","detail":"{range_begin:/registry/jobs/openstack/magnum-db-sync; range_end:; response_count:1; response_revision:23136; }","duration":"288.491217ms","start":"2026-08-13T01:40:28.903816Z","end":"2026-08-13T01:40:29.192307Z","steps":["trace[1560341021] 'range keys from in-memory index tree' (duration: 288.18502ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:40:29.192331Z","caller":"traceutil/trace.go:171","msg":"trace[303996387] range","detail":"{range_begin:/registry/jobs/openstack/magnum-ks-endpoints; range_end:; response_count:0; response_revision:23136; }","duration":"288.397954ms","start":"2026-08-13T01:40:28.90391Z","end":"2026-08-13T01:40:29.192308Z","steps":["trace[303996387] 'range keys from in-memory index tree' (duration: 288.043686ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:40:29.192348Z","caller":"traceutil/trace.go:171","msg":"trace[2041095979] range","detail":"{range_begin:/registry/jobs/openstack/magnum-domain-ks-user; range_end:; response_count:0; response_revision:23136; }","duration":"288.388804ms","start":"2026-08-13T01:40:28.903944Z","end":"2026-08-13T01:40:29.192332Z","steps":["trace[2041095979] 'range keys from in-memory index tree' (duration: 288.20902ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:40:29.19247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.036278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-rabbit-init\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-13T01:40:29.192502Z","caller":"traceutil/trace.go:171","msg":"trace[734379622] range","detail":"{range_begin:/registry/jobs/openstack/magnum-rabbit-init; range_end:; response_count:0; response_revision:23136; }","duration":"289.10954ms","start":"2026-08-13T01:40:28.903383Z","end":"2026-08-13T01:40:29.192493Z","steps":["trace[734379622] 'range keys from in-memory index tree' (duration: 288.945037ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:40:29.192678Z","caller":"traceutil/trace.go:171","msg":"trace[404326636] transaction","detail":"{read_only:false; response_revision:23137; number_of_response:1; }","duration":"255.940474ms","start":"2026-08-13T01:40:28.936655Z","end":"2026-08-13T01:40:29.192596Z","steps":["trace[404326636] 'process raft request' (duration: 228.030649ms)","trace[404326636] 'compare' (duration: 27.138428ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T01:40:29.193086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.598317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/addons.cluster.x-k8s.io/clusterresourcesets/\" range_end:\"/registry/addons.cluster.x-k8s.io/clusterresourcesets0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-13T01:40:29.19313Z","caller":"traceutil/trace.go:171","msg":"trace[1191623336] range","detail":"{range_begin:/registry/addons.cluster.x-k8s.io/clusterresourcesets/; range_end:/registry/addons.cluster.x-k8s.io/clusterresourcesets0; response_count:0; response_revision:23137; }","duration":"249.673829ms","start":"2026-08-13T01:40:28.943442Z","end":"2026-08-13T01:40:29.193116Z","steps":["trace[1191623336] 'agreement among raft nodes before linearized reading' (duration: 249.569467ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:40:29.192614Z","caller":"traceutil/trace.go:171","msg":"trace[1790634555] linearizableReadLoop","detail":"{readStateIndex:23909; appliedIndex:23908; }","duration":"249.103226ms","start":"2026-08-13T01:40:28.94348Z","end":"2026-08-13T01:40:29.192583Z","steps":["trace[1790634555] 'read index received' (duration: 221.175511ms)","trace[1790634555] 'applied index is now lower than readState.Index' (duration: 27.926625ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T01:40:29.193569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.540203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtime.cluster.x-k8s.io/extensionconfigs/\" range_end:\"/registry/runtime.cluster.x-k8s.io/extensionconfigs0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-13T01:40:29.193667Z","caller":"traceutil/trace.go:171","msg":"trace[1991654024] range","detail":"{range_begin:/registry/runtime.cluster.x-k8s.io/extensionconfigs/; range_end:/registry/runtime.cluster.x-k8s.io/extensionconfigs0; response_count:0; response_revision:23136; }","duration":"261.680176ms","start":"2026-08-13T01:40:28.931954Z","end":"2026-08-13T01:40:29.193634Z","steps":["trace[1991654024] 'count revisions from in-memory index tree' (duration: 259.820664ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:40:29.198416Z","caller":"traceutil/trace.go:171","msg":"trace[39864408] transaction","detail":"{read_only:false; response_revision:23138; number_of_response:1; }","duration":"182.215801ms","start":"2026-08-13T01:40:29.015938Z","end":"2026-08-13T01:40:29.198153Z","steps":["trace[39864408] 'process raft request' (duration: 182.074138ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:40:49.395912Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20087} {"level":"info","ts":"2026-08-13T01:40:49.508889Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20087,"took":"108.791414ms","hash":3691880129,"current-db-size-bytes":58118144,"current-db-size":"58 MB","current-db-size-in-use-bytes":43257856,"current-db-size-in-use":"43 MB"} {"level":"info","ts":"2026-08-13T01:40:49.508969Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3691880129,"revision":20087,"compact-revision":17980} {"level":"info","ts":"2026-08-13T01:45:49.401813Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23301} {"level":"info","ts":"2026-08-13T01:45:49.542044Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23301,"took":"135.346002ms","hash":4109030216,"current-db-size-bytes":58118144,"current-db-size":"58 MB","current-db-size-in-use-bytes":31096832,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-08-13T01:45:49.542109Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4109030216,"revision":23301,"compact-revision":20087}