{"level":"warn","ts":"2026-10-16T00:06:01.648365Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-16T00:06:01.648549Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.167:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.167:2380","--initial-cluster=instance=https://162.253.55.167:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.167:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.167:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-10-16T00:06:01.648686Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-16T00:06:01.648722Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.167:2380"]} {"level":"info","ts":"2026-10-16T00:06:01.648766Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-10-16T00:06:01.650211Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.167:2379"]} {"level":"info","ts":"2026-10-16T00:06:01.650383Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.167:2380"],"listen-peer-urls":["https://162.253.55.167:2380"],"advertise-client-urls":["https://162.253.55.167:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.167:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.167:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-10-16T00:06:01.653351Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.559976ms"} {"level":"info","ts":"2026-10-16T00:06:01.660932Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"83287f3a81241ad4","cluster-id":"185ed9b8ed398b9a"} {"level":"info","ts":"2026-10-16T00:06:01.661084Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"83287f3a81241ad4 switched to configuration voters=()"} {"level":"info","ts":"2026-10-16T00:06:01.661183Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"83287f3a81241ad4 became follower at term 0"} {"level":"info","ts":"2026-10-16T00:06:01.661206Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 83287f3a81241ad4 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-16T00:06:01.661303Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"83287f3a81241ad4 became follower at term 1"} {"level":"info","ts":"2026-10-16T00:06:01.661397Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"83287f3a81241ad4 switched to configuration voters=(9450943707288443604)"} {"level":"warn","ts":"2026-10-16T00:06:01.66827Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-16T00:06:01.670675Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-16T00:06:01.672498Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-10-16T00:06:01.677171Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"83287f3a81241ad4","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-16T00:06:01.677734Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-10-16T00:06:01.677885Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-10-16T00:06:01.677914Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-10-16T00:06:01.67784Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"83287f3a81241ad4","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-16T00:06:01.67878Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"83287f3a81241ad4 switched to configuration voters=(9450943707288443604)"} {"level":"info","ts":"2026-10-16T00:06:01.679865Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"185ed9b8ed398b9a","local-member-id":"83287f3a81241ad4","added-peer-id":"83287f3a81241ad4","added-peer-peer-urls":["https://162.253.55.167:2380"]} {"level":"info","ts":"2026-10-16T00:06:01.682818Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-10-16T00:06:01.68302Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.167:2380"} {"level":"info","ts":"2026-10-16T00:06:01.683199Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.167:2380"} {"level":"info","ts":"2026-10-16T00:06:01.683249Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"83287f3a81241ad4","initial-advertise-peer-urls":["https://162.253.55.167:2380"],"listen-peer-urls":["https://162.253.55.167:2380"],"advertise-client-urls":["https://162.253.55.167:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.167:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-16T00:06:01.683343Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-16T00:06:02.662608Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"83287f3a81241ad4 is starting a new election at term 1"} {"level":"info","ts":"2026-10-16T00:06:02.66267Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"83287f3a81241ad4 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-16T00:06:02.662705Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"83287f3a81241ad4 received MsgPreVoteResp from 83287f3a81241ad4 at term 1"} {"level":"info","ts":"2026-10-16T00:06:02.662725Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"83287f3a81241ad4 became candidate at term 2"} {"level":"info","ts":"2026-10-16T00:06:02.662737Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"83287f3a81241ad4 received MsgVoteResp from 83287f3a81241ad4 at term 2"} {"level":"info","ts":"2026-10-16T00:06:02.662752Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"83287f3a81241ad4 became leader at term 2"} {"level":"info","ts":"2026-10-16T00:06:02.662765Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 83287f3a81241ad4 elected leader 83287f3a81241ad4 at term 2"} {"level":"info","ts":"2026-10-16T00:06:02.7775Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-16T00:06:02.778822Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-16T00:06:02.778832Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"83287f3a81241ad4","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.167:2379]}","request-path":"/0/members/83287f3a81241ad4/attributes","cluster-id":"185ed9b8ed398b9a","publish-timeout":"7s"} {"level":"info","ts":"2026-10-16T00:06:02.778922Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-16T00:06:02.779542Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"185ed9b8ed398b9a","local-member-id":"83287f3a81241ad4","cluster-version":"3.5"} {"level":"info","ts":"2026-10-16T00:06:02.779707Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-16T00:06:02.779751Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-16T00:06:02.780232Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-16T00:06:02.780279Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-16T00:06:02.782109Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-16T00:06:02.783177Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.167:2379"} {"level":"info","ts":"2026-10-16T00:06:18.350612Z","caller":"traceutil/trace.go:171","msg":"trace[719170447] transaction","detail":"{read_only:false; response_revision:407; number_of_response:1; }","duration":"173.347793ms","start":"2026-10-16T00:06:18.177232Z","end":"2026-10-16T00:06:18.35058Z","steps":["trace[719170447] 'process raft request' (duration: 173.152179ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:06:55.606601Z","caller":"traceutil/trace.go:171","msg":"trace[428199460] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"229.790443ms","start":"2026-10-16T00:06:55.376789Z","end":"2026-10-16T00:06:55.60658Z","steps":["trace[428199460] 'process raft request' (duration: 229.670901ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:06:55.856121Z","caller":"traceutil/trace.go:171","msg":"trace[177568054] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"462.313106ms","start":"2026-10-16T00:06:55.393775Z","end":"2026-10-16T00:06:55.856088Z","steps":["trace[177568054] 'process raft request' (duration: 455.260698ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:06:55.857049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:06:55.393737Z","time spent":"462.468208ms","remote":"127.0.0.1:42446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-16T00:06:55.862362Z","caller":"traceutil/trace.go:171","msg":"trace[286591556] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"377.482599ms","start":"2026-10-16T00:06:55.484843Z","end":"2026-10-16T00:06:55.862326Z","steps":["trace[286591556] 'process raft request' (duration: 371.898559ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:06:55.862544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:06:55.484819Z","time spent":"377.642313ms","remote":"127.0.0.1:42280","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036213,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-16T00:06:56.502648Z","caller":"traceutil/trace.go:171","msg":"trace[31781052] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"570.36105ms","start":"2026-10-16T00:06:55.932264Z","end":"2026-10-16T00:06:56.502625Z","steps":["trace[31781052] 'process raft request' (duration: 570.204547ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:06:56.502792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:06:55.932234Z","time spent":"570.491681ms","remote":"127.0.0.1:42520","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1092,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-16T00:06:56.502947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.935099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.167\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-10-16T00:06:56.503031Z","caller":"traceutil/trace.go:171","msg":"trace[299106427] linearizableReadLoop","detail":"{readStateIndex:679; appliedIndex:678; }","duration":"287.612013ms","start":"2026-10-16T00:06:56.21498Z","end":"2026-10-16T00:06:56.502592Z","steps":["trace[299106427] 'read index received' (duration: 287.45909ms)","trace[299106427] 'applied index is now lower than readState.Index' (duration: 152.033µs)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:06:56.503075Z","caller":"traceutil/trace.go:171","msg":"trace[524661248] range","detail":"{range_begin:/registry/masterleases/162.253.55.167; range_end:; response_count:1; response_revision:651; }","duration":"288.124292ms","start":"2026-10-16T00:06:56.214931Z","end":"2026-10-16T00:06:56.503056Z","steps":["trace[524661248] 'agreement among raft nodes before linearized reading' (duration: 287.860397ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:06:56.503344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.149563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-10-16T00:06:56.503384Z","caller":"traceutil/trace.go:171","msg":"trace[1127644550] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:651; }","duration":"189.240454ms","start":"2026-10-16T00:06:56.314134Z","end":"2026-10-16T00:06:56.503375Z","steps":["trace[1127644550] 'agreement among raft nodes before linearized reading' (duration: 189.034181ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:07:12.861413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.921009ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-16T00:07:12.86152Z","caller":"traceutil/trace.go:171","msg":"trace[220908427] linearizableReadLoop","detail":"{readStateIndex:855; appliedIndex:854; }","duration":"380.387221ms","start":"2026-10-16T00:07:12.481116Z","end":"2026-10-16T00:07:12.861504Z","steps":["trace[220908427] 'read index received' (duration: 151.994054ms)","trace[220908427] 'applied index is now lower than readState.Index' (duration: 228.391677ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:07:12.861676Z","caller":"traceutil/trace.go:171","msg":"trace[347727479] transaction","detail":"{read_only:false; response_revision:821; number_of_response:1; }","duration":"383.874305ms","start":"2026-10-16T00:07:12.47777Z","end":"2026-10-16T00:07:12.861644Z","steps":["trace[347727479] 'process raft request' (duration: 155.458857ms)","trace[347727479] 'compare' (duration: 227.799838ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T00:07:12.861833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.469203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:07:12.861872Z","caller":"traceutil/trace.go:171","msg":"trace[1437569446] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:821; }","duration":"380.723858ms","start":"2026-10-16T00:07:12.481135Z","end":"2026-10-16T00:07:12.861859Z","steps":["trace[1437569446] 'agreement among raft nodes before linearized reading' (duration: 380.476473ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:07:12.861916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:07:12.481118Z","time spent":"380.787479ms","remote":"127.0.0.1:54970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-10-16T00:07:12.861974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.523184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:07:12.862018Z","caller":"traceutil/trace.go:171","msg":"trace[2005543340] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:821; }","duration":"112.589876ms","start":"2026-10-16T00:07:12.749415Z","end":"2026-10-16T00:07:12.862005Z","steps":["trace[2005543340] 'agreement among raft nodes before linearized reading' (duration: 112.530204ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:07:12.862073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:07:12.47776Z","time spent":"384.082929ms","remote":"127.0.0.1:42358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4025,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-16T00:07:12.861713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.740589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-16T00:07:12.862223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.764861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-16T00:07:12.862216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.558412ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:07:12.862236Z","caller":"traceutil/trace.go:171","msg":"trace[130350679] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:821; }","duration":"172.293178ms","start":"2026-10-16T00:07:12.689914Z","end":"2026-10-16T00:07:12.862207Z","steps":["trace[130350679] 'agreement among raft nodes before linearized reading' (duration: 171.745308ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:07:12.862257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.570022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-16T00:07:12.862307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.859753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:07:12.862309Z","caller":"traceutil/trace.go:171","msg":"trace[1726068345] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:821; }","duration":"113.641334ms","start":"2026-10-16T00:07:12.748651Z","end":"2026-10-16T00:07:12.862292Z","steps":["trace[1726068345] 'agreement among raft nodes before linearized reading' (duration: 113.548352ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:07:12.862302Z","caller":"traceutil/trace.go:171","msg":"trace[2067417391] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:821; }","duration":"113.654444ms","start":"2026-10-16T00:07:12.748609Z","end":"2026-10-16T00:07:12.862263Z","steps":["trace[2067417391] 'agreement among raft nodes before linearized reading' (duration: 113.502412ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:07:12.862339Z","caller":"traceutil/trace.go:171","msg":"trace[197735041] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:821; }","duration":"135.928335ms","start":"2026-10-16T00:07:12.726403Z","end":"2026-10-16T00:07:12.862331Z","steps":["trace[197735041] 'agreement among raft nodes before linearized reading' (duration: 135.877804ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:07:12.861698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.546785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:07:12.862263Z","caller":"traceutil/trace.go:171","msg":"trace[1269529991] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:821; }","duration":"135.805382ms","start":"2026-10-16T00:07:12.726443Z","end":"2026-10-16T00:07:12.862249Z","steps":["trace[1269529991] 'agreement among raft nodes before linearized reading' (duration: 135.745571ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:07:12.86247Z","caller":"traceutil/trace.go:171","msg":"trace[286703743] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:821; }","duration":"381.37809ms","start":"2026-10-16T00:07:12.481078Z","end":"2026-10-16T00:07:12.862456Z","steps":["trace[286703743] 'agreement among raft nodes before linearized reading' (duration: 380.519004ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:07:12.862523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:07:12.481059Z","time spent":"381.435702ms","remote":"127.0.0.1:54970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-10-16T00:07:12.862827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.028723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-16T00:07:12.86283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.321725ms","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":"warn","ts":"2026-10-16T00:07:12.862852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.816515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:07:12.862878Z","caller":"traceutil/trace.go:171","msg":"trace[2109695777] 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:821; }","duration":"219.372135ms","start":"2026-10-16T00:07:12.643495Z","end":"2026-10-16T00:07:12.862867Z","steps":["trace[2109695777] 'agreement among raft nodes before linearized reading' (duration: 219.304144ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:07:12.862883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.553624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:07:12.862884Z","caller":"traceutil/trace.go:171","msg":"trace[2001471703] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:821; }","duration":"328.866676ms","start":"2026-10-16T00:07:12.534007Z","end":"2026-10-16T00:07:12.862874Z","steps":["trace[2001471703] 'agreement among raft nodes before linearized reading' (duration: 328.809964ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:07:12.862871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.402483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-10-16T00:07:12.862885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.419257ms","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\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-16T00:07:12.862885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.740685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:07:12.862916Z","caller":"traceutil/trace.go:171","msg":"trace[1748427748] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:821; }","duration":"247.609774ms","start":"2026-10-16T00:07:12.615296Z","end":"2026-10-16T00:07:12.862906Z","steps":["trace[1748427748] 'agreement among raft nodes before linearized reading' (duration: 247.562613ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:07:12.86292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:07:12.534Z","time spent":"328.910706ms","remote":"127.0.0.1:54990","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 "} {"level":"info","ts":"2026-10-16T00:07:12.862933Z","caller":"traceutil/trace.go:171","msg":"trace[1700547270] 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:821; }","duration":"219.467327ms","start":"2026-10-16T00:07:12.643455Z","end":"2026-10-16T00:07:12.862922Z","steps":["trace[1700547270] 'agreement among raft nodes before linearized reading' (duration: 219.404976ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:07:12.862941Z","caller":"traceutil/trace.go:171","msg":"trace[415681313] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:821; }","duration":"282.828618ms","start":"2026-10-16T00:07:12.580099Z","end":"2026-10-16T00:07:12.862927Z","steps":["trace[415681313] 'agreement among raft nodes before linearized reading' (duration: 282.753066ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:07:12.862941Z","caller":"traceutil/trace.go:171","msg":"trace[1929513732] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:821; }","duration":"131.481134ms","start":"2026-10-16T00:07:12.731436Z","end":"2026-10-16T00:07:12.862917Z","steps":["trace[1929513732] 'agreement among raft nodes before linearized reading' (duration: 131.294121ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:07:12.863125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.327368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-10-16T00:07:12.862837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.510074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:07:12.863176Z","caller":"traceutil/trace.go:171","msg":"trace[1757446379] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:821; }","duration":"208.417089ms","start":"2026-10-16T00:07:12.654745Z","end":"2026-10-16T00:07:12.863162Z","steps":["trace[1757446379] 'agreement among raft nodes before linearized reading' (duration: 208.299587ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:07:12.8632Z","caller":"traceutil/trace.go:171","msg":"trace[153657429] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:821; }","duration":"246.906701ms","start":"2026-10-16T00:07:12.616281Z","end":"2026-10-16T00:07:12.863187Z","steps":["trace[153657429] 'agreement among raft nodes before linearized reading' (duration: 246.525244ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:07:12.863259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.728791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-16T00:07:12.863298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.237453ms","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\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:07:12.863304Z","caller":"traceutil/trace.go:171","msg":"trace[1596874214] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:821; }","duration":"329.790322ms","start":"2026-10-16T00:07:12.533501Z","end":"2026-10-16T00:07:12.863292Z","steps":["trace[1596874214] 'agreement among raft nodes before linearized reading' (duration: 329.724921ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:07:12.863327Z","caller":"traceutil/trace.go:171","msg":"trace[1163260474] 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:821; }","duration":"219.302155ms","start":"2026-10-16T00:07:12.644015Z","end":"2026-10-16T00:07:12.863317Z","steps":["trace[1163260474] 'agreement among raft nodes before linearized reading' (duration: 219.253434ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:07:12.863335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:07:12.533494Z","time spent":"329.830793ms","remote":"127.0.0.1:54990","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"warn","ts":"2026-10-16T00:07:12.863447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.131098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:07:12.863482Z","caller":"traceutil/trace.go:171","msg":"trace[1084531854] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:821; }","duration":"330.189609ms","start":"2026-10-16T00:07:12.533283Z","end":"2026-10-16T00:07:12.863472Z","steps":["trace[1084531854] 'agreement among raft nodes before linearized reading' (duration: 330.134768ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:07:12.863526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:07:12.53327Z","time spent":"330.23126ms","remote":"127.0.0.1:54990","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 "} {"level":"warn","ts":"2026-10-16T00:07:12.863178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.89174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-16T00:07:12.863531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.226514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-10-16T00:07:12.863577Z","caller":"traceutil/trace.go:171","msg":"trace[881060229] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:821; }","duration":"218.294896ms","start":"2026-10-16T00:07:12.645271Z","end":"2026-10-16T00:07:12.863566Z","steps":["trace[881060229] 'agreement among raft nodes before linearized reading' (duration: 217.922509ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:07:12.863586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.538891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:07:12.863619Z","caller":"traceutil/trace.go:171","msg":"trace[95315848] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:821; }","duration":"362.592022ms","start":"2026-10-16T00:07:12.501016Z","end":"2026-10-16T00:07:12.863608Z","steps":["trace[95315848] 'agreement among raft nodes before linearized reading' (duration: 362.530881ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:07:12.863656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:07:12.50101Z","time spent":"362.636123ms","remote":"127.0.0.1:54978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-10-16T00:07:12.863629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.49218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-16T00:07:12.863939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.051592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:07:12.864025Z","caller":"traceutil/trace.go:171","msg":"trace[482381818] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:821; }","duration":"382.193394ms","start":"2026-10-16T00:07:12.481805Z","end":"2026-10-16T00:07:12.863998Z","steps":["trace[482381818] 'agreement among raft nodes before linearized reading' (duration: 382.069332ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:07:12.864079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:07:12.481791Z","time spent":"382.272975ms","remote":"127.0.0.1:54970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 "} {"level":"info","ts":"2026-10-16T00:07:12.863571Z","caller":"traceutil/trace.go:171","msg":"trace[104894389] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:821; }","duration":"248.307787ms","start":"2026-10-16T00:07:12.61525Z","end":"2026-10-16T00:07:12.863558Z","steps":["trace[104894389] 'agreement among raft nodes before linearized reading' (duration: 247.89503ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:07:12.863979Z","caller":"traceutil/trace.go:171","msg":"trace[16842285] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:821; }","duration":"363.006298ms","start":"2026-10-16T00:07:12.50095Z","end":"2026-10-16T00:07:12.863957Z","steps":["trace[16842285] 'agreement among raft nodes before linearized reading' (duration: 362.334937ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:07:12.862827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.651123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-16T00:07:12.86494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.065154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:07:12.865129Z","caller":"traceutil/trace.go:171","msg":"trace[1455897328] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:821; }","duration":"138.404799ms","start":"2026-10-16T00:07:12.726696Z","end":"2026-10-16T00:07:12.865101Z","steps":["trace[1455897328] 'agreement among raft nodes before linearized reading' (duration: 135.394045ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:07:12.865782Z","caller":"traceutil/trace.go:171","msg":"trace[1457709572] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:821; }","duration":"285.614018ms","start":"2026-10-16T00:07:12.580152Z","end":"2026-10-16T00:07:12.865766Z","steps":["trace[1457709572] 'agreement among raft nodes before linearized reading' (duration: 282.642944ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:07:12.862873Z","caller":"traceutil/trace.go:171","msg":"trace[1174613496] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:821; }","duration":"361.096284ms","start":"2026-10-16T00:07:12.501765Z","end":"2026-10-16T00:07:12.862861Z","steps":["trace[1174613496] 'agreement among raft nodes before linearized reading' (duration: 361.032883ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:07:12.866187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:07:12.500939Z","time spent":"364.430975ms","remote":"127.0.0.1:54978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true "} {"level":"warn","ts":"2026-10-16T00:07:12.86619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:07:12.501753Z","time spent":"364.374554ms","remote":"127.0.0.1:54978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 "} {"level":"warn","ts":"2026-10-16T00:07:12.862134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.235368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:07:12.866647Z","caller":"traceutil/trace.go:171","msg":"trace[860406502] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:821; }","duration":"176.736289ms","start":"2026-10-16T00:07:12.689888Z","end":"2026-10-16T00:07:12.866624Z","steps":["trace[860406502] 'agreement among raft nodes before linearized reading' (duration: 172.213977ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:08:08.115232Z","caller":"traceutil/trace.go:171","msg":"trace[2616375] transaction","detail":"{read_only:false; response_revision:1498; number_of_response:1; }","duration":"110.056744ms","start":"2026-10-16T00:08:08.005142Z","end":"2026-10-16T00:08:08.115199Z","steps":["trace[2616375] 'process raft request' (duration: 55.966054ms)","trace[2616375] 'compare' (duration: 53.889406ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T00:08:33.075618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.544083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-3c1f9e99-2610-426f-aad8-5fffd3ccad0d\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-10-16T00:08:33.075741Z","caller":"traceutil/trace.go:171","msg":"trace[859092620] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-3c1f9e99-2610-426f-aad8-5fffd3ccad0d; range_end:; response_count:1; response_revision:1901; }","duration":"162.750047ms","start":"2026-10-16T00:08:32.912965Z","end":"2026-10-16T00:08:33.075715Z","steps":["trace[859092620] 'range keys from in-memory index tree' (duration: 162.242249ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:09:18.446717Z","caller":"traceutil/trace.go:171","msg":"trace[1308333264] transaction","detail":"{read_only:false; response_revision:2206; number_of_response:1; }","duration":"109.126623ms","start":"2026-10-16T00:09:18.337558Z","end":"2026-10-16T00:09:18.446685Z","steps":["trace[1308333264] 'process raft request' (duration: 108.936599ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:09:18.488586Z","caller":"traceutil/trace.go:171","msg":"trace[557880603] transaction","detail":"{read_only:false; response_revision:2207; number_of_response:1; }","duration":"111.851694ms","start":"2026-10-16T00:09:18.376683Z","end":"2026-10-16T00:09:18.488535Z","steps":["trace[557880603] 'process raft request' (duration: 79.065068ms)","trace[557880603] 'compare' (duration: 32.581872ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:09:18.836089Z","caller":"traceutil/trace.go:171","msg":"trace[1752177462] transaction","detail":"{read_only:false; response_revision:2208; number_of_response:1; }","duration":"102.694542ms","start":"2026-10-16T00:09:18.733368Z","end":"2026-10-16T00:09:18.836062Z","steps":["trace[1752177462] 'process raft request' (duration: 102.525609ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:10:14.093284Z","caller":"traceutil/trace.go:171","msg":"trace[2027047619] transaction","detail":"{read_only:false; response_revision:2675; number_of_response:1; }","duration":"257.281889ms","start":"2026-10-16T00:10:13.835977Z","end":"2026-10-16T00:10:14.093259Z","steps":["trace[2027047619] 'process raft request' (duration: 257.129516ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:10:14.112213Z","caller":"traceutil/trace.go:171","msg":"trace[2064356827] transaction","detail":"{read_only:false; response_revision:2676; number_of_response:1; }","duration":"240.714249ms","start":"2026-10-16T00:10:13.871464Z","end":"2026-10-16T00:10:14.112178Z","steps":["trace[2064356827] 'process raft request' (duration: 240.485345ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:10:47.194706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.827585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:10:47.194853Z","caller":"traceutil/trace.go:171","msg":"trace[1391724107] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2879; }","duration":"113.049899ms","start":"2026-10-16T00:10:47.081767Z","end":"2026-10-16T00:10:47.194817Z","steps":["trace[1391724107] 'range keys from in-memory index tree' (duration: 112.643401ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:10:58.549239Z","caller":"traceutil/trace.go:171","msg":"trace[365941580] transaction","detail":"{read_only:false; response_revision:2942; number_of_response:1; }","duration":"126.286365ms","start":"2026-10-16T00:10:58.422914Z","end":"2026-10-16T00:10:58.5492Z","steps":["trace[365941580] 'process raft request' (duration: 107.535916ms)","trace[365941580] 'compare' (duration: 18.413913ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:14:09.865593Z","caller":"traceutil/trace.go:171","msg":"trace[879705059] linearizableReadLoop","detail":"{readStateIndex:4302; appliedIndex:4301; }","duration":"309.031026ms","start":"2026-10-16T00:14:09.55654Z","end":"2026-10-16T00:14:09.865571Z","steps":["trace[879705059] 'read index received' (duration: 308.919814ms)","trace[879705059] 'applied index is now lower than readState.Index' (duration: 110.182µs)"],"step_count":2} {"level":"warn","ts":"2026-10-16T00:14:09.865925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.356871ms","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-10-16T00:14:09.866023Z","caller":"traceutil/trace.go:171","msg":"trace[261642490] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4140; }","duration":"309.531844ms","start":"2026-10-16T00:14:09.556474Z","end":"2026-10-16T00:14:09.866006Z","steps":["trace[261642490] 'agreement among raft nodes before linearized reading' (duration: 309.231678ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:14:09.866073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:14:09.556445Z","time spent":"309.619475ms","remote":"127.0.0.1:42446","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":"info","ts":"2026-10-16T00:14:09.866518Z","caller":"traceutil/trace.go:171","msg":"trace[1886159050] transaction","detail":"{read_only:false; response_revision:4140; number_of_response:1; }","duration":"326.890352ms","start":"2026-10-16T00:14:09.538763Z","end":"2026-10-16T00:14:09.865654Z","steps":["trace[1886159050] 'process raft request' (duration: 326.651138ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:14:09.86663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:14:09.538731Z","time spent":"327.831838ms","remote":"127.0.0.1:42446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-16T00:14:09.874497Z","caller":"traceutil/trace.go:171","msg":"trace[80473405] transaction","detail":"{read_only:false; response_revision:4141; number_of_response:1; }","duration":"285.468244ms","start":"2026-10-16T00:14:09.589008Z","end":"2026-10-16T00:14:09.874476Z","steps":["trace[80473405] 'process raft request' (duration: 285.289411ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:14:09.874728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.311562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-10-16T00:14:09.874777Z","caller":"traceutil/trace.go:171","msg":"trace[2026208738] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4142; }","duration":"308.421324ms","start":"2026-10-16T00:14:09.566344Z","end":"2026-10-16T00:14:09.874765Z","steps":["trace[2026208738] 'agreement among raft nodes before linearized reading' (duration: 308.290131ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:14:09.874806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:14:09.566329Z","time spent":"308.470115ms","remote":"127.0.0.1:42446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-10-16T00:14:09.874922Z","caller":"traceutil/trace.go:171","msg":"trace[573708647] transaction","detail":"{read_only:false; response_revision:4142; number_of_response:1; }","duration":"193.946833ms","start":"2026-10-16T00:14:09.680966Z","end":"2026-10-16T00:14:09.874913Z","steps":["trace[573708647] 'process raft request' (duration: 193.472834ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:14:09.874888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.036529ms","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-10-16T00:14:09.874984Z","caller":"traceutil/trace.go:171","msg":"trace[333188722] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4142; }","duration":"295.224912ms","start":"2026-10-16T00:14:09.579737Z","end":"2026-10-16T00:14:09.874962Z","steps":["trace[333188722] 'agreement among raft nodes before linearized reading' (duration: 294.960578ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:14:09.87503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.392447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-10-16T00:14:09.875156Z","caller":"traceutil/trace.go:171","msg":"trace[1973319034] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4142; }","duration":"300.5581ms","start":"2026-10-16T00:14:09.574568Z","end":"2026-10-16T00:14:09.875126Z","steps":["trace[1973319034] 'agreement among raft nodes before linearized reading' (duration: 300.198884ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:14:09.875028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.924335ms","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-10-16T00:14:09.875226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:14:09.574555Z","time spent":"300.655402ms","remote":"127.0.0.1:42446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-10-16T00:14:09.875292Z","caller":"traceutil/trace.go:171","msg":"trace[728805660] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4142; }","duration":"290.18882ms","start":"2026-10-16T00:14:09.585041Z","end":"2026-10-16T00:14:09.87523Z","steps":["trace[728805660] 'agreement among raft nodes before linearized reading' (duration: 289.796323ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:15:40.575203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.645316ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-16T00:15:40.575484Z","caller":"traceutil/trace.go:171","msg":"trace[578961347] transaction","detail":"{read_only:false; response_revision:5249; number_of_response:1; }","duration":"168.67466ms","start":"2026-10-16T00:15:40.406788Z","end":"2026-10-16T00:15:40.575463Z","steps":["trace[578961347] 'process raft request' (duration: 168.544797ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:15:40.575562Z","caller":"traceutil/trace.go:171","msg":"trace[1973371528] transaction","detail":"{read_only:false; response_revision:5248; number_of_response:1; }","duration":"168.886344ms","start":"2026-10-16T00:15:40.406621Z","end":"2026-10-16T00:15:40.575507Z","steps":["trace[1973371528] 'process raft request' (duration: 51.751788ms)","trace[1973371528] 'compare' (duration: 116.532504ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:15:40.575685Z","caller":"traceutil/trace.go:171","msg":"trace[2076221565] linearizableReadLoop","detail":"{readStateIndex:5456; appliedIndex:5453; }","duration":"160.249885ms","start":"2026-10-16T00:15:40.415402Z","end":"2026-10-16T00:15:40.575652Z","steps":["trace[2076221565] 'read index received' (duration: 42.941987ms)","trace[2076221565] 'applied index is now lower than readState.Index' (duration: 117.305808ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:15:40.575805Z","caller":"traceutil/trace.go:171","msg":"trace[1741095937] transaction","detail":"{read_only:false; response_revision:5250; number_of_response:1; }","duration":"168.575158ms","start":"2026-10-16T00:15:40.407186Z","end":"2026-10-16T00:15:40.575761Z","steps":["trace[1741095937] 'process raft request' (duration: 168.230792ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:15:40.575995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.557641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-m6chk\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-10-16T00:15:40.576039Z","caller":"traceutil/trace.go:171","msg":"trace[776881807] range","detail":"{range_begin:/registry/pods/openstack/keepalived-m6chk; range_end:; response_count:1; response_revision:5250; }","duration":"160.672733ms","start":"2026-10-16T00:15:40.415353Z","end":"2026-10-16T00:15:40.576025Z","steps":["trace[776881807] 'agreement among raft nodes before linearized reading' (duration: 160.465959ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:15:40.576474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.558432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:23 size:531280"} {"level":"info","ts":"2026-10-16T00:15:40.576542Z","caller":"traceutil/trace.go:171","msg":"trace[1189404884] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:23; response_revision:5250; }","duration":"135.642895ms","start":"2026-10-16T00:15:40.440883Z","end":"2026-10-16T00:15:40.576526Z","steps":["trace[1189404884] 'agreement among raft nodes before linearized reading' (duration: 134.999694ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:15:43.899336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.487826ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-16T00:15:43.899513Z","caller":"traceutil/trace.go:171","msg":"trace[2046683646] transaction","detail":"{read_only:false; response_revision:5349; number_of_response:1; }","duration":"201.069233ms","start":"2026-10-16T00:15:43.698406Z","end":"2026-10-16T00:15:43.899475Z","steps":["trace[2046683646] 'process raft request' (duration: 62.368563ms)","trace[2046683646] 'compare' (duration: 138.292334ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T00:15:46.340818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.77792ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-16T00:15:46.340943Z","caller":"traceutil/trace.go:171","msg":"trace[1973098835] transaction","detail":"{read_only:false; response_revision:5387; number_of_response:1; }","duration":"402.130001ms","start":"2026-10-16T00:15:45.938793Z","end":"2026-10-16T00:15:46.340923Z","steps":["trace[1973098835] 'process raft request' (duration: 34.130717ms)","trace[1973098835] 'compare' (duration: 367.624178ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T00:15:46.341003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:15:45.938762Z","time spent":"402.212573ms","remote":"127.0.0.1:42280","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58173,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-16T00:15:46.35672Z","caller":"traceutil/trace.go:171","msg":"trace[1750100141] linearizableReadLoop","detail":"{readStateIndex:5599; appliedIndex:5597; }","duration":"394.083147ms","start":"2026-10-16T00:15:45.962598Z","end":"2026-10-16T00:15:46.356681Z","steps":["trace[1750100141] 'read index received' (duration: 10.355347ms)","trace[1750100141] 'applied index is now lower than readState.Index' (duration: 383.72667ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:15:46.356824Z","caller":"traceutil/trace.go:171","msg":"trace[1146014591] transaction","detail":"{read_only:false; response_revision:5388; number_of_response:1; }","duration":"409.478946ms","start":"2026-10-16T00:15:45.947302Z","end":"2026-10-16T00:15:46.356781Z","steps":["trace[1146014591] 'process raft request' (duration: 409.211731ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:15:46.357021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:15:45.947278Z","time spent":"409.663939ms","remote":"127.0.0.1:42358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4888,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-16T00:15:46.357059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.437904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4f73d577-6255-42c8-9959-0656a7a55d18\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-10-16T00:15:46.357112Z","caller":"traceutil/trace.go:171","msg":"trace[463412644] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-4f73d577-6255-42c8-9959-0656a7a55d18; range_end:; response_count:1; response_revision:5388; }","duration":"394.547256ms","start":"2026-10-16T00:15:45.962548Z","end":"2026-10-16T00:15:46.357095Z","steps":["trace[463412644] 'agreement among raft nodes before linearized reading' (duration: 394.301671ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:15:46.357155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:15:45.96253Z","time spent":"394.615508ms","remote":"127.0.0.1:42358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3624,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4f73d577-6255-42c8-9959-0656a7a55d18\" "} {"level":"info","ts":"2026-10-16T00:15:46.409401Z","caller":"traceutil/trace.go:171","msg":"trace[337781343] transaction","detail":"{read_only:false; response_revision:5389; number_of_response:1; }","duration":"129.851369ms","start":"2026-10-16T00:15:46.279525Z","end":"2026-10-16T00:15:46.409376Z","steps":["trace[337781343] 'process raft request' (duration: 129.647065ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:15:46.409631Z","caller":"traceutil/trace.go:171","msg":"trace[1790383854] transaction","detail":"{read_only:false; response_revision:5390; number_of_response:1; }","duration":"126.689712ms","start":"2026-10-16T00:15:46.282905Z","end":"2026-10-16T00:15:46.409595Z","steps":["trace[1790383854] 'process raft request' (duration: 126.410007ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:15:46.409712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.147511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4f73d577-6255-42c8-9959-0656a7a55d18\" ","response":"range_response_count:1 size:3601"} {"level":"warn","ts":"2026-10-16T00:15:46.409728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.208842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.167\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-10-16T00:15:46.409822Z","caller":"traceutil/trace.go:171","msg":"trace[1585988846] range","detail":"{range_begin:/registry/masterleases/162.253.55.167; range_end:; response_count:1; response_revision:5390; }","duration":"163.369735ms","start":"2026-10-16T00:15:46.246431Z","end":"2026-10-16T00:15:46.409801Z","steps":["trace[1585988846] 'agreement among raft nodes before linearized reading' (duration: 163.12758ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:15:46.409762Z","caller":"traceutil/trace.go:171","msg":"trace[1835274087] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-4f73d577-6255-42c8-9959-0656a7a55d18; range_end:; response_count:1; response_revision:5390; }","duration":"137.243042ms","start":"2026-10-16T00:15:46.272505Z","end":"2026-10-16T00:15:46.409748Z","steps":["trace[1835274087] 'agreement among raft nodes before linearized reading' (duration: 137.057138ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:15:48.593628Z","caller":"traceutil/trace.go:171","msg":"trace[1034944293] transaction","detail":"{read_only:false; response_revision:5412; number_of_response:1; }","duration":"178.284115ms","start":"2026-10-16T00:15:48.415312Z","end":"2026-10-16T00:15:48.593596Z","steps":["trace[1034944293] 'process raft request' (duration: 178.099721ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:15:48.745529Z","caller":"traceutil/trace.go:171","msg":"trace[915537264] linearizableReadLoop","detail":"{readStateIndex:5625; appliedIndex:5623; }","duration":"237.542406ms","start":"2026-10-16T00:15:48.507947Z","end":"2026-10-16T00:15:48.745489Z","steps":["trace[915537264] 'read index received' (duration: 85.465126ms)","trace[915537264] 'applied index is now lower than readState.Index' (duration: 152.07585ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:15:48.745593Z","caller":"traceutil/trace.go:171","msg":"trace[2114014062] transaction","detail":"{read_only:false; response_revision:5413; number_of_response:1; }","duration":"329.393108ms","start":"2026-10-16T00:15:48.415751Z","end":"2026-10-16T00:15:48.745144Z","steps":["trace[2114014062] 'process raft request' (duration: 296.461271ms)","trace[2114014062] 'compare' (duration: 32.726893ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:15:48.74565Z","caller":"traceutil/trace.go:171","msg":"trace[210206703] transaction","detail":"{read_only:false; response_revision:5414; number_of_response:1; }","duration":"227.515203ms","start":"2026-10-16T00:15:48.518095Z","end":"2026-10-16T00:15:48.745611Z","steps":["trace[210206703] 'process raft request' (duration: 226.966534ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:15:48.745814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:15:48.415723Z","time spent":"329.975758ms","remote":"127.0.0.1:42446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-16T00:15:48.745843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.872352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-10-16T00:15:48.745884Z","caller":"traceutil/trace.go:171","msg":"trace[1542173585] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5414; }","duration":"238.001284ms","start":"2026-10-16T00:15:48.507872Z","end":"2026-10-16T00:15:48.745873Z","steps":["trace[1542173585] 'agreement among raft nodes before linearized reading' (duration: 237.79991ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:15:48.74602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.979086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-10-16T00:15:48.746074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.433805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-10-16T00:15:48.746122Z","caller":"traceutil/trace.go:171","msg":"trace[942394301] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5414; }","duration":"226.108379ms","start":"2026-10-16T00:15:48.519985Z","end":"2026-10-16T00:15:48.746093Z","steps":["trace[942394301] 'agreement among raft nodes before linearized reading' (duration: 225.806754ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:15:48.746204Z","caller":"traceutil/trace.go:171","msg":"trace[1639643765] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5414; }","duration":"106.630199ms","start":"2026-10-16T00:15:48.639541Z","end":"2026-10-16T00:15:48.746171Z","steps":["trace[1639643765] 'agreement among raft nodes before linearized reading' (duration: 106.259662ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:15:48.746242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.63365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-m6chk\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-10-16T00:15:48.74641Z","caller":"traceutil/trace.go:171","msg":"trace[1607635213] range","detail":"{range_begin:/registry/pods/openstack/keepalived-m6chk; range_end:; response_count:1; response_revision:5414; }","duration":"100.819644ms","start":"2026-10-16T00:15:48.645576Z","end":"2026-10-16T00:15:48.746395Z","steps":["trace[1607635213] 'agreement among raft nodes before linearized reading' (duration: 100.491418ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:15:48.746441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.40796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-10-16T00:15:48.7465Z","caller":"traceutil/trace.go:171","msg":"trace[1910443967] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5414; }","duration":"129.479342ms","start":"2026-10-16T00:15:48.617006Z","end":"2026-10-16T00:15:48.746485Z","steps":["trace[1910443967] 'agreement among raft nodes before linearized reading' (duration: 129.314439ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:15:48.746656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.492528ms","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-10-16T00:15:48.746769Z","caller":"traceutil/trace.go:171","msg":"trace[578528317] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5414; }","duration":"131.674761ms","start":"2026-10-16T00:15:48.615067Z","end":"2026-10-16T00:15:48.746742Z","steps":["trace[578528317] 'agreement among raft nodes before linearized reading' (duration: 131.310134ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:16:01.867815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.452055ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-16T00:16:01.867943Z","caller":"traceutil/trace.go:171","msg":"trace[82267867] transaction","detail":"{read_only:false; response_revision:5665; number_of_response:1; }","duration":"288.954476ms","start":"2026-10-16T00:16:01.578965Z","end":"2026-10-16T00:16:01.86792Z","steps":["trace[82267867] 'process raft request' (duration: 67.297797ms)","trace[82267867] 'compare' (duration: 221.298962ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:16:01.937844Z","caller":"traceutil/trace.go:171","msg":"trace[1028979105] transaction","detail":"{read_only:false; response_revision:5666; number_of_response:1; }","duration":"268.837562ms","start":"2026-10-16T00:16:01.668967Z","end":"2026-10-16T00:16:01.937804Z","steps":["trace[1028979105] 'process raft request' (duration: 268.605368ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:16:01.966271Z","caller":"traceutil/trace.go:171","msg":"trace[2128947837] transaction","detail":"{read_only:false; response_revision:5667; number_of_response:1; }","duration":"288.188041ms","start":"2026-10-16T00:16:01.678054Z","end":"2026-10-16T00:16:01.966242Z","steps":["trace[2128947837] 'process raft request' (duration: 287.985748ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:16:02.813727Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2965} {"level":"info","ts":"2026-10-16T00:16:02.900586Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2965,"took":"84.742783ms","hash":2881156489,"current-db-size-bytes":54460416,"current-db-size":"54 MB","current-db-size-in-use-bytes":31281152,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-16T00:16:02.900664Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2881156489,"revision":2965,"compact-revision":-1} {"level":"info","ts":"2026-10-16T00:16:11.26612Z","caller":"traceutil/trace.go:171","msg":"trace[763555448] transaction","detail":"{read_only:false; response_revision:5831; number_of_response:1; }","duration":"275.838498ms","start":"2026-10-16T00:16:10.990243Z","end":"2026-10-16T00:16:11.266081Z","steps":["trace[763555448] 'process raft request' (duration: 275.758937ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:16:11.266213Z","caller":"traceutil/trace.go:171","msg":"trace[1854597769] transaction","detail":"{read_only:false; response_revision:5830; number_of_response:1; }","duration":"276.011392ms","start":"2026-10-16T00:16:10.990112Z","end":"2026-10-16T00:16:11.266123Z","steps":["trace[1854597769] 'process raft request' (duration: 275.696876ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:16:11.266594Z","caller":"traceutil/trace.go:171","msg":"trace[588346280] transaction","detail":"{read_only:false; response_revision:5833; number_of_response:1; }","duration":"274.8111ms","start":"2026-10-16T00:16:10.991765Z","end":"2026-10-16T00:16:11.266577Z","steps":["trace[588346280] 'process raft request' (duration: 274.649387ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:16:11.266591Z","caller":"traceutil/trace.go:171","msg":"trace[1998485503] transaction","detail":"{read_only:false; response_revision:5832; number_of_response:1; }","duration":"275.024724ms","start":"2026-10-16T00:16:10.991525Z","end":"2026-10-16T00:16:11.26655Z","steps":["trace[1998485503] 'process raft request' (duration: 274.512724ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:16:11.266591Z","caller":"traceutil/trace.go:171","msg":"trace[338558965] linearizableReadLoop","detail":"{readStateIndex:6056; appliedIndex:6051; }","duration":"272.264944ms","start":"2026-10-16T00:16:10.994295Z","end":"2026-10-16T00:16:11.26656Z","steps":["trace[338558965] 'read index received' (duration: 79.182092ms)","trace[338558965] 'applied index is now lower than readState.Index' (duration: 193.081762ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T00:16:11.266846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.997038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:16:11.266897Z","caller":"traceutil/trace.go:171","msg":"trace[1303807499] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5833; }","duration":"184.115801ms","start":"2026-10-16T00:16:11.082767Z","end":"2026-10-16T00:16:11.266883Z","steps":["trace[1303807499] 'agreement among raft nodes before linearized reading' (duration: 183.985278ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:16:11.266942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.618761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-54f106af-c856-4ad4-9cfd-cd6351716ebe\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-10-16T00:16:11.266992Z","caller":"traceutil/trace.go:171","msg":"trace[1275417240] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-54f106af-c856-4ad4-9cfd-cd6351716ebe; range_end:; response_count:1; response_revision:5833; }","duration":"272.726393ms","start":"2026-10-16T00:16:10.994251Z","end":"2026-10-16T00:16:11.266977Z","steps":["trace[1275417240] 'agreement among raft nodes before linearized reading' (duration: 272.468498ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:16:11.267016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.346514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1988"} {"level":"info","ts":"2026-10-16T00:16:11.267073Z","caller":"traceutil/trace.go:171","msg":"trace[775074978] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:5833; }","duration":"122.460175ms","start":"2026-10-16T00:16:11.144597Z","end":"2026-10-16T00:16:11.267057Z","steps":["trace[775074978] 'agreement among raft nodes before linearized reading' (duration: 122.263021ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:16:11.617934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.099603ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-16T00:16:11.618062Z","caller":"traceutil/trace.go:171","msg":"trace[526377649] transaction","detail":"{read_only:false; response_revision:5834; number_of_response:1; }","duration":"341.72128ms","start":"2026-10-16T00:16:11.276317Z","end":"2026-10-16T00:16:11.618038Z","steps":["trace[526377649] 'process raft request' (duration: 65.405043ms)","trace[526377649] 'compare' (duration: 275.803297ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T00:16:11.618129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:16:11.276299Z","time spent":"341.798162ms","remote":"127.0.0.1:42478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1622,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-16T00:16:11.652018Z","caller":"traceutil/trace.go:171","msg":"trace[415663273] linearizableReadLoop","detail":"{readStateIndex:6059; appliedIndex:6056; }","duration":"362.931713ms","start":"2026-10-16T00:16:11.289058Z","end":"2026-10-16T00:16:11.651989Z","steps":["trace[415663273] 'read index received' (duration: 52.680802ms)","trace[415663273] 'applied index is now lower than readState.Index' (duration: 310.249661ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:16:11.652096Z","caller":"traceutil/trace.go:171","msg":"trace[199025930] transaction","detail":"{read_only:false; response_revision:5835; number_of_response:1; }","duration":"375.562532ms","start":"2026-10-16T00:16:11.276489Z","end":"2026-10-16T00:16:11.652052Z","steps":["trace[199025930] 'process raft request' (duration: 375.223876ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:16:11.652163Z","caller":"traceutil/trace.go:171","msg":"trace[1364795790] transaction","detail":"{read_only:false; response_revision:5836; number_of_response:1; }","duration":"374.821378ms","start":"2026-10-16T00:16:11.277297Z","end":"2026-10-16T00:16:11.652118Z","steps":["trace[1364795790] 'process raft request' (duration: 374.625564ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:16:11.65222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.133897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:16:11.652273Z","caller":"traceutil/trace.go:171","msg":"trace[1599154010] range","detail":"{range_begin:/registry/rabbitmq.com/users/; range_end:/registry/rabbitmq.com/users0; response_count:0; response_revision:5836; }","duration":"363.226639ms","start":"2026-10-16T00:16:11.289031Z","end":"2026-10-16T00:16:11.652257Z","steps":["trace[1599154010] 'agreement among raft nodes before linearized reading' (duration: 363.117747ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:16:11.652283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:16:11.276454Z","time spent":"375.692535ms","remote":"127.0.0.1:42478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1414,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-16T00:16:11.652326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:16:11.289019Z","time spent":"363.29412ms","remote":"127.0.0.1:49598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true "} {"level":"warn","ts":"2026-10-16T00:16:11.652409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:16:11.277276Z","time spent":"374.984212ms","remote":"127.0.0.1:42478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1606,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-16T00:16:11.813065Z","caller":"traceutil/trace.go:171","msg":"trace[1885600925] linearizableReadLoop","detail":"{readStateIndex:6060; appliedIndex:6059; }","duration":"160.933021ms","start":"2026-10-16T00:16:11.652104Z","end":"2026-10-16T00:16:11.813037Z","steps":["trace[1885600925] 'read index received' (duration: 63.360555ms)","trace[1885600925] 'applied index is now lower than readState.Index' (duration: 97.570526ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T00:16:11.813286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.488021ms","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":"warn","ts":"2026-10-16T00:16:11.813374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.637975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-54f106af-c856-4ad4-9cfd-cd6351716ebe\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-10-16T00:16:11.81338Z","caller":"traceutil/trace.go:171","msg":"trace[383696743] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:5836; }","duration":"182.649083ms","start":"2026-10-16T00:16:11.630698Z","end":"2026-10-16T00:16:11.813347Z","steps":["trace[383696743] 'agreement among raft nodes before linearized reading' (duration: 182.498251ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:16:11.813421Z","caller":"traceutil/trace.go:171","msg":"trace[128318685] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-54f106af-c856-4ad4-9cfd-cd6351716ebe; range_end:; response_count:1; response_revision:5836; }","duration":"207.775467ms","start":"2026-10-16T00:16:11.60563Z","end":"2026-10-16T00:16:11.813406Z","steps":["trace[128318685] 'agreement among raft nodes before linearized reading' (duration: 207.575104ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:16:11.813382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.139937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-alertmanager.18deda4e0ba7d4b8\" ","response":"range_response_count:1 size:751"} {"level":"warn","ts":"2026-10-16T00:16:11.813503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.610873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:16:11.813541Z","caller":"traceutil/trace.go:171","msg":"trace[1458058475] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-alertmanager.18deda4e0ba7d4b8; range_end:; response_count:1; response_revision:5836; }","duration":"191.39529ms","start":"2026-10-16T00:16:11.622112Z","end":"2026-10-16T00:16:11.813507Z","steps":["trace[1458058475] 'agreement among raft nodes before linearized reading' (duration: 191.042155ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:16:11.813551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"487.256521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-16T00:16:11.813604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.759915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1781"} {"level":"info","ts":"2026-10-16T00:16:11.813665Z","caller":"traceutil/trace.go:171","msg":"trace[1829875044] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:5836; }","duration":"140.867617ms","start":"2026-10-16T00:16:11.672783Z","end":"2026-10-16T00:16:11.813651Z","steps":["trace[1829875044] 'agreement among raft nodes before linearized reading' (duration: 140.623493ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:16:11.813673Z","caller":"traceutil/trace.go:171","msg":"trace[1992890800] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:5836; }","duration":"487.471625ms","start":"2026-10-16T00:16:11.32617Z","end":"2026-10-16T00:16:11.813642Z","steps":["trace[1992890800] 'agreement among raft nodes before linearized reading' (duration: 487.13827ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:16:11.813597Z","caller":"traceutil/trace.go:171","msg":"trace[742767133] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:5836; }","duration":"312.774116ms","start":"2026-10-16T00:16:11.500801Z","end":"2026-10-16T00:16:11.813575Z","steps":["trace[742767133] 'agreement among raft nodes before linearized reading' (duration: 312.623943ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:16:11.813735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:16:11.326125Z","time spent":"487.597797ms","remote":"127.0.0.1:55168","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-10-16T00:16:11.813786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:16:11.500772Z","time spent":"312.99717ms","remote":"127.0.0.1:49582","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true "} {"level":"info","ts":"2026-10-16T00:16:11.998375Z","caller":"traceutil/trace.go:171","msg":"trace[1710187305] transaction","detail":"{read_only:false; response_revision:5838; number_of_response:1; }","duration":"177.060381ms","start":"2026-10-16T00:16:11.821269Z","end":"2026-10-16T00:16:11.998329Z","steps":["trace[1710187305] 'process raft request' (duration: 176.809057ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:16:11.998615Z","caller":"traceutil/trace.go:171","msg":"trace[268797176] transaction","detail":"{read_only:false; response_revision:5839; number_of_response:1; }","duration":"162.751644ms","start":"2026-10-16T00:16:11.83584Z","end":"2026-10-16T00:16:11.998591Z","steps":["trace[268797176] 'process raft request' (duration: 162.432378ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:16:11.998965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.390381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana.18deda4e0b9e821d\" ","response":"range_response_count:1 size:736"} {"level":"info","ts":"2026-10-16T00:16:11.999042Z","caller":"traceutil/trace.go:171","msg":"trace[1542656185] linearizableReadLoop","detail":"{readStateIndex:6063; appliedIndex:6061; }","duration":"138.976493ms","start":"2026-10-16T00:16:11.859555Z","end":"2026-10-16T00:16:11.998531Z","steps":["trace[1542656185] 'read index received' (duration: 138.573316ms)","trace[1542656185] 'applied index is now lower than readState.Index' (duration: 401.777µs)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:16:11.999049Z","caller":"traceutil/trace.go:171","msg":"trace[99112578] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana.18deda4e0b9e821d; range_end:; response_count:1; response_revision:5839; }","duration":"139.488423ms","start":"2026-10-16T00:16:11.859539Z","end":"2026-10-16T00:16:11.999027Z","steps":["trace[99112578] 'agreement among raft nodes before linearized reading' (duration: 139.234138ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:16:23.471852Z","caller":"traceutil/trace.go:171","msg":"trace[1732021021] transaction","detail":"{read_only:false; response_revision:5998; number_of_response:1; }","duration":"114.96139ms","start":"2026-10-16T00:16:23.356845Z","end":"2026-10-16T00:16:23.471807Z","steps":["trace[1732021021] 'process raft request' (duration: 86.440934ms)","trace[1732021021] 'compare' (duration: 28.358213ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:17:04.085952Z","caller":"traceutil/trace.go:171","msg":"trace[1204482078] transaction","detail":"{read_only:false; response_revision:6349; number_of_response:1; }","duration":"116.676461ms","start":"2026-10-16T00:17:03.969246Z","end":"2026-10-16T00:17:04.085922Z","steps":["trace[1204482078] 'process raft request' (duration: 116.133941ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:17:17.900835Z","caller":"traceutil/trace.go:171","msg":"trace[1842822511] transaction","detail":"{read_only:false; response_revision:6448; number_of_response:1; }","duration":"125.110992ms","start":"2026-10-16T00:17:17.775686Z","end":"2026-10-16T00:17:17.900797Z","steps":["trace[1842822511] 'process raft request' (duration: 124.98134ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:17:17.900849Z","caller":"traceutil/trace.go:171","msg":"trace[725454242] transaction","detail":"{read_only:false; response_revision:6447; number_of_response:1; }","duration":"125.217144ms","start":"2026-10-16T00:17:17.775571Z","end":"2026-10-16T00:17:17.900788Z","steps":["trace[725454242] 'process raft request' (duration: 84.301015ms)","trace[725454242] 'compare' (duration: 40.496771ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:20:45.23775Z","caller":"traceutil/trace.go:171","msg":"trace[1306694427] linearizableReadLoop","detail":"{readStateIndex:8186; appliedIndex:8185; }","duration":"104.796839ms","start":"2026-10-16T00:20:45.13293Z","end":"2026-10-16T00:20:45.237726Z","steps":["trace[1306694427] 'read index received' (duration: 24.088877ms)","trace[1306694427] 'applied index is now lower than readState.Index' (duration: 80.706792ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T00:20:45.238015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.066655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-10-16T00:20:45.238062Z","caller":"traceutil/trace.go:171","msg":"trace[331044265] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:7897; }","duration":"105.159626ms","start":"2026-10-16T00:20:45.132888Z","end":"2026-10-16T00:20:45.238048Z","steps":["trace[331044265] 'agreement among raft nodes before linearized reading' (duration: 104.953353ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:20:45.238244Z","caller":"traceutil/trace.go:171","msg":"trace[2047590811] transaction","detail":"{read_only:false; response_revision:7897; number_of_response:1; }","duration":"124.209371ms","start":"2026-10-16T00:20:45.113983Z","end":"2026-10-16T00:20:45.238192Z","steps":["trace[2047590811] 'process raft request' (duration: 123.58657ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:21:02.827089Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5678} {"level":"info","ts":"2026-10-16T00:21:02.93779Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5678,"took":"108.620039ms","hash":2127174016,"current-db-size-bytes":54460416,"current-db-size":"54 MB","current-db-size-in-use-bytes":27623424,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-16T00:21:02.9379Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2127174016,"revision":5678,"compact-revision":2965} {"level":"info","ts":"2026-10-16T00:22:15.597384Z","caller":"traceutil/trace.go:171","msg":"trace[1356265870] linearizableReadLoop","detail":"{readStateIndex:8966; appliedIndex:8965; }","duration":"386.303792ms","start":"2026-10-16T00:22:15.211052Z","end":"2026-10-16T00:22:15.597356Z","steps":["trace[1356265870] 'read index received' (duration: 386.058728ms)","trace[1356265870] 'applied index is now lower than readState.Index' (duration: 243.754µs)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:22:15.597672Z","caller":"traceutil/trace.go:171","msg":"trace[693508023] transaction","detail":"{read_only:false; response_revision:8653; number_of_response:1; }","duration":"407.128281ms","start":"2026-10-16T00:22:15.190528Z","end":"2026-10-16T00:22:15.597657Z","steps":["trace[693508023] 'process raft request' (duration: 406.658192ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:22:15.597837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:22:15.190509Z","time spent":"407.206472ms","remote":"127.0.0.1:42446","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-10-16T00:22:15.598131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.074746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephcosidrivers/\" range_end:\"/registry/ceph.rook.io/cephcosidrivers0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:22:15.598202Z","caller":"traceutil/trace.go:171","msg":"trace[250615608] range","detail":"{range_begin:/registry/ceph.rook.io/cephcosidrivers/; range_end:/registry/ceph.rook.io/cephcosidrivers0; response_count:0; response_revision:8653; }","duration":"387.175948ms","start":"2026-10-16T00:22:15.211014Z","end":"2026-10-16T00:22:15.59819Z","steps":["trace[250615608] 'agreement among raft nodes before linearized reading' (duration: 387.066186ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:22:15.598233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:22:15.211001Z","time spent":"387.223509ms","remote":"127.0.0.1:44032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephcosidrivers/\" range_end:\"/registry/ceph.rook.io/cephcosidrivers0\" limit:10000 "} {"level":"warn","ts":"2026-10-16T00:22:15.598468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.115997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephcosidrivers/\" range_end:\"/registry/ceph.rook.io/cephcosidrivers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-16T00:22:15.598634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.002269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces/\" range_end:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:22:15.59868Z","caller":"traceutil/trace.go:171","msg":"trace[264599753] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpoolradosnamespaces/; range_end:/registry/ceph.rook.io/cephblockpoolradosnamespaces0; response_count:0; response_revision:8653; }","duration":"294.06526ms","start":"2026-10-16T00:22:15.304604Z","end":"2026-10-16T00:22:15.598669Z","steps":["trace[264599753] 'agreement among raft nodes before linearized reading' (duration: 293.998569ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:22:15.598574Z","caller":"traceutil/trace.go:171","msg":"trace[1862749741] range","detail":"{range_begin:/registry/ceph.rook.io/cephcosidrivers/; range_end:/registry/ceph.rook.io/cephcosidrivers0; response_count:0; response_revision:8653; }","duration":"387.25365ms","start":"2026-10-16T00:22:15.211295Z","end":"2026-10-16T00:22:15.598549Z","steps":["trace[1862749741] 'agreement among raft nodes before linearized reading' (duration: 387.081737ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:22:15.598823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:22:15.211237Z","time spent":"387.515285ms","remote":"127.0.0.1:44032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephcosidrivers/\" range_end:\"/registry/ceph.rook.io/cephcosidrivers0\" count_only:true "} {"level":"warn","ts":"2026-10-16T00:22:15.59897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.771489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-10-16T00:22:15.599007Z","caller":"traceutil/trace.go:171","msg":"trace[571892304] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8653; }","duration":"147.851679ms","start":"2026-10-16T00:22:15.451146Z","end":"2026-10-16T00:22:15.598997Z","steps":["trace[571892304] 'agreement among raft nodes before linearized reading' (duration: 147.701307ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:22:15.599205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.918092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbucketnotifications/\" range_end:\"/registry/ceph.rook.io/cephbucketnotifications0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:22:15.599255Z","caller":"traceutil/trace.go:171","msg":"trace[1632424311] range","detail":"{range_begin:/registry/ceph.rook.io/cephbucketnotifications/; range_end:/registry/ceph.rook.io/cephbucketnotifications0; response_count:0; response_revision:8653; }","duration":"317.982793ms","start":"2026-10-16T00:22:15.281254Z","end":"2026-10-16T00:22:15.599236Z","steps":["trace[1632424311] 'agreement among raft nodes before linearized reading' (duration: 317.900851ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:22:15.599488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.895433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzones/\" range_end:\"/registry/ceph.rook.io/cephobjectzones0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-16T00:22:15.599492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.807087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/objectbucket.io/objectbuckets/\" range_end:\"/registry/objectbucket.io/objectbuckets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-16T00:22:15.599517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:22:15.28124Z","time spent":"318.258609ms","remote":"127.0.0.1:44056","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephbucketnotifications/\" range_end:\"/registry/ceph.rook.io/cephbucketnotifications0\" limit:500 "} {"level":"info","ts":"2026-10-16T00:22:15.599552Z","caller":"traceutil/trace.go:171","msg":"trace[1038777937] range","detail":"{range_begin:/registry/objectbucket.io/objectbuckets/; range_end:/registry/objectbucket.io/objectbuckets0; response_count:0; response_revision:8653; }","duration":"276.881698ms","start":"2026-10-16T00:22:15.322656Z","end":"2026-10-16T00:22:15.599538Z","steps":["trace[1038777937] 'agreement among raft nodes before linearized reading' (duration: 276.800427ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:22:15.599553Z","caller":"traceutil/trace.go:171","msg":"trace[1351221345] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzones/; range_end:/registry/ceph.rook.io/cephobjectzones0; response_count:0; response_revision:8653; }","duration":"236.941724ms","start":"2026-10-16T00:22:15.362584Z","end":"2026-10-16T00:22:15.599526Z","steps":["trace[1351221345] 'agreement among raft nodes before linearized reading' (duration: 236.868973ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:22:15.599608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.927561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbucketnotifications/\" range_end:\"/registry/ceph.rook.io/cephbucketnotifications0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-16T00:22:15.599579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.380196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces/\" range_end:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:22:15.599648Z","caller":"traceutil/trace.go:171","msg":"trace[2066087069] range","detail":"{range_begin:/registry/ceph.rook.io/cephbucketnotifications/; range_end:/registry/ceph.rook.io/cephbucketnotifications0; response_count:0; response_revision:8653; }","duration":"318.984642ms","start":"2026-10-16T00:22:15.280652Z","end":"2026-10-16T00:22:15.599637Z","steps":["trace[2066087069] 'agreement among raft nodes before linearized reading' (duration: 318.931151ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:22:15.599672Z","caller":"traceutil/trace.go:171","msg":"trace[1486651920] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpoolradosnamespaces/; range_end:/registry/ceph.rook.io/cephblockpoolradosnamespaces0; response_count:0; response_revision:8653; }","duration":"294.496158ms","start":"2026-10-16T00:22:15.305154Z","end":"2026-10-16T00:22:15.59965Z","steps":["trace[1486651920] 'agreement among raft nodes before linearized reading' (duration: 294.326365ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:22:15.599687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:22:15.280642Z","time spent":"319.036233ms","remote":"127.0.0.1:44056","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephbucketnotifications/\" range_end:\"/registry/ceph.rook.io/cephbucketnotifications0\" limit:10000 "} {"level":"warn","ts":"2026-10-16T00:22:15.599494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.484325ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystems/\" range_end:\"/registry/ceph.rook.io/cephfilesystems0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-16T00:22:15.599786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.155315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectrealms/\" range_end:\"/registry/ceph.rook.io/cephobjectrealms0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:22:15.600637Z","caller":"traceutil/trace.go:171","msg":"trace[1702085616] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectrealms/; range_end:/registry/ceph.rook.io/cephobjectrealms0; response_count:0; response_revision:8653; }","duration":"368.041421ms","start":"2026-10-16T00:22:15.232579Z","end":"2026-10-16T00:22:15.60062Z","steps":["trace[1702085616] 'agreement among raft nodes before linearized reading' (duration: 367.144035ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:22:15.600699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:22:15.232564Z","time spent":"368.118874ms","remote":"127.0.0.1:44044","response type":"/etcdserverpb.KV/Range","request count":0,"request size":87,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephobjectrealms/\" range_end:\"/registry/ceph.rook.io/cephobjectrealms0\" limit:500 "} {"level":"warn","ts":"2026-10-16T00:22:15.599564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.724817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbucketnotifications/\" range_end:\"/registry/ceph.rook.io/cephbucketnotifications0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:22:15.600913Z","caller":"traceutil/trace.go:171","msg":"trace[1583290867] range","detail":"{range_begin:/registry/ceph.rook.io/cephbucketnotifications/; range_end:/registry/ceph.rook.io/cephbucketnotifications0; response_count:0; response_revision:8653; }","duration":"320.125103ms","start":"2026-10-16T00:22:15.280775Z","end":"2026-10-16T00:22:15.6009Z","steps":["trace[1583290867] 'agreement among raft nodes before linearized reading' (duration: 318.758737ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:22:15.60095Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:22:15.280727Z","time spent":"320.209614ms","remote":"127.0.0.1:44056","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephbucketnotifications/\" range_end:\"/registry/ceph.rook.io/cephbucketnotifications0\" count_only:true "} {"level":"info","ts":"2026-10-16T00:22:15.599793Z","caller":"traceutil/trace.go:171","msg":"trace[1793273068] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystems/; range_end:/registry/ceph.rook.io/cephfilesystems0; response_count:0; response_revision:8653; }","duration":"338.806412ms","start":"2026-10-16T00:22:15.260974Z","end":"2026-10-16T00:22:15.59978Z","steps":["trace[1793273068] 'agreement among raft nodes before linearized reading' (duration: 338.485816ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:22:15.60113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:22:15.260962Z","time spent":"340.156017ms","remote":"127.0.0.1:44048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephfilesystems/\" range_end:\"/registry/ceph.rook.io/cephfilesystems0\" limit:10000 "} {"level":"warn","ts":"2026-10-16T00:22:15.599349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.575209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces/\" range_end:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:22:15.601366Z","caller":"traceutil/trace.go:171","msg":"trace[210540696] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpoolradosnamespaces/; range_end:/registry/ceph.rook.io/cephblockpoolradosnamespaces0; response_count:0; response_revision:8653; }","duration":"296.635727ms","start":"2026-10-16T00:22:15.304716Z","end":"2026-10-16T00:22:15.601352Z","steps":["trace[210540696] 'agreement among raft nodes before linearized reading' (duration: 294.571689ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:22:15.599385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.559403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/objectbucket.io/objectbuckets/\" range_end:\"/registry/objectbucket.io/objectbuckets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:22:15.601621Z","caller":"traceutil/trace.go:171","msg":"trace[1761441537] range","detail":"{range_begin:/registry/objectbucket.io/objectbuckets/; range_end:/registry/objectbucket.io/objectbuckets0; response_count:0; response_revision:8653; }","duration":"278.874366ms","start":"2026-10-16T00:22:15.322733Z","end":"2026-10-16T00:22:15.601608Z","steps":["trace[1761441537] 'agreement among raft nodes before linearized reading' (duration: 276.528972ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:22:15.599862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.6295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystems/\" range_end:\"/registry/ceph.rook.io/cephfilesystems0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:22:15.603103Z","caller":"traceutil/trace.go:171","msg":"trace[1926142999] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystems/; range_end:/registry/ceph.rook.io/cephfilesystems0; response_count:0; response_revision:8653; }","duration":"340.882959ms","start":"2026-10-16T00:22:15.262205Z","end":"2026-10-16T00:22:15.603088Z","steps":["trace[1926142999] 'agreement among raft nodes before linearized reading' (duration: 337.62946ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:22:15.603152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:22:15.262195Z","time spent":"340.93938ms","remote":"127.0.0.1:44048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephfilesystems/\" range_end:\"/registry/ceph.rook.io/cephfilesystems0\" limit:500 "} {"level":"warn","ts":"2026-10-16T00:22:15.599864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.286031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzones/\" range_end:\"/registry/ceph.rook.io/cephobjectzones0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:22:15.603483Z","caller":"traceutil/trace.go:171","msg":"trace[92575580] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzones/; range_end:/registry/ceph.rook.io/cephobjectzones0; response_count:0; response_revision:8653; }","duration":"240.917247ms","start":"2026-10-16T00:22:15.362552Z","end":"2026-10-16T00:22:15.603469Z","steps":["trace[92575580] 'agreement among raft nodes before linearized reading' (duration: 237.278411ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:22:15.599912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.381892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzones/\" range_end:\"/registry/ceph.rook.io/cephobjectzones0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:22:15.603887Z","caller":"traceutil/trace.go:171","msg":"trace[163448475] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzones/; range_end:/registry/ceph.rook.io/cephobjectzones0; response_count:0; response_revision:8653; }","duration":"241.392775ms","start":"2026-10-16T00:22:15.362478Z","end":"2026-10-16T00:22:15.603871Z","steps":["trace[163448475] 'agreement among raft nodes before linearized reading' (duration: 237.413863ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:22:15.59991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.823942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystems/\" range_end:\"/registry/ceph.rook.io/cephfilesystems0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:22:15.604083Z","caller":"traceutil/trace.go:171","msg":"trace[423480532] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystems/; range_end:/registry/ceph.rook.io/cephfilesystems0; response_count:0; response_revision:8653; }","duration":"343.021918ms","start":"2026-10-16T00:22:15.261042Z","end":"2026-10-16T00:22:15.604064Z","steps":["trace[423480532] 'agreement among raft nodes before linearized reading' (duration: 338.841682ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:22:15.599954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.40764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/objectbucket.io/objectbuckets/\" range_end:\"/registry/objectbucket.io/objectbuckets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-16T00:22:15.604329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:22:15.261018Z","time spent":"343.291934ms","remote":"127.0.0.1:44048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephfilesystems/\" range_end:\"/registry/ceph.rook.io/cephfilesystems0\" count_only:true "} {"level":"info","ts":"2026-10-16T00:22:15.604369Z","caller":"traceutil/trace.go:171","msg":"trace[479695941] range","detail":"{range_begin:/registry/objectbucket.io/objectbuckets/; range_end:/registry/objectbucket.io/objectbuckets0; response_count:0; response_revision:8653; }","duration":"280.81053ms","start":"2026-10-16T00:22:15.323539Z","end":"2026-10-16T00:22:15.60435Z","steps":["trace[479695941] 'agreement among raft nodes before linearized reading' (duration: 276.38936ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:22:15.60006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.953192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephcosidrivers/\" range_end:\"/registry/ceph.rook.io/cephcosidrivers0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:22:15.604533Z","caller":"traceutil/trace.go:171","msg":"trace[1703038751] range","detail":"{range_begin:/registry/ceph.rook.io/cephcosidrivers/; range_end:/registry/ceph.rook.io/cephcosidrivers0; response_count:0; response_revision:8653; }","duration":"392.447352ms","start":"2026-10-16T00:22:15.212069Z","end":"2026-10-16T00:22:15.604517Z","steps":["trace[1703038751] 'agreement among raft nodes before linearized reading' (duration: 387.939911ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:22:15.604579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:22:15.212054Z","time spent":"392.510384ms","remote":"127.0.0.1:44032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephcosidrivers/\" range_end:\"/registry/ceph.rook.io/cephcosidrivers0\" limit:500 "} {"level":"warn","ts":"2026-10-16T00:22:15.600063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.01395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectrealms/\" range_end:\"/registry/ceph.rook.io/cephobjectrealms0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:22:15.604654Z","caller":"traceutil/trace.go:171","msg":"trace[1884233668] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectrealms/; range_end:/registry/ceph.rook.io/cephobjectrealms0; response_count:0; response_revision:8653; }","duration":"372.589712ms","start":"2026-10-16T00:22:15.232038Z","end":"2026-10-16T00:22:15.604628Z","steps":["trace[1884233668] 'agreement among raft nodes before linearized reading' (duration: 367.9964ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:22:15.599293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.621179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-m6chk\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-10-16T00:22:15.604748Z","caller":"traceutil/trace.go:171","msg":"trace[1186839436] range","detail":"{range_begin:/registry/pods/openstack/keepalived-m6chk; range_end:; response_count:1; response_revision:8653; }","duration":"199.118918ms","start":"2026-10-16T00:22:15.405611Z","end":"2026-10-16T00:22:15.60473Z","steps":["trace[1186839436] 'agreement among raft nodes before linearized reading' (duration: 193.533927ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:22:15.604786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:22:15.232003Z","time spent":"372.720175ms","remote":"127.0.0.1:44044","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephobjectrealms/\" range_end:\"/registry/ceph.rook.io/cephobjectrealms0\" count_only:true "} {"level":"warn","ts":"2026-10-16T00:22:15.600136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.103622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectrealms/\" range_end:\"/registry/ceph.rook.io/cephobjectrealms0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:22:15.604936Z","caller":"traceutil/trace.go:171","msg":"trace[548373466] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectrealms/; range_end:/registry/ceph.rook.io/cephobjectrealms0; response_count:0; response_revision:8653; }","duration":"372.910978ms","start":"2026-10-16T00:22:15.231987Z","end":"2026-10-16T00:22:15.604898Z","steps":["trace[548373466] 'agreement among raft nodes before linearized reading' (duration: 368.105422ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:22:15.605005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:22:15.231971Z","time spent":"373.012801ms","remote":"127.0.0.1:44044","response type":"/etcdserverpb.KV/Range","request count":0,"request size":87,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephobjectrealms/\" range_end:\"/registry/ceph.rook.io/cephobjectrealms0\" limit:10000 "} {"level":"info","ts":"2026-10-16T00:22:15.859164Z","caller":"traceutil/trace.go:171","msg":"trace[831386874] linearizableReadLoop","detail":"{readStateIndex:8967; appliedIndex:8966; }","duration":"247.292103ms","start":"2026-10-16T00:22:15.611843Z","end":"2026-10-16T00:22:15.859135Z","steps":["trace[831386874] 'read index received' (duration: 225.855844ms)","trace[831386874] 'applied index is now lower than readState.Index' (duration: 21.435299ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:22:15.859225Z","caller":"traceutil/trace.go:171","msg":"trace[489826477] transaction","detail":"{read_only:false; response_revision:8654; number_of_response:1; }","duration":"254.560396ms","start":"2026-10-16T00:22:15.604619Z","end":"2026-10-16T00:22:15.859179Z","steps":["trace[489826477] 'process raft request' (duration: 233.068066ms)","trace[489826477] 'compare' (duration: 21.133283ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T00:22:15.859544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.69392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:25 size:223820"} {"level":"info","ts":"2026-10-16T00:22:15.859573Z","caller":"traceutil/trace.go:171","msg":"trace[986719288] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:25; response_revision:8654; }","duration":"247.787931ms","start":"2026-10-16T00:22:15.611753Z","end":"2026-10-16T00:22:15.859565Z","steps":["trace[986719288] 'agreement among raft nodes before linearized reading' (duration: 247.476255ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:22:15.870208Z","caller":"traceutil/trace.go:171","msg":"trace[1089185268] transaction","detail":"{read_only:false; response_revision:8655; number_of_response:1; }","duration":"171.02655ms","start":"2026-10-16T00:22:15.699151Z","end":"2026-10-16T00:22:15.870178Z","steps":["trace[1089185268] 'process raft request' (duration: 170.744945ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:22:15.870429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.209756ms","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-10-16T00:22:15.870551Z","caller":"traceutil/trace.go:171","msg":"trace[1728474143] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8655; }","duration":"170.373518ms","start":"2026-10-16T00:22:15.700155Z","end":"2026-10-16T00:22:15.870529Z","steps":["trace[1728474143] 'agreement among raft nodes before linearized reading' (duration: 169.956612ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:22:15.870484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.440161ms","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-10-16T00:22:15.870688Z","caller":"traceutil/trace.go:171","msg":"trace[1735596869] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8655; }","duration":"174.675866ms","start":"2026-10-16T00:22:15.695976Z","end":"2026-10-16T00:22:15.870652Z","steps":["trace[1735596869] 'agreement among raft nodes before linearized reading' (duration: 174.058915ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:22:27.563394Z","caller":"traceutil/trace.go:171","msg":"trace[756113122] transaction","detail":"{read_only:false; response_revision:8717; number_of_response:1; }","duration":"101.421748ms","start":"2026-10-16T00:22:27.461944Z","end":"2026-10-16T00:22:27.563366Z","steps":["trace[756113122] 'process raft request' (duration: 101.242115ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:22:28.368972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.729447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-10-16T00:22:28.369081Z","caller":"traceutil/trace.go:171","msg":"trace[1372739806] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8723; }","duration":"196.90308ms","start":"2026-10-16T00:22:28.172155Z","end":"2026-10-16T00:22:28.369058Z","steps":["trace[1372739806] 'range keys from in-memory index tree' (duration: 196.535223ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:22:28.505797Z","caller":"traceutil/trace.go:171","msg":"trace[274912586] linearizableReadLoop","detail":"{readStateIndex:9041; appliedIndex:9040; }","duration":"130.583677ms","start":"2026-10-16T00:22:28.375141Z","end":"2026-10-16T00:22:28.505724Z","steps":["trace[274912586] 'read index received' (duration: 130.421334ms)","trace[274912586] 'applied index is now lower than readState.Index' (duration: 160.713µs)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:22:28.505935Z","caller":"traceutil/trace.go:171","msg":"trace[1009576159] transaction","detail":"{read_only:false; response_revision:8724; number_of_response:1; }","duration":"131.178278ms","start":"2026-10-16T00:22:28.374702Z","end":"2026-10-16T00:22:28.50588Z","steps":["trace[1009576159] 'process raft request' (duration: 130.829821ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:22:28.506063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.883982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:20206"} {"level":"info","ts":"2026-10-16T00:22:28.506107Z","caller":"traceutil/trace.go:171","msg":"trace[20521521] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:8724; }","duration":"130.978454ms","start":"2026-10-16T00:22:28.375118Z","end":"2026-10-16T00:22:28.506096Z","steps":["trace[20521521] 'agreement among raft nodes before linearized reading' (duration: 130.7659ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:22:28.540307Z","caller":"traceutil/trace.go:171","msg":"trace[1664229363] transaction","detail":"{read_only:false; response_revision:8725; number_of_response:1; }","duration":"159.018962ms","start":"2026-10-16T00:22:28.381251Z","end":"2026-10-16T00:22:28.54027Z","steps":["trace[1664229363] 'process raft request' (duration: 158.749087ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:22:28.540546Z","caller":"traceutil/trace.go:171","msg":"trace[677452405] transaction","detail":"{read_only:false; response_revision:8726; number_of_response:1; }","duration":"111.127435ms","start":"2026-10-16T00:22:28.429378Z","end":"2026-10-16T00:22:28.540506Z","steps":["trace[677452405] 'process raft request' (duration: 110.835359ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:23:06.464107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.457179ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:23:06.464282Z","caller":"traceutil/trace.go:171","msg":"trace[1223156528] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:8975; }","duration":"214.661273ms","start":"2026-10-16T00:23:06.249593Z","end":"2026-10-16T00:23:06.464254Z","steps":["trace[1223156528] 'range keys from in-memory index tree' (duration: 214.439379ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:23:06.46447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.874257ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-16T00:23:06.4648Z","caller":"traceutil/trace.go:171","msg":"trace[215944990] transaction","detail":"{read_only:false; response_revision:8976; number_of_response:1; }","duration":"329.096321ms","start":"2026-10-16T00:23:06.135683Z","end":"2026-10-16T00:23:06.464779Z","steps":["trace[215944990] 'process raft request' (duration: 157.775096ms)","trace[215944990] 'compare' (duration: 170.218684ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T00:23:06.464871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:23:06.13565Z","time spent":"329.195672ms","remote":"127.0.0.1:42446","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-10-16T00:23:06.494157Z","caller":"traceutil/trace.go:171","msg":"trace[1023930742] linearizableReadLoop","detail":"{readStateIndex:9303; appliedIndex:9301; }","duration":"270.565704ms","start":"2026-10-16T00:23:06.223559Z","end":"2026-10-16T00:23:06.494124Z","steps":["trace[1023930742] 'read index received' (duration: 69.940178ms)","trace[1023930742] 'applied index is now lower than readState.Index' (duration: 200.624516ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:23:06.494254Z","caller":"traceutil/trace.go:171","msg":"trace[1014444615] transaction","detail":"{read_only:false; response_revision:8977; number_of_response:1; }","duration":"337.542736ms","start":"2026-10-16T00:23:06.156673Z","end":"2026-10-16T00:23:06.494215Z","steps":["trace[1014444615] 'process raft request' (duration: 337.350143ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:23:06.494335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.45297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-10-16T00:23:06.494356Z","caller":"traceutil/trace.go:171","msg":"trace[153746079] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8977; }","duration":"232.478051ms","start":"2026-10-16T00:23:06.261871Z","end":"2026-10-16T00:23:06.494349Z","steps":["trace[153746079] 'agreement among raft nodes before linearized reading' (duration: 232.360019ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:23:06.494443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:23:06.15664Z","time spent":"337.70829ms","remote":"127.0.0.1:42446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-16T00:23:06.494496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.932129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-10-16T00:23:06.494554Z","caller":"traceutil/trace.go:171","msg":"trace[176986358] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8977; }","duration":"271.050511ms","start":"2026-10-16T00:23:06.223485Z","end":"2026-10-16T00:23:06.494536Z","steps":["trace[176986358] 'agreement among raft nodes before linearized reading' (duration: 270.749917ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:23:06.49462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.733246ms","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-10-16T00:23:06.494675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.342717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-m6chk\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-10-16T00:23:06.494723Z","caller":"traceutil/trace.go:171","msg":"trace[1957805047] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8977; }","duration":"162.866808ms","start":"2026-10-16T00:23:06.33183Z","end":"2026-10-16T00:23:06.494697Z","steps":["trace[1957805047] 'agreement among raft nodes before linearized reading' (duration: 162.591803ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:23:06.494749Z","caller":"traceutil/trace.go:171","msg":"trace[1103435118] range","detail":"{range_begin:/registry/pods/openstack/keepalived-m6chk; range_end:; response_count:1; response_revision:8977; }","duration":"221.466039ms","start":"2026-10-16T00:23:06.27326Z","end":"2026-10-16T00:23:06.494726Z","steps":["trace[1103435118] 'agreement among raft nodes before linearized reading' (duration: 221.084703ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:23:06.494981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.502519ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.167\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-10-16T00:23:06.495139Z","caller":"traceutil/trace.go:171","msg":"trace[1816775216] range","detail":"{range_begin:/registry/masterleases/162.253.55.167; range_end:; response_count:1; response_revision:8977; }","duration":"227.693093ms","start":"2026-10-16T00:23:06.267413Z","end":"2026-10-16T00:23:06.495107Z","steps":["trace[1816775216] 'agreement among raft nodes before linearized reading' (duration: 227.01657ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:23:06.495875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.064692ms","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-10-16T00:23:06.496043Z","caller":"traceutil/trace.go:171","msg":"trace[232143749] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8977; }","duration":"183.259075ms","start":"2026-10-16T00:23:06.312766Z","end":"2026-10-16T00:23:06.496025Z","steps":["trace[232143749] 'agreement among raft nodes before linearized reading' (duration: 181.538404ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:23:14.082806Z","caller":"traceutil/trace.go:171","msg":"trace[141800816] linearizableReadLoop","detail":"{readStateIndex:9390; appliedIndex:9389; }","duration":"172.988826ms","start":"2026-10-16T00:23:13.909775Z","end":"2026-10-16T00:23:14.082764Z","steps":["trace[141800816] 'read index received' (duration: 122.785691ms)","trace[141800816] 'applied index is now lower than readState.Index' (duration: 50.201755ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:23:14.082891Z","caller":"traceutil/trace.go:171","msg":"trace[271919353] transaction","detail":"{read_only:false; response_revision:9058; number_of_response:1; }","duration":"173.799091ms","start":"2026-10-16T00:23:13.909053Z","end":"2026-10-16T00:23:14.082852Z","steps":["trace[271919353] 'process raft request' (duration: 123.621787ms)","trace[271919353] 'compare' (duration: 49.895219ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T00:23:14.08312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.298621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/openstack/rook-ceph-detect-version-dzpjk\" ","response":"range_response_count:1 size:2801"} {"level":"info","ts":"2026-10-16T00:23:14.083171Z","caller":"traceutil/trace.go:171","msg":"trace[740886772] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/openstack/rook-ceph-detect-version-dzpjk; range_end:; response_count:1; response_revision:9058; }","duration":"173.409404ms","start":"2026-10-16T00:23:13.909743Z","end":"2026-10-16T00:23:14.083153Z","steps":["trace[740886772] 'agreement among raft nodes before linearized reading' (duration: 173.173929ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:23:14.746525Z","caller":"traceutil/trace.go:171","msg":"trace[114754254] linearizableReadLoop","detail":"{readStateIndex:9395; appliedIndex:9394; }","duration":"151.601902ms","start":"2026-10-16T00:23:14.59489Z","end":"2026-10-16T00:23:14.746491Z","steps":["trace[114754254] 'read index received' (duration: 144.744665ms)","trace[114754254] 'applied index is now lower than readState.Index' (duration: 6.855507ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:23:14.746612Z","caller":"traceutil/trace.go:171","msg":"trace[435396202] transaction","detail":"{read_only:false; response_revision:9063; number_of_response:1; }","duration":"155.102856ms","start":"2026-10-16T00:23:14.591475Z","end":"2026-10-16T00:23:14.746578Z","steps":["trace[435396202] 'process raft request' (duration: 148.234669ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:23:14.746875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.950179ms","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-10-16T00:23:14.74692Z","caller":"traceutil/trace.go:171","msg":"trace[50675643] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:9063; }","duration":"152.122392ms","start":"2026-10-16T00:23:14.594786Z","end":"2026-10-16T00:23:14.746909Z","steps":["trace[50675643] 'agreement among raft nodes before linearized reading' (duration: 151.853416ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:23:14.746986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.189724ms","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-10-16T00:23:14.747086Z","caller":"traceutil/trace.go:171","msg":"trace[488605738] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:9063; }","duration":"151.347067ms","start":"2026-10-16T00:23:14.595716Z","end":"2026-10-16T00:23:14.747063Z","steps":["trace[488605738] 'agreement among raft nodes before linearized reading' (duration: 151.008691ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:23:14.747229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.112569ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/barbican-api-7575765dd-kl4x7.18dedaa9cf6c487c\" ","response":"range_response_count:1 size:1132"} {"level":"info","ts":"2026-10-16T00:23:14.747295Z","caller":"traceutil/trace.go:171","msg":"trace[322271783] range","detail":"{range_begin:/registry/events/openstack/barbican-api-7575765dd-kl4x7.18dedaa9cf6c487c; range_end:; response_count:1; response_revision:9063; }","duration":"141.230841ms","start":"2026-10-16T00:23:14.606044Z","end":"2026-10-16T00:23:14.747275Z","steps":["trace[322271783] 'agreement among raft nodes before linearized reading' (duration: 141.041688ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:23:14.747269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.873164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-m6chk\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-10-16T00:23:14.747365Z","caller":"traceutil/trace.go:171","msg":"trace[1602997265] range","detail":"{range_begin:/registry/pods/openstack/keepalived-m6chk; range_end:; response_count:1; response_revision:9063; }","duration":"141.032188ms","start":"2026-10-16T00:23:14.606307Z","end":"2026-10-16T00:23:14.747339Z","steps":["trace[1602997265] 'agreement among raft nodes before linearized reading' (duration: 140.684961ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:23:14.747471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.370059ms","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-10-16T00:23:14.747209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.955059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/passwords/\" range_end:\"/registry/secretgen.k14s.io/passwords0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-16T00:23:14.747702Z","caller":"traceutil/trace.go:171","msg":"trace[1682466926] range","detail":"{range_begin:/registry/secretgen.k14s.io/passwords/; range_end:/registry/secretgen.k14s.io/passwords0; response_count:0; response_revision:9063; }","duration":"114.485188ms","start":"2026-10-16T00:23:14.633189Z","end":"2026-10-16T00:23:14.747674Z","steps":["trace[1682466926] 'agreement among raft nodes before linearized reading' (duration: 113.853057ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:23:14.747517Z","caller":"traceutil/trace.go:171","msg":"trace[1703525866] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:9063; }","duration":"150.439181ms","start":"2026-10-16T00:23:14.597062Z","end":"2026-10-16T00:23:14.747501Z","steps":["trace[1703525866] 'agreement among raft nodes before linearized reading' (duration: 150.33568ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:23:15.105914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.590971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5683"} {"level":"info","ts":"2026-10-16T00:23:15.106022Z","caller":"traceutil/trace.go:171","msg":"trace[1418963012] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:9071; }","duration":"107.860386ms","start":"2026-10-16T00:23:14.998138Z","end":"2026-10-16T00:23:15.105998Z","steps":["trace[1418963012] 'range keys from in-memory index tree' (duration: 107.344767ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:23:27.693836Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002532.wal"} {"level":"info","ts":"2026-10-16T00:24:13.134353Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"83287f3a81241ad4","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-16T00:24:13.142893Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-10-16T00:24:13.143096Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-10-16T00:24:36.656Z","caller":"traceutil/trace.go:171","msg":"trace[82905150] transaction","detail":"{read_only:false; response_revision:9839; number_of_response:1; }","duration":"111.659567ms","start":"2026-10-16T00:24:36.544297Z","end":"2026-10-16T00:24:36.655957Z","steps":["trace[82905150] 'process raft request' (duration: 63.49617ms)","trace[82905150] 'compare' (duration: 47.979874ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:26:02.83471Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8038} {"level":"info","ts":"2026-10-16T00:26:02.926109Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8038,"took":"88.847138ms","hash":1846344064,"current-db-size-bytes":54460416,"current-db-size":"54 MB","current-db-size-in-use-bytes":25165824,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-10-16T00:26:02.926228Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1846344064,"revision":8038,"compact-revision":5678} {"level":"warn","ts":"2026-10-16T00:28:04.701079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.039132ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-16T00:28:04.701398Z","caller":"traceutil/trace.go:171","msg":"trace[962328542] transaction","detail":"{read_only:false; response_revision:11592; number_of_response:1; }","duration":"251.660791ms","start":"2026-10-16T00:28:04.449713Z","end":"2026-10-16T00:28:04.701374Z","steps":["trace[962328542] 'process raft request' (duration: 119.213801ms)","trace[962328542] 'compare' (duration: 131.709328ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:28:04.701461Z","caller":"traceutil/trace.go:171","msg":"trace[312731737] transaction","detail":"{read_only:false; response_revision:11593; number_of_response:1; }","duration":"251.396326ms","start":"2026-10-16T00:28:04.450028Z","end":"2026-10-16T00:28:04.701425Z","steps":["trace[312731737] 'process raft request' (duration: 251.189072ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:28:20.280429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.57862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-storage-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:28:20.280569Z","caller":"traceutil/trace.go:171","msg":"trace[662441491] range","detail":"{range_begin:/registry/jobs/openstack/cinder-storage-init; range_end:; response_count:0; response_revision:11677; }","duration":"195.753533ms","start":"2026-10-16T00:28:20.084788Z","end":"2026-10-16T00:28:20.280542Z","steps":["trace[662441491] 'range keys from in-memory index tree' (duration: 195.488599ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:28:20.280568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.487406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:28:20.280727Z","caller":"traceutil/trace.go:171","msg":"trace[234465478] range","detail":"{range_begin:/registry/jobs/openstack/cinder-rabbit-init; range_end:; response_count:0; response_revision:11677; }","duration":"196.64861ms","start":"2026-10-16T00:28:20.084026Z","end":"2026-10-16T00:28:20.280675Z","steps":["trace[234465478] 'range keys from in-memory index tree' (duration: 196.422755ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:28:20.280725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.71295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-16T00:28:20.280784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.764121ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-endpoints\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-16T00:28:20.280725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.773039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-db-sync\" ","response":"range_response_count:1 size:5079"} {"level":"info","ts":"2026-10-16T00:28:20.280879Z","caller":"traceutil/trace.go:171","msg":"trace[2079588490] range","detail":"{range_begin:/registry/jobs/openstack/cinder-db-sync; range_end:; response_count:1; response_revision:11677; }","duration":"181.959082ms","start":"2026-10-16T00:28:20.098911Z","end":"2026-10-16T00:28:20.28087Z","steps":["trace[2079588490] 'range keys from in-memory index tree' (duration: 181.613646ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:28:20.280902Z","caller":"traceutil/trace.go:171","msg":"trace[846994270] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-endpoints; range_end:; response_count:0; response_revision:11677; }","duration":"196.974675ms","start":"2026-10-16T00:28:20.083897Z","end":"2026-10-16T00:28:20.280872Z","steps":["trace[846994270] 'range keys from in-memory index tree' (duration: 196.531097ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:28:20.280836Z","caller":"traceutil/trace.go:171","msg":"trace[1578716739] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:11677; }","duration":"197.885782ms","start":"2026-10-16T00:28:20.082916Z","end":"2026-10-16T00:28:20.280801Z","steps":["trace[1578716739] 'range keys from in-memory index tree' (duration: 197.544696ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:28:20.28086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.616391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-user\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:28:20.281682Z","caller":"traceutil/trace.go:171","msg":"trace[1014049580] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-user; range_end:; response_count:0; response_revision:11677; }","duration":"196.832144ms","start":"2026-10-16T00:28:20.084766Z","end":"2026-10-16T00:28:20.281598Z","steps":["trace[1014049580] 'range keys from in-memory index tree' (duration: 195.529639ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:28:20.323887Z","caller":"traceutil/trace.go:171","msg":"trace[813004517] transaction","detail":"{read_only:false; response_revision:11678; number_of_response:1; }","duration":"206.225354ms","start":"2026-10-16T00:28:20.117614Z","end":"2026-10-16T00:28:20.323839Z","steps":["trace[813004517] 'process raft request' (duration: 205.959479ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:28:20.354526Z","caller":"traceutil/trace.go:171","msg":"trace[108950488] transaction","detail":"{read_only:false; response_revision:11679; number_of_response:1; }","duration":"236.523107ms","start":"2026-10-16T00:28:20.117961Z","end":"2026-10-16T00:28:20.354484Z","steps":["trace[108950488] 'process raft request' (duration: 236.17118ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:31:02.843265Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10432} {"level":"info","ts":"2026-10-16T00:31:02.939672Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10432,"took":"93.287122ms","hash":958454685,"current-db-size-bytes":54460416,"current-db-size":"54 MB","current-db-size-in-use-bytes":27914240,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-16T00:31:02.93976Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":958454685,"revision":10432,"compact-revision":8038} {"level":"warn","ts":"2026-10-16T00:34:11.079334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.532491ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-16T00:34:11.079532Z","caller":"traceutil/trace.go:171","msg":"trace[492893180] transaction","detail":"{read_only:false; response_revision:14076; number_of_response:1; }","duration":"218.156824ms","start":"2026-10-16T00:34:10.861329Z","end":"2026-10-16T00:34:11.079486Z","steps":["trace[492893180] 'process raft request' (duration: 106.383898ms)","trace[492893180] 'compare' (duration: 111.410849ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:34:14.240233Z","caller":"traceutil/trace.go:171","msg":"trace[1499227017] linearizableReadLoop","detail":"{readStateIndex:14584; appliedIndex:14583; }","duration":"106.602532ms","start":"2026-10-16T00:34:14.133592Z","end":"2026-10-16T00:34:14.240194Z","steps":["trace[1499227017] 'read index received' (duration: 106.323467ms)","trace[1499227017] 'applied index is now lower than readState.Index' (duration: 277.105µs)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:34:14.240377Z","caller":"traceutil/trace.go:171","msg":"trace[1933939506] transaction","detail":"{read_only:false; response_revision:14093; number_of_response:1; }","duration":"132.688598ms","start":"2026-10-16T00:34:14.107603Z","end":"2026-10-16T00:34:14.240291Z","steps":["trace[1933939506] 'process raft request' (duration: 132.354952ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:34:14.242225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.503817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-16T00:34:14.242298Z","caller":"traceutil/trace.go:171","msg":"trace[1030583910] range","detail":"{range_begin:/registry/cert-manager.io/certificates/; range_end:/registry/cert-manager.io/certificates0; response_count:0; response_revision:14093; }","duration":"108.73543ms","start":"2026-10-16T00:34:14.133541Z","end":"2026-10-16T00:34:14.242277Z","steps":["trace[1030583910] 'agreement among raft nodes before linearized reading' (duration: 106.800985ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:34:36.012443Z","caller":"traceutil/trace.go:171","msg":"trace[912400981] transaction","detail":"{read_only:false; response_revision:14208; number_of_response:1; }","duration":"137.361055ms","start":"2026-10-16T00:34:35.875038Z","end":"2026-10-16T00:34:36.012399Z","steps":["trace[912400981] 'process raft request' (duration: 137.208682ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:34:36.150876Z","caller":"traceutil/trace.go:171","msg":"trace[119003596] transaction","detail":"{read_only:false; response_revision:14209; number_of_response:1; }","duration":"267.190751ms","start":"2026-10-16T00:34:35.883661Z","end":"2026-10-16T00:34:36.150852Z","steps":["trace[119003596] 'process raft request' (duration: 264.016203ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:34:36.151065Z","caller":"traceutil/trace.go:171","msg":"trace[1739518697] transaction","detail":"{read_only:false; response_revision:14210; number_of_response:1; }","duration":"119.251793ms","start":"2026-10-16T00:34:36.031803Z","end":"2026-10-16T00:34:36.151055Z","steps":["trace[1739518697] 'process raft request' (duration: 118.652082ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:34:49.89476Z","caller":"traceutil/trace.go:171","msg":"trace[1351083345] transaction","detail":"{read_only:false; response_revision:14296; number_of_response:1; }","duration":"186.147936ms","start":"2026-10-16T00:34:49.708584Z","end":"2026-10-16T00:34:49.894732Z","steps":["trace[1351083345] 'process raft request' (duration: 185.983373ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:34:55.688061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.172273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/openvswitch-xnncs\" ","response":"range_response_count:1 size:12599"} {"level":"info","ts":"2026-10-16T00:34:55.688173Z","caller":"traceutil/trace.go:171","msg":"trace[963667123] range","detail":"{range_begin:/registry/pods/openstack/openvswitch-xnncs; range_end:; response_count:1; response_revision:14326; }","duration":"454.354167ms","start":"2026-10-16T00:34:55.23379Z","end":"2026-10-16T00:34:55.688144Z","steps":["trace[963667123] 'range keys from in-memory index tree' (duration: 453.910459ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:34:55.688221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:34:55.233766Z","time spent":"454.445169ms","remote":"127.0.0.1:42358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":12622,"request content":"key:\"/registry/pods/openstack/openvswitch-xnncs\" "} {"level":"warn","ts":"2026-10-16T00:34:55.688396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.671906ms","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-10-16T00:34:55.688485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"496.423307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-10-16T00:34:55.688503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"496.797334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-10-16T00:34:55.688515Z","caller":"traceutil/trace.go:171","msg":"trace[769903736] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:14326; }","duration":"340.863779ms","start":"2026-10-16T00:34:55.347623Z","end":"2026-10-16T00:34:55.688487Z","steps":["trace[769903736] 'range keys from in-memory index tree' (duration: 340.463672ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:34:55.68855Z","caller":"traceutil/trace.go:171","msg":"trace[1222354444] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:14326; }","duration":"496.500718ms","start":"2026-10-16T00:34:55.192032Z","end":"2026-10-16T00:34:55.688532Z","steps":["trace[1222354444] 'range keys from in-memory index tree' (duration: 496.144492ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:34:55.688569Z","caller":"traceutil/trace.go:171","msg":"trace[1615551770] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:14326; }","duration":"496.902186ms","start":"2026-10-16T00:34:55.191648Z","end":"2026-10-16T00:34:55.68855Z","steps":["trace[1615551770] 'range keys from in-memory index tree' (duration: 496.485088ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:34:55.688571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:34:55.347589Z","time spent":"340.971571ms","remote":"127.0.0.1:42446","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-10-16T00:34:55.688539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"496.520679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-10-16T00:34:55.688602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:34:55.191622Z","time spent":"496.972347ms","remote":"127.0.0.1:42446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-10-16T00:34:55.688588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:34:55.192023Z","time spent":"496.55597ms","remote":"127.0.0.1:42446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-10-16T00:34:55.688642Z","caller":"traceutil/trace.go:171","msg":"trace[517165303] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:14326; }","duration":"496.901686ms","start":"2026-10-16T00:34:55.191717Z","end":"2026-10-16T00:34:55.688618Z","steps":["trace[517165303] 'range keys from in-memory index tree' (duration: 496.095921ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:34:55.688684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:34:55.191683Z","time spent":"496.991658ms","remote":"127.0.0.1:42446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-10-16T00:34:55.894677Z","caller":"traceutil/trace.go:171","msg":"trace[1286715613] transaction","detail":"{read_only:false; response_revision:14327; number_of_response:1; }","duration":"200.427529ms","start":"2026-10-16T00:34:55.694222Z","end":"2026-10-16T00:34:55.89465Z","steps":["trace[1286715613] 'process raft request' (duration: 200.259526ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:34:56.194671Z","caller":"traceutil/trace.go:171","msg":"trace[751055548] transaction","detail":"{read_only:false; response_revision:14328; number_of_response:1; }","duration":"500.264927ms","start":"2026-10-16T00:34:55.694365Z","end":"2026-10-16T00:34:56.19463Z","steps":["trace[751055548] 'process raft request' (duration: 499.963281ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:34:56.194846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:34:55.694332Z","time spent":"500.42168ms","remote":"127.0.0.1:42446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-16T00:34:56.195483Z","caller":"traceutil/trace.go:171","msg":"trace[486472028] transaction","detail":"{read_only:false; response_revision:14329; number_of_response:1; }","duration":"501.028411ms","start":"2026-10-16T00:34:55.694387Z","end":"2026-10-16T00:34:56.195416Z","steps":["trace[486472028] 'process raft request' (duration: 500.184576ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:34:56.195589Z","caller":"traceutil/trace.go:171","msg":"trace[49481419] transaction","detail":"{read_only:false; response_revision:14330; number_of_response:1; }","duration":"500.743786ms","start":"2026-10-16T00:34:55.69482Z","end":"2026-10-16T00:34:56.195564Z","steps":["trace[49481419] 'process raft request' (duration: 500.457621ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:34:56.195608Z","caller":"traceutil/trace.go:171","msg":"trace[1090670362] transaction","detail":"{read_only:false; response_revision:14331; number_of_response:1; }","duration":"490.959127ms","start":"2026-10-16T00:34:55.704598Z","end":"2026-10-16T00:34:56.195557Z","steps":["trace[1090670362] 'process raft request' (duration: 490.831135ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:34:56.195689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:34:55.694804Z","time spent":"500.832117ms","remote":"127.0.0.1:42446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-16T00:34:56.1957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:34:55.694358Z","time spent":"501.241125ms","remote":"127.0.0.1:42446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-16T00:34:56.195718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:34:55.704578Z","time spent":"491.08993ms","remote":"127.0.0.1:42358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12713,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-16T00:34:56.201612Z","caller":"traceutil/trace.go:171","msg":"trace[1222394355] transaction","detail":"{read_only:false; response_revision:14332; number_of_response:1; }","duration":"285.954844ms","start":"2026-10-16T00:34:55.915627Z","end":"2026-10-16T00:34:56.201581Z","steps":["trace[1222394355] 'process raft request' (duration: 285.73608ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:34:56.201783Z","caller":"traceutil/trace.go:171","msg":"trace[647249569] linearizableReadLoop","detail":"{readStateIndex:14832; appliedIndex:14827; }","duration":"119.166921ms","start":"2026-10-16T00:34:56.082592Z","end":"2026-10-16T00:34:56.201759Z","steps":["trace[647249569] 'read index received' (duration: 111.664504ms)","trace[647249569] 'applied index is now lower than readState.Index' (duration: 7.499467ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:34:56.201859Z","caller":"traceutil/trace.go:171","msg":"trace[793703142] transaction","detail":"{read_only:false; response_revision:14333; number_of_response:1; }","duration":"109.26455ms","start":"2026-10-16T00:34:56.09256Z","end":"2026-10-16T00:34:56.201824Z","steps":["trace[793703142] 'process raft request' (duration: 108.976226ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:34:56.201922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.323484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:34:56.202001Z","caller":"traceutil/trace.go:171","msg":"trace[1236741630] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14333; }","duration":"119.442556ms","start":"2026-10-16T00:34:56.082537Z","end":"2026-10-16T00:34:56.201979Z","steps":["trace[1236741630] 'agreement among raft nodes before linearized reading' (duration: 119.294823ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:36:02.851108Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12781} {"level":"info","ts":"2026-10-16T00:36:02.943381Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12781,"took":"87.860068ms","hash":1392555165,"current-db-size-bytes":54460416,"current-db-size":"54 MB","current-db-size-in-use-bytes":31236096,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-16T00:36:02.943462Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1392555165,"revision":12781,"compact-revision":10432} {"level":"info","ts":"2026-10-16T00:36:37.157681Z","caller":"traceutil/trace.go:171","msg":"trace[119625380] linearizableReadLoop","detail":"{readStateIndex:16071; appliedIndex:16070; }","duration":"337.696592ms","start":"2026-10-16T00:36:36.81996Z","end":"2026-10-16T00:36:37.157656Z","steps":["trace[119625380] 'read index received' (duration: 337.366866ms)","trace[119625380] 'applied index is now lower than readState.Index' (duration: 328.746µs)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:36:37.157869Z","caller":"traceutil/trace.go:171","msg":"trace[1630062892] transaction","detail":"{read_only:false; response_revision:15534; number_of_response:1; }","duration":"351.76272ms","start":"2026-10-16T00:36:36.806093Z","end":"2026-10-16T00:36:37.157856Z","steps":["trace[1630062892] 'process raft request' (duration: 351.323381ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:36:37.158009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.70109ms","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-10-16T00:36:37.158069Z","caller":"traceutil/trace.go:171","msg":"trace[1884953215] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:15534; }","duration":"161.807542ms","start":"2026-10-16T00:36:36.996248Z","end":"2026-10-16T00:36:37.158055Z","steps":["trace[1884953215] 'agreement among raft nodes before linearized reading' (duration: 161.716161ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:36:37.158269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.900667ms","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-10-16T00:36:37.158312Z","caller":"traceutil/trace.go:171","msg":"trace[1797729476] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15534; }","duration":"153.999019ms","start":"2026-10-16T00:36:37.004302Z","end":"2026-10-16T00:36:37.158301Z","steps":["trace[1797729476] 'agreement among raft nodes before linearized reading' (duration: 153.800575ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:36:37.158338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.718965ms","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-10-16T00:36:37.15837Z","caller":"traceutil/trace.go:171","msg":"trace[135981308] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:15534; }","duration":"158.769657ms","start":"2026-10-16T00:36:36.999592Z","end":"2026-10-16T00:36:37.158362Z","steps":["trace[135981308] 'agreement among raft nodes before linearized reading' (duration: 158.718996ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:36:37.158485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.795682ms","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-10-16T00:36:37.158546Z","caller":"traceutil/trace.go:171","msg":"trace[1364633565] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15534; }","duration":"160.870164ms","start":"2026-10-16T00:36:36.997668Z","end":"2026-10-16T00:36:37.158538Z","steps":["trace[1364633565] 'agreement among raft nodes before linearized reading' (duration: 160.796873ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:36:37.158674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.590678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:667"} {"level":"info","ts":"2026-10-16T00:36:37.158706Z","caller":"traceutil/trace.go:171","msg":"trace[1686294329] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15534; }","duration":"161.638308ms","start":"2026-10-16T00:36:36.997061Z","end":"2026-10-16T00:36:37.158699Z","steps":["trace[1686294329] 'agreement among raft nodes before linearized reading' (duration: 161.543837ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:36:37.158809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.403655ms","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-10-16T00:36:37.158876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.005736ms","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-10-16T00:36:37.158903Z","caller":"traceutil/trace.go:171","msg":"trace[1472129580] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15534; }","duration":"162.068346ms","start":"2026-10-16T00:36:36.996827Z","end":"2026-10-16T00:36:37.158895Z","steps":["trace[1472129580] 'agreement among raft nodes before linearized reading' (duration: 162.024335ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:36:37.158041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:36:36.806073Z","time spent":"351.861621ms","remote":"127.0.0.1:42446","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-10-16T00:36:37.158925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.934164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-10-16T00:36:37.159025Z","caller":"traceutil/trace.go:171","msg":"trace[162234404] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:15534; }","duration":"339.059436ms","start":"2026-10-16T00:36:36.819937Z","end":"2026-10-16T00:36:37.158996Z","steps":["trace[162234404] 'agreement among raft nodes before linearized reading' (duration: 338.874053ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:36:37.159079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:36:36.819928Z","time spent":"339.137667ms","remote":"127.0.0.1:42446","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-10-16T00:36:37.158877Z","caller":"traceutil/trace.go:171","msg":"trace[1464764810] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15534; }","duration":"154.491838ms","start":"2026-10-16T00:36:37.004375Z","end":"2026-10-16T00:36:37.158867Z","steps":["trace[1464764810] 'agreement among raft nodes before linearized reading' (duration: 154.329275ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:36:37.420943Z","caller":"traceutil/trace.go:171","msg":"trace[649527905] transaction","detail":"{read_only:false; response_revision:15535; number_of_response:1; }","duration":"256.570157ms","start":"2026-10-16T00:36:37.164346Z","end":"2026-10-16T00:36:37.420916Z","steps":["trace[649527905] 'process raft request' (duration: 200.078672ms)","trace[649527905] 'compare' (duration: 56.361972ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T00:36:37.634589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.504079ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-16T00:36:37.63472Z","caller":"traceutil/trace.go:171","msg":"trace[2056283873] linearizableReadLoop","detail":"{readStateIndex:16073; appliedIndex:16071; }","duration":"442.209114ms","start":"2026-10-16T00:36:37.192485Z","end":"2026-10-16T00:36:37.634694Z","steps":["trace[2056283873] 'read index received' (duration: 171.951578ms)","trace[2056283873] 'applied index is now lower than readState.Index' (duration: 270.256106ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:36:37.634817Z","caller":"traceutil/trace.go:171","msg":"trace[820047980] transaction","detail":"{read_only:false; response_revision:15536; number_of_response:1; }","duration":"470.089564ms","start":"2026-10-16T00:36:37.164678Z","end":"2026-10-16T00:36:37.634767Z","steps":["trace[820047980] 'process raft request' (duration: 357.28465ms)","trace[820047980] 'compare' (duration: 112.244215ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T00:36:37.634852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.337976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-16T00:36:37.634927Z","caller":"traceutil/trace.go:171","msg":"trace[793871705] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:15536; }","duration":"442.452449ms","start":"2026-10-16T00:36:37.192457Z","end":"2026-10-16T00:36:37.634909Z","steps":["trace[793871705] 'agreement among raft nodes before linearized reading' (duration: 442.314917ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:36:37.634944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:36:37.164665Z","time spent":"470.201156ms","remote":"127.0.0.1:42446","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-10-16T00:36:37.634968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:36:37.192445Z","time spent":"442.5126ms","remote":"127.0.0.1:46712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":30,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-10-16T00:36:37.635104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.406187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-npx9k\" ","response":"range_response_count:1 size:9799"} {"level":"info","ts":"2026-10-16T00:36:37.635141Z","caller":"traceutil/trace.go:171","msg":"trace[225662941] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-npx9k; range_end:; response_count:1; response_revision:15536; }","duration":"142.489738ms","start":"2026-10-16T00:36:37.49264Z","end":"2026-10-16T00:36:37.63513Z","steps":["trace[225662941] 'agreement among raft nodes before linearized reading' (duration: 142.356886ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:36:37.635134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.966431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:667"} {"level":"info","ts":"2026-10-16T00:36:37.635194Z","caller":"traceutil/trace.go:171","msg":"trace[1109769068] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15536; }","duration":"435.044463ms","start":"2026-10-16T00:36:37.200132Z","end":"2026-10-16T00:36:37.635177Z","steps":["trace[1109769068] 'agreement among raft nodes before linearized reading' (duration: 434.85691ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:36:37.635239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:36:37.200123Z","time spent":"435.102434ms","remote":"127.0.0.1:42348","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":690,"request content":"key:\"/registry/services/endpoints/openstack/nova-api\" "} {"level":"warn","ts":"2026-10-16T00:36:37.63538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.639969ms","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-10-16T00:36:37.635414Z","caller":"traceutil/trace.go:171","msg":"trace[103649126] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:15536; }","duration":"373.700889ms","start":"2026-10-16T00:36:37.261703Z","end":"2026-10-16T00:36:37.635404Z","steps":["trace[103649126] 'agreement among raft nodes before linearized reading' (duration: 373.599328ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:36:37.635442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:36:37.26169Z","time spent":"373.744991ms","remote":"127.0.0.1:42446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":552,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "} {"level":"info","ts":"2026-10-16T00:41:02.862276Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15347} {"level":"info","ts":"2026-10-16T00:41:02.966793Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15347,"took":"101.382814ms","hash":159579321,"current-db-size-bytes":54460416,"current-db-size":"54 MB","current-db-size-in-use-bytes":31723520,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-16T00:41:02.966849Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":159579321,"revision":15347,"compact-revision":12781} {"level":"warn","ts":"2026-10-16T00:42:18.956817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.84654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-10-16T00:42:18.956951Z","caller":"traceutil/trace.go:171","msg":"trace[2080722616] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:18094; }","duration":"114.066165ms","start":"2026-10-16T00:42:18.842856Z","end":"2026-10-16T00:42:18.956923Z","steps":["trace[2080722616] 'count revisions from in-memory index tree' (duration: 113.577416ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:42:22.685681Z","caller":"traceutil/trace.go:171","msg":"trace[1547193572] linearizableReadLoop","detail":"{readStateIndex:18751; appliedIndex:18750; }","duration":"204.741382ms","start":"2026-10-16T00:42:22.480886Z","end":"2026-10-16T00:42:22.685628Z","steps":["trace[1547193572] 'read index received' (duration: 204.383856ms)","trace[1547193572] 'applied index is now lower than readState.Index' (duration: 356.236µs)"],"step_count":2} {"level":"warn","ts":"2026-10-16T00:42:22.685907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.985016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/queues/\" range_end:\"/registry/rabbitmq.com/queues0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-16T00:42:22.685959Z","caller":"traceutil/trace.go:171","msg":"trace[1020067102] range","detail":"{range_begin:/registry/rabbitmq.com/queues/; range_end:/registry/rabbitmq.com/queues0; response_count:0; response_revision:18130; }","duration":"205.117969ms","start":"2026-10-16T00:42:22.480824Z","end":"2026-10-16T00:42:22.685942Z","steps":["trace[1020067102] 'agreement among raft nodes before linearized reading' (duration: 204.954876ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:42:22.686421Z","caller":"traceutil/trace.go:171","msg":"trace[94554222] transaction","detail":"{read_only:false; response_revision:18130; number_of_response:1; }","duration":"219.718526ms","start":"2026-10-16T00:42:22.466689Z","end":"2026-10-16T00:42:22.686408Z","steps":["trace[94554222] 'process raft request' (duration: 218.666847ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:42:23.086707Z","caller":"traceutil/trace.go:171","msg":"trace[1455925015] linearizableReadLoop","detail":"{readStateIndex:18753; appliedIndex:18752; }","duration":"185.946108ms","start":"2026-10-16T00:42:22.900739Z","end":"2026-10-16T00:42:23.086685Z","steps":["trace[1455925015] 'read index received' (duration: 185.694213ms)","trace[1455925015] 'applied index is now lower than readState.Index' (duration: 251.035µs)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:42:23.087008Z","caller":"traceutil/trace.go:171","msg":"trace[1341039352] transaction","detail":"{read_only:false; response_revision:18132; number_of_response:1; }","duration":"254.477492ms","start":"2026-10-16T00:42:22.832517Z","end":"2026-10-16T00:42:23.086994Z","steps":["trace[1341039352] 'process raft request' (duration: 254.013373ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:42:23.08734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.097274ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-heat-server-0\" ","response":"range_response_count:1 size:1852"} {"level":"info","ts":"2026-10-16T00:42:23.087466Z","caller":"traceutil/trace.go:171","msg":"trace[1933275324] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-heat-server-0; range_end:; response_count:1; response_revision:18132; }","duration":"179.264997ms","start":"2026-10-16T00:42:22.90817Z","end":"2026-10-16T00:42:23.087435Z","steps":["trace[1933275324] 'agreement among raft nodes before linearized reading' (duration: 178.88897ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:42:23.087668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.862175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:533"} {"level":"info","ts":"2026-10-16T00:42:23.087805Z","caller":"traceutil/trace.go:171","msg":"trace[368495000] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:18132; }","duration":"187.040588ms","start":"2026-10-16T00:42:22.900734Z","end":"2026-10-16T00:42:23.087774Z","steps":["trace[368495000] 'agreement among raft nodes before linearized reading' (duration: 186.56739ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:42:25.1073Z","caller":"traceutil/trace.go:171","msg":"trace[1240078516] linearizableReadLoop","detail":"{readStateIndex:18776; appliedIndex:18775; }","duration":"167.783377ms","start":"2026-10-16T00:42:24.939484Z","end":"2026-10-16T00:42:25.107267Z","steps":["trace[1240078516] 'read index received' (duration: 167.433311ms)","trace[1240078516] 'applied index is now lower than readState.Index' (duration: 349.276µs)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:42:25.107388Z","caller":"traceutil/trace.go:171","msg":"trace[1151039386] transaction","detail":"{read_only:false; response_revision:18155; number_of_response:1; }","duration":"183.585545ms","start":"2026-10-16T00:42:24.923759Z","end":"2026-10-16T00:42:25.107345Z","steps":["trace[1151039386] 'process raft request' (duration: 183.238619ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:42:25.107552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.042792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-heat-server-0\" ","response":"range_response_count:1 size:1852"} {"level":"info","ts":"2026-10-16T00:42:25.107592Z","caller":"traceutil/trace.go:171","msg":"trace[264767032] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-heat-server-0; range_end:; response_count:1; response_revision:18155; }","duration":"168.124053ms","start":"2026-10-16T00:42:24.939454Z","end":"2026-10-16T00:42:25.107578Z","steps":["trace[264767032] 'agreement among raft nodes before linearized reading' (duration: 167.95679ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:42:25.349193Z","caller":"traceutil/trace.go:171","msg":"trace[1322523716] linearizableReadLoop","detail":"{readStateIndex:18777; appliedIndex:18776; }","duration":"187.886534ms","start":"2026-10-16T00:42:25.161277Z","end":"2026-10-16T00:42:25.349163Z","steps":["trace[1322523716] 'read index received' (duration: 173.603143ms)","trace[1322523716] 'applied index is now lower than readState.Index' (duration: 14.282051ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:42:25.349318Z","caller":"traceutil/trace.go:171","msg":"trace[1306494342] transaction","detail":"{read_only:false; response_revision:18156; number_of_response:1; }","duration":"213.670906ms","start":"2026-10-16T00:42:25.135594Z","end":"2026-10-16T00:42:25.349265Z","steps":["trace[1306494342] 'process raft request' (duration: 199.347194ms)","trace[1306494342] 'compare' (duration: 14.067187ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T00:42:25.349424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.131259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-10-16T00:42:25.349474Z","caller":"traceutil/trace.go:171","msg":"trace[1103077013] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:18156; }","duration":"188.455855ms","start":"2026-10-16T00:42:25.161004Z","end":"2026-10-16T00:42:25.349459Z","steps":["trace[1103077013] 'agreement among raft nodes before linearized reading' (duration: 188.263371ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:42:25.355785Z","caller":"traceutil/trace.go:171","msg":"trace[1449119493] transaction","detail":"{read_only:false; response_revision:18157; number_of_response:1; }","duration":"178.044475ms","start":"2026-10-16T00:42:25.177713Z","end":"2026-10-16T00:42:25.355757Z","steps":["trace[1449119493] 'process raft request' (duration: 177.872042ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:44:42.822481Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"83287f3a81241ad4","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-16T00:44:42.839072Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-10-16T00:44:42.839224Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-10-16T00:46:02.877657Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17498} {"level":"info","ts":"2026-10-16T00:46:02.984749Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17498,"took":"101.590377ms","hash":2415904121,"current-db-size-bytes":54460416,"current-db-size":"54 MB","current-db-size-in-use-bytes":35356672,"current-db-size-in-use":"35 MB"} {"level":"info","ts":"2026-10-16T00:46:02.98485Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2415904121,"revision":17498,"compact-revision":15347} {"level":"info","ts":"2026-10-16T00:47:39.096581Z","caller":"traceutil/trace.go:171","msg":"trace[1688142586] transaction","detail":"{read_only:false; response_revision:20574; number_of_response:1; }","duration":"212.765184ms","start":"2026-10-16T00:47:38.883784Z","end":"2026-10-16T00:47:39.096549Z","steps":["trace[1688142586] 'process raft request' (duration: 212.53825ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:47:39.354216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.300818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-10-16T00:47:39.354301Z","caller":"traceutil/trace.go:171","msg":"trace[1398784943] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:20574; }","duration":"191.42534ms","start":"2026-10-16T00:47:39.162855Z","end":"2026-10-16T00:47:39.354281Z","steps":["trace[1398784943] 'range keys from in-memory index tree' (duration: 191.148265ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:47:39.354265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.55783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:357"} {"level":"info","ts":"2026-10-16T00:47:39.354545Z","caller":"traceutil/trace.go:171","msg":"trace[2045039700] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:20574; }","duration":"203.886397ms","start":"2026-10-16T00:47:39.150633Z","end":"2026-10-16T00:47:39.35452Z","steps":["trace[2045039700] 'range keys from in-memory index tree' (duration: 203.331626ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:47:39.770276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.485918ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-16T00:47:39.770591Z","caller":"traceutil/trace.go:171","msg":"trace[495785834] linearizableReadLoop","detail":"{readStateIndex:21280; appliedIndex:21278; }","duration":"434.117091ms","start":"2026-10-16T00:47:39.336455Z","end":"2026-10-16T00:47:39.770572Z","steps":["trace[495785834] 'read index received' (duration: 182.240215ms)","trace[495785834] 'applied index is now lower than readState.Index' (duration: 251.875786ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:47:39.770881Z","caller":"traceutil/trace.go:171","msg":"trace[1222948208] transaction","detail":"{read_only:false; response_revision:20577; number_of_response:1; }","duration":"441.611992ms","start":"2026-10-16T00:47:39.329256Z","end":"2026-10-16T00:47:39.770868Z","steps":["trace[1222948208] 'process raft request' (duration: 441.207845ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:47:39.771014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:47:39.329242Z","time spent":"441.715524ms","remote":"127.0.0.1:42446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-16T00:47:39.771398Z","caller":"traceutil/trace.go:171","msg":"trace[1575290418] transaction","detail":"{read_only:false; response_revision:20576; number_of_response:1; }","duration":"490.956929ms","start":"2026-10-16T00:47:39.280038Z","end":"2026-10-16T00:47:39.770995Z","steps":["trace[1575290418] 'process raft request' (duration: 238.646945ms)","trace[1575290418] 'compare' (duration: 251.269924ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T00:47:39.771465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.978097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"warn","ts":"2026-10-16T00:47:39.772198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:47:39.280012Z","time spent":"492.07457ms","remote":"127.0.0.1:42446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-16T00:47:39.772266Z","caller":"traceutil/trace.go:171","msg":"trace[1244036442] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:20577; }","duration":"435.834433ms","start":"2026-10-16T00:47:39.336408Z","end":"2026-10-16T00:47:39.772242Z","steps":["trace[1244036442] 'agreement among raft nodes before linearized reading' (duration: 434.808714ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:47:39.772333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:47:39.336388Z","time spent":"435.925624ms","remote":"127.0.0.1:42446","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":"warn","ts":"2026-10-16T00:47:39.826509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.953576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" ","response":"range_response_count:1 size:418236"} {"level":"info","ts":"2026-10-16T00:47:39.826648Z","caller":"traceutil/trace.go:171","msg":"trace[1203034775] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance; range_end:; response_count:1; response_revision:20578; }","duration":"205.111019ms","start":"2026-10-16T00:47:39.621489Z","end":"2026-10-16T00:47:39.8266Z","steps":["trace[1203034775] 'agreement among raft nodes before linearized reading' (duration: 204.240872ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:47:39.825892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"483.332564ms","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-10-16T00:47:39.826765Z","caller":"traceutil/trace.go:171","msg":"trace[420796994] transaction","detail":"{read_only:false; response_revision:20578; number_of_response:1; }","duration":"468.094075ms","start":"2026-10-16T00:47:39.358568Z","end":"2026-10-16T00:47:39.826662Z","steps":["trace[420796994] 'process raft request' (duration: 466.959403ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:47:39.826806Z","caller":"traceutil/trace.go:171","msg":"trace[354893070] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:20578; }","duration":"484.257142ms","start":"2026-10-16T00:47:39.342496Z","end":"2026-10-16T00:47:39.826753Z","steps":["trace[354893070] 'agreement among raft nodes before linearized reading' (duration: 483.202712ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:47:39.826962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:47:39.342475Z","time spent":"484.429685ms","remote":"127.0.0.1:42446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-10-16T00:47:39.826977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:47:39.358552Z","time spent":"468.312059ms","remote":"127.0.0.1:42446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-16T00:47:39.826549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.677827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-10-16T00:47:39.827341Z","caller":"traceutil/trace.go:171","msg":"trace[1761764792] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:20578; }","duration":"402.435941ms","start":"2026-10-16T00:47:39.424802Z","end":"2026-10-16T00:47:39.827238Z","steps":["trace[1761764792] 'agreement among raft nodes before linearized reading' (duration: 400.993384ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:47:39.827526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:47:39.42479Z","time spent":"402.665866ms","remote":"127.0.0.1:42446","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":"warn","ts":"2026-10-16T00:47:40.134879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.792491ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-16T00:47:40.135009Z","caller":"traceutil/trace.go:171","msg":"trace[566130976] transaction","detail":"{read_only:false; response_revision:20579; number_of_response:1; }","duration":"358.105969ms","start":"2026-10-16T00:47:39.776881Z","end":"2026-10-16T00:47:40.134987Z","steps":["trace[566130976] 'process raft request' (duration: 218.067804ms)","trace[566130976] 'compare' (duration: 139.636648ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T00:47:40.135071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:47:39.776853Z","time spent":"358.187671ms","remote":"127.0.0.1:42446","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-10-16T00:47:40.144486Z","caller":"traceutil/trace.go:171","msg":"trace[898710493] transaction","detail":"{read_only:false; response_revision:20580; number_of_response:1; }","duration":"310.084759ms","start":"2026-10-16T00:47:39.834368Z","end":"2026-10-16T00:47:40.144453Z","steps":["trace[898710493] 'process raft request' (duration: 309.854296ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:47:40.144684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:47:39.834341Z","time spent":"310.237222ms","remote":"127.0.0.1:42446","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-10-16T00:47:40.144966Z","caller":"traceutil/trace.go:171","msg":"trace[1647195601] transaction","detail":"{read_only:false; response_revision:20581; number_of_response:1; }","duration":"308.537381ms","start":"2026-10-16T00:47:39.836397Z","end":"2026-10-16T00:47:40.144934Z","steps":["trace[1647195601] 'process raft request' (duration: 307.99288ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:47:40.145095Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:47:39.836353Z","time spent":"308.680153ms","remote":"127.0.0.1:42446","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-10-16T00:47:40.931935Z","caller":"traceutil/trace.go:171","msg":"trace[1435040405] transaction","detail":"{read_only:false; response_revision:20583; number_of_response:1; }","duration":"234.20637ms","start":"2026-10-16T00:47:40.6977Z","end":"2026-10-16T00:47:40.931906Z","steps":["trace[1435040405] 'process raft request' (duration: 234.015597ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:51:02.885972Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20016} {"level":"info","ts":"2026-10-16T00:51:03.010321Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20016,"took":"121.422931ms","hash":3451900533,"current-db-size-bytes":54460416,"current-db-size":"54 MB","current-db-size-in-use-bytes":30838784,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-16T00:51:03.010398Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3451900533,"revision":20016,"compact-revision":17498} {"level":"info","ts":"2026-10-16T00:51:32.616816Z","caller":"traceutil/trace.go:171","msg":"trace[1028688805] transaction","detail":"{read_only:false; response_revision:23008; number_of_response:1; }","duration":"288.813883ms","start":"2026-10-16T00:51:32.327972Z","end":"2026-10-16T00:51:32.616785Z","steps":["trace[1028688805] 'process raft request' (duration: 287.297004ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:51:32.649244Z","caller":"traceutil/trace.go:171","msg":"trace[168879304] transaction","detail":"{read_only:false; response_revision:23009; number_of_response:1; }","duration":"262.96164ms","start":"2026-10-16T00:51:32.38624Z","end":"2026-10-16T00:51:32.649201Z","steps":["trace[168879304] 'process raft request' (duration: 262.751306ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:53:01.496912Z","caller":"traceutil/trace.go:171","msg":"trace[1350790824] transaction","detail":"{read_only:false; response_revision:23960; number_of_response:1; }","duration":"109.656456ms","start":"2026-10-16T00:53:01.387228Z","end":"2026-10-16T00:53:01.496885Z","steps":["trace[1350790824] 'process raft request' (duration: 109.278159ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:54:57.333809Z","caller":"traceutil/trace.go:171","msg":"trace[1505978745] linearizableReadLoop","detail":"{readStateIndex:25856; appliedIndex:25855; }","duration":"118.399305ms","start":"2026-10-16T00:54:57.215383Z","end":"2026-10-16T00:54:57.333783Z","steps":["trace[1505978745] 'read index received' (duration: 118.189082ms)","trace[1505978745] 'applied index is now lower than readState.Index' (duration: 208.993µs)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:54:57.333885Z","caller":"traceutil/trace.go:171","msg":"trace[601277167] transaction","detail":"{read_only:false; response_revision:25026; number_of_response:1; }","duration":"182.133171ms","start":"2026-10-16T00:54:57.151722Z","end":"2026-10-16T00:54:57.333855Z","steps":["trace[601277167] 'process raft request' (duration: 181.876197ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:54:57.334084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.68819ms","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-10-16T00:54:57.334166Z","caller":"traceutil/trace.go:171","msg":"trace[1920193601] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25026; }","duration":"118.788462ms","start":"2026-10-16T00:54:57.215328Z","end":"2026-10-16T00:54:57.334117Z","steps":["trace[1920193601] 'agreement among raft nodes before linearized reading' (duration: 118.597269ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:54:57.675855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.231833ms","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-10-16T00:54:57.675967Z","caller":"traceutil/trace.go:171","msg":"trace[257086760] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:25026; }","duration":"217.449327ms","start":"2026-10-16T00:54:57.458492Z","end":"2026-10-16T00:54:57.675941Z","steps":["trace[257086760] 'range keys from in-memory index tree' (duration: 217.138171ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:54:57.67596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.318194ms","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-10-16T00:54:57.676073Z","caller":"traceutil/trace.go:171","msg":"trace[1438107031] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25026; }","duration":"217.473827ms","start":"2026-10-16T00:54:57.45858Z","end":"2026-10-16T00:54:57.676054Z","steps":["trace[1438107031] 'range keys from in-memory index tree' (duration: 217.166621ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:54:58.009581Z","caller":"traceutil/trace.go:171","msg":"trace[796639294] transaction","detail":"{read_only:false; response_revision:25027; number_of_response:1; }","duration":"530.045405ms","start":"2026-10-16T00:54:57.479505Z","end":"2026-10-16T00:54:58.009551Z","steps":["trace[796639294] 'process raft request' (duration: 529.888972ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:54:58.010127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:54:57.479481Z","time spent":"530.181747ms","remote":"127.0.0.1:42446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-16T00:54:58.050626Z","caller":"traceutil/trace.go:171","msg":"trace[1636275460] linearizableReadLoop","detail":"{readStateIndex:25858; appliedIndex:25856; }","duration":"423.354033ms","start":"2026-10-16T00:54:57.62725Z","end":"2026-10-16T00:54:58.050604Z","steps":["trace[1636275460] 'read index received' (duration: 382.21395ms)","trace[1636275460] 'applied index is now lower than readState.Index' (duration: 41.138933ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:54:58.050842Z","caller":"traceutil/trace.go:171","msg":"trace[83830206] transaction","detail":"{read_only:false; response_revision:25028; number_of_response:1; }","duration":"436.543104ms","start":"2026-10-16T00:54:57.614288Z","end":"2026-10-16T00:54:58.050831Z","steps":["trace[83830206] 'process raft request' (duration: 436.152987ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:54:58.050915Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:54:57.614261Z","time spent":"436.613126ms","remote":"127.0.0.1:42446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-16T00:54:58.051082Z","caller":"traceutil/trace.go:171","msg":"trace[1455144524] transaction","detail":"{read_only:false; response_revision:25029; number_of_response:1; }","duration":"406.924783ms","start":"2026-10-16T00:54:57.644148Z","end":"2026-10-16T00:54:58.051073Z","steps":["trace[1455144524] 'process raft request' (duration: 406.383782ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:54:58.051145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:54:57.644121Z","time spent":"406.992113ms","remote":"127.0.0.1:42446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-16T00:54:58.05126Z","caller":"traceutil/trace.go:171","msg":"trace[163446151] transaction","detail":"{read_only:false; response_revision:25030; number_of_response:1; }","duration":"371.430773ms","start":"2026-10-16T00:54:57.679821Z","end":"2026-10-16T00:54:58.051252Z","steps":["trace[163446151] 'process raft request' (duration: 370.7458ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:54:58.051313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:54:57.679804Z","time spent":"371.483345ms","remote":"127.0.0.1:42446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-16T00:54:58.051404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.150168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/networks/\" range_end:\"/registry/openstack.k-orc.cloud/networks0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-16T00:54:58.05144Z","caller":"traceutil/trace.go:171","msg":"trace[1445022146] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/networks/; range_end:/registry/openstack.k-orc.cloud/networks0; response_count:0; response_revision:25030; }","duration":"424.28564ms","start":"2026-10-16T00:54:57.627144Z","end":"2026-10-16T00:54:58.05143Z","steps":["trace[1445022146] 'agreement among raft nodes before linearized reading' (duration: 424.228729ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:54:58.051473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:54:57.627123Z","time spent":"424.343001ms","remote":"127.0.0.1:47862","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":29,"request content":"key:\"/registry/openstack.k-orc.cloud/networks/\" range_end:\"/registry/openstack.k-orc.cloud/networks0\" count_only:true "} {"level":"warn","ts":"2026-10-16T00:54:58.051636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.113181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/domains/\" range_end:\"/registry/openstack.k-orc.cloud/domains0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-16T00:54:58.051672Z","caller":"traceutil/trace.go:171","msg":"trace[785540571] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/domains/; range_end:/registry/openstack.k-orc.cloud/domains0; response_count:0; response_revision:25030; }","duration":"393.171982ms","start":"2026-10-16T00:54:57.658492Z","end":"2026-10-16T00:54:58.051664Z","steps":["trace[785540571] 'agreement among raft nodes before linearized reading' (duration: 393.121011ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:54:58.051699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:54:57.658481Z","time spent":"393.208412ms","remote":"127.0.0.1:48040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":29,"request content":"key:\"/registry/openstack.k-orc.cloud/domains/\" range_end:\"/registry/openstack.k-orc.cloud/domains0\" count_only:true "} {"level":"warn","ts":"2026-10-16T00:54:58.051907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.556813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-16T00:54:58.051945Z","caller":"traceutil/trace.go:171","msg":"trace[2039499501] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:25030; }","duration":"250.635515ms","start":"2026-10-16T00:54:57.8013Z","end":"2026-10-16T00:54:58.051935Z","steps":["trace[2039499501] 'agreement among raft nodes before linearized reading' (duration: 250.576123ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:54:58.052173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.681827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-16T00:54:58.052497Z","caller":"traceutil/trace.go:171","msg":"trace[351953215] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:25030; }","duration":"373.037824ms","start":"2026-10-16T00:54:57.679441Z","end":"2026-10-16T00:54:58.052479Z","steps":["trace[351953215] 'agreement among raft nodes before linearized reading' (duration: 372.690417ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:54:58.052542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:54:57.679421Z","time spent":"373.109205ms","remote":"127.0.0.1:42374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":29,"request content":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" "} {"level":"info","ts":"2026-10-16T00:54:58.545552Z","caller":"traceutil/trace.go:171","msg":"trace[1827024982] transaction","detail":"{read_only:false; response_revision:25031; number_of_response:1; }","duration":"429.258882ms","start":"2026-10-16T00:54:58.116259Z","end":"2026-10-16T00:54:58.545518Z","steps":["trace[1827024982] 'process raft request' (duration: 382.964554ms)","trace[1827024982] 'compare' (duration: 45.560004ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T00:54:58.545712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:54:58.116219Z","time spent":"429.407495ms","remote":"127.0.0.1:42446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":496,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-16T00:54:58.751087Z","caller":"traceutil/trace.go:171","msg":"trace[1833074494] linearizableReadLoop","detail":"{readStateIndex:25862; appliedIndex:25860; }","duration":"584.093473ms","start":"2026-10-16T00:54:58.166952Z","end":"2026-10-16T00:54:58.751045Z","steps":["trace[1833074494] 'read index received' (duration: 332.302688ms)","trace[1833074494] 'applied index is now lower than readState.Index' (duration: 251.789175ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:54:58.751168Z","caller":"traceutil/trace.go:171","msg":"trace[726715998] transaction","detail":"{read_only:false; response_revision:25032; number_of_response:1; }","duration":"597.247474ms","start":"2026-10-16T00:54:58.15389Z","end":"2026-10-16T00:54:58.751138Z","steps":["trace[726715998] 'process raft request' (duration: 594.926952ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:54:58.751349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:54:58.15387Z","time spent":"597.372096ms","remote":"127.0.0.1:42446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-16T00:54:58.75138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"584.365838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-16T00:54:58.751518Z","caller":"traceutil/trace.go:171","msg":"trace[1906614633] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25032; }","duration":"584.607152ms","start":"2026-10-16T00:54:58.166881Z","end":"2026-10-16T00:54:58.751488Z","steps":["trace[1906614633] 'agreement among raft nodes before linearized reading' (duration: 584.362048ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:54:58.751583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:54:58.166871Z","time spent":"584.700584ms","remote":"127.0.0.1:42182","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-10-16T00:54:58.763186Z","caller":"traceutil/trace.go:171","msg":"trace[41215354] transaction","detail":"{read_only:false; response_revision:25033; number_of_response:1; }","duration":"194.519008ms","start":"2026-10-16T00:54:58.568642Z","end":"2026-10-16T00:54:58.763161Z","steps":["trace[41215354] 'process raft request' (duration: 194.339495ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:54:58.76349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"490.310098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1782"} {"level":"info","ts":"2026-10-16T00:54:58.763544Z","caller":"traceutil/trace.go:171","msg":"trace[1553921609] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:25034; }","duration":"490.38999ms","start":"2026-10-16T00:54:58.273139Z","end":"2026-10-16T00:54:58.763529Z","steps":["trace[1553921609] 'agreement among raft nodes before linearized reading' (duration: 490.192606ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:54:58.763575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:54:58.273121Z","time spent":"490.447401ms","remote":"127.0.0.1:42334","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":1805,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" "} {"level":"warn","ts":"2026-10-16T00:54:58.763638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.770518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-10-16T00:54:58.76373Z","caller":"traceutil/trace.go:171","msg":"trace[1633926156] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25034; }","duration":"243.904561ms","start":"2026-10-16T00:54:58.5198Z","end":"2026-10-16T00:54:58.763705Z","steps":["trace[1633926156] 'agreement among raft nodes before linearized reading' (duration: 243.637616ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:54:58.763954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.364587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-10-16T00:54:58.763996Z","caller":"traceutil/trace.go:171","msg":"trace[306135848] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25034; }","duration":"187.461608ms","start":"2026-10-16T00:54:58.576522Z","end":"2026-10-16T00:54:58.763984Z","steps":["trace[306135848] 'agreement among raft nodes before linearized reading' (duration: 187.347696ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:55:04.095802Z","caller":"traceutil/trace.go:171","msg":"trace[436459087] transaction","detail":"{read_only:false; response_revision:25085; number_of_response:1; }","duration":"128.601522ms","start":"2026-10-16T00:55:03.967172Z","end":"2026-10-16T00:55:04.095774Z","steps":["trace[436459087] 'process raft request' (duration: 111.094092ms)","trace[436459087] 'compare' (duration: 17.268306ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:55:04.095919Z","caller":"traceutil/trace.go:171","msg":"trace[630745874] transaction","detail":"{read_only:false; response_revision:25086; number_of_response:1; }","duration":"123.708023ms","start":"2026-10-16T00:55:03.97218Z","end":"2026-10-16T00:55:04.095888Z","steps":["trace[630745874] 'process raft request' (duration: 123.462419ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:55:04.740343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.480463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/policies/\" range_end:\"/registry/rabbitmq.com/policies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-16T00:55:04.74043Z","caller":"traceutil/trace.go:171","msg":"trace[2117866405] range","detail":"{range_begin:/registry/rabbitmq.com/policies/; range_end:/registry/rabbitmq.com/policies0; response_count:0; response_revision:25094; }","duration":"103.624755ms","start":"2026-10-16T00:55:04.636785Z","end":"2026-10-16T00:55:04.740409Z","steps":["trace[2117866405] 'count revisions from in-memory index tree' (duration: 103.365071ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:55:04.740611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.081213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-16T00:55:04.740699Z","caller":"traceutil/trace.go:171","msg":"trace[712429114] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0; response_count:0; response_revision:25094; }","duration":"128.265277ms","start":"2026-10-16T00:55:04.612414Z","end":"2026-10-16T00:55:04.740679Z","steps":["trace[712429114] 'range keys from in-memory index tree' (duration: 127.953271ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:55:58.550417Z","caller":"traceutil/trace.go:171","msg":"trace[418343597] transaction","detail":"{read_only:false; response_revision:25602; number_of_response:1; }","duration":"209.337021ms","start":"2026-10-16T00:55:58.341042Z","end":"2026-10-16T00:55:58.550379Z","steps":["trace[418343597] 'process raft request' (duration: 209.119677ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:55:58.565204Z","caller":"traceutil/trace.go:171","msg":"trace[532897736] linearizableReadLoop","detail":"{readStateIndex:26448; appliedIndex:26445; }","duration":"151.991921ms","start":"2026-10-16T00:55:58.413188Z","end":"2026-10-16T00:55:58.56518Z","steps":["trace[532897736] 'read index received' (duration: 137.012638ms)","trace[532897736] 'applied index is now lower than readState.Index' (duration: 14.978093ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:55:58.565244Z","caller":"traceutil/trace.go:171","msg":"trace[1926754836] transaction","detail":"{read_only:false; response_revision:25603; number_of_response:1; }","duration":"219.729851ms","start":"2026-10-16T00:55:58.345489Z","end":"2026-10-16T00:55:58.565219Z","steps":["trace[1926754836] 'process raft request' (duration: 219.510758ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:55:58.565468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.250646ms","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-10-16T00:55:58.565448Z","caller":"traceutil/trace.go:171","msg":"trace[1236264863] transaction","detail":"{read_only:false; response_revision:25604; number_of_response:1; }","duration":"219.428185ms","start":"2026-10-16T00:55:58.345868Z","end":"2026-10-16T00:55:58.565296Z","steps":["trace[1236264863] 'process raft request' (duration: 219.266412ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:55:58.565515Z","caller":"traceutil/trace.go:171","msg":"trace[401473236] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25604; }","duration":"152.363528ms","start":"2026-10-16T00:55:58.413138Z","end":"2026-10-16T00:55:58.565502Z","steps":["trace[401473236] 'agreement among raft nodes before linearized reading' (duration: 152.154544ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:56:02.895311Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":22239} {"level":"info","ts":"2026-10-16T00:56:03.01324Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":22239,"took":"113.529398ms","hash":3479380884,"current-db-size-bytes":56999936,"current-db-size":"57 MB","current-db-size-in-use-bytes":44941312,"current-db-size-in-use":"45 MB"} {"level":"info","ts":"2026-10-16T00:56:03.01333Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3479380884,"revision":22239,"compact-revision":20016} {"level":"info","ts":"2026-10-16T00:56:04.303494Z","caller":"traceutil/trace.go:171","msg":"trace[827430645] linearizableReadLoop","detail":"{readStateIndex:26490; appliedIndex:26489; }","duration":"253.215914ms","start":"2026-10-16T00:56:04.050244Z","end":"2026-10-16T00:56:04.30346Z","steps":["trace[827430645] 'read index received' (duration: 253.130673ms)","trace[827430645] 'applied index is now lower than readState.Index' (duration: 84.011µs)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:56:04.303797Z","caller":"traceutil/trace.go:171","msg":"trace[1360517481] transaction","detail":"{read_only:false; response_revision:25644; number_of_response:1; }","duration":"499.057224ms","start":"2026-10-16T00:56:03.804695Z","end":"2026-10-16T00:56:04.303753Z","steps":["trace[1360517481] 'process raft request' (duration: 498.485993ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:56:04.303967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.698154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/sshkeys/\" range_end:\"/registry/secretgen.k14s.io/sshkeys0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-10-16T00:56:04.304009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:56:03.804663Z","time spent":"499.238958ms","remote":"127.0.0.1:42446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-16T00:56:04.304037Z","caller":"traceutil/trace.go:171","msg":"trace[326504884] range","detail":"{range_begin:/registry/secretgen.k14s.io/sshkeys/; range_end:/registry/secretgen.k14s.io/sshkeys0; response_count:0; response_revision:25644; }","duration":"253.830926ms","start":"2026-10-16T00:56:04.050189Z","end":"2026-10-16T00:56:04.30402Z","steps":["trace[326504884] 'agreement among raft nodes before linearized reading' (duration: 253.689503ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:56:04.354606Z","caller":"traceutil/trace.go:171","msg":"trace[1723996734] transaction","detail":"{read_only:false; response_revision:25645; number_of_response:1; }","duration":"148.843754ms","start":"2026-10-16T00:56:04.205723Z","end":"2026-10-16T00:56:04.354566Z","steps":["trace[1723996734] 'process raft request' (duration: 148.651251ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:56:04.355351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.863324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-10-16T00:56:04.355401Z","caller":"traceutil/trace.go:171","msg":"trace[1164602753] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:25645; }","duration":"113.994406ms","start":"2026-10-16T00:56:04.241394Z","end":"2026-10-16T00:56:04.355389Z","steps":["trace[1164602753] 'agreement among raft nodes before linearized reading' (duration: 113.883344ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:56:04.355692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.058575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-16T00:56:04.355733Z","caller":"traceutil/trace.go:171","msg":"trace[6183908] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:25645; }","duration":"186.129776ms","start":"2026-10-16T00:56:04.169593Z","end":"2026-10-16T00:56:04.355723Z","steps":["trace[6183908] 'agreement among raft nodes before linearized reading' (duration: 186.064754ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:56:04.355995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.413353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machines/\" range_end:\"/registry/cluster.x-k8s.io/machines0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-16T00:56:04.356034Z","caller":"traceutil/trace.go:171","msg":"trace[1629660715] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machines/; range_end:/registry/cluster.x-k8s.io/machines0; response_count:0; response_revision:25645; }","duration":"274.510714ms","start":"2026-10-16T00:56:04.081512Z","end":"2026-10-16T00:56:04.356023Z","steps":["trace[1629660715] 'agreement among raft nodes before linearized reading' (duration: 274.447593ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:56:04.653978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.703449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/volumes/\" range_end:\"/registry/openstack.k-orc.cloud/volumes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-16T00:56:04.654116Z","caller":"traceutil/trace.go:171","msg":"trace[1345279348] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/volumes/; range_end:/registry/openstack.k-orc.cloud/volumes0; response_count:0; response_revision:25645; }","duration":"321.903232ms","start":"2026-10-16T00:56:04.332182Z","end":"2026-10-16T00:56:04.654085Z","steps":["trace[1345279348] 'agreement among raft nodes before linearized reading' (duration: 24.373627ms)","trace[1345279348] 'count revisions from in-memory index tree' (duration: 297.355383ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T00:56:04.654188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:56:04.332155Z","time spent":"322.019264ms","remote":"127.0.0.1:47902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":29,"request content":"key:\"/registry/openstack.k-orc.cloud/volumes/\" range_end:\"/registry/openstack.k-orc.cloud/volumes0\" count_only:true "} {"level":"info","ts":"2026-10-16T00:56:04.881809Z","caller":"traceutil/trace.go:171","msg":"trace[2017364069] linearizableReadLoop","detail":"{readStateIndex:26494; appliedIndex:26491; }","duration":"286.010235ms","start":"2026-10-16T00:56:04.595742Z","end":"2026-10-16T00:56:04.881752Z","steps":["trace[2017364069] 'read index received' (duration: 69.34022ms)","trace[2017364069] 'applied index is now lower than readState.Index' (duration: 216.668295ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:56:04.88199Z","caller":"traceutil/trace.go:171","msg":"trace[1685912560] transaction","detail":"{read_only:false; response_revision:25648; number_of_response:1; }","duration":"293.385209ms","start":"2026-10-16T00:56:04.588571Z","end":"2026-10-16T00:56:04.881957Z","steps":["trace[1685912560] 'process raft request' (duration: 293.108024ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:56:04.882298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.528655ms","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-10-16T00:56:04.882361Z","caller":"traceutil/trace.go:171","msg":"trace[1258526992] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25648; }","duration":"286.651558ms","start":"2026-10-16T00:56:04.595695Z","end":"2026-10-16T00:56:04.882347Z","steps":["trace[1258526992] 'agreement among raft nodes before linearized reading' (duration: 286.343032ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:56:04.881843Z","caller":"traceutil/trace.go:171","msg":"trace[2077285051] transaction","detail":"{read_only:false; response_revision:25647; number_of_response:1; }","duration":"295.786793ms","start":"2026-10-16T00:56:04.586001Z","end":"2026-10-16T00:56:04.881788Z","steps":["trace[2077285051] 'process raft request' (duration: 286.097316ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:56:05.150953Z","caller":"traceutil/trace.go:171","msg":"trace[982287547] linearizableReadLoop","detail":"{readStateIndex:26495; appliedIndex:26494; }","duration":"268.599826ms","start":"2026-10-16T00:56:04.882314Z","end":"2026-10-16T00:56:05.150914Z","steps":["trace[982287547] 'read index received' (duration: 268.29695ms)","trace[982287547] 'applied index is now lower than readState.Index' (duration: 300.956µs)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:56:05.151421Z","caller":"traceutil/trace.go:171","msg":"trace[93682103] transaction","detail":"{read_only:false; response_revision:25649; number_of_response:1; }","duration":"317.305038ms","start":"2026-10-16T00:56:04.834092Z","end":"2026-10-16T00:56:05.151397Z","steps":["trace[93682103] 'process raft request' (duration: 316.566284ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:56:05.151595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:56:04.834045Z","time spent":"317.42264ms","remote":"127.0.0.1:42446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-16T00:56:05.151849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.908261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-10-16T00:56:05.151947Z","caller":"traceutil/trace.go:171","msg":"trace[199166042] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:25649; }","duration":"470.054174ms","start":"2026-10-16T00:56:04.681866Z","end":"2026-10-16T00:56:05.15192Z","steps":["trace[199166042] 'agreement among raft nodes before linearized reading' (duration: 469.772069ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:56:05.151994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:56:04.681844Z","time spent":"470.139085ms","remote":"127.0.0.1:42348","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":91,"response size":31,"request content":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true "} {"level":"warn","ts":"2026-10-16T00:56:05.152577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.580533ms","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-10-16T00:56:05.152738Z","caller":"traceutil/trace.go:171","msg":"trace[1002496917] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25649; }","duration":"493.819028ms","start":"2026-10-16T00:56:04.658869Z","end":"2026-10-16T00:56:05.152688Z","steps":["trace[1002496917] 'agreement among raft nodes before linearized reading' (duration: 492.948023ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:56:05.152902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:56:04.658848Z","time spent":"494.041092ms","remote":"127.0.0.1:42358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12240,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-10-16T00:56:05.468115Z","caller":"traceutil/trace.go:171","msg":"trace[246119990] transaction","detail":"{read_only:false; response_revision:25651; number_of_response:1; }","duration":"448.56701ms","start":"2026-10-16T00:56:05.019507Z","end":"2026-10-16T00:56:05.468075Z","steps":["trace[246119990] 'process raft request' (duration: 448.380677ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:56:05.468155Z","caller":"traceutil/trace.go:171","msg":"trace[1774047989] transaction","detail":"{read_only:false; response_revision:25650; number_of_response:1; }","duration":"576.690525ms","start":"2026-10-16T00:56:04.891383Z","end":"2026-10-16T00:56:05.468074Z","steps":["trace[1774047989] 'process raft request' (duration: 503.513476ms)","trace[1774047989] 'compare' (duration: 72.625429ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:56:05.468248Z","caller":"traceutil/trace.go:171","msg":"trace[11214333] transaction","detail":"{read_only:false; response_revision:25652; number_of_response:1; }","duration":"446.224838ms","start":"2026-10-16T00:56:05.021999Z","end":"2026-10-16T00:56:05.468224Z","steps":["trace[11214333] 'process raft request' (duration: 446.008254ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:56:05.468985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:56:04.891356Z","time spent":"577.544719ms","remote":"127.0.0.1:42446","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-10-16T00:56:05.468251Z","caller":"traceutil/trace.go:171","msg":"trace[1451741452] linearizableReadLoop","detail":"{readStateIndex:26499; appliedIndex:26495; }","duration":"317.136385ms","start":"2026-10-16T00:56:05.151089Z","end":"2026-10-16T00:56:05.468225Z","steps":["trace[1451741452] 'read index received' (duration: 243.65961ms)","trace[1451741452] 'applied index is now lower than readState.Index' (duration: 73.475635ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T00:56:05.468394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"490.056429ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-16T00:56:05.469175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:56:05.02196Z","time spent":"447.058473ms","remote":"127.0.0.1:42446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-16T00:56:05.469231Z","caller":"traceutil/trace.go:171","msg":"trace[179726699] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0; response_count:0; response_revision:25653; }","duration":"490.893884ms","start":"2026-10-16T00:56:04.978303Z","end":"2026-10-16T00:56:05.469197Z","steps":["trace[179726699] 'agreement among raft nodes before linearized reading' (duration: 490.000778ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:56:05.469288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:56:04.978231Z","time spent":"491.036536ms","remote":"127.0.0.1:59204","response type":"/etcdserverpb.KV/Range","request count":0,"request size":152,"response count":0,"response size":29,"request content":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" "} {"level":"info","ts":"2026-10-16T00:56:05.468365Z","caller":"traceutil/trace.go:171","msg":"trace[372355443] transaction","detail":"{read_only:false; response_revision:25653; number_of_response:1; }","duration":"402.046189ms","start":"2026-10-16T00:56:05.066288Z","end":"2026-10-16T00:56:05.468334Z","steps":["trace[372355443] 'process raft request' (duration: 401.846105ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:56:05.468975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:56:05.019489Z","time spent":"449.302703ms","remote":"127.0.0.1:42446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-16T00:56:05.469409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.418968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-16T00:56:05.469468Z","caller":"traceutil/trace.go:171","msg":"trace[1865046871] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:25653; }","duration":"277.490389ms","start":"2026-10-16T00:56:05.191954Z","end":"2026-10-16T00:56:05.469444Z","steps":["trace[1865046871] 'agreement among raft nodes before linearized reading' (duration: 277.403657ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:56:05.469502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.507655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:19232"} {"level":"warn","ts":"2026-10-16T00:56:05.468424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.413683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-16T00:56:05.469596Z","caller":"traceutil/trace.go:171","msg":"trace[1915886695] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:25653; }","duration":"314.659089ms","start":"2026-10-16T00:56:05.154909Z","end":"2026-10-16T00:56:05.469569Z","steps":["trace[1915886695] 'agreement among raft nodes before linearized reading' (duration: 314.384054ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:56:05.469474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.151614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-10-16T00:56:05.469612Z","caller":"traceutil/trace.go:171","msg":"trace[908119220] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25653; }","duration":"387.659975ms","start":"2026-10-16T00:56:05.081917Z","end":"2026-10-16T00:56:05.469577Z","steps":["trace[908119220] 'agreement among raft nodes before linearized reading' (duration: 386.379482ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:56:05.469653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:56:05.154884Z","time spent":"314.75623ms","remote":"127.0.0.1:42354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":19255,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-10-16T00:56:05.469656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.061828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-10-16T00:56:05.46975Z","caller":"traceutil/trace.go:171","msg":"trace[1904483810] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25653; }","duration":"314.192551ms","start":"2026-10-16T00:56:05.155544Z","end":"2026-10-16T00:56:05.469737Z","steps":["trace[1904483810] 'agreement among raft nodes before linearized reading' (duration: 313.854905ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:56:05.469788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.893734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0\" ","response":"range_response_count:1 size:1634"} {"level":"info","ts":"2026-10-16T00:56:05.469835Z","caller":"traceutil/trace.go:171","msg":"trace[517603156] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0; range_end:; response_count:1; response_revision:25653; }","duration":"243.962495ms","start":"2026-10-16T00:56:05.22586Z","end":"2026-10-16T00:56:05.469822Z","steps":["trace[517603156] 'agreement among raft nodes before linearized reading' (duration: 243.470585ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:56:05.469673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:56:05.08189Z","time spent":"387.768457ms","remote":"127.0.0.1:42182","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-16T00:56:05.469936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.209383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"warn","ts":"2026-10-16T00:56:05.469794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:56:05.155525Z","time spent":"314.259542ms","remote":"127.0.0.1:42446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-10-16T00:56:05.469949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:56:05.066257Z","time spent":"403.153869ms","remote":"127.0.0.1:42446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-16T00:56:05.469982Z","caller":"traceutil/trace.go:171","msg":"trace[260648734] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25653; }","duration":"272.293334ms","start":"2026-10-16T00:56:05.197675Z","end":"2026-10-16T00:56:05.469968Z","steps":["trace[260648734] 'agreement among raft nodes before linearized reading' (duration: 271.632422ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:56:05.469658Z","caller":"traceutil/trace.go:171","msg":"trace[1907621498] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25653; }","duration":"270.352227ms","start":"2026-10-16T00:56:05.19929Z","end":"2026-10-16T00:56:05.469642Z","steps":["trace[1907621498] 'agreement among raft nodes before linearized reading' (duration: 270.058822ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:56:05.471515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.389713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-10-16T00:56:05.471713Z","caller":"traceutil/trace.go:171","msg":"trace[142397015] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25653; }","duration":"328.309538ms","start":"2026-10-16T00:56:05.143307Z","end":"2026-10-16T00:56:05.471617Z","steps":["trace[142397015] 'agreement among raft nodes before linearized reading' (duration: 324.948087ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:56:05.471965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:56:05.143288Z","time spent":"328.664985ms","remote":"127.0.0.1:42446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-10-16T00:57:33.606554Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006adf.wal"} {"level":"info","ts":"2026-10-16T01:00:03.866081Z","caller":"traceutil/trace.go:171","msg":"trace[1428000383] transaction","detail":"{read_only:false; response_revision:28051; number_of_response:1; }","duration":"115.733217ms","start":"2026-10-16T01:00:03.750316Z","end":"2026-10-16T01:00:03.86605Z","steps":["trace[1428000383] 'process raft request' (duration: 87.116074ms)","trace[1428000383] 'compare' (duration: 28.245367ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T01:01:02.901668Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25635} {"level":"info","ts":"2026-10-16T01:01:03.074825Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25635,"took":"168.494745ms","hash":503654111,"current-db-size-bytes":58597376,"current-db-size":"59 MB","current-db-size-in-use-bytes":36175872,"current-db-size-in-use":"36 MB"} {"level":"info","ts":"2026-10-16T01:01:03.074896Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":503654111,"revision":25635,"compact-revision":22239} {"level":"info","ts":"2026-10-16T01:02:11.777449Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"83287f3a81241ad4","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-16T01:02:11.785369Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-10-16T01:02:11.785492Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-10-16T01:06:02.909565Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28562} {"level":"info","ts":"2026-10-16T01:06:03.066942Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28562,"took":"152.444036ms","hash":2882985655,"current-db-size-bytes":58597376,"current-db-size":"59 MB","current-db-size-in-use-bytes":31150080,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-16T01:06:03.067004Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2882985655,"revision":28562,"compact-revision":25635} {"level":"info","ts":"2026-10-16T01:11:02.928123Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30812} {"level":"info","ts":"2026-10-16T01:11:03.080896Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30812,"took":"148.675226ms","hash":1741911723,"current-db-size-bytes":58597376,"current-db-size":"59 MB","current-db-size-in-use-bytes":30507008,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-10-16T01:11:03.080964Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1741911723,"revision":30812,"compact-revision":28562} {"level":"info","ts":"2026-10-16T01:16:02.934865Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33073} {"level":"info","ts":"2026-10-16T01:16:03.097206Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33073,"took":"156.55479ms","hash":2012849700,"current-db-size-bytes":58597376,"current-db-size":"59 MB","current-db-size-in-use-bytes":31145984,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-16T01:16:03.097279Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2012849700,"revision":33073,"compact-revision":30812} {"level":"info","ts":"2026-10-16T01:21:02.944402Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35369} {"level":"info","ts":"2026-10-16T01:21:03.079363Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35369,"took":"130.595035ms","hash":3464380062,"current-db-size-bytes":58597376,"current-db-size":"59 MB","current-db-size-in-use-bytes":33075200,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-10-16T01:21:03.079532Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3464380062,"revision":35369,"compact-revision":33073} {"level":"info","ts":"2026-10-16T01:23:39.472126Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"83287f3a81241ad4","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-16T01:23:39.479414Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-10-16T01:23:39.479536Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-10-16T01:26:02.957197Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37594} {"level":"info","ts":"2026-10-16T01:26:03.112873Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37594,"took":"152.267179ms","hash":1353355624,"current-db-size-bytes":59867136,"current-db-size":"60 MB","current-db-size-in-use-bytes":32927744,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-10-16T01:26:03.112945Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1353355624,"revision":37594,"compact-revision":35369}