{"level":"warn","ts":"2026-07-02T10:05:52.172422Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-02T10:05:52.172535Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.66:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.66:2380","--initial-cluster=instance=https://199.19.213.66:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.66:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.66:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-07-02T10:05:52.172673Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-02T10:05:52.172907Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.66:2380"]} {"level":"info","ts":"2026-07-02T10:05:52.172944Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-07-02T10:05:52.173791Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.66:2379"]} {"level":"info","ts":"2026-07-02T10:05:52.17388Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.66:2380"],"listen-peer-urls":["https://199.19.213.66:2380"],"advertise-client-urls":["https://199.19.213.66:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.66:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.66:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-07-02T10:05:52.177971Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.754694ms"} {"level":"info","ts":"2026-07-02T10:05:52.183357Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"dc35f804a62878ec","cluster-id":"ef5544f2dd66d370"} {"level":"info","ts":"2026-07-02T10:05:52.183433Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dc35f804a62878ec switched to configuration voters=()"} {"level":"info","ts":"2026-07-02T10:05:52.183456Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dc35f804a62878ec became follower at term 0"} {"level":"info","ts":"2026-07-02T10:05:52.183472Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft dc35f804a62878ec [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-02T10:05:52.183485Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dc35f804a62878ec became follower at term 1"} {"level":"info","ts":"2026-07-02T10:05:52.183527Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dc35f804a62878ec switched to configuration voters=(15867861560961038572)"} {"level":"warn","ts":"2026-07-02T10:05:52.188966Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-02T10:05:52.190525Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-02T10:05:52.191906Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-07-02T10:05:52.194659Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"dc35f804a62878ec","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-02T10:05:52.194874Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"dc35f804a62878ec","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-02T10:05:52.195068Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-02T10:05:52.195313Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-02T10:05:52.195393Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-02T10:05:52.197311Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dc35f804a62878ec switched to configuration voters=(15867861560961038572)"} {"level":"info","ts":"2026-07-02T10:05:52.197813Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ef5544f2dd66d370","local-member-id":"dc35f804a62878ec","added-peer-id":"dc35f804a62878ec","added-peer-peer-urls":["https://199.19.213.66:2380"]} {"level":"info","ts":"2026-07-02T10:05:52.200042Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-07-02T10:05:52.200204Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.66:2380"} {"level":"info","ts":"2026-07-02T10:05:52.200267Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.66:2380"} {"level":"info","ts":"2026-07-02T10:05:52.200412Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"dc35f804a62878ec","initial-advertise-peer-urls":["https://199.19.213.66:2380"],"listen-peer-urls":["https://199.19.213.66:2380"],"advertise-client-urls":["https://199.19.213.66:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.66:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-02T10:05:52.200498Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-02T10:05:53.084609Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dc35f804a62878ec is starting a new election at term 1"} {"level":"info","ts":"2026-07-02T10:05:53.084715Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dc35f804a62878ec became pre-candidate at term 1"} {"level":"info","ts":"2026-07-02T10:05:53.08476Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dc35f804a62878ec received MsgPreVoteResp from dc35f804a62878ec at term 1"} {"level":"info","ts":"2026-07-02T10:05:53.084775Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dc35f804a62878ec became candidate at term 2"} {"level":"info","ts":"2026-07-02T10:05:53.084782Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dc35f804a62878ec received MsgVoteResp from dc35f804a62878ec at term 2"} {"level":"info","ts":"2026-07-02T10:05:53.084792Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dc35f804a62878ec became leader at term 2"} {"level":"info","ts":"2026-07-02T10:05:53.084802Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: dc35f804a62878ec elected leader dc35f804a62878ec at term 2"} {"level":"info","ts":"2026-07-02T10:05:53.085687Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"dc35f804a62878ec","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.66:2379]}","request-path":"/0/members/dc35f804a62878ec/attributes","cluster-id":"ef5544f2dd66d370","publish-timeout":"7s"} {"level":"info","ts":"2026-07-02T10:05:53.085694Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-02T10:05:53.085694Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-02T10:05:53.085743Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-02T10:05:53.085974Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-02T10:05:53.086033Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-02T10:05:53.087104Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ef5544f2dd66d370","local-member-id":"dc35f804a62878ec","cluster-version":"3.5"} {"level":"info","ts":"2026-07-02T10:05:53.087206Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-02T10:05:53.087245Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-02T10:05:53.088362Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-02T10:05:53.089691Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.66:2379"} {"level":"info","ts":"2026-07-02T10:06:31.134667Z","caller":"traceutil/trace.go:171","msg":"trace[1507778190] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"182.606058ms","start":"2026-07-02T10:06:30.952029Z","end":"2026-07-02T10:06:31.134635Z","steps":["trace[1507778190] 'process raft request' (duration: 94.824656ms)","trace[1507778190] 'compare' (duration: 87.640619ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:06:31.141335Z","caller":"traceutil/trace.go:171","msg":"trace[1480951973] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"163.185945ms","start":"2026-07-02T10:06:30.978089Z","end":"2026-07-02T10:06:31.141275Z","steps":["trace[1480951973] 'process raft request' (duration: 158.668328ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:06:37.50849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.183425ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T10:06:37.508763Z","caller":"traceutil/trace.go:171","msg":"trace[218652551] linearizableReadLoop","detail":"{readStateIndex:654; appliedIndex:652; }","duration":"350.923322ms","start":"2026-07-02T10:06:37.157819Z","end":"2026-07-02T10:06:37.508742Z","steps":["trace[218652551] 'read index received' (duration: 65.793518ms)","trace[218652551] 'applied index is now lower than readState.Index' (duration: 285.128584ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:06:37.508932Z","caller":"traceutil/trace.go:171","msg":"trace[136897898] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"367.596623ms","start":"2026-07-02T10:06:37.14132Z","end":"2026-07-02T10:06:37.508917Z","steps":["trace[136897898] 'process raft request' (duration: 367.340977ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:06:37.508976Z","caller":"traceutil/trace.go:171","msg":"trace[1065800099] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"449.129575ms","start":"2026-07-02T10:06:37.059823Z","end":"2026-07-02T10:06:37.508953Z","steps":["trace[1065800099] 'process raft request' (duration: 163.692635ms)","trace[1065800099] 'compare' (duration: 284.069943ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:06:37.509019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:06:37.141251Z","time spent":"367.729236ms","remote":"127.0.0.1:42460","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1044,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-02T10:06:37.509174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:06:37.059797Z","time spent":"449.277447ms","remote":"127.0.0.1:42330","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T10:06:37.50924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.004118ms","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-07-02T10:06:37.509356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.536054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-07-02T10:06:37.509411Z","caller":"traceutil/trace.go:171","msg":"trace[1857838101] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:630; }","duration":"351.630225ms","start":"2026-07-02T10:06:37.157766Z","end":"2026-07-02T10:06:37.509396Z","steps":["trace[1857838101] 'agreement among raft nodes before linearized reading' (duration: 351.492222ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:06:37.509463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:06:37.157743Z","time spent":"351.711757ms","remote":"127.0.0.1:42392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-02T10:06:37.509378Z","caller":"traceutil/trace.go:171","msg":"trace[2088433927] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:630; }","duration":"343.172412ms","start":"2026-07-02T10:06:37.166184Z","end":"2026-07-02T10:06:37.509356Z","steps":["trace[2088433927] 'agreement among raft nodes before linearized reading' (duration: 342.775475ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:06:37.509571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:06:37.166171Z","time spent":"343.382836ms","remote":"127.0.0.1:42392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-02T10:06:37.642123Z","caller":"traceutil/trace.go:171","msg":"trace[1276417044] linearizableReadLoop","detail":"{readStateIndex:656; appliedIndex:655; }","duration":"121.670275ms","start":"2026-07-02T10:06:37.520418Z","end":"2026-07-02T10:06:37.642088Z","steps":["trace[1276417044] 'read index received' (duration: 77.809879ms)","trace[1276417044] 'applied index is now lower than readState.Index' (duration: 43.858196ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:06:37.642222Z","caller":"traceutil/trace.go:171","msg":"trace[1248103044] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"127.464406ms","start":"2026-07-02T10:06:37.514725Z","end":"2026-07-02T10:06:37.642189Z","steps":["trace[1248103044] 'process raft request' (duration: 102.127408ms)","trace[1248103044] 'compare' (duration: 25.087363ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:06:37.642318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.873228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T10:06:37.642365Z","caller":"traceutil/trace.go:171","msg":"trace[632611596] range","detail":"{range_begin:/registry/clusterroles/envoy-gateway-gateway-helm-certgen:envoy-gateway-system; range_end:; response_count:0; response_revision:632; }","duration":"121.95625ms","start":"2026-07-02T10:06:37.520393Z","end":"2026-07-02T10:06:37.64235Z","steps":["trace[632611596] 'agreement among raft nodes before linearized reading' (duration: 121.857938ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:06:53.69128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.500364ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-07-02T10:06:53.691373Z","caller":"traceutil/trace.go:171","msg":"trace[1955365539] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:799; }","duration":"184.641146ms","start":"2026-07-02T10:06:53.506712Z","end":"2026-07-02T10:06:53.691353Z","steps":["trace[1955365539] 'range keys from in-memory index tree' (duration: 184.353111ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:08:07.6054Z","caller":"traceutil/trace.go:171","msg":"trace[1140744192] linearizableReadLoop","detail":"{readStateIndex:1923; appliedIndex:1922; }","duration":"110.771367ms","start":"2026-07-02T10:08:07.494603Z","end":"2026-07-02T10:08:07.605374Z","steps":["trace[1140744192] 'read index received' (duration: 110.591384ms)","trace[1140744192] 'applied index is now lower than readState.Index' (duration: 179.023µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:08:07.605528Z","caller":"traceutil/trace.go:171","msg":"trace[36580923] transaction","detail":"{read_only:false; response_revision:1851; number_of_response:1; }","duration":"154.425872ms","start":"2026-07-02T10:08:07.451091Z","end":"2026-07-02T10:08:07.605517Z","steps":["trace[36580923] 'process raft request' (duration: 154.120296ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:08:07.605775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.162015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-3eed8305-432e-4f1a-9ce7-0169c61bf359\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-07-02T10:08:07.60582Z","caller":"traceutil/trace.go:171","msg":"trace[1672957790] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-3eed8305-432e-4f1a-9ce7-0169c61bf359; range_end:; response_count:1; response_revision:1851; }","duration":"111.254126ms","start":"2026-07-02T10:08:07.494555Z","end":"2026-07-02T10:08:07.605809Z","steps":["trace[1672957790] 'agreement among raft nodes before linearized reading' (duration: 111.097874ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:08:07.723946Z","caller":"traceutil/trace.go:171","msg":"trace[812097052] transaction","detail":"{read_only:false; response_revision:1852; number_of_response:1; }","duration":"161.822475ms","start":"2026-07-02T10:08:07.562095Z","end":"2026-07-02T10:08:07.723918Z","steps":["trace[812097052] 'process raft request' (duration: 111.38201ms)","trace[812097052] 'compare' (duration: 50.212551ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:08:07.724129Z","caller":"traceutil/trace.go:171","msg":"trace[1949618422] linearizableReadLoop","detail":"{readStateIndex:1925; appliedIndex:1923; }","duration":"118.615499ms","start":"2026-07-02T10:08:07.605479Z","end":"2026-07-02T10:08:07.724095Z","steps":["trace[1949618422] 'read index received' (duration: 68.013511ms)","trace[1949618422] 'applied index is now lower than readState.Index' (duration: 50.599998ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:08:07.724159Z","caller":"traceutil/trace.go:171","msg":"trace[1311851393] transaction","detail":"{read_only:false; response_revision:1853; number_of_response:1; }","duration":"137.757484ms","start":"2026-07-02T10:08:07.58639Z","end":"2026-07-02T10:08:07.724148Z","steps":["trace[1311851393] 'process raft request' (duration: 137.451728ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:08:07.724246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.211541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T10:08:07.724312Z","caller":"traceutil/trace.go:171","msg":"trace[738236924] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1853; }","duration":"139.314774ms","start":"2026-07-02T10:08:07.584982Z","end":"2026-07-02T10:08:07.724297Z","steps":["trace[738236924] 'agreement among raft nodes before linearized reading' (duration: 139.217592ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:08:07.761378Z","caller":"traceutil/trace.go:171","msg":"trace[448916601] transaction","detail":"{read_only:false; response_revision:1854; number_of_response:1; }","duration":"147.060032ms","start":"2026-07-02T10:08:07.61429Z","end":"2026-07-02T10:08:07.76135Z","steps":["trace[448916601] 'process raft request' (duration: 146.896538ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:08:07.761528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.623349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-3eed8305-432e-4f1a-9ce7-0169c61bf359\" ","response":"range_response_count:1 size:3746"} {"level":"info","ts":"2026-07-02T10:08:07.761605Z","caller":"traceutil/trace.go:171","msg":"trace[1092338762] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-3eed8305-432e-4f1a-9ce7-0169c61bf359; range_end:; response_count:1; response_revision:1854; }","duration":"129.757922ms","start":"2026-07-02T10:08:07.631829Z","end":"2026-07-02T10:08:07.761587Z","steps":["trace[1092338762] 'agreement among raft nodes before linearized reading' (duration: 129.521507ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:08:08.158149Z","caller":"traceutil/trace.go:171","msg":"trace[1606066061] transaction","detail":"{read_only:false; response_revision:1855; number_of_response:1; }","duration":"191.92554ms","start":"2026-07-02T10:08:07.966196Z","end":"2026-07-02T10:08:08.158121Z","steps":["trace[1606066061] 'process raft request' (duration: 191.586794ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:08:51.600575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.87092ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"warn","ts":"2026-07-02T10:10:25.003725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.159222ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T10:10:25.0041Z","caller":"traceutil/trace.go:171","msg":"trace[1602996848] transaction","detail":"{read_only:false; response_revision:2842; number_of_response:1; }","duration":"240.025471ms","start":"2026-07-02T10:10:24.76404Z","end":"2026-07-02T10:10:25.004066Z","steps":["trace[1602996848] 'process raft request' (duration: 93.43325ms)","trace[1602996848] 'compare' (duration: 146.03177ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:14:35.015696Z","caller":"traceutil/trace.go:171","msg":"trace[1761038028] transaction","detail":"{read_only:false; response_revision:4974; number_of_response:1; }","duration":"144.039137ms","start":"2026-07-02T10:14:34.871623Z","end":"2026-07-02T10:14:35.015662Z","steps":["trace[1761038028] 'process raft request' (duration: 55.863313ms)","trace[1761038028] 'compare' (duration: 88.022761ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:14:35.334671Z","caller":"traceutil/trace.go:171","msg":"trace[718530218] transaction","detail":"{read_only:false; response_revision:4977; number_of_response:1; }","duration":"255.813365ms","start":"2026-07-02T10:14:35.078828Z","end":"2026-07-02T10:14:35.334641Z","steps":["trace[718530218] 'process raft request' (duration: 255.54439ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:14:35.334793Z","caller":"traceutil/trace.go:171","msg":"trace[2097551629] linearizableReadLoop","detail":"{readStateIndex:5169; appliedIndex:5167; }","duration":"170.730749ms","start":"2026-07-02T10:14:35.164034Z","end":"2026-07-02T10:14:35.334765Z","steps":["trace[2097551629] 'read index received' (duration: 170.336812ms)","trace[2097551629] 'applied index is now lower than readState.Index' (duration: 392.177µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:14:35.33488Z","caller":"traceutil/trace.go:171","msg":"trace[1237103855] transaction","detail":"{read_only:false; response_revision:4978; number_of_response:1; }","duration":"253.688243ms","start":"2026-07-02T10:14:35.081169Z","end":"2026-07-02T10:14:35.334857Z","steps":["trace[1237103855] 'process raft request' (duration: 253.400567ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:14:35.334983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.913043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T10:14:35.335048Z","caller":"traceutil/trace.go:171","msg":"trace[306993398] range","detail":"{range_begin:/registry/acme.cert-manager.io/orders/; range_end:/registry/acme.cert-manager.io/orders0; response_count:0; response_revision:4978; }","duration":"171.045905ms","start":"2026-07-02T10:14:35.163984Z","end":"2026-07-02T10:14:35.335029Z","steps":["trace[306993398] 'agreement among raft nodes before linearized reading' (duration: 170.871482ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:14:35.463812Z","caller":"traceutil/trace.go:171","msg":"trace[1701454737] linearizableReadLoop","detail":"{readStateIndex:5170; appliedIndex:5169; }","duration":"120.79473ms","start":"2026-07-02T10:14:35.342976Z","end":"2026-07-02T10:14:35.46377Z","steps":["trace[1701454737] 'read index received' (duration: 33.412802ms)","trace[1701454737] 'applied index is now lower than readState.Index' (duration: 87.380588ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:14:35.463908Z","caller":"traceutil/trace.go:171","msg":"trace[296106145] transaction","detail":"{read_only:false; response_revision:4979; number_of_response:1; }","duration":"148.675076ms","start":"2026-07-02T10:14:35.315122Z","end":"2026-07-02T10:14:35.463797Z","steps":["trace[296106145] 'process raft request' (duration: 61.243787ms)","trace[296106145] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io; req_size:532; } (duration: 86.95748ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:14:35.464134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.143717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-kl8kh\" ","response":"range_response_count:1 size:6520"} {"level":"info","ts":"2026-07-02T10:14:35.464205Z","caller":"traceutil/trace.go:171","msg":"trace[39760239] range","detail":"{range_begin:/registry/pods/openstack/keepalived-kl8kh; range_end:; response_count:1; response_revision:4979; }","duration":"121.29294ms","start":"2026-07-02T10:14:35.342898Z","end":"2026-07-02T10:14:35.464191Z","steps":["trace[39760239] 'agreement among raft nodes before linearized reading' (duration: 120.992853ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:14:35.483537Z","caller":"traceutil/trace.go:171","msg":"trace[962125650] transaction","detail":"{read_only:false; response_revision:4980; number_of_response:1; }","duration":"138.700294ms","start":"2026-07-02T10:14:35.344809Z","end":"2026-07-02T10:14:35.483509Z","steps":["trace[962125650] 'process raft request' (duration: 138.272806ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:14:39.019018Z","caller":"traceutil/trace.go:171","msg":"trace[896982949] linearizableReadLoop","detail":"{readStateIndex:5317; appliedIndex:5316; }","duration":"125.032373ms","start":"2026-07-02T10:14:38.893942Z","end":"2026-07-02T10:14:39.018974Z","steps":["trace[896982949] 'read index received' (duration: 76.777515ms)","trace[896982949] 'applied index is now lower than readState.Index' (duration: 48.253168ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:14:39.019047Z","caller":"traceutil/trace.go:171","msg":"trace[403379173] transaction","detail":"{read_only:false; response_revision:5122; number_of_response:1; }","duration":"148.616286ms","start":"2026-07-02T10:14:38.870377Z","end":"2026-07-02T10:14:39.018993Z","steps":["trace[403379173] 'process raft request' (duration: 100.45814ms)","trace[403379173] 'compare' (duration: 47.88648ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:14:39.019241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.271047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-02T10:14:39.019294Z","caller":"traceutil/trace.go:171","msg":"trace[1099571697] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:5122; }","duration":"125.407529ms","start":"2026-07-02T10:14:38.89387Z","end":"2026-07-02T10:14:39.019278Z","steps":["trace[1099571697] 'agreement among raft nodes before linearized reading' (duration: 125.254957ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:14:39.233489Z","caller":"traceutil/trace.go:171","msg":"trace[711437107] transaction","detail":"{read_only:false; response_revision:5123; number_of_response:1; }","duration":"176.205815ms","start":"2026-07-02T10:14:39.057253Z","end":"2026-07-02T10:14:39.233459Z","steps":["trace[711437107] 'process raft request' (duration: 175.779486ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:15:53.115625Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2996} {"level":"info","ts":"2026-07-02T10:15:53.192241Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2996,"took":"74.2634ms","hash":1969455462,"current-db-size-bytes":57978880,"current-db-size":"58 MB","current-db-size-in-use-bytes":33525760,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-07-02T10:15:53.192314Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1969455462,"revision":2996,"compact-revision":-1} {"level":"info","ts":"2026-07-02T10:20:53.126054Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6039} {"level":"info","ts":"2026-07-02T10:20:53.262682Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6039,"took":"134.508446ms","hash":1732237741,"current-db-size-bytes":57978880,"current-db-size":"58 MB","current-db-size-in-use-bytes":21737472,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-07-02T10:20:53.262784Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1732237741,"revision":6039,"compact-revision":2996} {"level":"info","ts":"2026-07-02T10:21:12.308349Z","caller":"traceutil/trace.go:171","msg":"trace[13249290] transaction","detail":"{read_only:false; response_revision:8394; number_of_response:1; }","duration":"383.836239ms","start":"2026-07-02T10:21:11.924481Z","end":"2026-07-02T10:21:12.308317Z","steps":["trace[13249290] 'process raft request' (duration: 383.509702ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:21:12.30848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.955925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeaturerules/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeaturerules0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T10:21:12.308315Z","caller":"traceutil/trace.go:171","msg":"trace[1047548703] linearizableReadLoop","detail":"{readStateIndex:8695; appliedIndex:8694; }","duration":"308.717111ms","start":"2026-07-02T10:21:11.999507Z","end":"2026-07-02T10:21:12.308224Z","steps":["trace[1047548703] 'read index received' (duration: 308.551818ms)","trace[1047548703] 'applied index is now lower than readState.Index' (duration: 164.293µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:21:12.308522Z","caller":"traceutil/trace.go:171","msg":"trace[95927208] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeaturerules/; range_end:/registry/nfd.k8s-sigs.io/nodefeaturerules0; response_count:0; response_revision:8394; }","duration":"309.076818ms","start":"2026-07-02T10:21:11.999432Z","end":"2026-07-02T10:21:12.308509Z","steps":["trace[95927208] 'agreement among raft nodes before linearized reading' (duration: 308.969566ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:21:12.308541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:21:11.923489Z","time spent":"384.95259ms","remote":"127.0.0.1:42392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T10:21:12.308554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:21:11.999393Z","time spent":"309.152769ms","remote":"127.0.0.1:54788","response type":"/etcdserverpb.KV/Range","request count":0,"request size":92,"response count":0,"response size":29,"request content":"key:\"/registry/nfd.k8s-sigs.io/nodefeaturerules/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeaturerules0\" count_only:true "} {"level":"warn","ts":"2026-07-02T10:21:12.309538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.232247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-kl8kh\" ","response":"range_response_count:1 size:6520"} {"level":"info","ts":"2026-07-02T10:21:12.309621Z","caller":"traceutil/trace.go:171","msg":"trace[2076360145] range","detail":"{range_begin:/registry/pods/openstack/keepalived-kl8kh; range_end:; response_count:1; response_revision:8395; }","duration":"244.39099ms","start":"2026-07-02T10:21:12.065213Z","end":"2026-07-02T10:21:12.309604Z","steps":["trace[2076360145] 'agreement among raft nodes before linearized reading' (duration: 244.159344ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:21:15.246507Z","caller":"traceutil/trace.go:171","msg":"trace[568688065] linearizableReadLoop","detail":"{readStateIndex:8711; appliedIndex:8710; }","duration":"205.194609ms","start":"2026-07-02T10:21:15.041286Z","end":"2026-07-02T10:21:15.246481Z","steps":["trace[568688065] 'read index received' (duration: 204.966604ms)","trace[568688065] 'applied index is now lower than readState.Index' (duration: 227.005µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:21:15.246672Z","caller":"traceutil/trace.go:171","msg":"trace[914277110] transaction","detail":"{read_only:false; response_revision:8410; number_of_response:1; }","duration":"284.497737ms","start":"2026-07-02T10:21:14.962126Z","end":"2026-07-02T10:21:15.246624Z","steps":["trace[914277110] 'process raft request' (duration: 284.188152ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:21:15.246746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.447213ms","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-07-02T10:21:15.246843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.755212ms","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-07-02T10:21:15.246881Z","caller":"traceutil/trace.go:171","msg":"trace[1733505591] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8410; }","duration":"190.831354ms","start":"2026-07-02T10:21:15.056035Z","end":"2026-07-02T10:21:15.246866Z","steps":["trace[1733505591] 'agreement among raft nodes before linearized reading' (duration: 190.745052ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:21:15.246876Z","caller":"traceutil/trace.go:171","msg":"trace[883633922] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8410; }","duration":"205.628486ms","start":"2026-07-02T10:21:15.041227Z","end":"2026-07-02T10:21:15.246855Z","steps":["trace[883633922] 'agreement among raft nodes before linearized reading' (duration: 205.395642ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:21:15.412164Z","caller":"traceutil/trace.go:171","msg":"trace[84271773] transaction","detail":"{read_only:false; response_revision:8411; number_of_response:1; }","duration":"160.278708ms","start":"2026-07-02T10:21:15.251859Z","end":"2026-07-02T10:21:15.412138Z","steps":["trace[84271773] 'process raft request' (duration: 157.974704ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:21:15.412819Z","caller":"traceutil/trace.go:171","msg":"trace[1326910233] transaction","detail":"{read_only:false; response_revision:8412; number_of_response:1; }","duration":"160.433532ms","start":"2026-07-02T10:21:15.252371Z","end":"2026-07-02T10:21:15.412804Z","steps":["trace[1326910233] 'process raft request' (duration: 159.733888ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:21:25.549913Z","caller":"traceutil/trace.go:171","msg":"trace[1794548157] transaction","detail":"{read_only:false; response_revision:8461; number_of_response:1; }","duration":"101.694067ms","start":"2026-07-02T10:21:25.44818Z","end":"2026-07-02T10:21:25.549874Z","steps":["trace[1794548157] 'process raft request' (duration: 101.360211ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:21:27.085717Z","caller":"traceutil/trace.go:171","msg":"trace[821500419] transaction","detail":"{read_only:false; response_revision:8470; number_of_response:1; }","duration":"190.990657ms","start":"2026-07-02T10:21:26.894689Z","end":"2026-07-02T10:21:27.08568Z","steps":["trace[821500419] 'process raft request' (duration: 190.65979ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:21:54.619246Z","caller":"traceutil/trace.go:171","msg":"trace[747432251] transaction","detail":"{read_only:false; response_revision:8673; number_of_response:1; }","duration":"113.195647ms","start":"2026-07-02T10:21:54.506028Z","end":"2026-07-02T10:21:54.619224Z","steps":["trace[747432251] 'process raft request' (duration: 112.79635ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:22:09.343761Z","caller":"traceutil/trace.go:171","msg":"trace[28995274] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8792; }","duration":"157.7541ms","start":"2026-07-02T10:22:09.185967Z","end":"2026-07-02T10:22:09.343721Z","steps":["trace[28995274] 'process raft request' (duration: 127.541262ms)","trace[28995274] 'compare' (duration: 29.80242ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:22:09.353445Z","caller":"traceutil/trace.go:171","msg":"trace[438839302] transaction","detail":"{read_only:false; response_revision:8793; number_of_response:1; }","duration":"165.311514ms","start":"2026-07-02T10:22:09.1881Z","end":"2026-07-02T10:22:09.353412Z","steps":["trace[438839302] 'process raft request' (duration: 164.855166ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:22:10.066127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.895382ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T10:22:10.066275Z","caller":"traceutil/trace.go:171","msg":"trace[1087577895] linearizableReadLoop","detail":"{readStateIndex:9117; appliedIndex:9116; }","duration":"155.769452ms","start":"2026-07-02T10:22:09.910486Z","end":"2026-07-02T10:22:10.066255Z","steps":["trace[1087577895] 'read index received' (duration: 43.571664ms)","trace[1087577895] 'applied index is now lower than readState.Index' (duration: 112.196158ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:22:10.066408Z","caller":"traceutil/trace.go:171","msg":"trace[223772019] transaction","detail":"{read_only:false; response_revision:8799; number_of_response:1; }","duration":"195.904071ms","start":"2026-07-02T10:22:09.870491Z","end":"2026-07-02T10:22:10.066395Z","steps":["trace[223772019] 'process raft request' (duration: 83.653431ms)","trace[223772019] 'compare' (duration: 111.617987ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:22:10.066674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.216441ms","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-07-02T10:22:10.066717Z","caller":"traceutil/trace.go:171","msg":"trace[1856390418] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8799; }","duration":"156.311433ms","start":"2026-07-02T10:22:09.910393Z","end":"2026-07-02T10:22:10.066704Z","steps":["trace[1856390418] 'agreement among raft nodes before linearized reading' (duration: 156.126649ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:22:10.066984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.421631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-07-02T10:22:10.067132Z","caller":"traceutil/trace.go:171","msg":"trace[169158536] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8799; }","duration":"138.660195ms","start":"2026-07-02T10:22:09.928452Z","end":"2026-07-02T10:22:10.067112Z","steps":["trace[169158536] 'agreement among raft nodes before linearized reading' (duration: 138.295048ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:22:10.25318Z","caller":"traceutil/trace.go:171","msg":"trace[48222846] linearizableReadLoop","detail":"{readStateIndex:9119; appliedIndex:9118; }","duration":"172.117325ms","start":"2026-07-02T10:22:10.081022Z","end":"2026-07-02T10:22:10.253139Z","steps":["trace[48222846] 'read index received' (duration: 112.79368ms)","trace[48222846] 'applied index is now lower than readState.Index' (duration: 59.322345ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:22:10.253257Z","caller":"traceutil/trace.go:171","msg":"trace[437339040] transaction","detail":"{read_only:false; response_revision:8801; number_of_response:1; }","duration":"177.56644ms","start":"2026-07-02T10:22:10.075639Z","end":"2026-07-02T10:22:10.253205Z","steps":["trace[437339040] 'process raft request' (duration: 118.237965ms)","trace[437339040] 'compare' (duration: 59.07175ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:22:10.253566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.313789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheusagents/\" range_end:\"/registry/monitoring.coreos.com/prometheusagents0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T10:22:10.25516Z","caller":"traceutil/trace.go:171","msg":"trace[1923687723] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheusagents/; range_end:/registry/monitoring.coreos.com/prometheusagents0; response_count:0; response_revision:8801; }","duration":"174.125544ms","start":"2026-07-02T10:22:10.081009Z","end":"2026-07-02T10:22:10.255135Z","steps":["trace[1923687723] 'agreement among raft nodes before linearized reading' (duration: 172.275858ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:22:11.069855Z","caller":"traceutil/trace.go:171","msg":"trace[1828086348] transaction","detail":"{read_only:false; response_revision:8803; number_of_response:1; }","duration":"371.102265ms","start":"2026-07-02T10:22:10.69872Z","end":"2026-07-02T10:22:11.069822Z","steps":["trace[1828086348] 'process raft request' (duration: 370.881181ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:22:11.070074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:22:10.698681Z","time spent":"371.271818ms","remote":"127.0.0.1:55804","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T10:22:11.082128Z","caller":"traceutil/trace.go:171","msg":"trace[1776723112] transaction","detail":"{read_only:false; response_revision:8804; number_of_response:1; }","duration":"358.877161ms","start":"2026-07-02T10:22:10.723232Z","end":"2026-07-02T10:22:11.082109Z","steps":["trace[1776723112] 'process raft request' (duration: 358.708328ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:22:11.082269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:22:10.723196Z","time spent":"358.997363ms","remote":"127.0.0.1:42392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T10:22:11.082524Z","caller":"traceutil/trace.go:171","msg":"trace[1760746751] transaction","detail":"{read_only:false; response_revision:8805; number_of_response:1; }","duration":"357.344652ms","start":"2026-07-02T10:22:10.725164Z","end":"2026-07-02T10:22:11.082508Z","steps":["trace[1760746751] 'process raft request' (duration: 356.899024ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:22:11.082585Z","caller":"traceutil/trace.go:171","msg":"trace[658820730] linearizableReadLoop","detail":"{readStateIndex:9123; appliedIndex:9120; }","duration":"337.577733ms","start":"2026-07-02T10:22:10.744994Z","end":"2026-07-02T10:22:11.082572Z","steps":["trace[658820730] 'read index received' (duration: 324.554414ms)","trace[658820730] 'applied index is now lower than readState.Index' (duration: 13.022499ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:22:11.08259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:22:10.725151Z","time spent":"357.409623ms","remote":"127.0.0.1:42392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T10:22:11.082623Z","caller":"traceutil/trace.go:171","msg":"trace[95533628] transaction","detail":"{read_only:false; response_revision:8806; number_of_response:1; }","duration":"294.465298ms","start":"2026-07-02T10:22:10.788141Z","end":"2026-07-02T10:22:11.082606Z","steps":["trace[95533628] 'process raft request' (duration: 294.202383ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:22:11.082766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.784717ms","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-07-02T10:22:11.082806Z","caller":"traceutil/trace.go:171","msg":"trace[2001578935] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8806; }","duration":"337.919909ms","start":"2026-07-02T10:22:10.744876Z","end":"2026-07-02T10:22:11.082796Z","steps":["trace[2001578935] 'agreement among raft nodes before linearized reading' (duration: 337.766046ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:22:11.082841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:22:10.744808Z","time spent":"338.026452ms","remote":"127.0.0.1:42392","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":"warn","ts":"2026-07-02T10:22:11.082775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.169533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-kl8kh\" ","response":"range_response_count:1 size:6520"} {"level":"info","ts":"2026-07-02T10:22:11.083018Z","caller":"traceutil/trace.go:171","msg":"trace[74481056] range","detail":"{range_begin:/registry/pods/openstack/keepalived-kl8kh; range_end:; response_count:1; response_revision:8806; }","duration":"327.772256ms","start":"2026-07-02T10:22:10.755228Z","end":"2026-07-02T10:22:11.083Z","steps":["trace[74481056] 'agreement among raft nodes before linearized reading' (duration: 327.468219ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:22:11.083057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:22:10.755203Z","time spent":"327.843188ms","remote":"127.0.0.1:42330","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6544,"request content":"key:\"/registry/pods/openstack/keepalived-kl8kh\" "} {"level":"warn","ts":"2026-07-02T10:22:11.083055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.913486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-262td\" ","response":"range_response_count:1 size:4652"} {"level":"info","ts":"2026-07-02T10:22:11.083149Z","caller":"traceutil/trace.go:171","msg":"trace[1599570246] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-262td; range_end:; response_count:1; response_revision:8806; }","duration":"296.073489ms","start":"2026-07-02T10:22:10.787054Z","end":"2026-07-02T10:22:11.083127Z","steps":["trace[1599570246] 'agreement among raft nodes before linearized reading' (duration: 295.781973ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:22:25.747754Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000243f.wal"} {"level":"info","ts":"2026-07-02T10:23:26.777636Z","caller":"traceutil/trace.go:171","msg":"trace[1322548000] transaction","detail":"{read_only:false; response_revision:9547; number_of_response:1; }","duration":"276.259304ms","start":"2026-07-02T10:23:26.501346Z","end":"2026-07-02T10:23:26.777605Z","steps":["trace[1322548000] 'process raft request' (duration: 276.0511ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:23:26.794796Z","caller":"traceutil/trace.go:171","msg":"trace[2134071941] linearizableReadLoop","detail":"{readStateIndex:9887; appliedIndex:9885; }","duration":"208.955043ms","start":"2026-07-02T10:23:26.585807Z","end":"2026-07-02T10:23:26.794762Z","steps":["trace[2134071941] 'read index received' (duration: 191.552865ms)","trace[2134071941] 'applied index is now lower than readState.Index' (duration: 17.400438ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:23:26.794859Z","caller":"traceutil/trace.go:171","msg":"trace[1798677104] transaction","detail":"{read_only:false; response_revision:9548; number_of_response:1; }","duration":"293.279845ms","start":"2026-07-02T10:23:26.501531Z","end":"2026-07-02T10:23:26.79481Z","steps":["trace[1798677104] 'process raft request' (duration: 293.016ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:23:26.795001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.165768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T10:23:26.795116Z","caller":"traceutil/trace.go:171","msg":"trace[935552538] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9548; }","duration":"209.357892ms","start":"2026-07-02T10:23:26.585736Z","end":"2026-07-02T10:23:26.795094Z","steps":["trace[935552538] 'agreement among raft nodes before linearized reading' (duration: 209.160648ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:23:26.954393Z","caller":"traceutil/trace.go:171","msg":"trace[1120720834] transaction","detail":"{read_only:false; response_revision:9549; number_of_response:1; }","duration":"152.445858ms","start":"2026-07-02T10:23:26.801906Z","end":"2026-07-02T10:23:26.954352Z","steps":["trace[1120720834] 'process raft request' (duration: 97.764145ms)","trace[1120720834] 'compare' (duration: 54.153243ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:23:39.589205Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"dc35f804a62878ec","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-02T10:23:39.594313Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-07-02T10:23:39.594453Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-07-02T10:25:21.754805Z","caller":"traceutil/trace.go:171","msg":"trace[1942744289] linearizableReadLoop","detail":"{readStateIndex:10736; appliedIndex:10735; }","duration":"110.69176ms","start":"2026-07-02T10:25:21.644081Z","end":"2026-07-02T10:25:21.754773Z","steps":["trace[1942744289] 'read index received' (duration: 107.613184ms)","trace[1942744289] 'applied index is now lower than readState.Index' (duration: 3.077426ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:25:21.755033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.911694ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T10:25:21.755163Z","caller":"traceutil/trace.go:171","msg":"trace[785285547] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:10370; }","duration":"111.127878ms","start":"2026-07-02T10:25:21.644007Z","end":"2026-07-02T10:25:21.755135Z","steps":["trace[785285547] 'agreement among raft nodes before linearized reading' (duration: 110.873903ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:25:32.70264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.270622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T10:25:32.70276Z","caller":"traceutil/trace.go:171","msg":"trace[377125388] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:10442; }","duration":"117.447605ms","start":"2026-07-02T10:25:32.585283Z","end":"2026-07-02T10:25:32.702731Z","steps":["trace[377125388] 'range keys from in-memory index tree' (duration: 117.155149ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:25:32.703194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"495.475332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-07-02T10:25:32.703168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"542.255014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-07-02T10:25:32.703169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.705371ms","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-07-02T10:25:32.703257Z","caller":"traceutil/trace.go:171","msg":"trace[2110349357] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:10442; }","duration":"495.543363ms","start":"2026-07-02T10:25:32.207696Z","end":"2026-07-02T10:25:32.70324Z","steps":["trace[2110349357] 'count revisions from in-memory index tree' (duration: 495.347448ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:25:32.703232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.893485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-07-02T10:25:32.703275Z","caller":"traceutil/trace.go:171","msg":"trace[1608235759] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:10442; }","duration":"542.443417ms","start":"2026-07-02T10:25:32.160807Z","end":"2026-07-02T10:25:32.703251Z","steps":["trace[1608235759] 'count revisions from in-memory index tree' (duration: 542.140631ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:25:32.703301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:25:32.207611Z","time spent":"495.674725ms","remote":"127.0.0.1:44980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":31,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true "} {"level":"warn","ts":"2026-07-02T10:25:32.70333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:25:32.160779Z","time spent":"542.539378ms","remote":"127.0.0.1:42492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":31,"request content":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true "} {"level":"info","ts":"2026-07-02T10:25:32.703315Z","caller":"traceutil/trace.go:171","msg":"trace[208578190] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:10442; }","duration":"409.889253ms","start":"2026-07-02T10:25:32.293382Z","end":"2026-07-02T10:25:32.703271Z","steps":["trace[208578190] 'range keys from in-memory index tree' (duration: 409.484257ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:25:32.703331Z","caller":"traceutil/trace.go:171","msg":"trace[625413289] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:10442; }","duration":"180.044448ms","start":"2026-07-02T10:25:32.523264Z","end":"2026-07-02T10:25:32.703309Z","steps":["trace[625413289] 'range keys from in-memory index tree' (duration: 179.60528ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:25:32.703477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:25:32.293359Z","time spent":"410.094589ms","remote":"127.0.0.1:42392","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-07-02T10:25:32.707927Z","caller":"traceutil/trace.go:171","msg":"trace[556273402] transaction","detail":"{read_only:false; response_revision:10443; number_of_response:1; }","duration":"110.847382ms","start":"2026-07-02T10:25:32.597055Z","end":"2026-07-02T10:25:32.707902Z","steps":["trace[556273402] 'process raft request' (duration: 110.373263ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:25:53.134208Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8119} {"level":"info","ts":"2026-07-02T10:25:53.199013Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8119,"took":"62.671416ms","hash":2464543602,"current-db-size-bytes":57978880,"current-db-size":"58 MB","current-db-size-in-use-bytes":29286400,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-07-02T10:25:53.19967Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2464543602,"revision":8119,"compact-revision":6039} {"level":"info","ts":"2026-07-02T10:27:14.266753Z","caller":"traceutil/trace.go:171","msg":"trace[1560869122] linearizableReadLoop","detail":"{readStateIndex:11810; appliedIndex:11809; }","duration":"140.326325ms","start":"2026-07-02T10:27:14.126395Z","end":"2026-07-02T10:27:14.266721Z","steps":["trace[1560869122] 'read index received' (duration: 140.08212ms)","trace[1560869122] 'applied index is now lower than readState.Index' (duration: 243.325µs)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:27:14.267005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.58574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-07-02T10:27:14.267054Z","caller":"traceutil/trace.go:171","msg":"trace[265794631] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:11416; }","duration":"140.701782ms","start":"2026-07-02T10:27:14.126334Z","end":"2026-07-02T10:27:14.267035Z","steps":["trace[265794631] 'agreement among raft nodes before linearized reading' (duration: 140.516738ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:27:14.267206Z","caller":"traceutil/trace.go:171","msg":"trace[1774692022] transaction","detail":"{read_only:false; response_revision:11416; number_of_response:1; }","duration":"152.213791ms","start":"2026-07-02T10:27:14.114946Z","end":"2026-07-02T10:27:14.26716Z","steps":["trace[1774692022] 'process raft request' (duration: 151.60745ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:30:53.14047Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10670} {"level":"info","ts":"2026-07-02T10:30:53.227629Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10670,"took":"84.730683ms","hash":889743015,"current-db-size-bytes":57978880,"current-db-size":"58 MB","current-db-size-in-use-bytes":27230208,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-07-02T10:30:53.227703Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":889743015,"revision":10670,"compact-revision":8119} {"level":"info","ts":"2026-07-02T10:33:40.806173Z","caller":"traceutil/trace.go:171","msg":"trace[358509802] transaction","detail":"{read_only:false; response_revision:13998; number_of_response:1; }","duration":"114.298077ms","start":"2026-07-02T10:33:40.691828Z","end":"2026-07-02T10:33:40.806126Z","steps":["trace[358509802] 'process raft request' (duration: 113.90517ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:33:49.231476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.387395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-kl8kh\" ","response":"range_response_count:1 size:6520"} {"level":"info","ts":"2026-07-02T10:33:49.23159Z","caller":"traceutil/trace.go:171","msg":"trace[739759317] range","detail":"{range_begin:/registry/pods/openstack/keepalived-kl8kh; range_end:; response_count:1; response_revision:14061; }","duration":"121.550657ms","start":"2026-07-02T10:33:49.11001Z","end":"2026-07-02T10:33:49.23156Z","steps":["trace[739759317] 'range keys from in-memory index tree' (duration: 121.17524ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:33:58.756209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.411944ms","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-07-02T10:33:58.756222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.241332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-07-02T10:33:58.75632Z","caller":"traceutil/trace.go:171","msg":"trace[343552689] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:14227; }","duration":"215.579328ms","start":"2026-07-02T10:33:58.540713Z","end":"2026-07-02T10:33:58.756292Z","steps":["trace[343552689] 'range keys from in-memory index tree' (duration: 215.197089ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:33:58.756334Z","caller":"traceutil/trace.go:171","msg":"trace[349263357] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:14227; }","duration":"132.414725ms","start":"2026-07-02T10:33:58.623895Z","end":"2026-07-02T10:33:58.756309Z","steps":["trace[349263357] 'range keys from in-memory index tree' (duration: 132.045238ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:33:58.889116Z","caller":"traceutil/trace.go:171","msg":"trace[696445258] transaction","detail":"{read_only:false; response_revision:14228; number_of_response:1; }","duration":"128.609743ms","start":"2026-07-02T10:33:58.760475Z","end":"2026-07-02T10:33:58.889085Z","steps":["trace[696445258] 'process raft request' (duration: 128.429229ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:33:58.919004Z","caller":"traceutil/trace.go:171","msg":"trace[843715057] linearizableReadLoop","detail":"{readStateIndex:14720; appliedIndex:14718; }","duration":"140.759385ms","start":"2026-07-02T10:33:58.778209Z","end":"2026-07-02T10:33:58.918969Z","steps":["trace[843715057] 'read index received' (duration: 110.72214ms)","trace[843715057] 'applied index is now lower than readState.Index' (duration: 30.035525ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:33:58.919235Z","caller":"traceutil/trace.go:171","msg":"trace[436625031] transaction","detail":"{read_only:false; response_revision:14229; number_of_response:1; }","duration":"158.075156ms","start":"2026-07-02T10:33:58.761103Z","end":"2026-07-02T10:33:58.919179Z","steps":["trace[436625031] 'process raft request' (duration: 157.663059ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:33:58.919341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.102391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12211"} {"level":"info","ts":"2026-07-02T10:33:58.919405Z","caller":"traceutil/trace.go:171","msg":"trace[423157506] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:14229; }","duration":"141.231514ms","start":"2026-07-02T10:33:58.778155Z","end":"2026-07-02T10:33:58.919387Z","steps":["trace[423157506] 'agreement among raft nodes before linearized reading' (duration: 140.970329ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:33:59.003851Z","caller":"traceutil/trace.go:171","msg":"trace[137255666] transaction","detail":"{read_only:false; response_revision:14230; number_of_response:1; }","duration":"109.597198ms","start":"2026-07-02T10:33:58.894193Z","end":"2026-07-02T10:33:59.00379Z","steps":["trace[137255666] 'process raft request' (duration: 99.79852ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:35:26.319707Z","caller":"traceutil/trace.go:171","msg":"trace[582278371] linearizableReadLoop","detail":"{readStateIndex:15775; appliedIndex:15773; }","duration":"235.578001ms","start":"2026-07-02T10:35:26.084105Z","end":"2026-07-02T10:35:26.319683Z","steps":["trace[582278371] 'read index received' (duration: 63.70854ms)","trace[582278371] 'applied index is now lower than readState.Index' (duration: 171.868531ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:35:26.319938Z","caller":"traceutil/trace.go:171","msg":"trace[892408269] transaction","detail":"{read_only:false; response_revision:15253; number_of_response:1; }","duration":"236.985477ms","start":"2026-07-02T10:35:26.082941Z","end":"2026-07-02T10:35:26.319927Z","steps":["trace[892408269] 'process raft request' (duration: 203.71805ms)","trace[892408269] 'compare' (duration: 32.921731ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:35:26.320157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.045009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-02T10:35:26.320192Z","caller":"traceutil/trace.go:171","msg":"trace[237388961] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:15253; }","duration":"236.115291ms","start":"2026-07-02T10:35:26.084067Z","end":"2026-07-02T10:35:26.320183Z","steps":["trace[237388961] 'agreement among raft nodes before linearized reading' (duration: 236.010079ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:35:26.320304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.447933ms","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-07-02T10:35:26.320332Z","caller":"traceutil/trace.go:171","msg":"trace[1322613560] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:15253; }","duration":"194.516344ms","start":"2026-07-02T10:35:26.125808Z","end":"2026-07-02T10:35:26.320324Z","steps":["trace[1322613560] 'agreement among raft nodes before linearized reading' (duration: 194.472744ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:35:26.321092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.608106ms","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-07-02T10:35:26.321124Z","caller":"traceutil/trace.go:171","msg":"trace[1918595101] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15253; }","duration":"193.659879ms","start":"2026-07-02T10:35:26.127458Z","end":"2026-07-02T10:35:26.321117Z","steps":["trace[1918595101] 'agreement among raft nodes before linearized reading' (duration: 193.589398ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:35:26.32124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.222518ms","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-07-02T10:35:26.321282Z","caller":"traceutil/trace.go:171","msg":"trace[1088808452] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:15253; }","duration":"195.31256ms","start":"2026-07-02T10:35:26.125961Z","end":"2026-07-02T10:35:26.321274Z","steps":["trace[1088808452] 'agreement among raft nodes before linearized reading' (duration: 195.249059ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:35:26.321409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.480443ms","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-07-02T10:35:26.321436Z","caller":"traceutil/trace.go:171","msg":"trace[910705597] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15253; }","duration":"195.551395ms","start":"2026-07-02T10:35:26.125879Z","end":"2026-07-02T10:35:26.32143Z","steps":["trace[910705597] 'agreement among raft nodes before linearized reading' (duration: 195.510774ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:35:26.43498Z","caller":"traceutil/trace.go:171","msg":"trace[1243860245] linearizableReadLoop","detail":"{readStateIndex:15776; appliedIndex:15775; }","duration":"109.442545ms","start":"2026-07-02T10:35:26.325515Z","end":"2026-07-02T10:35:26.434958Z","steps":["trace[1243860245] 'read index received' (duration: 106.242334ms)","trace[1243860245] 'applied index is now lower than readState.Index' (duration: 3.198621ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:35:26.435147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.613618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T10:35:26.435191Z","caller":"traceutil/trace.go:171","msg":"trace[558648200] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:15253; }","duration":"109.72098ms","start":"2026-07-02T10:35:26.325458Z","end":"2026-07-02T10:35:26.435179Z","steps":["trace[558648200] 'agreement among raft nodes before linearized reading' (duration: 109.618108ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:35:26.43668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.455229ms","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-07-02T10:35:26.436803Z","caller":"traceutil/trace.go:171","msg":"trace[1928573031] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15254; }","duration":"106.642832ms","start":"2026-07-02T10:35:26.33013Z","end":"2026-07-02T10:35:26.436773Z","steps":["trace[1928573031] 'agreement among raft nodes before linearized reading' (duration: 106.367577ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:35:26.436914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.901276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"} {"level":"info","ts":"2026-07-02T10:35:26.436956Z","caller":"traceutil/trace.go:171","msg":"trace[1242628472] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15254; }","duration":"107.955458ms","start":"2026-07-02T10:35:26.328992Z","end":"2026-07-02T10:35:26.436947Z","steps":["trace[1242628472] 'agreement among raft nodes before linearized reading' (duration: 107.811824ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:35:26.436991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.998299ms","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-07-02T10:35:26.437131Z","caller":"traceutil/trace.go:171","msg":"trace[435051818] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15254; }","duration":"108.167852ms","start":"2026-07-02T10:35:26.328932Z","end":"2026-07-02T10:35:26.4371Z","steps":["trace[435051818] 'agreement among raft nodes before linearized reading' (duration: 107.926166ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:35:26.437043Z","caller":"traceutil/trace.go:171","msg":"trace[507137391] transaction","detail":"{read_only:false; response_revision:15254; number_of_response:1; }","duration":"110.731821ms","start":"2026-07-02T10:35:26.326292Z","end":"2026-07-02T10:35:26.437024Z","steps":["trace[507137391] 'process raft request' (duration: 109.764923ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:35:26.437347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.401455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:79 size:769701"} {"level":"info","ts":"2026-07-02T10:35:26.437416Z","caller":"traceutil/trace.go:171","msg":"trace[435662438] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:79; response_revision:15254; }","duration":"109.489656ms","start":"2026-07-02T10:35:26.32791Z","end":"2026-07-02T10:35:26.4374Z","steps":["trace[435662438] 'agreement among raft nodes before linearized reading' (duration: 108.374295ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:35:53.146999Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12818} {"level":"info","ts":"2026-07-02T10:35:53.23672Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12818,"took":"86.833282ms","hash":1086997287,"current-db-size-bytes":57978880,"current-db-size":"58 MB","current-db-size-in-use-bytes":30429184,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-07-02T10:35:53.236801Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1086997287,"revision":12818,"compact-revision":10670} {"level":"info","ts":"2026-07-02T10:40:53.154659Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15393} {"level":"info","ts":"2026-07-02T10:40:53.258631Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15393,"took":"100.011393ms","hash":3646921157,"current-db-size-bytes":57978880,"current-db-size":"58 MB","current-db-size-in-use-bytes":32280576,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-07-02T10:40:53.258707Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3646921157,"revision":15393,"compact-revision":12818} {"level":"warn","ts":"2026-07-02T10:41:14.93368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.189695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-cbftw\" ","response":"range_response_count:1 size:22122"} {"level":"info","ts":"2026-07-02T10:41:14.933752Z","caller":"traceutil/trace.go:171","msg":"trace[251227077] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-cbftw; range_end:; response_count:1; response_revision:17756; }","duration":"125.323597ms","start":"2026-07-02T10:41:14.808414Z","end":"2026-07-02T10:41:14.933737Z","steps":["trace[251227077] 'range keys from in-memory index tree' (duration: 124.992701ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:41:14.986134Z","caller":"traceutil/trace.go:171","msg":"trace[728461471] transaction","detail":"{read_only:false; response_revision:17757; number_of_response:1; }","duration":"145.292129ms","start":"2026-07-02T10:41:14.840807Z","end":"2026-07-02T10:41:14.986099Z","steps":["trace[728461471] 'process raft request' (duration: 144.933592ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:41:16.512366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.486766ms","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-07-02T10:41:16.512486Z","caller":"traceutil/trace.go:171","msg":"trace[759302831] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:17786; }","duration":"109.668039ms","start":"2026-07-02T10:41:16.402793Z","end":"2026-07-02T10:41:16.512461Z","steps":["trace[759302831] 'range keys from in-memory index tree' (duration: 109.27241ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:41:20.294667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.770213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-07-02T10:41:20.294804Z","caller":"traceutil/trace.go:171","msg":"trace[972838669] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:17869; }","duration":"197.995097ms","start":"2026-07-02T10:41:20.096781Z","end":"2026-07-02T10:41:20.294776Z","steps":["trace[972838669] 'count revisions from in-memory index tree' (duration: 197.644331ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:41:20.294798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.085313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-07-02T10:41:20.294954Z","caller":"traceutil/trace.go:171","msg":"trace[847819076] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:17869; }","duration":"103.358478ms","start":"2026-07-02T10:41:20.191554Z","end":"2026-07-02T10:41:20.294913Z","steps":["trace[847819076] 'range keys from in-memory index tree' (duration: 102.727496ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:41:23.095028Z","caller":"traceutil/trace.go:171","msg":"trace[606242545] linearizableReadLoop","detail":"{readStateIndex:18494; appliedIndex:18493; }","duration":"171.664234ms","start":"2026-07-02T10:41:22.923327Z","end":"2026-07-02T10:41:23.094991Z","steps":["trace[606242545] 'read index received' (duration: 171.183966ms)","trace[606242545] 'applied index is now lower than readState.Index' (duration: 478.618µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:41:23.095139Z","caller":"traceutil/trace.go:171","msg":"trace[749182701] transaction","detail":"{read_only:false; response_revision:17884; number_of_response:1; }","duration":"243.59066ms","start":"2026-07-02T10:41:22.851503Z","end":"2026-07-02T10:41:23.095094Z","steps":["trace[749182701] 'process raft request' (duration: 243.237524ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:41:23.095282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.93049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-07-02T10:41:23.095351Z","caller":"traceutil/trace.go:171","msg":"trace[525541830] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:17884; }","duration":"172.058752ms","start":"2026-07-02T10:41:22.923268Z","end":"2026-07-02T10:41:23.095327Z","steps":["trace[525541830] 'agreement among raft nodes before linearized reading' (duration: 171.932309ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:41:23.126582Z","caller":"traceutil/trace.go:171","msg":"trace[1610173569] transaction","detail":"{read_only:false; response_revision:17885; number_of_response:1; }","duration":"106.5962ms","start":"2026-07-02T10:41:23.019934Z","end":"2026-07-02T10:41:23.12653Z","steps":["trace[1610173569] 'process raft request' (duration: 93.522989ms)","trace[1610173569] 'compare' (duration: 12.716484ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:44:19.916721Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"dc35f804a62878ec","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-02T10:44:19.922723Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-07-02T10:44:19.922883Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-07-02T10:45:53.160228Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17582} {"level":"info","ts":"2026-07-02T10:45:53.260754Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17582,"took":"96.796854ms","hash":1480588311,"current-db-size-bytes":57978880,"current-db-size":"58 MB","current-db-size-in-use-bytes":34304000,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-07-02T10:45:53.260826Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1480588311,"revision":17582,"compact-revision":15393} {"level":"info","ts":"2026-07-02T10:47:21.681149Z","caller":"traceutil/trace.go:171","msg":"trace[342442764] transaction","detail":"{read_only:false; response_revision:20575; number_of_response:1; }","duration":"123.733341ms","start":"2026-07-02T10:47:21.557371Z","end":"2026-07-02T10:47:21.681105Z","steps":["trace[342442764] 'process raft request' (duration: 123.354454ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:47:27.587672Z","caller":"traceutil/trace.go:171","msg":"trace[161231715] linearizableReadLoop","detail":"{readStateIndex:21307; appliedIndex:21306; }","duration":"179.719524ms","start":"2026-07-02T10:47:27.407921Z","end":"2026-07-02T10:47:27.58764Z","steps":["trace[161231715] 'read index received' (duration: 179.662693ms)","trace[161231715] 'applied index is now lower than readState.Index' (duration: 55.641µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:47:27.587776Z","caller":"traceutil/trace.go:171","msg":"trace[128149312] transaction","detail":"{read_only:false; response_revision:20603; number_of_response:1; }","duration":"198.413582ms","start":"2026-07-02T10:47:27.3893Z","end":"2026-07-02T10:47:27.587713Z","steps":["trace[128149312] 'process raft request' (duration: 198.139577ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:47:27.58801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.080191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" ","response":"range_response_count:1 size:18506"} {"level":"info","ts":"2026-07-02T10:47:27.588105Z","caller":"traceutil/trace.go:171","msg":"trace[109672204] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:1; response_revision:20603; }","duration":"180.214283ms","start":"2026-07-02T10:47:27.40785Z","end":"2026-07-02T10:47:27.588065Z","steps":["trace[109672204] 'agreement among raft nodes before linearized reading' (duration: 179.947288ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:47:27.702593Z","caller":"traceutil/trace.go:171","msg":"trace[1627887563] linearizableReadLoop","detail":"{readStateIndex:21308; appliedIndex:21307; }","duration":"114.709938ms","start":"2026-07-02T10:47:27.587839Z","end":"2026-07-02T10:47:27.702549Z","steps":["trace[1627887563] 'read index received' (duration: 107.740314ms)","trace[1627887563] 'applied index is now lower than readState.Index' (duration: 6.967504ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:47:27.702867Z","caller":"traceutil/trace.go:171","msg":"trace[1667432695] transaction","detail":"{read_only:false; response_revision:20604; number_of_response:1; }","duration":"278.951886ms","start":"2026-07-02T10:47:27.423887Z","end":"2026-07-02T10:47:27.702838Z","steps":["trace[1667432695] 'process raft request' (duration: 271.709797ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:47:27.702997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.096925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-02T10:47:27.703048Z","caller":"traceutil/trace.go:171","msg":"trace[744374558] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:20604; }","duration":"116.220167ms","start":"2026-07-02T10:47:27.586814Z","end":"2026-07-02T10:47:27.703034Z","steps":["trace[744374558] 'agreement among raft nodes before linearized reading' (duration: 116.093715ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:47:27.703628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.07422ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/kube-system/kube-prometheus-stack-kubelet\" ","response":"range_response_count:1 size:1137"} {"level":"info","ts":"2026-07-02T10:47:27.703689Z","caller":"traceutil/trace.go:171","msg":"trace[1226075396] range","detail":"{range_begin:/registry/services/specs/kube-system/kube-prometheus-stack-kubelet; range_end:; response_count:1; response_revision:20604; }","duration":"110.136211ms","start":"2026-07-02T10:47:27.593537Z","end":"2026-07-02T10:47:27.703673Z","steps":["trace[1226075396] 'agreement among raft nodes before linearized reading' (duration: 109.727493ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:47:27.838363Z","caller":"traceutil/trace.go:171","msg":"trace[1044440662] linearizableReadLoop","detail":"{readStateIndex:21309; appliedIndex:21308; }","duration":"125.349122ms","start":"2026-07-02T10:47:27.712981Z","end":"2026-07-02T10:47:27.83833Z","steps":["trace[1044440662] 'read index received' (duration: 119.935539ms)","trace[1044440662] 'applied index is now lower than readState.Index' (duration: 5.412123ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:47:27.838683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.677958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/kube-system/kube-prometheus-stack-kubelet\" ","response":"range_response_count:1 size:1137"} {"level":"info","ts":"2026-07-02T10:47:27.838447Z","caller":"traceutil/trace.go:171","msg":"trace[845926729] transaction","detail":"{read_only:false; response_revision:20605; number_of_response:1; }","duration":"126.244359ms","start":"2026-07-02T10:47:27.71215Z","end":"2026-07-02T10:47:27.838394Z","steps":["trace[845926729] 'process raft request' (duration: 120.785185ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:47:27.83879Z","caller":"traceutil/trace.go:171","msg":"trace[742326786] range","detail":"{range_begin:/registry/services/specs/kube-system/kube-prometheus-stack-kubelet; range_end:; response_count:1; response_revision:20605; }","duration":"125.864001ms","start":"2026-07-02T10:47:27.712897Z","end":"2026-07-02T10:47:27.838761Z","steps":["trace[742326786] 'agreement among raft nodes before linearized reading' (duration: 125.568186ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:47:27.838788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.763001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-07-02T10:47:27.83879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.813595ms","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-07-02T10:47:27.838848Z","caller":"traceutil/trace.go:171","msg":"trace[657916668] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:20605; }","duration":"124.866473ms","start":"2026-07-02T10:47:27.713969Z","end":"2026-07-02T10:47:27.838835Z","steps":["trace[657916668] 'agreement among raft nodes before linearized reading' (duration: 124.536386ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:47:27.838902Z","caller":"traceutil/trace.go:171","msg":"trace[1694772654] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:20605; }","duration":"120.979258ms","start":"2026-07-02T10:47:27.71789Z","end":"2026-07-02T10:47:27.838869Z","steps":["trace[1694772654] 'agreement among raft nodes before linearized reading' (duration: 120.663762ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:47:28.131506Z","caller":"traceutil/trace.go:171","msg":"trace[2073885026] linearizableReadLoop","detail":"{readStateIndex:21311; appliedIndex:21309; }","duration":"284.079533ms","start":"2026-07-02T10:47:27.847399Z","end":"2026-07-02T10:47:28.131479Z","steps":["trace[2073885026] 'read index received' (duration: 7.215078ms)","trace[2073885026] 'applied index is now lower than readState.Index' (duration: 276.863375ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:47:28.131539Z","caller":"traceutil/trace.go:171","msg":"trace[1917708095] transaction","detail":"{read_only:false; response_revision:20607; number_of_response:1; }","duration":"286.072642ms","start":"2026-07-02T10:47:27.84544Z","end":"2026-07-02T10:47:28.131513Z","steps":["trace[1917708095] 'process raft request' (duration: 204.523529ms)","trace[1917708095] 'compare' (duration: 81.40148ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:47:28.13184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.42355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/kube-system/kube-prometheus-stack-kubelet\" ","response":"range_response_count:1 size:684"} {"level":"info","ts":"2026-07-02T10:47:28.131941Z","caller":"traceutil/trace.go:171","msg":"trace[1004298828] range","detail":"{range_begin:/registry/services/endpoints/kube-system/kube-prometheus-stack-kubelet; range_end:; response_count:1; response_revision:20607; }","duration":"284.541463ms","start":"2026-07-02T10:47:27.847372Z","end":"2026-07-02T10:47:28.131913Z","steps":["trace[1004298828] 'agreement among raft nodes before linearized reading' (duration: 284.248288ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:48:44.299137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.537584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/octavia-rabbit-init\" ","response":"range_response_count:1 size:5003"} {"level":"info","ts":"2026-07-02T10:48:44.29929Z","caller":"traceutil/trace.go:171","msg":"trace[1520161782] range","detail":"{range_begin:/registry/jobs/openstack/octavia-rabbit-init; range_end:; response_count:1; response_revision:21291; }","duration":"187.751678ms","start":"2026-07-02T10:48:44.111507Z","end":"2026-07-02T10:48:44.299259Z","steps":["trace[1520161782] 'range keys from in-memory index tree' (duration: 187.246639ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:48:44.299555Z","caller":"traceutil/trace.go:171","msg":"trace[644302719] transaction","detail":"{read_only:false; response_revision:21292; number_of_response:1; }","duration":"184.614598ms","start":"2026-07-02T10:48:44.114902Z","end":"2026-07-02T10:48:44.299516Z","steps":["trace[644302719] 'process raft request' (duration: 183.11706ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:48:44.299789Z","caller":"traceutil/trace.go:171","msg":"trace[1462687641] transaction","detail":"{read_only:false; response_revision:21293; number_of_response:1; }","duration":"146.529977ms","start":"2026-07-02T10:48:44.15324Z","end":"2026-07-02T10:48:44.29977Z","steps":["trace[1462687641] 'process raft request' (duration: 146.412655ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:48:45.522545Z","caller":"traceutil/trace.go:171","msg":"trace[501285642] transaction","detail":"{read_only:false; response_revision:21303; number_of_response:1; }","duration":"186.28361ms","start":"2026-07-02T10:48:45.336202Z","end":"2026-07-02T10:48:45.522485Z","steps":["trace[501285642] 'process raft request' (duration: 185.349513ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:50:53.168867Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20093} {"level":"info","ts":"2026-07-02T10:50:53.294463Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20093,"took":"121.794544ms","hash":2067172280,"current-db-size-bytes":57978880,"current-db-size":"58 MB","current-db-size-in-use-bytes":30552064,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-07-02T10:50:53.294535Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2067172280,"revision":20093,"compact-revision":17582} {"level":"info","ts":"2026-07-02T10:51:24.556844Z","caller":"traceutil/trace.go:171","msg":"trace[1481812474] linearizableReadLoop","detail":"{readStateIndex:23839; appliedIndex:23838; }","duration":"136.478956ms","start":"2026-07-02T10:51:24.420338Z","end":"2026-07-02T10:51:24.556817Z","steps":["trace[1481812474] 'read index received' (duration: 136.23546ms)","trace[1481812474] 'applied index is now lower than readState.Index' (duration: 242.226µs)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:51:24.557313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.865093ms","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-07-02T10:51:24.557385Z","caller":"traceutil/trace.go:171","msg":"trace[1657079632] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:23060; }","duration":"137.092747ms","start":"2026-07-02T10:51:24.420273Z","end":"2026-07-02T10:51:24.557366Z","steps":["trace[1657079632] 'agreement among raft nodes before linearized reading' (duration: 136.660809ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:51:24.557805Z","caller":"traceutil/trace.go:171","msg":"trace[1322425705] transaction","detail":"{read_only:false; response_revision:23060; number_of_response:1; }","duration":"161.131538ms","start":"2026-07-02T10:51:24.396657Z","end":"2026-07-02T10:51:24.557788Z","steps":["trace[1322425705] 'process raft request' (duration: 160.017377ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:54:45.601233Z","caller":"traceutil/trace.go:171","msg":"trace[1537880676] transaction","detail":"{read_only:false; response_revision:25095; number_of_response:1; }","duration":"117.38181ms","start":"2026-07-02T10:54:45.483801Z","end":"2026-07-02T10:54:45.601183Z","steps":["trace[1537880676] 'process raft request' (duration: 117.061254ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:54:46.483576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.407557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-07-02T10:54:46.483694Z","caller":"traceutil/trace.go:171","msg":"trace[1745338270] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:25099; }","duration":"168.893816ms","start":"2026-07-02T10:54:46.314782Z","end":"2026-07-02T10:54:46.483676Z","steps":["trace[1745338270] 'count revisions from in-memory index tree' (duration: 168.139212ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:54:46.526793Z","caller":"traceutil/trace.go:171","msg":"trace[2032625690] linearizableReadLoop","detail":"{readStateIndex:25930; appliedIndex:25929; }","duration":"160.293471ms","start":"2026-07-02T10:54:46.36646Z","end":"2026-07-02T10:54:46.526754Z","steps":["trace[2032625690] 'read index received' (duration: 159.933945ms)","trace[2032625690] 'applied index is now lower than readState.Index' (duration: 358.236µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:54:46.527306Z","caller":"traceutil/trace.go:171","msg":"trace[761758697] transaction","detail":"{read_only:false; response_revision:25100; number_of_response:1; }","duration":"183.544607ms","start":"2026-07-02T10:54:46.343698Z","end":"2026-07-02T10:54:46.527242Z","steps":["trace[761758697] 'process raft request' (duration: 182.844794ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:54:46.527507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.027546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.66\" ","response":"range_response_count:1 size:137"} {"level":"info","ts":"2026-07-02T10:54:46.527652Z","caller":"traceutil/trace.go:171","msg":"trace[1353091007] range","detail":"{range_begin:/registry/masterleases/199.19.213.66; range_end:; response_count:1; response_revision:25100; }","duration":"161.225469ms","start":"2026-07-02T10:54:46.366399Z","end":"2026-07-02T10:54:46.527625Z","steps":["trace[1353091007] 'agreement among raft nodes before linearized reading' (duration: 160.843021ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:54:46.770508Z","caller":"traceutil/trace.go:171","msg":"trace[2005394640] transaction","detail":"{read_only:false; response_revision:25101; number_of_response:1; }","duration":"285.317188ms","start":"2026-07-02T10:54:46.485162Z","end":"2026-07-02T10:54:46.770479Z","steps":["trace[2005394640] 'process raft request' (duration: 285.040293ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:54:46.770811Z","caller":"traceutil/trace.go:171","msg":"trace[1240198620] linearizableReadLoop","detail":"{readStateIndex:25932; appliedIndex:25930; }","duration":"243.890323ms","start":"2026-07-02T10:54:46.526886Z","end":"2026-07-02T10:54:46.770777Z","steps":["trace[1240198620] 'read index received' (duration: 243.270032ms)","trace[1240198620] 'applied index is now lower than readState.Index' (duration: 618.611µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:54:46.770947Z","caller":"traceutil/trace.go:171","msg":"trace[1524142244] transaction","detail":"{read_only:false; response_revision:25102; number_of_response:1; }","duration":"280.298152ms","start":"2026-07-02T10:54:46.49062Z","end":"2026-07-02T10:54:46.770918Z","steps":["trace[1524142244] 'process raft request' (duration: 279.765462ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:54:46.771082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.463255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/glance-api\" ","response":"range_response_count:1 size:11837"} {"level":"info","ts":"2026-07-02T10:54:46.771117Z","caller":"traceutil/trace.go:171","msg":"trace[894979250] range","detail":"{range_begin:/registry/deployments/openstack/glance-api; range_end:; response_count:1; response_revision:25102; }","duration":"280.549817ms","start":"2026-07-02T10:54:46.490554Z","end":"2026-07-02T10:54:46.771104Z","steps":["trace[894979250] 'agreement among raft nodes before linearized reading' (duration: 280.356853ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:54:46.77126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.588392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-02T10:54:46.771309Z","caller":"traceutil/trace.go:171","msg":"trace[1461089136] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25102; }","duration":"395.678264ms","start":"2026-07-02T10:54:46.375618Z","end":"2026-07-02T10:54:46.771296Z","steps":["trace[1461089136] 'agreement among raft nodes before linearized reading' (duration: 395.48624ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:54:46.771344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:54:46.375605Z","time spent":"395.730685ms","remote":"127.0.0.1:42392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-02T10:54:46.771759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.849812ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/magnum-api-7c8fcf9f49-jdv55\" ","response":"range_response_count:1 size:8651"} {"level":"info","ts":"2026-07-02T10:54:46.771802Z","caller":"traceutil/trace.go:171","msg":"trace[88107938] range","detail":"{range_begin:/registry/pods/openstack/magnum-api-7c8fcf9f49-jdv55; range_end:; response_count:1; response_revision:25102; }","duration":"233.954184ms","start":"2026-07-02T10:54:46.537838Z","end":"2026-07-02T10:54:46.771792Z","steps":["trace[88107938] 'agreement among raft nodes before linearized reading' (duration: 233.839262ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:54:46.771966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.554873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-02T10:54:46.771985Z","caller":"traceutil/trace.go:171","msg":"trace[1007468054] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25102; }","duration":"188.649676ms","start":"2026-07-02T10:54:46.583329Z","end":"2026-07-02T10:54:46.771979Z","steps":["trace[1007468054] 'agreement among raft nodes before linearized reading' (duration: 188.614315ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:54:46.772037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.941857ms","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:6"} {"level":"info","ts":"2026-07-02T10:54:46.77208Z","caller":"traceutil/trace.go:171","msg":"trace[166125063] range","detail":"{range_begin:/registry/ceph.rook.io/cephbucketnotifications/; range_end:/registry/ceph.rook.io/cephbucketnotifications0; response_count:0; response_revision:25102; }","duration":"205.035059ms","start":"2026-07-02T10:54:46.567032Z","end":"2026-07-02T10:54:46.772067Z","steps":["trace[166125063] 'agreement among raft nodes before linearized reading' (duration: 204.959448ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:54:50.8914Z","caller":"traceutil/trace.go:171","msg":"trace[1314152614] linearizableReadLoop","detail":"{readStateIndex:25973; appliedIndex:25972; }","duration":"101.285981ms","start":"2026-07-02T10:54:50.790089Z","end":"2026-07-02T10:54:50.891375Z","steps":["trace[1314152614] 'read index received' (duration: 101.109048ms)","trace[1314152614] 'applied index is now lower than readState.Index' (duration: 175.993µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:54:50.891492Z","caller":"traceutil/trace.go:171","msg":"trace[750598874] transaction","detail":"{read_only:false; response_revision:25142; number_of_response:1; }","duration":"105.630904ms","start":"2026-07-02T10:54:50.785836Z","end":"2026-07-02T10:54:50.891467Z","steps":["trace[750598874] 'process raft request' (duration: 105.39273ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:54:50.891657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.560327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-02T10:54:50.89169Z","caller":"traceutil/trace.go:171","msg":"trace[358216069] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25142; }","duration":"101.656639ms","start":"2026-07-02T10:54:50.790024Z","end":"2026-07-02T10:54:50.891681Z","steps":["trace[358216069] 'agreement among raft nodes before linearized reading' (duration: 101.510195ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:54:51.162889Z","caller":"traceutil/trace.go:171","msg":"trace[993665317] linearizableReadLoop","detail":"{readStateIndex:25976; appliedIndex:25974; }","duration":"201.800577ms","start":"2026-07-02T10:54:50.961063Z","end":"2026-07-02T10:54:51.162863Z","steps":["trace[993665317] 'read index received' (duration: 171.469077ms)","trace[993665317] 'applied index is now lower than readState.Index' (duration: 30.33011ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:54:51.163131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.057572ms","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-07-02T10:54:51.163172Z","caller":"traceutil/trace.go:171","msg":"trace[979365598] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25145; }","duration":"202.162454ms","start":"2026-07-02T10:54:50.960999Z","end":"2026-07-02T10:54:51.163161Z","steps":["trace[979365598] 'agreement among raft nodes before linearized reading' (duration: 201.96431ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:54:51.163295Z","caller":"traceutil/trace.go:171","msg":"trace[1309418055] transaction","detail":"{read_only:false; response_revision:25144; number_of_response:1; }","duration":"267.293253ms","start":"2026-07-02T10:54:50.895969Z","end":"2026-07-02T10:54:51.163263Z","steps":["trace[1309418055] 'process raft request' (duration: 236.584634ms)","trace[1309418055] 'compare' (duration: 30.090706ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:54:51.163366Z","caller":"traceutil/trace.go:171","msg":"trace[1071822582] transaction","detail":"{read_only:false; response_revision:25145; number_of_response:1; }","duration":"266.953377ms","start":"2026-07-02T10:54:50.896364Z","end":"2026-07-02T10:54:51.163318Z","steps":["trace[1071822582] 'process raft request' (duration: 266.443716ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:54:51.457624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.322875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-02T10:54:51.457744Z","caller":"traceutil/trace.go:171","msg":"trace[215148533] range","detail":"{range_begin:/registry/rabbitmq.com/federations/; range_end:/registry/rabbitmq.com/federations0; response_count:0; response_revision:25147; }","duration":"193.466007ms","start":"2026-07-02T10:54:51.264249Z","end":"2026-07-02T10:54:51.457716Z","steps":["trace[215148533] 'count revisions from in-memory index tree' (duration: 193.186282ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:54:51.458157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.399823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-07-02T10:54:51.458548Z","caller":"traceutil/trace.go:171","msg":"trace[245174640] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25147; }","duration":"173.847111ms","start":"2026-07-02T10:54:51.284672Z","end":"2026-07-02T10:54:51.458519Z","steps":["trace[245174640] 'range keys from in-memory index tree' (duration: 172.731021ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:54:51.62192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.357941ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:30"} {"level":"info","ts":"2026-07-02T10:54:51.622187Z","caller":"traceutil/trace.go:171","msg":"trace[909265150] linearizableReadLoop","detail":"{readStateIndex:25979; appliedIndex:25978; }","duration":"180.990538ms","start":"2026-07-02T10:54:51.441172Z","end":"2026-07-02T10:54:51.622163Z","steps":["trace[909265150] 'read index received' (duration: 18.369252ms)","trace[909265150] 'applied index is now lower than readState.Index' (duration: 162.619446ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:54:51.622356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.217833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-02T10:54:51.622408Z","caller":"traceutil/trace.go:171","msg":"trace[757025951] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:25147; }","duration":"181.282314ms","start":"2026-07-02T10:54:51.441116Z","end":"2026-07-02T10:54:51.622398Z","steps":["trace[757025951] 'agreement among raft nodes before linearized reading' (duration: 181.188322ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:54:51.62279Z","caller":"traceutil/trace.go:171","msg":"trace[1386696673] transaction","detail":"{read_only:false; response_revision:25148; number_of_response:1; }","duration":"160.365593ms","start":"2026-07-02T10:54:51.462391Z","end":"2026-07-02T10:54:51.622757Z","steps":["trace[1386696673] 'process raft request' (duration: 159.650859ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:54:51.771684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.967843ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-02T10:54:51.771781Z","caller":"traceutil/trace.go:171","msg":"trace[1706815986] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:25148; }","duration":"151.083265ms","start":"2026-07-02T10:54:51.620675Z","end":"2026-07-02T10:54:51.771758Z","steps":["trace[1706815986] 'count revisions from in-memory index tree' (duration: 148.882513ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:54:51.772313Z","caller":"traceutil/trace.go:171","msg":"trace[1747980632] transaction","detail":"{read_only:false; response_revision:25149; number_of_response:1; }","duration":"149.636698ms","start":"2026-07-02T10:54:51.622617Z","end":"2026-07-02T10:54:51.772254Z","steps":["trace[1747980632] 'process raft request' (duration: 146.244052ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:54:51.79327Z","caller":"traceutil/trace.go:171","msg":"trace[316610077] linearizableReadLoop","detail":"{readStateIndex:25982; appliedIndex:25980; }","duration":"141.051113ms","start":"2026-07-02T10:54:51.652201Z","end":"2026-07-02T10:54:51.793252Z","steps":["trace[316610077] 'read index received' (duration: 116.650935ms)","trace[316610077] 'applied index is now lower than readState.Index' (duration: 24.399198ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:54:51.79338Z","caller":"traceutil/trace.go:171","msg":"trace[1084873390] transaction","detail":"{read_only:false; response_revision:25150; number_of_response:1; }","duration":"170.423766ms","start":"2026-07-02T10:54:51.622934Z","end":"2026-07-02T10:54:51.793358Z","steps":["trace[1084873390] 'process raft request' (duration: 170.218131ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:54:51.793628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.39495ms","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-07-02T10:54:51.793743Z","caller":"traceutil/trace.go:171","msg":"trace[528861843] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25150; }","duration":"141.577923ms","start":"2026-07-02T10:54:51.652139Z","end":"2026-07-02T10:54:51.793717Z","steps":["trace[528861843] 'agreement among raft nodes before linearized reading' (duration: 141.249437ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:54:52.195032Z","caller":"traceutil/trace.go:171","msg":"trace[362315642] transaction","detail":"{read_only:false; response_revision:25151; number_of_response:1; }","duration":"418.759335ms","start":"2026-07-02T10:54:51.776248Z","end":"2026-07-02T10:54:52.195007Z","steps":["trace[362315642] 'process raft request' (duration: 418.570652ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:54:52.195172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:54:51.776223Z","time spent":"418.875778ms","remote":"127.0.0.1:42392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":628,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T10:54:52.382531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.031446ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-02T10:54:52.383121Z","caller":"traceutil/trace.go:171","msg":"trace[2077330067] linearizableReadLoop","detail":"{readStateIndex:25985; appliedIndex:25982; }","duration":"405.709145ms","start":"2026-07-02T10:54:51.97739Z","end":"2026-07-02T10:54:52.383099Z","steps":["trace[2077330067] 'read index received' (duration: 217.462297ms)","trace[2077330067] 'applied index is now lower than readState.Index' (duration: 188.245798ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:54:52.383144Z","caller":"traceutil/trace.go:171","msg":"trace[115837922] transaction","detail":"{read_only:false; response_revision:25152; number_of_response:1; }","duration":"584.93676ms","start":"2026-07-02T10:54:51.798183Z","end":"2026-07-02T10:54:52.383119Z","steps":["trace[115837922] 'process raft request' (duration: 424.20121ms)","trace[115837922] 'compare' (duration: 159.534747ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:54:52.383141Z","caller":"traceutil/trace.go:171","msg":"trace[864768321] transaction","detail":"{read_only:false; response_revision:25154; number_of_response:1; }","duration":"194.411956ms","start":"2026-07-02T10:54:52.188705Z","end":"2026-07-02T10:54:52.383117Z","steps":["trace[864768321] 'process raft request' (duration: 194.281234ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:54:52.383139Z","caller":"traceutil/trace.go:171","msg":"trace[1451484272] transaction","detail":"{read_only:false; response_revision:25153; number_of_response:1; }","duration":"509.705668ms","start":"2026-07-02T10:54:51.873401Z","end":"2026-07-02T10:54:52.383107Z","steps":["trace[1451484272] 'process raft request' (duration: 509.264419ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:54:52.383273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.877349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-02T10:54:52.383433Z","caller":"traceutil/trace.go:171","msg":"trace[1735946049] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25154; }","duration":"406.036651ms","start":"2026-07-02T10:54:51.977336Z","end":"2026-07-02T10:54:52.383372Z","steps":["trace[1735946049] 'agreement among raft nodes before linearized reading' (duration: 405.821947ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:54:52.383544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:54:51.977314Z","time spent":"406.212315ms","remote":"127.0.0.1:51240","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-02T10:54:52.383287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:54:51.798164Z","time spent":"585.040462ms","remote":"127.0.0.1:42392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T10:54:52.383665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:54:51.873374Z","time spent":"509.994284ms","remote":"127.0.0.1:42392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T10:54:52.681Z","caller":"traceutil/trace.go:171","msg":"trace[904423206] transaction","detail":"{read_only:false; response_revision:25155; number_of_response:1; }","duration":"133.130973ms","start":"2026-07-02T10:54:52.547842Z","end":"2026-07-02T10:54:52.680973Z","steps":["trace[904423206] 'process raft request' (duration: 73.815535ms)","trace[904423206] 'compare' (duration: 59.147934ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:54:53.06088Z","caller":"traceutil/trace.go:171","msg":"trace[2023850411] linearizableReadLoop","detail":"{readStateIndex:25988; appliedIndex:25987; }","duration":"146.978456ms","start":"2026-07-02T10:54:52.913867Z","end":"2026-07-02T10:54:53.060845Z","steps":["trace[2023850411] 'read index received' (duration: 146.573519ms)","trace[2023850411] 'applied index is now lower than readState.Index' (duration: 403.707µs)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:54:53.061296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.411555ms","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-07-02T10:54:53.061389Z","caller":"traceutil/trace.go:171","msg":"trace[1654163552] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25156; }","duration":"147.527076ms","start":"2026-07-02T10:54:52.913809Z","end":"2026-07-02T10:54:53.061336Z","steps":["trace[1654163552] 'agreement among raft nodes before linearized reading' (duration: 147.21119ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:54:53.061791Z","caller":"traceutil/trace.go:171","msg":"trace[980811780] transaction","detail":"{read_only:false; response_revision:25156; number_of_response:1; }","duration":"164.823638ms","start":"2026-07-02T10:54:52.89695Z","end":"2026-07-02T10:54:53.061774Z","steps":["trace[980811780] 'process raft request' (duration: 163.596385ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:54:53.352107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.289613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-02T10:54:53.35222Z","caller":"traceutil/trace.go:171","msg":"trace[137655806] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25157; }","duration":"183.463646ms","start":"2026-07-02T10:54:53.168731Z","end":"2026-07-02T10:54:53.352195Z","steps":["trace[137655806] 'range keys from in-memory index tree' (duration: 183.024478ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:54:53.35231Z","caller":"traceutil/trace.go:171","msg":"trace[534999107] linearizableReadLoop","detail":"{readStateIndex:25990; appliedIndex:25989; }","duration":"164.722068ms","start":"2026-07-02T10:54:53.187571Z","end":"2026-07-02T10:54:53.352293Z","steps":["trace[534999107] 'read index received' (duration: 135.574189ms)","trace[534999107] 'applied index is now lower than readState.Index' (duration: 29.146949ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:54:53.352355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.023777ms","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-07-02T10:54:53.352417Z","caller":"traceutil/trace.go:171","msg":"trace[33733883] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25157; }","duration":"184.087038ms","start":"2026-07-02T10:54:53.168312Z","end":"2026-07-02T10:54:53.352399Z","steps":["trace[33733883] 'range keys from in-memory index tree' (duration: 183.872633ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:54:53.352465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.886041ms","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-07-02T10:54:53.352507Z","caller":"traceutil/trace.go:171","msg":"trace[616703213] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25158; }","duration":"164.975112ms","start":"2026-07-02T10:54:53.187518Z","end":"2026-07-02T10:54:53.352493Z","steps":["trace[616703213] 'agreement among raft nodes before linearized reading' (duration: 164.83069ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:54:53.352963Z","caller":"traceutil/trace.go:171","msg":"trace[1529942480] transaction","detail":"{read_only:false; response_revision:25158; number_of_response:1; }","duration":"177.641824ms","start":"2026-07-02T10:54:53.174999Z","end":"2026-07-02T10:54:53.352641Z","steps":["trace[1529942480] 'process raft request' (duration: 148.137039ms)","trace[1529942480] 'compare' (duration: 28.949495ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:54:53.670004Z","caller":"traceutil/trace.go:171","msg":"trace[443372199] linearizableReadLoop","detail":"{readStateIndex:25993; appliedIndex:25990; }","duration":"258.539405ms","start":"2026-07-02T10:54:53.411443Z","end":"2026-07-02T10:54:53.669983Z","steps":["trace[443372199] 'read index received' (duration: 9.232487ms)","trace[443372199] 'applied index is now lower than readState.Index' (duration: 249.305738ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:54:53.670056Z","caller":"traceutil/trace.go:171","msg":"trace[2075925458] transaction","detail":"{read_only:false; response_revision:25161; number_of_response:1; }","duration":"311.743505ms","start":"2026-07-02T10:54:53.35828Z","end":"2026-07-02T10:54:53.670023Z","steps":["trace[2075925458] 'process raft request' (duration: 311.669443ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:54:53.67022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:54:53.358267Z","time spent":"311.858127ms","remote":"127.0.0.1:42392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T10:54:53.670239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.791219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates/\" range_end:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-02T10:54:53.670293Z","caller":"traceutil/trace.go:171","msg":"trace[794903643] range","detail":"{range_begin:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates/; range_end:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates0; response_count:0; response_revision:25161; }","duration":"258.855351ms","start":"2026-07-02T10:54:53.411423Z","end":"2026-07-02T10:54:53.670278Z","steps":["trace[794903643] 'agreement among raft nodes before linearized reading' (duration: 258.681997ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:54:53.670222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.315246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/exchanges/\" range_end:\"/registry/rabbitmq.com/exchanges0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-02T10:54:53.670357Z","caller":"traceutil/trace.go:171","msg":"trace[951729459] range","detail":"{range_begin:/registry/rabbitmq.com/exchanges/; range_end:/registry/rabbitmq.com/exchanges0; response_count:0; response_revision:25161; }","duration":"168.53376ms","start":"2026-07-02T10:54:53.501812Z","end":"2026-07-02T10:54:53.670346Z","steps":["trace[951729459] 'agreement among raft nodes before linearized reading' (duration: 168.298975ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:54:53.670056Z","caller":"traceutil/trace.go:171","msg":"trace[324274700] transaction","detail":"{read_only:false; response_revision:25160; number_of_response:1; }","duration":"311.788176ms","start":"2026-07-02T10:54:53.358221Z","end":"2026-07-02T10:54:53.670009Z","steps":["trace[324274700] 'process raft request' (duration: 311.583772ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:54:53.670771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:54:53.358201Z","time spent":"312.524779ms","remote":"127.0.0.1:42392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T10:54:53.904766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.166618ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-02T10:54:53.904989Z","caller":"traceutil/trace.go:171","msg":"trace[1990228172] transaction","detail":"{read_only:false; response_revision:25164; number_of_response:1; }","duration":"105.692656ms","start":"2026-07-02T10:54:53.799278Z","end":"2026-07-02T10:54:53.90497Z","steps":["trace[1990228172] 'process raft request' (duration: 105.653195ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:54:53.905345Z","caller":"traceutil/trace.go:171","msg":"trace[714485307] transaction","detail":"{read_only:false; response_revision:25163; number_of_response:1; }","duration":"126.348751ms","start":"2026-07-02T10:54:53.778986Z","end":"2026-07-02T10:54:53.905334Z","steps":["trace[714485307] 'process raft request' (duration: 125.889453ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:54:53.905337Z","caller":"traceutil/trace.go:171","msg":"trace[731400269] transaction","detail":"{read_only:false; response_revision:25162; number_of_response:1; }","duration":"231.14175ms","start":"2026-07-02T10:54:53.67416Z","end":"2026-07-02T10:54:53.905302Z","steps":["trace[731400269] 'process raft request' (duration: 128.34506ms)","trace[731400269] 'compare' (duration: 101.969934ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:54:54.218897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.325043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"} {"level":"info","ts":"2026-07-02T10:54:54.219119Z","caller":"traceutil/trace.go:171","msg":"trace[2006237259] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25164; }","duration":"148.568857ms","start":"2026-07-02T10:54:54.070501Z","end":"2026-07-02T10:54:54.219069Z","steps":["trace[2006237259] 'range keys from in-memory index tree' (duration: 148.132819ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:54:54.496507Z","caller":"traceutil/trace.go:171","msg":"trace[460294209] transaction","detail":"{read_only:false; response_revision:25167; number_of_response:1; }","duration":"106.979629ms","start":"2026-07-02T10:54:54.389504Z","end":"2026-07-02T10:54:54.496483Z","steps":["trace[460294209] 'process raft request' (duration: 106.918158ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:54:54.496596Z","caller":"traceutil/trace.go:171","msg":"trace[1120106412] transaction","detail":"{read_only:false; response_revision:25166; number_of_response:1; }","duration":"107.693963ms","start":"2026-07-02T10:54:54.38886Z","end":"2026-07-02T10:54:54.496554Z","steps":["trace[1120106412] 'process raft request' (duration: 107.385238ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:54:54.808172Z","caller":"traceutil/trace.go:171","msg":"trace[667539598] linearizableReadLoop","detail":"{readStateIndex:26000; appliedIndex:25999; }","duration":"234.003385ms","start":"2026-07-02T10:54:54.574149Z","end":"2026-07-02T10:54:54.808152Z","steps":["trace[667539598] 'read index received' (duration: 150.203259ms)","trace[667539598] 'applied index is now lower than readState.Index' (duration: 83.799246ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:54:54.808216Z","caller":"traceutil/trace.go:171","msg":"trace[1526589293] transaction","detail":"{read_only:false; response_revision:25168; number_of_response:1; }","duration":"369.713495ms","start":"2026-07-02T10:54:54.438449Z","end":"2026-07-02T10:54:54.808162Z","steps":["trace[1526589293] 'process raft request' (duration: 285.656814ms)","trace[1526589293] 'compare' (duration: 83.868687ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:54:54.808372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:54:54.438425Z","time spent":"369.861328ms","remote":"127.0.0.1:42392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T10:54:54.808411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.523335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-02T10:54:54.808463Z","caller":"traceutil/trace.go:171","msg":"trace[332858453] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25169; }","duration":"223.624856ms","start":"2026-07-02T10:54:54.584824Z","end":"2026-07-02T10:54:54.808449Z","steps":["trace[332858453] 'agreement among raft nodes before linearized reading' (duration: 223.511524ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:54:54.808808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.639706ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-07-02T10:54:54.808836Z","caller":"traceutil/trace.go:171","msg":"trace[461401696] transaction","detail":"{read_only:false; response_revision:25169; number_of_response:1; }","duration":"119.875147ms","start":"2026-07-02T10:54:54.688933Z","end":"2026-07-02T10:54:54.808808Z","steps":["trace[461401696] 'process raft request' (duration: 119.182944ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:54:54.808917Z","caller":"traceutil/trace.go:171","msg":"trace[1385913072] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:25168; }","duration":"234.788789ms","start":"2026-07-02T10:54:54.574081Z","end":"2026-07-02T10:54:54.808869Z","steps":["trace[1385913072] 'agreement among raft nodes before linearized reading' (duration: 234.201208ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:54:55.178524Z","caller":"traceutil/trace.go:171","msg":"trace[1046161484] linearizableReadLoop","detail":"{readStateIndex:26002; appliedIndex:26001; }","duration":"103.278469ms","start":"2026-07-02T10:54:55.075224Z","end":"2026-07-02T10:54:55.178503Z","steps":["trace[1046161484] 'read index received' (duration: 103.158456ms)","trace[1046161484] 'applied index is now lower than readState.Index' (duration: 119.053µs)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:54:55.178915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.673127ms","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-07-02T10:54:55.178926Z","caller":"traceutil/trace.go:171","msg":"trace[282715040] transaction","detail":"{read_only:false; response_revision:25170; number_of_response:1; }","duration":"111.164531ms","start":"2026-07-02T10:54:55.067722Z","end":"2026-07-02T10:54:55.178887Z","steps":["trace[282715040] 'process raft request' (duration: 110.65221ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:54:55.178956Z","caller":"traceutil/trace.go:171","msg":"trace[2091446693] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25170; }","duration":"103.767629ms","start":"2026-07-02T10:54:55.075174Z","end":"2026-07-02T10:54:55.178942Z","steps":["trace[2091446693] 'agreement among raft nodes before linearized reading' (duration: 103.410051ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:54:55.329033Z","caller":"traceutil/trace.go:171","msg":"trace[1929470558] transaction","detail":"{read_only:false; response_revision:25171; number_of_response:1; }","duration":"145.424908ms","start":"2026-07-02T10:54:55.183578Z","end":"2026-07-02T10:54:55.329003Z","steps":["trace[1929470558] 'process raft request' (duration: 131.865287ms)","trace[1929470558] 'compare' (duration: 13.342877ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:54:55.629782Z","caller":"traceutil/trace.go:171","msg":"trace[1212900248] linearizableReadLoop","detail":"{readStateIndex:26004; appliedIndex:26003; }","duration":"204.700023ms","start":"2026-07-02T10:54:55.425059Z","end":"2026-07-02T10:54:55.629759Z","steps":["trace[1212900248] 'read index received' (duration: 204.446108ms)","trace[1212900248] 'applied index is now lower than readState.Index' (duration: 252.985µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:54:55.629896Z","caller":"traceutil/trace.go:171","msg":"trace[1855141134] transaction","detail":"{read_only:false; response_revision:25172; number_of_response:1; }","duration":"269.182129ms","start":"2026-07-02T10:54:55.360676Z","end":"2026-07-02T10:54:55.629858Z","steps":["trace[1855141134] 'process raft request' (duration: 268.926665ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:54:55.629994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.923428ms","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-07-02T10:54:55.630254Z","caller":"traceutil/trace.go:171","msg":"trace[1663096284] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25172; }","duration":"205.232963ms","start":"2026-07-02T10:54:55.425002Z","end":"2026-07-02T10:54:55.630235Z","steps":["trace[1663096284] 'agreement among raft nodes before linearized reading' (duration: 204.858406ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:54:55.79211Z","caller":"traceutil/trace.go:171","msg":"trace[1710010541] transaction","detail":"{read_only:false; response_revision:25175; number_of_response:1; }","duration":"112.349083ms","start":"2026-07-02T10:54:55.679736Z","end":"2026-07-02T10:54:55.792085Z","steps":["trace[1710010541] 'process raft request' (duration: 112.293662ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:54:55.792161Z","caller":"traceutil/trace.go:171","msg":"trace[1816652207] transaction","detail":"{read_only:false; response_revision:25174; number_of_response:1; }","duration":"112.427255ms","start":"2026-07-02T10:54:55.679704Z","end":"2026-07-02T10:54:55.792131Z","steps":["trace[1816652207] 'process raft request' (duration: 108.691944ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:54:56.040605Z","caller":"traceutil/trace.go:171","msg":"trace[1685639531] transaction","detail":"{read_only:false; response_revision:25177; number_of_response:1; }","duration":"129.512661ms","start":"2026-07-02T10:54:55.911064Z","end":"2026-07-02T10:54:56.040577Z","steps":["trace[1685639531] 'process raft request' (duration: 129.326688ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:54:56.06722Z","caller":"traceutil/trace.go:171","msg":"trace[1628784336] transaction","detail":"{read_only:false; response_revision:25178; number_of_response:1; }","duration":"109.172282ms","start":"2026-07-02T10:54:55.958023Z","end":"2026-07-02T10:54:56.067195Z","steps":["trace[1628784336] 'process raft request' (duration: 107.638073ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:55:03.516221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.174354ms","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-07-02T10:55:03.516305Z","caller":"traceutil/trace.go:171","msg":"trace[1462079522] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25244; }","duration":"154.335277ms","start":"2026-07-02T10:55:03.361949Z","end":"2026-07-02T10:55:03.516284Z","steps":["trace[1462079522] 'range keys from in-memory index tree' (duration: 153.583304ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:55:03.807351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.579215ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-02T10:55:03.807498Z","caller":"traceutil/trace.go:171","msg":"trace[1020517819] linearizableReadLoop","detail":"{readStateIndex:26080; appliedIndex:26079; }","duration":"112.073348ms","start":"2026-07-02T10:55:03.695398Z","end":"2026-07-02T10:55:03.807472Z","steps":["trace[1020517819] 'read index received' (duration: 78.981µs)","trace[1020517819] 'applied index is now lower than readState.Index' (duration: 111.992247ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:55:03.807612Z","caller":"traceutil/trace.go:171","msg":"trace[1184105638] transaction","detail":"{read_only:false; response_revision:25246; number_of_response:1; }","duration":"153.757336ms","start":"2026-07-02T10:55:03.653807Z","end":"2026-07-02T10:55:03.807564Z","steps":["trace[1184105638] 'process raft request' (duration: 13.828204ms)","trace[1184105638] 'compare' (duration: 139.350041ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:55:03.80808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.66544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-02T10:55:03.808153Z","caller":"traceutil/trace.go:171","msg":"trace[576741920] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25246; }","duration":"112.788732ms","start":"2026-07-02T10:55:03.695346Z","end":"2026-07-02T10:55:03.808135Z","steps":["trace[576741920] 'agreement among raft nodes before linearized reading' (duration: 112.195161ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:55:04.068496Z","caller":"traceutil/trace.go:171","msg":"trace[393485298] transaction","detail":"{read_only:false; response_revision:25249; number_of_response:1; }","duration":"234.76823ms","start":"2026-07-02T10:55:03.833694Z","end":"2026-07-02T10:55:04.068463Z","steps":["trace[393485298] 'process raft request' (duration: 206.689912ms)","trace[393485298] 'compare' (duration: 27.943685ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:55:04.238951Z","caller":"traceutil/trace.go:171","msg":"trace[2119221642] transaction","detail":"{read_only:false; response_revision:25252; number_of_response:1; }","duration":"135.381494ms","start":"2026-07-02T10:55:04.103536Z","end":"2026-07-02T10:55:04.238917Z","steps":["trace[2119221642] 'process raft request' (duration: 131.751065ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:55:04.644123Z","caller":"traceutil/trace.go:171","msg":"trace[1159295879] transaction","detail":"{read_only:false; response_revision:25253; number_of_response:1; }","duration":"108.704734ms","start":"2026-07-02T10:55:04.535391Z","end":"2026-07-02T10:55:04.644095Z","steps":["trace[1159295879] 'process raft request' (duration: 108.551111ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:55:04.993553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.603425ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-02T10:55:04.993966Z","caller":"traceutil/trace.go:171","msg":"trace[725206499] transaction","detail":"{read_only:false; response_revision:25254; number_of_response:1; }","duration":"456.087531ms","start":"2026-07-02T10:55:04.537818Z","end":"2026-07-02T10:55:04.993905Z","steps":["trace[725206499] 'process raft request' (duration: 267.871213ms)","trace[725206499] 'compare' (duration: 187.31026ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:55:04.994031Z","caller":"traceutil/trace.go:171","msg":"trace[1534282091] linearizableReadLoop","detail":"{readStateIndex:26088; appliedIndex:26086; }","duration":"456.125541ms","start":"2026-07-02T10:55:04.537872Z","end":"2026-07-02T10:55:04.993998Z","steps":["trace[1534282091] 'read index received' (duration: 106.150444ms)","trace[1534282091] 'applied index is now lower than readState.Index' (duration: 349.972477ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:55:04.994244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:55:04.537744Z","time spent":"456.349796ms","remote":"127.0.0.1:42392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T10:55:04.994322Z","caller":"traceutil/trace.go:171","msg":"trace[1404886338] transaction","detail":"{read_only:false; response_revision:25255; number_of_response:1; }","duration":"185.277321ms","start":"2026-07-02T10:55:04.809024Z","end":"2026-07-02T10:55:04.994301Z","steps":["trace[1404886338] 'process raft request' (duration: 185.187639ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:55:04.994242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.329195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinedrainrules/\" range_end:\"/registry/cluster.x-k8s.io/machinedrainrules0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-02T10:55:04.994424Z","caller":"traceutil/trace.go:171","msg":"trace[1896113737] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinedrainrules/; range_end:/registry/cluster.x-k8s.io/machinedrainrules0; response_count:0; response_revision:25254; }","duration":"456.5676ms","start":"2026-07-02T10:55:04.537824Z","end":"2026-07-02T10:55:04.994391Z","steps":["trace[1896113737] 'agreement among raft nodes before linearized reading' (duration: 456.265054ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:55:04.994502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:55:04.537802Z","time spent":"456.675142ms","remote":"127.0.0.1:57724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":30,"request content":"key:\"/registry/cluster.x-k8s.io/machinedrainrules/\" range_end:\"/registry/cluster.x-k8s.io/machinedrainrules0\" count_only:true "} {"level":"warn","ts":"2026-07-02T10:55:05.003087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.878637ms","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-07-02T10:55:05.003161Z","caller":"traceutil/trace.go:171","msg":"trace[1471234781] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:25256; }","duration":"443.00021ms","start":"2026-07-02T10:55:04.560141Z","end":"2026-07-02T10:55:05.003141Z","steps":["trace[1471234781] 'agreement among raft nodes before linearized reading' (duration: 442.834717ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:55:05.003124Z","caller":"traceutil/trace.go:171","msg":"trace[533398694] transaction","detail":"{read_only:false; response_revision:25256; number_of_response:1; }","duration":"161.481704ms","start":"2026-07-02T10:55:04.841567Z","end":"2026-07-02T10:55:05.003048Z","steps":["trace[533398694] 'process raft request' (duration: 161.154598ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:55:05.0032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:55:04.560124Z","time spent":"443.066381ms","remote":"127.0.0.1:42544","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":30,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"warn","ts":"2026-07-02T10:55:05.00336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.606684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-02T10:55:05.003411Z","caller":"traceutil/trace.go:171","msg":"trace[818216906] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates0; response_count:0; response_revision:25256; }","duration":"105.680785ms","start":"2026-07-02T10:55:04.897717Z","end":"2026-07-02T10:55:05.003398Z","steps":["trace[818216906] 'agreement among raft nodes before linearized reading' (duration: 105.579313ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:55:05.003482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.637141ms","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-07-02T10:55:05.003522Z","caller":"traceutil/trace.go:171","msg":"trace[1142719579] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25256; }","duration":"157.716123ms","start":"2026-07-02T10:55:04.845796Z","end":"2026-07-02T10:55:05.003513Z","steps":["trace[1142719579] 'agreement among raft nodes before linearized reading' (duration: 157.557929ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:55:05.143888Z","caller":"traceutil/trace.go:171","msg":"trace[1758751293] linearizableReadLoop","detail":"{readStateIndex:26091; appliedIndex:26090; }","duration":"134.324274ms","start":"2026-07-02T10:55:05.009538Z","end":"2026-07-02T10:55:05.143862Z","steps":["trace[1758751293] 'read index received' (duration: 123.493216ms)","trace[1758751293] 'applied index is now lower than readState.Index' (duration: 10.829398ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:55:05.14395Z","caller":"traceutil/trace.go:171","msg":"trace[1775544049] transaction","detail":"{read_only:false; response_revision:25257; number_of_response:1; }","duration":"136.209771ms","start":"2026-07-02T10:55:05.00769Z","end":"2026-07-02T10:55:05.143899Z","steps":["trace[1775544049] 'process raft request' (duration: 125.356243ms)","trace[1775544049] 'compare' (duration: 10.702455ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:55:05.144108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.549478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"} {"level":"info","ts":"2026-07-02T10:55:05.14416Z","caller":"traceutil/trace.go:171","msg":"trace[550006553] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25257; }","duration":"134.65456ms","start":"2026-07-02T10:55:05.009491Z","end":"2026-07-02T10:55:05.144145Z","steps":["trace[550006553] 'agreement among raft nodes before linearized reading' (duration: 134.470107ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:55:05.948264Z","caller":"traceutil/trace.go:171","msg":"trace[1694270794] transaction","detail":"{read_only:false; response_revision:25259; number_of_response:1; }","duration":"360.520239ms","start":"2026-07-02T10:55:05.58772Z","end":"2026-07-02T10:55:05.94824Z","steps":["trace[1694270794] 'process raft request' (duration: 360.360766ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:55:05.948409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:55:05.587707Z","time spent":"360.625601ms","remote":"127.0.0.1:42392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T10:55:05.977365Z","caller":"traceutil/trace.go:171","msg":"trace[1811611952] transaction","detail":"{read_only:false; response_revision:25260; number_of_response:1; }","duration":"384.647812ms","start":"2026-07-02T10:55:05.592689Z","end":"2026-07-02T10:55:05.977337Z","steps":["trace[1811611952] 'process raft request' (duration: 384.388117ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:55:05.977556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:55:05.592661Z","time spent":"384.803055ms","remote":"127.0.0.1:42392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T10:55:05.977663Z","caller":"traceutil/trace.go:171","msg":"trace[813724189] transaction","detail":"{read_only:false; response_revision:25261; number_of_response:1; }","duration":"161.75662ms","start":"2026-07-02T10:55:05.815828Z","end":"2026-07-02T10:55:05.977584Z","steps":["trace[813724189] 'process raft request' (duration: 161.443944ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:55:05.977599Z","caller":"traceutil/trace.go:171","msg":"trace[1926313425] linearizableReadLoop","detail":"{readStateIndex:26095; appliedIndex:26093; }","duration":"151.114726ms","start":"2026-07-02T10:55:05.826416Z","end":"2026-07-02T10:55:05.977531Z","steps":["trace[1926313425] 'read index received' (duration: 121.984957ms)","trace[1926313425] 'applied index is now lower than readState.Index' (duration: 29.127279ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:55:05.977872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.430882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-02T10:55:05.977988Z","caller":"traceutil/trace.go:171","msg":"trace[2139117192] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25261; }","duration":"151.558095ms","start":"2026-07-02T10:55:05.826405Z","end":"2026-07-02T10:55:05.977963Z","steps":["trace[2139117192] 'agreement among raft nodes before linearized reading' (duration: 151.29108ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:55:05.979049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.50337ms","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-07-02T10:55:05.979219Z","caller":"traceutil/trace.go:171","msg":"trace[1238514072] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25261; }","duration":"109.675352ms","start":"2026-07-02T10:55:05.869497Z","end":"2026-07-02T10:55:05.979173Z","steps":["trace[1238514072] 'agreement among raft nodes before linearized reading' (duration: 108.379907ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:55:08.051998Z","caller":"traceutil/trace.go:171","msg":"trace[2137184125] linearizableReadLoop","detail":"{readStateIndex:26114; appliedIndex:26113; }","duration":"231.479117ms","start":"2026-07-02T10:55:07.820486Z","end":"2026-07-02T10:55:08.051965Z","steps":["trace[2137184125] 'read index received' (duration: 231.211392ms)","trace[2137184125] 'applied index is now lower than readState.Index' (duration: 265.825µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:55:08.052064Z","caller":"traceutil/trace.go:171","msg":"trace[631828781] transaction","detail":"{read_only:false; response_revision:25279; number_of_response:1; }","duration":"413.561657ms","start":"2026-07-02T10:55:07.638465Z","end":"2026-07-02T10:55:08.052026Z","steps":["trace[631828781] 'process raft request' (duration: 413.278981ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:55:08.052247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.725001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddresses/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddresses0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-02T10:55:08.052333Z","caller":"traceutil/trace.go:171","msg":"trace[355096940] range","detail":"{range_begin:/registry/ipam.cluster.x-k8s.io/ipaddresses/; range_end:/registry/ipam.cluster.x-k8s.io/ipaddresses0; response_count:0; response_revision:25279; }","duration":"231.884164ms","start":"2026-07-02T10:55:07.820427Z","end":"2026-07-02T10:55:08.052311Z","steps":["trace[355096940] 'agreement among raft nodes before linearized reading' (duration: 231.6948ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:55:08.052381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:55:07.638434Z","time spent":"413.700939ms","remote":"127.0.0.1:42330","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7161,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T10:55:08.072245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.575437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/probes/\" range_end:\"/registry/monitoring.coreos.com/probes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-07-02T10:55:08.072285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.095433ms","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-07-02T10:55:08.07235Z","caller":"traceutil/trace.go:171","msg":"trace[448415731] range","detail":"{range_begin:/registry/monitoring.coreos.com/probes/; range_end:/registry/monitoring.coreos.com/probes0; response_count:0; response_revision:25280; }","duration":"100.72547ms","start":"2026-07-02T10:55:07.971602Z","end":"2026-07-02T10:55:08.072327Z","steps":["trace[448415731] 'agreement among raft nodes before linearized reading' (duration: 100.503666ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:55:08.072373Z","caller":"traceutil/trace.go:171","msg":"trace[699770077] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25280; }","duration":"118.277076ms","start":"2026-07-02T10:55:07.95407Z","end":"2026-07-02T10:55:08.072347Z","steps":["trace[699770077] 'agreement among raft nodes before linearized reading' (duration: 118.042522ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:55:08.217644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.384076ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-02T10:55:08.217763Z","caller":"traceutil/trace.go:171","msg":"trace[1878793070] transaction","detail":"{read_only:false; response_revision:25281; number_of_response:1; }","duration":"139.903351ms","start":"2026-07-02T10:55:08.077835Z","end":"2026-07-02T10:55:08.217738Z","steps":["trace[1878793070] 'process raft request' (duration: 18.323701ms)","trace[1878793070] 'compare' (duration: 121.254584ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:55:08.220171Z","caller":"traceutil/trace.go:171","msg":"trace[358249064] linearizableReadLoop","detail":"{readStateIndex:26118; appliedIndex:26115; }","duration":"137.495004ms","start":"2026-07-02T10:55:08.082654Z","end":"2026-07-02T10:55:08.220149Z","steps":["trace[358249064] 'read index received' (duration: 13.483517ms)","trace[358249064] 'applied index is now lower than readState.Index' (duration: 124.010867ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:55:08.220446Z","caller":"traceutil/trace.go:171","msg":"trace[47573787] transaction","detail":"{read_only:false; response_revision:25282; number_of_response:1; }","duration":"141.164396ms","start":"2026-07-02T10:55:08.079273Z","end":"2026-07-02T10:55:08.220438Z","steps":["trace[47573787] 'process raft request' (duration: 140.640666ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:55:08.220566Z","caller":"traceutil/trace.go:171","msg":"trace[1201428893] transaction","detail":"{read_only:false; response_revision:25283; number_of_response:1; }","duration":"141.257957ms","start":"2026-07-02T10:55:08.079304Z","end":"2026-07-02T10:55:08.220562Z","steps":["trace[1201428893] 'process raft request' (duration: 140.738387ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:55:08.220711Z","caller":"traceutil/trace.go:171","msg":"trace[1962243674] transaction","detail":"{read_only:false; response_revision:25284; number_of_response:1; }","duration":"135.097029ms","start":"2026-07-02T10:55:08.085607Z","end":"2026-07-02T10:55:08.220704Z","steps":["trace[1962243674] 'process raft request' (duration: 134.469867ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:55:08.220774Z","caller":"traceutil/trace.go:171","msg":"trace[1890869584] transaction","detail":"{read_only:false; response_revision:25285; number_of_response:1; }","duration":"134.377785ms","start":"2026-07-02T10:55:08.086391Z","end":"2026-07-02T10:55:08.220769Z","steps":["trace[1890869584] 'process raft request' (duration: 133.730243ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:55:08.220927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.255418ms","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-07-02T10:55:08.220949Z","caller":"traceutil/trace.go:171","msg":"trace[1833662385] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25285; }","duration":"138.31766ms","start":"2026-07-02T10:55:08.082623Z","end":"2026-07-02T10:55:08.22094Z","steps":["trace[1833662385] 'agreement among raft nodes before linearized reading' (duration: 138.209728ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:55:08.221038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.53868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-02T10:55:08.221057Z","caller":"traceutil/trace.go:171","msg":"trace[4273114] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:0; response_revision:25285; }","duration":"109.584931ms","start":"2026-07-02T10:55:08.111467Z","end":"2026-07-02T10:55:08.221052Z","steps":["trace[4273114] 'agreement among raft nodes before linearized reading' (duration: 109.54877ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:55:10.873144Z","caller":"traceutil/trace.go:171","msg":"trace[1074558340] transaction","detail":"{read_only:false; response_revision:25363; number_of_response:1; }","duration":"131.056982ms","start":"2026-07-02T10:55:10.742066Z","end":"2026-07-02T10:55:10.873123Z","steps":["trace[1074558340] 'process raft request' (duration: 130.366488ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:55:15.82653Z","caller":"traceutil/trace.go:171","msg":"trace[181158620] transaction","detail":"{read_only:false; response_revision:25426; number_of_response:1; }","duration":"274.166242ms","start":"2026-07-02T10:55:15.552322Z","end":"2026-07-02T10:55:15.826489Z","steps":["trace[181158620] 'process raft request' (duration: 273.689434ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:55:15.959298Z","caller":"traceutil/trace.go:171","msg":"trace[1370009736] linearizableReadLoop","detail":"{readStateIndex:26263; appliedIndex:26262; }","duration":"101.703954ms","start":"2026-07-02T10:55:15.85757Z","end":"2026-07-02T10:55:15.959274Z","steps":["trace[1370009736] 'read index received' (duration: 101.46547ms)","trace[1370009736] 'applied index is now lower than readState.Index' (duration: 237.244µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:55:15.959351Z","caller":"traceutil/trace.go:171","msg":"trace[483038554] transaction","detail":"{read_only:false; response_revision:25427; number_of_response:1; }","duration":"122.94903ms","start":"2026-07-02T10:55:15.836364Z","end":"2026-07-02T10:55:15.959313Z","steps":["trace[483038554] 'process raft request' (duration: 122.736646ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:55:15.959567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.967069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0\" ","response":"range_response_count:1 size:1860"} {"level":"info","ts":"2026-07-02T10:55:15.959648Z","caller":"traceutil/trace.go:171","msg":"trace[1539157555] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:25427; }","duration":"102.114393ms","start":"2026-07-02T10:55:15.857513Z","end":"2026-07-02T10:55:15.959627Z","steps":["trace[1539157555] 'agreement among raft nodes before linearized reading' (duration: 101.866167ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:55:35.418577Z","caller":"traceutil/trace.go:171","msg":"trace[1909409459] linearizableReadLoop","detail":"{readStateIndex:26431; appliedIndex:26430; }","duration":"118.058857ms","start":"2026-07-02T10:55:35.300493Z","end":"2026-07-02T10:55:35.418552Z","steps":["trace[1909409459] 'read index received' (duration: 117.910544ms)","trace[1909409459] 'applied index is now lower than readState.Index' (duration: 146.983µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:55:35.418708Z","caller":"traceutil/trace.go:171","msg":"trace[326025150] transaction","detail":"{read_only:false; response_revision:25590; number_of_response:1; }","duration":"299.012458ms","start":"2026-07-02T10:55:35.119656Z","end":"2026-07-02T10:55:35.418669Z","steps":["trace[326025150] 'process raft request' (duration: 298.726672ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:55:35.41887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.349183ms","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-07-02T10:55:35.41893Z","caller":"traceutil/trace.go:171","msg":"trace[282823353] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25590; }","duration":"118.469566ms","start":"2026-07-02T10:55:35.30045Z","end":"2026-07-02T10:55:35.41892Z","steps":["trace[282823353] 'agreement among raft nodes before linearized reading' (duration: 118.230831ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:55:35.688772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.536293ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-02T10:55:35.68896Z","caller":"traceutil/trace.go:171","msg":"trace[1507725563] linearizableReadLoop","detail":"{readStateIndex:26433; appliedIndex:26431; }","duration":"243.058138ms","start":"2026-07-02T10:55:35.445882Z","end":"2026-07-02T10:55:35.688941Z","steps":["trace[1507725563] 'read index received' (duration: 51.038666ms)","trace[1507725563] 'applied index is now lower than readState.Index' (duration: 192.018112ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:55:35.689071Z","caller":"traceutil/trace.go:171","msg":"trace[48496733] transaction","detail":"{read_only:false; response_revision:25591; number_of_response:1; }","duration":"266.346953ms","start":"2026-07-02T10:55:35.42271Z","end":"2026-07-02T10:55:35.689057Z","steps":["trace[48496733] 'process raft request' (duration: 74.180338ms)","trace[48496733] 'compare' (duration: 191.3737ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:55:35.689394Z","caller":"traceutil/trace.go:171","msg":"trace[2137959537] transaction","detail":"{read_only:false; response_revision:25592; number_of_response:1; }","duration":"264.979737ms","start":"2026-07-02T10:55:35.424389Z","end":"2026-07-02T10:55:35.689368Z","steps":["trace[2137959537] 'process raft request' (duration: 264.489058ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:55:35.68948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.565558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-02T10:55:35.689578Z","caller":"traceutil/trace.go:171","msg":"trace[1180144441] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25592; }","duration":"106.714061ms","start":"2026-07-02T10:55:35.582838Z","end":"2026-07-02T10:55:35.689552Z","steps":["trace[1180144441] 'agreement among raft nodes before linearized reading' (duration: 106.530537ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:55:35.689594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.635579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/\" range_end:\"/registry/ceph.rook.io/cephclusters0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-07-02T10:55:35.689928Z","caller":"traceutil/trace.go:171","msg":"trace[733736350] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/; range_end:/registry/ceph.rook.io/cephclusters0; response_count:0; response_revision:25592; }","duration":"244.013695ms","start":"2026-07-02T10:55:35.445863Z","end":"2026-07-02T10:55:35.689876Z","steps":["trace[733736350] 'agreement among raft nodes before linearized reading' (duration: 243.536077ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:55:36.002154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.678845ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-02T10:55:36.002313Z","caller":"traceutil/trace.go:171","msg":"trace[1462659609] transaction","detail":"{read_only:false; response_revision:25593; number_of_response:1; }","duration":"235.847359ms","start":"2026-07-02T10:55:35.76645Z","end":"2026-07-02T10:55:36.002298Z","steps":["trace[1462659609] 'process raft request' (duration: 66.814158ms)","trace[1462659609] 'compare' (duration: 168.571643ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:55:36.002258Z","caller":"traceutil/trace.go:171","msg":"trace[664958972] linearizableReadLoop","detail":"{readStateIndex:26434; appliedIndex:26433; }","duration":"230.423315ms","start":"2026-07-02T10:55:35.771822Z","end":"2026-07-02T10:55:36.002245Z","steps":["trace[664958972] 'read index received' (duration: 61.370834ms)","trace[664958972] 'applied index is now lower than readState.Index' (duration: 169.051531ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:55:36.002676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.855495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"} {"level":"info","ts":"2026-07-02T10:55:36.002698Z","caller":"traceutil/trace.go:171","msg":"trace[58707315] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25593; }","duration":"230.939686ms","start":"2026-07-02T10:55:35.771751Z","end":"2026-07-02T10:55:36.002691Z","steps":["trace[58707315] 'agreement among raft nodes before linearized reading' (duration: 230.816464ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:55:36.116221Z","caller":"traceutil/trace.go:171","msg":"trace[405640246] linearizableReadLoop","detail":"{readStateIndex:26435; appliedIndex:26434; }","duration":"107.24864ms","start":"2026-07-02T10:55:36.008943Z","end":"2026-07-02T10:55:36.116191Z","steps":["trace[405640246] 'read index received' (duration: 105.834253ms)","trace[405640246] 'applied index is now lower than readState.Index' (duration: 1.413147ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:55:36.116429Z","caller":"traceutil/trace.go:171","msg":"trace[469472359] transaction","detail":"{read_only:false; response_revision:25594; number_of_response:1; }","duration":"110.208357ms","start":"2026-07-02T10:55:36.006182Z","end":"2026-07-02T10:55:36.116391Z","steps":["trace[469472359] 'process raft request' (duration: 108.621837ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:55:36.116525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.557856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"} {"level":"info","ts":"2026-07-02T10:55:36.11657Z","caller":"traceutil/trace.go:171","msg":"trace[1982918057] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25594; }","duration":"107.634008ms","start":"2026-07-02T10:55:36.00892Z","end":"2026-07-02T10:55:36.116554Z","steps":["trace[1982918057] 'agreement among raft nodes before linearized reading' (duration: 107.472285ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:55:36.402635Z","caller":"traceutil/trace.go:171","msg":"trace[2085160086] linearizableReadLoop","detail":"{readStateIndex:26436; appliedIndex:26435; }","duration":"181.714014ms","start":"2026-07-02T10:55:36.220897Z","end":"2026-07-02T10:55:36.402611Z","steps":["trace[2085160086] 'read index received' (duration: 181.604492ms)","trace[2085160086] 'applied index is now lower than readState.Index' (duration: 108.162µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:55:36.402707Z","caller":"traceutil/trace.go:171","msg":"trace[218270257] transaction","detail":"{read_only:false; response_revision:25595; number_of_response:1; }","duration":"207.670711ms","start":"2026-07-02T10:55:36.195002Z","end":"2026-07-02T10:55:36.402672Z","steps":["trace[218270257] 'process raft request' (duration: 207.445627ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:55:36.402794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.873466ms","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-07-02T10:55:36.402828Z","caller":"traceutil/trace.go:171","msg":"trace[5620181] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:25595; }","duration":"181.966389ms","start":"2026-07-02T10:55:36.220852Z","end":"2026-07-02T10:55:36.402819Z","steps":["trace[5620181] 'agreement among raft nodes before linearized reading' (duration: 181.881758ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:55:36.693803Z","caller":"traceutil/trace.go:171","msg":"trace[614225167] transaction","detail":"{read_only:false; response_revision:25596; number_of_response:1; }","duration":"457.58394ms","start":"2026-07-02T10:55:36.236194Z","end":"2026-07-02T10:55:36.693778Z","steps":["trace[614225167] 'process raft request' (duration: 453.142626ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:55:36.693941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:55:36.236164Z","time spent":"457.701772ms","remote":"127.0.0.1:42556","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9527,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T10:55:36.69413Z","caller":"traceutil/trace.go:171","msg":"trace[34161106] transaction","detail":"{read_only:false; response_revision:25597; number_of_response:1; }","duration":"367.937425ms","start":"2026-07-02T10:55:36.326159Z","end":"2026-07-02T10:55:36.694097Z","steps":["trace[34161106] 'process raft request' (duration: 367.518387ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:55:36.694304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:55:36.326133Z","time spent":"368.077468ms","remote":"127.0.0.1:42392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T10:55:36.694369Z","caller":"traceutil/trace.go:171","msg":"trace[1492285910] linearizableReadLoop","detail":"{readStateIndex:26439; appliedIndex:26436; }","duration":"291.641128ms","start":"2026-07-02T10:55:36.402707Z","end":"2026-07-02T10:55:36.694348Z","steps":["trace[1492285910] 'read index received' (duration: 286.509129ms)","trace[1492285910] 'applied index is now lower than readState.Index' (duration: 5.131289ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:55:36.694488Z","caller":"traceutil/trace.go:171","msg":"trace[2018200315] transaction","detail":"{read_only:false; response_revision:25598; number_of_response:1; }","duration":"367.094739ms","start":"2026-07-02T10:55:36.327386Z","end":"2026-07-02T10:55:36.694481Z","steps":["trace[2018200315] 'process raft request' (duration: 366.589749ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:55:36.694532Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:55:36.327362Z","time spent":"367.146121ms","remote":"127.0.0.1:42392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T10:55:36.69476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.524708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-07-02T10:55:36.694789Z","caller":"traceutil/trace.go:171","msg":"trace[787886021] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25598; }","duration":"310.571319ms","start":"2026-07-02T10:55:36.38421Z","end":"2026-07-02T10:55:36.694782Z","steps":["trace[787886021] 'agreement among raft nodes before linearized reading' (duration: 310.446866ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:55:36.694809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:55:36.384204Z","time spent":"310.600549ms","remote":"127.0.0.1:42392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":465,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-02T10:55:36.694948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.034302ms","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-07-02T10:55:36.694974Z","caller":"traceutil/trace.go:171","msg":"trace[1396844471] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25598; }","duration":"318.067522ms","start":"2026-07-02T10:55:36.376897Z","end":"2026-07-02T10:55:36.694965Z","steps":["trace[1396844471] 'agreement among raft nodes before linearized reading' (duration: 318.010001ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:55:36.694994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:55:36.376892Z","time spent":"318.097372ms","remote":"127.0.0.1:42392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":582,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-07-02T10:55:36.695108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.427278ms","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-07-02T10:55:36.695144Z","caller":"traceutil/trace.go:171","msg":"trace[2083899683] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25598; }","duration":"319.460118ms","start":"2026-07-02T10:55:36.375665Z","end":"2026-07-02T10:55:36.695125Z","steps":["trace[2083899683] 'agreement among raft nodes before linearized reading' (duration: 319.400657ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:55:36.695166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:55:36.375659Z","time spent":"319.50266ms","remote":"127.0.0.1:42392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":519,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-02T10:55:36.695281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.148711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-02T10:55:36.695307Z","caller":"traceutil/trace.go:171","msg":"trace[529508042] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25598; }","duration":"320.194032ms","start":"2026-07-02T10:55:36.375104Z","end":"2026-07-02T10:55:36.695298Z","steps":["trace[529508042] 'agreement among raft nodes before linearized reading' (duration: 320.136551ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:55:36.695324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:55:36.375094Z","time spent":"320.225933ms","remote":"127.0.0.1:42392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-02T10:55:36.695436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.661046ms","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-07-02T10:55:36.695458Z","caller":"traceutil/trace.go:171","msg":"trace[2069227561] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25598; }","duration":"326.702617ms","start":"2026-07-02T10:55:36.36875Z","end":"2026-07-02T10:55:36.695453Z","steps":["trace[2069227561] 'agreement among raft nodes before linearized reading' (duration: 326.644656ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:55:36.695476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:55:36.368742Z","time spent":"326.730777ms","remote":"127.0.0.1:42392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":533,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-02T10:55:36.695581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.577094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.66\" ","response":"range_response_count:1 size:137"} {"level":"info","ts":"2026-07-02T10:55:36.695603Z","caller":"traceutil/trace.go:171","msg":"trace[1812986270] range","detail":"{range_begin:/registry/masterleases/199.19.213.66; range_end:; response_count:1; response_revision:25598; }","duration":"327.638835ms","start":"2026-07-02T10:55:36.367958Z","end":"2026-07-02T10:55:36.695597Z","steps":["trace[1812986270] 'agreement among raft nodes before linearized reading' (duration: 327.584314ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:55:36.695618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:55:36.367943Z","time spent":"327.672116ms","remote":"127.0.0.1:51292","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":161,"request content":"key:\"/registry/masterleases/199.19.213.66\" "} {"level":"warn","ts":"2026-07-02T10:55:36.695742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.288962ms","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-07-02T10:55:36.695773Z","caller":"traceutil/trace.go:171","msg":"trace[1332706812] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:25598; }","duration":"289.360804ms","start":"2026-07-02T10:55:36.406406Z","end":"2026-07-02T10:55:36.695767Z","steps":["trace[1332706812] 'agreement among raft nodes before linearized reading' (duration: 289.309053ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:55:36.696078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.305678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-02T10:55:36.696107Z","caller":"traceutil/trace.go:171","msg":"trace[1998929022] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25598; }","duration":"111.37564ms","start":"2026-07-02T10:55:36.584725Z","end":"2026-07-02T10:55:36.6961Z","steps":["trace[1998929022] 'agreement among raft nodes before linearized reading' (duration: 111.329169ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:55:36.696245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.861985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-02T10:55:36.696272Z","caller":"traceutil/trace.go:171","msg":"trace[1542485153] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:25598; }","duration":"206.935407ms","start":"2026-07-02T10:55:36.48933Z","end":"2026-07-02T10:55:36.696266Z","steps":["trace[1542485153] 'agreement among raft nodes before linearized reading' (duration: 206.889456ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:55:36.696421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.252168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheusrules/\" range_end:\"/registry/monitoring.coreos.com/prometheusrules0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-07-02T10:55:36.696447Z","caller":"traceutil/trace.go:171","msg":"trace[290760054] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheusrules/; range_end:/registry/monitoring.coreos.com/prometheusrules0; response_count:0; response_revision:25598; }","duration":"212.323809ms","start":"2026-07-02T10:55:36.484117Z","end":"2026-07-02T10:55:36.696441Z","steps":["trace[290760054] 'agreement among raft nodes before linearized reading' (duration: 212.265278ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:55:36.860645Z","caller":"traceutil/trace.go:171","msg":"trace[1901941178] linearizableReadLoop","detail":"{readStateIndex:26440; appliedIndex:26439; }","duration":"160.438437ms","start":"2026-07-02T10:55:36.700148Z","end":"2026-07-02T10:55:36.860587Z","steps":["trace[1901941178] 'read index received' (duration: 108.043595ms)","trace[1901941178] 'applied index is now lower than readState.Index' (duration: 52.392972ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:55:36.860826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.653572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-02T10:55:36.86088Z","caller":"traceutil/trace.go:171","msg":"trace[1258260204] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25598; }","duration":"160.769134ms","start":"2026-07-02T10:55:36.700097Z","end":"2026-07-02T10:55:36.860866Z","steps":["trace[1258260204] 'agreement among raft nodes before linearized reading' (duration: 160.660692ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:55:37.121465Z","caller":"traceutil/trace.go:171","msg":"trace[59214718] transaction","detail":"{read_only:false; response_revision:25604; number_of_response:1; }","duration":"417.173757ms","start":"2026-07-02T10:55:36.704272Z","end":"2026-07-02T10:55:37.121445Z","steps":["trace[59214718] 'process raft request' (duration: 417.123486ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:55:37.121615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:55:36.704258Z","time spent":"417.269549ms","remote":"127.0.0.1:52248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3217,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T10:55:37.121623Z","caller":"traceutil/trace.go:171","msg":"trace[1456040658] transaction","detail":"{read_only:false; response_revision:25599; number_of_response:1; }","duration":"421.058851ms","start":"2026-07-02T10:55:36.700527Z","end":"2026-07-02T10:55:37.121586Z","steps":["trace[1456040658] 'process raft request' (duration: 406.652296ms)","trace[1456040658] 'compare' (duration: 13.602749ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:55:37.121655Z","caller":"traceutil/trace.go:171","msg":"trace[1060390660] transaction","detail":"{read_only:false; response_revision:25601; number_of_response:1; }","duration":"420.024911ms","start":"2026-07-02T10:55:36.701578Z","end":"2026-07-02T10:55:37.121603Z","steps":["trace[1060390660] 'process raft request' (duration: 419.742486ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:55:37.121759Z","caller":"traceutil/trace.go:171","msg":"trace[578097317] transaction","detail":"{read_only:false; response_revision:25602; number_of_response:1; }","duration":"419.532302ms","start":"2026-07-02T10:55:36.702219Z","end":"2026-07-02T10:55:37.121751Z","steps":["trace[578097317] 'process raft request' (duration: 419.128195ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:55:37.121803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:55:36.702206Z","time spent":"419.575444ms","remote":"127.0.0.1:42392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T10:55:37.121828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:55:36.70051Z","time spent":"421.196614ms","remote":"127.0.0.1:42392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T10:55:37.121913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:55:36.701561Z","time spent":"420.218995ms","remote":"127.0.0.1:42392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T10:55:37.12194Z","caller":"traceutil/trace.go:171","msg":"trace[1855459174] transaction","detail":"{read_only:false; response_revision:25603; number_of_response:1; }","duration":"419.556472ms","start":"2026-07-02T10:55:36.702377Z","end":"2026-07-02T10:55:37.121933Z","steps":["trace[1855459174] 'process raft request' (duration: 418.990562ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:55:37.122205Z","caller":"traceutil/trace.go:171","msg":"trace[1848229660] transaction","detail":"{read_only:false; response_revision:25600; number_of_response:1; }","duration":"421.496919ms","start":"2026-07-02T10:55:36.700693Z","end":"2026-07-02T10:55:37.122189Z","steps":["trace[1848229660] 'process raft request' (duration: 420.538601ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:55:37.122284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:55:36.700647Z","time spent":"421.598961ms","remote":"127.0.0.1:42392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T10:55:37.12221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:55:36.702368Z","time spent":"419.819308ms","remote":"127.0.0.1:42392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T10:55:37.123413Z","caller":"traceutil/trace.go:171","msg":"trace[1391890156] linearizableReadLoop","detail":"{readStateIndex:26447; appliedIndex:26440; }","duration":"262.643293ms","start":"2026-07-02T10:55:36.860728Z","end":"2026-07-02T10:55:37.123372Z","steps":["trace[1391890156] 'read index received' (duration: 246.384862ms)","trace[1391890156] 'applied index is now lower than readState.Index' (duration: 16.257331ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:55:37.123854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.05558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"} {"level":"info","ts":"2026-07-02T10:55:37.123921Z","caller":"traceutil/trace.go:171","msg":"trace[1836251078] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25606; }","duration":"422.170382ms","start":"2026-07-02T10:55:36.701738Z","end":"2026-07-02T10:55:37.123908Z","steps":["trace[1836251078] 'agreement among raft nodes before linearized reading' (duration: 421.962238ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:55:37.123955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:55:36.701714Z","time spent":"422.233314ms","remote":"127.0.0.1:42330","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12236,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-07-02T10:55:37.123971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.10358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1936"} {"level":"info","ts":"2026-07-02T10:55:37.124025Z","caller":"traceutil/trace.go:171","msg":"trace[35065744] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:25606; }","duration":"149.169463ms","start":"2026-07-02T10:55:36.974834Z","end":"2026-07-02T10:55:37.124003Z","steps":["trace[35065744] 'agreement among raft nodes before linearized reading' (duration: 148.976628ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:55:37.124111Z","caller":"traceutil/trace.go:171","msg":"trace[2082876683] transaction","detail":"{read_only:false; response_revision:25606; number_of_response:1; }","duration":"262.395768ms","start":"2026-07-02T10:55:36.861697Z","end":"2026-07-02T10:55:37.124092Z","steps":["trace[2082876683] 'process raft request' (duration: 261.618393ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:55:37.124272Z","caller":"traceutil/trace.go:171","msg":"trace[1093870579] transaction","detail":"{read_only:false; response_revision:25605; number_of_response:1; }","duration":"287.918125ms","start":"2026-07-02T10:55:36.836346Z","end":"2026-07-02T10:55:37.124264Z","steps":["trace[1093870579] 'process raft request' (duration: 286.802024ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:55:37.283743Z","caller":"traceutil/trace.go:171","msg":"trace[614038918] transaction","detail":"{read_only:false; response_revision:25608; number_of_response:1; }","duration":"117.480957ms","start":"2026-07-02T10:55:37.16624Z","end":"2026-07-02T10:55:37.283721Z","steps":["trace[614038918] 'process raft request' (duration: 117.339614ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:55:37.283794Z","caller":"traceutil/trace.go:171","msg":"trace[1632974638] linearizableReadLoop","detail":"{readStateIndex:26450; appliedIndex:26450; }","duration":"114.010241ms","start":"2026-07-02T10:55:37.169755Z","end":"2026-07-02T10:55:37.283765Z","steps":["trace[1632974638] 'read index received' (duration: 113.99664ms)","trace[1632974638] 'applied index is now lower than readState.Index' (duration: 11.281µs)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:55:37.284075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.292316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0\" ","response":"range_response_count:1 size:1860"} {"level":"info","ts":"2026-07-02T10:55:37.284127Z","caller":"traceutil/trace.go:171","msg":"trace[861222786] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:25608; }","duration":"114.379358ms","start":"2026-07-02T10:55:37.169734Z","end":"2026-07-02T10:55:37.284113Z","steps":["trace[861222786] 'agreement among raft nodes before linearized reading' (duration: 114.128673ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:55:37.322797Z","caller":"traceutil/trace.go:171","msg":"trace[1374047297] transaction","detail":"{read_only:false; response_revision:25609; number_of_response:1; }","duration":"136.228514ms","start":"2026-07-02T10:55:37.186543Z","end":"2026-07-02T10:55:37.322771Z","steps":["trace[1374047297] 'process raft request' (duration: 136.083992ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:55:37.705606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.146654ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-02T10:55:37.705815Z","caller":"traceutil/trace.go:171","msg":"trace[524099020] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:25611; }","duration":"181.373938ms","start":"2026-07-02T10:55:37.524415Z","end":"2026-07-02T10:55:37.705789Z","steps":["trace[524099020] 'range keys from in-memory index tree' (duration: 181.125173ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:55:37.706166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.526474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/rabbitmq-manila-nodes\" ","response":"range_response_count:1 size:1258"} {"level":"info","ts":"2026-07-02T10:55:37.706222Z","caller":"traceutil/trace.go:171","msg":"trace[1039324975] range","detail":"{range_begin:/registry/services/specs/openstack/rabbitmq-manila-nodes; range_end:; response_count:1; response_revision:25612; }","duration":"279.613336ms","start":"2026-07-02T10:55:37.426597Z","end":"2026-07-02T10:55:37.70621Z","steps":["trace[1039324975] 'agreement among raft nodes before linearized reading' (duration: 279.391241ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:55:37.705951Z","caller":"traceutil/trace.go:171","msg":"trace[1578368775] linearizableReadLoop","detail":"{readStateIndex:26454; appliedIndex:26453; }","duration":"279.298271ms","start":"2026-07-02T10:55:37.426637Z","end":"2026-07-02T10:55:37.705935Z","steps":["trace[1578368775] 'read index received' (duration: 255.817181ms)","trace[1578368775] 'applied index is now lower than readState.Index' (duration: 23.48013ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:55:37.706226Z","caller":"traceutil/trace.go:171","msg":"trace[459997881] transaction","detail":"{read_only:false; response_revision:25612; number_of_response:1; }","duration":"280.139756ms","start":"2026-07-02T10:55:37.426051Z","end":"2026-07-02T10:55:37.706191Z","steps":["trace[459997881] 'process raft request' (duration: 256.425963ms)","trace[459997881] 'compare' (duration: 23.327056ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:55:37.907619Z","caller":"traceutil/trace.go:171","msg":"trace[2006505031] linearizableReadLoop","detail":"{readStateIndex:26455; appliedIndex:26454; }","duration":"201.204317ms","start":"2026-07-02T10:55:37.706387Z","end":"2026-07-02T10:55:37.907591Z","steps":["trace[2006505031] 'read index received' (duration: 136.528401ms)","trace[2006505031] 'applied index is now lower than readState.Index' (duration: 64.675006ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:55:37.907678Z","caller":"traceutil/trace.go:171","msg":"trace[1659401484] transaction","detail":"{read_only:false; response_revision:25613; number_of_response:1; }","duration":"206.800894ms","start":"2026-07-02T10:55:37.70082Z","end":"2026-07-02T10:55:37.907621Z","steps":["trace[1659401484] 'process raft request' (duration: 142.115307ms)","trace[1659401484] 'compare' (duration: 64.532684ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:55:37.907899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.763512ms","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-07-02T10:55:37.907945Z","caller":"traceutil/trace.go:171","msg":"trace[1144345816] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25613; }","duration":"206.866105ms","start":"2026-07-02T10:55:37.701068Z","end":"2026-07-02T10:55:37.907935Z","steps":["trace[1144345816] 'agreement among raft nodes before linearized reading' (duration: 206.663061ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:55:37.908181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.899565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-02T10:55:37.908215Z","caller":"traceutil/trace.go:171","msg":"trace[884878450] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25613; }","duration":"321.968427ms","start":"2026-07-02T10:55:37.586238Z","end":"2026-07-02T10:55:37.908206Z","steps":["trace[884878450] 'agreement among raft nodes before linearized reading' (duration: 321.915246ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:55:37.908242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:55:37.586212Z","time spent":"322.022697ms","remote":"127.0.0.1:51240","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-02T10:55:37.908693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.68517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/rabbitmq-manila\" ","response":"range_response_count:1 size:1448"} {"level":"info","ts":"2026-07-02T10:55:37.908783Z","caller":"traceutil/trace.go:171","msg":"trace[751320435] range","detail":"{range_begin:/registry/services/specs/openstack/rabbitmq-manila; range_end:; response_count:1; response_revision:25613; }","duration":"197.900964ms","start":"2026-07-02T10:55:37.710865Z","end":"2026-07-02T10:55:37.908766Z","steps":["trace[751320435] 'agreement among raft nodes before linearized reading' (duration: 197.565278ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:55:39.101613Z","caller":"traceutil/trace.go:171","msg":"trace[1464583311] linearizableReadLoop","detail":"{readStateIndex:26460; appliedIndex:26459; }","duration":"114.831176ms","start":"2026-07-02T10:55:38.986761Z","end":"2026-07-02T10:55:39.101593Z","steps":["trace[1464583311] 'read index received' (duration: 114.547801ms)","trace[1464583311] 'applied index is now lower than readState.Index' (duration: 282.515µs)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:55:39.101739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.954808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups/\" range_end:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-02T10:55:39.101702Z","caller":"traceutil/trace.go:171","msg":"trace[408549908] transaction","detail":"{read_only:false; response_revision:25618; number_of_response:1; }","duration":"132.748848ms","start":"2026-07-02T10:55:38.96891Z","end":"2026-07-02T10:55:39.101658Z","steps":["trace[408549908] 'process raft request' (duration: 132.408552ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:55:39.101763Z","caller":"traceutil/trace.go:171","msg":"trace[232455102] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemsubvolumegroups/; range_end:/registry/ceph.rook.io/cephfilesystemsubvolumegroups0; response_count:0; response_revision:25618; }","duration":"115.009639ms","start":"2026-07-02T10:55:38.986745Z","end":"2026-07-02T10:55:39.101755Z","steps":["trace[232455102] 'agreement among raft nodes before linearized reading' (duration: 114.932137ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:55:39.249175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.734188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-02T10:55:39.249245Z","caller":"traceutil/trace.go:171","msg":"trace[436070928] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25618; }","duration":"121.81783ms","start":"2026-07-02T10:55:39.127411Z","end":"2026-07-02T10:55:39.249229Z","steps":["trace[436070928] 'range keys from in-memory index tree' (duration: 121.516934ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:55:39.249249Z","caller":"traceutil/trace.go:171","msg":"trace[2073615507] linearizableReadLoop","detail":"{readStateIndex:26461; appliedIndex:26460; }","duration":"118.136849ms","start":"2026-07-02T10:55:39.131094Z","end":"2026-07-02T10:55:39.249231Z","steps":["trace[2073615507] 'read index received' (duration: 50.311252ms)","trace[2073615507] 'applied index is now lower than readState.Index' (duration: 67.824817ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:55:39.249397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.079616ms","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-07-02T10:55:39.249434Z","caller":"traceutil/trace.go:171","msg":"trace[2609342] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25618; }","duration":"122.153826ms","start":"2026-07-02T10:55:39.127268Z","end":"2026-07-02T10:55:39.249422Z","steps":["trace[2609342] 'range keys from in-memory index tree' (duration: 121.962353ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:55:39.249482Z","caller":"traceutil/trace.go:171","msg":"trace[348139282] transaction","detail":"{read_only:false; response_revision:25619; number_of_response:1; }","duration":"120.255ms","start":"2026-07-02T10:55:39.129217Z","end":"2026-07-02T10:55:39.249472Z","steps":["trace[348139282] 'process raft request' (duration: 52.207399ms)","trace[348139282] 'compare' (duration: 67.571601ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:55:39.249479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.894702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"warn","ts":"2026-07-02T10:55:39.24958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.148977ms","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-07-02T10:55:39.249601Z","caller":"traceutil/trace.go:171","msg":"trace[1200686497] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25618; }","duration":"122.181507ms","start":"2026-07-02T10:55:39.127413Z","end":"2026-07-02T10:55:39.249594Z","steps":["trace[1200686497] 'range keys from in-memory index tree' (duration: 122.036904ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:55:39.249621Z","caller":"traceutil/trace.go:171","msg":"trace[1057273571] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25618; }","duration":"122.087905ms","start":"2026-07-02T10:55:39.1275Z","end":"2026-07-02T10:55:39.249588Z","steps":["trace[1057273571] 'range keys from in-memory index tree' (duration: 121.656096ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:55:39.249699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.601338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/rabbitmq-manila-default-user\" ","response":"range_response_count:1 size:1155"} {"level":"info","ts":"2026-07-02T10:55:39.249754Z","caller":"traceutil/trace.go:171","msg":"trace[1662053372] range","detail":"{range_begin:/registry/secrets/openstack/rabbitmq-manila-default-user; range_end:; response_count:1; response_revision:25619; }","duration":"118.654329ms","start":"2026-07-02T10:55:39.13109Z","end":"2026-07-02T10:55:39.249744Z","steps":["trace[1662053372] 'agreement among raft nodes before linearized reading' (duration: 118.510087ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:55:39.250264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.800208ms","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-07-02T10:55:39.250345Z","caller":"traceutil/trace.go:171","msg":"trace[2034890356] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25618; }","duration":"122.88139ms","start":"2026-07-02T10:55:39.127438Z","end":"2026-07-02T10:55:39.250319Z","steps":["trace[2034890356] 'range keys from in-memory index tree' (duration: 122.638755ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:55:39.415554Z","caller":"traceutil/trace.go:171","msg":"trace[1671353350] transaction","detail":"{read_only:false; response_revision:25621; number_of_response:1; }","duration":"159.850227ms","start":"2026-07-02T10:55:39.255675Z","end":"2026-07-02T10:55:39.415525Z","steps":["trace[1671353350] 'process raft request' (duration: 136.719735ms)","trace[1671353350] 'compare' (duration: 22.884347ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:55:39.41607Z","caller":"traceutil/trace.go:171","msg":"trace[1175029423] transaction","detail":"{read_only:false; response_revision:25622; number_of_response:1; }","duration":"160.268685ms","start":"2026-07-02T10:55:39.255766Z","end":"2026-07-02T10:55:39.416034Z","steps":["trace[1175029423] 'process raft request' (duration: 159.710394ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:55:39.416198Z","caller":"traceutil/trace.go:171","msg":"trace[1161230493] transaction","detail":"{read_only:false; response_revision:25623; number_of_response:1; }","duration":"160.236585ms","start":"2026-07-02T10:55:39.255947Z","end":"2026-07-02T10:55:39.416183Z","steps":["trace[1161230493] 'process raft request' (duration: 159.810676ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:55:39.416223Z","caller":"traceutil/trace.go:171","msg":"trace[1737317987] transaction","detail":"{read_only:false; response_revision:25624; number_of_response:1; }","duration":"159.919078ms","start":"2026-07-02T10:55:39.256276Z","end":"2026-07-02T10:55:39.416195Z","steps":["trace[1737317987] 'process raft request' (duration: 159.767005ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:55:41.551908Z","caller":"traceutil/trace.go:171","msg":"trace[1969578560] transaction","detail":"{read_only:false; response_revision:25638; number_of_response:1; }","duration":"127.06817ms","start":"2026-07-02T10:55:41.424788Z","end":"2026-07-02T10:55:41.551856Z","steps":["trace[1969578560] 'process raft request' (duration: 126.969418ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:55:41.552472Z","caller":"traceutil/trace.go:171","msg":"trace[1678885250] transaction","detail":"{read_only:false; response_revision:25639; number_of_response:1; }","duration":"127.63531ms","start":"2026-07-02T10:55:41.424823Z","end":"2026-07-02T10:55:41.552458Z","steps":["trace[1678885250] 'process raft request' (duration: 126.985648ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:55:41.552465Z","caller":"traceutil/trace.go:171","msg":"trace[1604526569] transaction","detail":"{read_only:false; response_revision:25637; number_of_response:1; }","duration":"127.696702ms","start":"2026-07-02T10:55:41.424745Z","end":"2026-07-02T10:55:41.552442Z","steps":["trace[1604526569] 'process raft request' (duration: 126.890567ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:55:41.551946Z","caller":"traceutil/trace.go:171","msg":"trace[2079536975] transaction","detail":"{read_only:false; response_revision:25636; number_of_response:1; }","duration":"127.331615ms","start":"2026-07-02T10:55:41.42458Z","end":"2026-07-02T10:55:41.551912Z","steps":["trace[2079536975] 'process raft request' (duration: 126.198703ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:55:41.553879Z","caller":"traceutil/trace.go:171","msg":"trace[2016506593] linearizableReadLoop","detail":"{readStateIndex:26481; appliedIndex:26476; }","duration":"116.373005ms","start":"2026-07-02T10:55:41.437491Z","end":"2026-07-02T10:55:41.553864Z","steps":["trace[2016506593] 'read index received' (duration: 28.029156ms)","trace[2016506593] 'applied index is now lower than readState.Index' (duration: 88.342709ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:55:41.553999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.476567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-07-02T10:55:41.554042Z","caller":"traceutil/trace.go:171","msg":"trace[1334653163] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:25639; }","duration":"116.56864ms","start":"2026-07-02T10:55:41.437462Z","end":"2026-07-02T10:55:41.554031Z","steps":["trace[1334653163] 'agreement among raft nodes before linearized reading' (duration: 116.461117ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:55:44.820386Z","caller":"traceutil/trace.go:171","msg":"trace[2085495717] transaction","detail":"{read_only:false; response_revision:25659; number_of_response:1; }","duration":"182.697223ms","start":"2026-07-02T10:55:44.637662Z","end":"2026-07-02T10:55:44.820359Z","steps":["trace[2085495717] 'process raft request' (duration: 182.489449ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:55:44.98037Z","caller":"traceutil/trace.go:171","msg":"trace[1556858958] transaction","detail":"{read_only:false; response_revision:25660; number_of_response:1; }","duration":"256.648148ms","start":"2026-07-02T10:55:44.723698Z","end":"2026-07-02T10:55:44.980347Z","steps":["trace[1556858958] 'process raft request' (duration: 246.123286ms)","trace[1556858958] 'compare' (duration: 10.154724ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:55:44.980777Z","caller":"traceutil/trace.go:171","msg":"trace[956687932] transaction","detail":"{read_only:false; response_revision:25661; number_of_response:1; }","duration":"248.701026ms","start":"2026-07-02T10:55:44.731984Z","end":"2026-07-02T10:55:44.980685Z","steps":["trace[956687932] 'process raft request' (duration: 248.327629ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:55:47.227622Z","caller":"traceutil/trace.go:171","msg":"trace[2118328457] transaction","detail":"{read_only:false; response_revision:25677; number_of_response:1; }","duration":"242.002447ms","start":"2026-07-02T10:55:46.985595Z","end":"2026-07-02T10:55:47.227597Z","steps":["trace[2118328457] 'process raft request' (duration: 217.07296ms)","trace[2118328457] 'compare' (duration: 24.366746ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:55:47.383003Z","caller":"traceutil/trace.go:171","msg":"trace[1942187483] linearizableReadLoop","detail":"{readStateIndex:26522; appliedIndex:26521; }","duration":"106.489656ms","start":"2026-07-02T10:55:47.276495Z","end":"2026-07-02T10:55:47.382984Z","steps":["trace[1942187483] 'read index received' (duration: 91.848735ms)","trace[1942187483] 'applied index is now lower than readState.Index' (duration: 14.640231ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:55:47.383101Z","caller":"traceutil/trace.go:171","msg":"trace[823529897] transaction","detail":"{read_only:false; response_revision:25678; number_of_response:1; }","duration":"107.846863ms","start":"2026-07-02T10:55:47.275245Z","end":"2026-07-02T10:55:47.383092Z","steps":["trace[823529897] 'process raft request' (duration: 93.07117ms)","trace[823529897] 'compare' (duration: 14.415195ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:55:47.383475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.937265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"} {"level":"info","ts":"2026-07-02T10:55:47.383589Z","caller":"traceutil/trace.go:171","msg":"trace[303669822] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25679; }","duration":"107.104188ms","start":"2026-07-02T10:55:47.276466Z","end":"2026-07-02T10:55:47.38357Z","steps":["trace[303669822] 'agreement among raft nodes before linearized reading' (duration: 106.656659ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:55:49.218223Z","caller":"traceutil/trace.go:171","msg":"trace[810724358] transaction","detail":"{read_only:false; response_revision:25690; number_of_response:1; }","duration":"206.037979ms","start":"2026-07-02T10:55:49.012162Z","end":"2026-07-02T10:55:49.2182Z","steps":["trace[810724358] 'process raft request' (duration: 205.886586ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:55:49.97358Z","caller":"traceutil/trace.go:171","msg":"trace[1816821839] transaction","detail":"{read_only:false; response_revision:25699; number_of_response:1; }","duration":"214.199815ms","start":"2026-07-02T10:55:49.759354Z","end":"2026-07-02T10:55:49.973554Z","steps":["trace[1816821839] 'process raft request' (duration: 214.031012ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:55:50.194999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.071946ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-02T10:55:50.19508Z","caller":"traceutil/trace.go:171","msg":"trace[1107542538] linearizableReadLoop","detail":"{readStateIndex:26544; appliedIndex:26543; }","duration":"210.056557ms","start":"2026-07-02T10:55:49.985011Z","end":"2026-07-02T10:55:50.195067Z","steps":["trace[1107542538] 'read index received' (duration: 89.852828ms)","trace[1107542538] 'applied index is now lower than readState.Index' (duration: 120.202839ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:55:50.195141Z","caller":"traceutil/trace.go:171","msg":"trace[2118440889] transaction","detail":"{read_only:false; response_revision:25700; number_of_response:1; }","duration":"241.830034ms","start":"2026-07-02T10:55:49.953304Z","end":"2026-07-02T10:55:50.195134Z","steps":["trace[2118440889] 'process raft request' (duration: 121.553924ms)","trace[2118440889] 'compare' (duration: 119.899253ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:55:50.195327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.186783ms","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-07-02T10:55:50.195393Z","caller":"traceutil/trace.go:171","msg":"trace[747182841] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25700; }","duration":"114.301385ms","start":"2026-07-02T10:55:50.081075Z","end":"2026-07-02T10:55:50.195377Z","steps":["trace[747182841] 'agreement among raft nodes before linearized reading' (duration: 114.124721ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:55:50.195329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.308071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-neutron-server-0\" ","response":"range_response_count:1 size:1863"} {"level":"info","ts":"2026-07-02T10:55:50.195513Z","caller":"traceutil/trace.go:171","msg":"trace[365483535] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-neutron-server-0; range_end:; response_count:1; response_revision:25700; }","duration":"210.546566ms","start":"2026-07-02T10:55:49.984956Z","end":"2026-07-02T10:55:50.195502Z","steps":["trace[365483535] 'agreement among raft nodes before linearized reading' (duration: 210.264931ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:55:51.890027Z","caller":"traceutil/trace.go:171","msg":"trace[722391902] transaction","detail":"{read_only:false; response_revision:25714; number_of_response:1; }","duration":"134.090574ms","start":"2026-07-02T10:55:51.755917Z","end":"2026-07-02T10:55:51.890007Z","steps":["trace[722391902] 'process raft request' (duration: 133.963652ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:55:53.17501Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":22269} {"level":"info","ts":"2026-07-02T10:55:53.285009Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":22269,"took":"107.096458ms","hash":1971951724,"current-db-size-bytes":57978880,"current-db-size":"58 MB","current-db-size-in-use-bytes":45326336,"current-db-size-in-use":"45 MB"} {"level":"info","ts":"2026-07-02T10:55:53.285156Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1971951724,"revision":22269,"compact-revision":20093} {"level":"info","ts":"2026-07-02T10:55:57.517873Z","caller":"traceutil/trace.go:171","msg":"trace[1125132031] transaction","detail":"{read_only:false; response_revision:25749; number_of_response:1; }","duration":"267.676758ms","start":"2026-07-02T10:55:57.250166Z","end":"2026-07-02T10:55:57.517843Z","steps":["trace[1125132031] 'process raft request' (duration: 267.388353ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:55:57.777272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.469656ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-02T10:55:57.777597Z","caller":"traceutil/trace.go:171","msg":"trace[579347896] transaction","detail":"{read_only:false; response_revision:25753; number_of_response:1; }","duration":"237.38836ms","start":"2026-07-02T10:55:57.540185Z","end":"2026-07-02T10:55:57.777573Z","steps":["trace[579347896] 'process raft request' (duration: 237.334409ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:55:57.777835Z","caller":"traceutil/trace.go:171","msg":"trace[236489308] transaction","detail":"{read_only:false; response_revision:25750; number_of_response:1; }","duration":"499.838827ms","start":"2026-07-02T10:55:57.277984Z","end":"2026-07-02T10:55:57.777822Z","steps":["trace[236489308] 'process raft request' (duration: 290.714948ms)","trace[236489308] 'compare' (duration: 208.355424ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:55:57.777917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:55:57.277962Z","time spent":"499.908409ms","remote":"127.0.0.1:42392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T10:55:57.778014Z","caller":"traceutil/trace.go:171","msg":"trace[1352591626] transaction","detail":"{read_only:false; response_revision:25751; number_of_response:1; }","duration":"382.216229ms","start":"2026-07-02T10:55:57.395788Z","end":"2026-07-02T10:55:57.778004Z","steps":["trace[1352591626] 'process raft request' (duration: 381.586597ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:55:57.778064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:55:57.395766Z","time spent":"382.268369ms","remote":"127.0.0.1:42392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":628,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T10:55:57.778161Z","caller":"traceutil/trace.go:171","msg":"trace[1228233700] transaction","detail":"{read_only:false; response_revision:25752; number_of_response:1; }","duration":"360.78131ms","start":"2026-07-02T10:55:57.417372Z","end":"2026-07-02T10:55:57.778153Z","steps":["trace[1228233700] 'process raft request' (duration: 360.086717ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:55:57.778208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:55:57.417364Z","time spent":"360.81733ms","remote":"127.0.0.1:42392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T10:55:57.778414Z","caller":"traceutil/trace.go:171","msg":"trace[1824430410] linearizableReadLoop","detail":"{readStateIndex:26599; appliedIndex:26595; }","duration":"322.929234ms","start":"2026-07-02T10:55:57.455435Z","end":"2026-07-02T10:55:57.778364Z","steps":["trace[1824430410] 'read index received' (duration: 62.141408ms)","trace[1824430410] 'applied index is now lower than readState.Index' (duration: 260.786056ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:55:57.778651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.939355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-07-02T10:55:57.778664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.21624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-02T10:55:57.778691Z","caller":"traceutil/trace.go:171","msg":"trace[1929300811] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:25753; }","duration":"255.027406ms","start":"2026-07-02T10:55:57.523649Z","end":"2026-07-02T10:55:57.778676Z","steps":["trace[1929300811] 'agreement among raft nodes before linearized reading' (duration: 254.896604ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:55:57.778712Z","caller":"traceutil/trace.go:171","msg":"trace[838458252] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25753; }","duration":"323.299962ms","start":"2026-07-02T10:55:57.455396Z","end":"2026-07-02T10:55:57.778696Z","steps":["trace[838458252] 'agreement among raft nodes before linearized reading' (duration: 323.123658ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:55:57.778744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:55:57.455383Z","time spent":"323.353043ms","remote":"127.0.0.1:42392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-02T10:55:57.778781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.036587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"warn","ts":"2026-07-02T10:55:57.778785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.822048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"} {"level":"warn","ts":"2026-07-02T10:55:57.778813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.802863ms","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":"warn","ts":"2026-07-02T10:55:57.778822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.613699ms","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-07-02T10:55:57.778885Z","caller":"traceutil/trace.go:171","msg":"trace[1514143288] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25753; }","duration":"191.976622ms","start":"2026-07-02T10:55:57.586885Z","end":"2026-07-02T10:55:57.778861Z","steps":["trace[1514143288] 'agreement among raft nodes before linearized reading' (duration: 191.684595ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:55:57.778882Z","caller":"traceutil/trace.go:171","msg":"trace[866918005] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25753; }","duration":"141.168819ms","start":"2026-07-02T10:55:57.637683Z","end":"2026-07-02T10:55:57.778852Z","steps":["trace[866918005] 'agreement among raft nodes before linearized reading' (duration: 140.875463ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:55:57.778901Z","caller":"traceutil/trace.go:171","msg":"trace[259699037] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25753; }","duration":"139.908655ms","start":"2026-07-02T10:55:57.638969Z","end":"2026-07-02T10:55:57.778878Z","steps":["trace[259699037] 'agreement among raft nodes before linearized reading' (duration: 139.633949ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:55:57.778885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.028009ms","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-07-02T10:55:57.778925Z","caller":"traceutil/trace.go:171","msg":"trace[247346463] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25753; }","duration":"141.782012ms","start":"2026-07-02T10:55:57.637117Z","end":"2026-07-02T10:55:57.778899Z","steps":["trace[247346463] 'agreement among raft nodes before linearized reading' (duration: 141.445745ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:55:57.778984Z","caller":"traceutil/trace.go:171","msg":"trace[2036344292] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25753; }","duration":"138.159572ms","start":"2026-07-02T10:55:57.640799Z","end":"2026-07-02T10:55:57.778959Z","steps":["trace[2036344292] 'agreement among raft nodes before linearized reading' (duration: 137.790605ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:55:57.98629Z","caller":"traceutil/trace.go:171","msg":"trace[374624369] transaction","detail":"{read_only:false; response_revision:25754; number_of_response:1; }","duration":"201.772198ms","start":"2026-07-02T10:55:57.784425Z","end":"2026-07-02T10:55:57.986197Z","steps":["trace[374624369] 'process raft request' (duration: 194.57722ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:55:57.99322Z","caller":"traceutil/trace.go:171","msg":"trace[476415191] transaction","detail":"{read_only:false; response_revision:25757; number_of_response:1; }","duration":"204.151204ms","start":"2026-07-02T10:55:57.789045Z","end":"2026-07-02T10:55:57.993196Z","steps":["trace[476415191] 'process raft request' (duration: 204.091903ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:55:57.993308Z","caller":"traceutil/trace.go:171","msg":"trace[1251850825] transaction","detail":"{read_only:false; response_revision:25755; number_of_response:1; }","duration":"208.16219ms","start":"2026-07-02T10:55:57.785071Z","end":"2026-07-02T10:55:57.993233Z","steps":["trace[1251850825] 'process raft request' (duration: 207.919306ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:55:57.993382Z","caller":"traceutil/trace.go:171","msg":"trace[462533916] transaction","detail":"{read_only:false; response_revision:25756; number_of_response:1; }","duration":"208.203321ms","start":"2026-07-02T10:55:57.785115Z","end":"2026-07-02T10:55:57.993319Z","steps":["trace[462533916] 'process raft request' (duration: 207.981637ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:55:57.993459Z","caller":"traceutil/trace.go:171","msg":"trace[533876086] linearizableReadLoop","detail":"{readStateIndex:26603; appliedIndex:26600; }","duration":"207.618419ms","start":"2026-07-02T10:55:57.785825Z","end":"2026-07-02T10:55:57.993443Z","steps":["trace[533876086] 'read index received' (duration: 193.323996ms)","trace[533876086] 'applied index is now lower than readState.Index' (duration: 14.293623ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:55:57.993685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.838613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18475"} {"level":"info","ts":"2026-07-02T10:55:57.99372Z","caller":"traceutil/trace.go:171","msg":"trace[157049307] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:25758; }","duration":"207.905124ms","start":"2026-07-02T10:55:57.785806Z","end":"2026-07-02T10:55:57.993711Z","steps":["trace[157049307] 'agreement among raft nodes before linearized reading' (duration: 207.68366ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:55:57.993714Z","caller":"traceutil/trace.go:171","msg":"trace[1384370906] transaction","detail":"{read_only:false; response_revision:25758; number_of_response:1; }","duration":"202.784138ms","start":"2026-07-02T10:55:57.790913Z","end":"2026-07-02T10:55:57.993697Z","steps":["trace[1384370906] 'process raft request' (duration: 202.252828ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:56:25.380001Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-00000000000068f0.wal"} {"level":"info","ts":"2026-07-02T10:56:58.385418Z","caller":"traceutil/trace.go:171","msg":"trace[901825949] transaction","detail":"{read_only:false; response_revision:26380; number_of_response:1; }","duration":"298.549259ms","start":"2026-07-02T10:56:58.086833Z","end":"2026-07-02T10:56:58.385382Z","steps":["trace[901825949] 'process raft request' (duration: 298.299494ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:56:58.395222Z","caller":"traceutil/trace.go:171","msg":"trace[910659637] transaction","detail":"{read_only:false; response_revision:26381; number_of_response:1; }","duration":"307.394788ms","start":"2026-07-02T10:56:58.087795Z","end":"2026-07-02T10:56:58.39519Z","steps":["trace[910659637] 'process raft request' (duration: 307.130343ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:56:58.395226Z","caller":"traceutil/trace.go:171","msg":"trace[1394634012] transaction","detail":"{read_only:false; response_revision:26382; number_of_response:1; }","duration":"301.910663ms","start":"2026-07-02T10:56:58.093292Z","end":"2026-07-02T10:56:58.395202Z","steps":["trace[1394634012] 'process raft request' (duration: 301.813312ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:56:58.395501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:56:58.087766Z","time spent":"307.609133ms","remote":"127.0.0.1:42392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T10:56:58.395551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:56:58.093266Z","time spent":"302.202308ms","remote":"127.0.0.1:42392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T10:59:28.006317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.21011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-02T10:59:28.00638Z","caller":"traceutil/trace.go:171","msg":"trace[223262966] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:27808; }","duration":"421.285092ms","start":"2026-07-02T10:59:27.585081Z","end":"2026-07-02T10:59:28.006367Z","steps":["trace[223262966] 'range keys from in-memory index tree' (duration: 421.118759ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:59:28.006406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:59:27.585017Z","time spent":"421.381684ms","remote":"127.0.0.1:51240","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-02T10:59:28.006537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"534.485163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings/\" range_end:\"/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-02T10:59:28.006681Z","caller":"traceutil/trace.go:171","msg":"trace[696634745] range","detail":"{range_begin:/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings/; range_end:/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings0; response_count:0; response_revision:27808; }","duration":"534.669887ms","start":"2026-07-02T10:59:27.471967Z","end":"2026-07-02T10:59:28.006637Z","steps":["trace[696634745] 'count revisions from in-memory index tree' (duration: 534.340591ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:59:28.00672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:59:27.471909Z","time spent":"534.799729ms","remote":"127.0.0.1:57588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":128,"response count":0,"response size":30,"request content":"key:\"/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings/\" range_end:\"/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings0\" count_only:true "} {"level":"warn","ts":"2026-07-02T10:59:28.006933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.410918ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-02T10:59:28.007118Z","caller":"traceutil/trace.go:171","msg":"trace[938134098] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:27808; }","duration":"482.614782ms","start":"2026-07-02T10:59:27.524475Z","end":"2026-07-02T10:59:28.00709Z","steps":["trace[938134098] 'range keys from in-memory index tree' (duration: 482.374948ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:59:47.477005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.360668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-02T10:59:47.477205Z","caller":"traceutil/trace.go:171","msg":"trace[1424463028] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:28000; }","duration":"141.645364ms","start":"2026-07-02T10:59:47.335533Z","end":"2026-07-02T10:59:47.477178Z","steps":["trace[1424463028] 'count revisions from in-memory index tree' (duration: 141.261497ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:59:47.477279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.593735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-07-02T10:59:47.477334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.093014ms","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-07-02T10:59:47.4774Z","caller":"traceutil/trace.go:171","msg":"trace[1773420541] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:28000; }","duration":"151.210946ms","start":"2026-07-02T10:59:47.326171Z","end":"2026-07-02T10:59:47.477382Z","steps":["trace[1773420541] 'range keys from in-memory index tree' (duration: 150.86942ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:59:47.477428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.70215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:4726"} {"level":"warn","ts":"2026-07-02T10:59:47.477147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.441811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-07-02T10:59:47.477484Z","caller":"traceutil/trace.go:171","msg":"trace[881152305] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:28000; }","duration":"179.778022ms","start":"2026-07-02T10:59:47.297691Z","end":"2026-07-02T10:59:47.477469Z","steps":["trace[881152305] 'range keys from in-memory index tree' (duration: 179.488377ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:59:47.4774Z","caller":"traceutil/trace.go:171","msg":"trace[205880778] range","detail":"{range_begin:/registry/ipam.cluster.x-k8s.io/ipaddressclaims/; range_end:/registry/ipam.cluster.x-k8s.io/ipaddressclaims0; response_count:0; response_revision:28000; }","duration":"161.789708ms","start":"2026-07-02T10:59:47.315583Z","end":"2026-07-02T10:59:47.477373Z","steps":["trace[205880778] 'count revisions from in-memory index tree' (duration: 161.468582ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:59:47.477565Z","caller":"traceutil/trace.go:171","msg":"trace[1755161591] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:28000; }","duration":"139.861439ms","start":"2026-07-02T10:59:47.337652Z","end":"2026-07-02T10:59:47.477514Z","steps":["trace[1755161591] 'range keys from in-memory index tree' (duration: 139.279738ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:59:47.479162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.883801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:57 size:2224957"} {"level":"info","ts":"2026-07-02T10:59:47.479223Z","caller":"traceutil/trace.go:171","msg":"trace[277846995] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:57; response_revision:28000; }","duration":"139.952972ms","start":"2026-07-02T10:59:47.339258Z","end":"2026-07-02T10:59:47.479211Z","steps":["trace[277846995] 'range keys from in-memory index tree' (duration: 138.169877ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:59:47.909402Z","caller":"traceutil/trace.go:171","msg":"trace[1294670125] linearizableReadLoop","detail":"{readStateIndex:28912; appliedIndex:28911; }","duration":"315.287528ms","start":"2026-07-02T10:59:47.594087Z","end":"2026-07-02T10:59:47.909374Z","steps":["trace[1294670125] 'read index received' (duration: 315.016463ms)","trace[1294670125] 'applied index is now lower than readState.Index' (duration: 269.985µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:59:47.909526Z","caller":"traceutil/trace.go:171","msg":"trace[1660171801] transaction","detail":"{read_only:false; response_revision:28008; number_of_response:1; }","duration":"315.681596ms","start":"2026-07-02T10:59:47.593832Z","end":"2026-07-02T10:59:47.909514Z","steps":["trace[1660171801] 'process raft request' (duration: 315.35875ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:59:47.909645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:59:47.593816Z","time spent":"315.737347ms","remote":"127.0.0.1:39458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7438,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T10:59:47.909825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.731976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-02T10:59:47.909873Z","caller":"traceutil/trace.go:171","msg":"trace[1505044844] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:28008; }","duration":"315.789407ms","start":"2026-07-02T10:59:47.594073Z","end":"2026-07-02T10:59:47.909862Z","steps":["trace[1505044844] 'agreement among raft nodes before linearized reading' (duration: 315.719696ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:59:47.909903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:59:47.594067Z","time spent":"315.829649ms","remote":"127.0.0.1:51234","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-02T11:00:53.188826Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25720} {"level":"info","ts":"2026-07-02T11:00:53.3607Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25720,"took":"163.784367ms","hash":3934977556,"current-db-size-bytes":59666432,"current-db-size":"60 MB","current-db-size-in-use-bytes":36605952,"current-db-size-in-use":"37 MB"} {"level":"info","ts":"2026-07-02T11:00:53.360763Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3934977556,"revision":25720,"compact-revision":22269} {"level":"info","ts":"2026-07-02T11:01:47.95704Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"dc35f804a62878ec","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-02T11:01:47.963971Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-07-02T11:01:47.964107Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-07-02T11:05:53.197413Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28666} {"level":"info","ts":"2026-07-02T11:05:53.366367Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28666,"took":"162.692416ms","hash":2682758446,"current-db-size-bytes":59666432,"current-db-size":"60 MB","current-db-size-in-use-bytes":31191040,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-07-02T11:05:53.366441Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2682758446,"revision":28666,"compact-revision":25720} {"level":"info","ts":"2026-07-02T11:08:34.674069Z","caller":"traceutil/trace.go:171","msg":"trace[1838934781] linearizableReadLoop","detail":"{readStateIndex:33156; appliedIndex:33155; }","duration":"108.192184ms","start":"2026-07-02T11:08:34.565852Z","end":"2026-07-02T11:08:34.674045Z","steps":["trace[1838934781] 'read index received' (duration: 107.905639ms)","trace[1838934781] 'applied index is now lower than readState.Index' (duration: 285.865µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T11:08:34.674207Z","caller":"traceutil/trace.go:171","msg":"trace[183552020] transaction","detail":"{read_only:false; response_revision:32138; number_of_response:1; }","duration":"120.144872ms","start":"2026-07-02T11:08:34.554016Z","end":"2026-07-02T11:08:34.674161Z","steps":["trace[183552020] 'process raft request' (duration: 119.853985ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T11:08:34.67443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.543732ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/openstack/key-manager\" ","response":"range_response_count:1 size:866"} {"level":"info","ts":"2026-07-02T11:08:34.674522Z","caller":"traceutil/trace.go:171","msg":"trace[1146342888] range","detail":"{range_begin:/registry/ingress/openstack/key-manager; range_end:; response_count:1; response_revision:32138; }","duration":"108.700005ms","start":"2026-07-02T11:08:34.565802Z","end":"2026-07-02T11:08:34.674502Z","steps":["trace[1146342888] 'agreement among raft nodes before linearized reading' (duration: 108.387499ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T11:10:53.204942Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30922} {"level":"info","ts":"2026-07-02T11:10:53.332056Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30922,"took":"122.016657ms","hash":3533642390,"current-db-size-bytes":59666432,"current-db-size":"60 MB","current-db-size-in-use-bytes":30482432,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-07-02T11:10:53.332123Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3533642390,"revision":30922,"compact-revision":28666} {"level":"info","ts":"2026-07-02T11:15:29.237243Z","caller":"traceutil/trace.go:171","msg":"trace[16327448] linearizableReadLoop","detail":"{readStateIndex:36405; appliedIndex:36403; }","duration":"109.432108ms","start":"2026-07-02T11:15:29.127781Z","end":"2026-07-02T11:15:29.237213Z","steps":["trace[16327448] 'read index received' (duration: 15.28144ms)","trace[16327448] 'applied index is now lower than readState.Index' (duration: 94.149648ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T11:15:29.237318Z","caller":"traceutil/trace.go:171","msg":"trace[268977907] transaction","detail":"{read_only:false; response_revision:35297; number_of_response:1; }","duration":"126.817339ms","start":"2026-07-02T11:15:29.110464Z","end":"2026-07-02T11:15:29.237281Z","steps":["trace[268977907] 'process raft request' (duration: 52.931456ms)","trace[268977907] 'compare' (duration: 73.641028ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T11:15:29.237398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.587671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-02T11:15:29.23748Z","caller":"traceutil/trace.go:171","msg":"trace[134690220] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:35297; }","duration":"109.720903ms","start":"2026-07-02T11:15:29.127743Z","end":"2026-07-02T11:15:29.237463Z","steps":["trace[134690220] 'agreement among raft nodes before linearized reading' (duration: 109.588621ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T11:15:53.212445Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33180} {"level":"info","ts":"2026-07-02T11:15:53.360114Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33180,"took":"142.402044ms","hash":681589563,"current-db-size-bytes":60706816,"current-db-size":"61 MB","current-db-size-in-use-bytes":31272960,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-07-02T11:15:53.360209Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":681589563,"revision":33180,"compact-revision":30922} {"level":"info","ts":"2026-07-02T11:20:53.220773Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35481} {"level":"info","ts":"2026-07-02T11:20:53.391216Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35481,"took":"166.042695ms","hash":2673882538,"current-db-size-bytes":60706816,"current-db-size":"61 MB","current-db-size-in-use-bytes":31240192,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-07-02T11:20:53.391308Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2673882538,"revision":35481,"compact-revision":33180} {"level":"info","ts":"2026-07-02T11:23:15.701266Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"dc35f804a62878ec","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-02T11:23:15.705581Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-07-02T11:23:15.7057Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-07-02T11:25:53.227663Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37707} {"level":"info","ts":"2026-07-02T11:25:53.346681Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37707,"took":"114.642642ms","hash":2387403784,"current-db-size-bytes":60706816,"current-db-size":"61 MB","current-db-size-in-use-bytes":32112640,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-07-02T11:25:53.34676Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2387403784,"revision":37707,"compact-revision":35481}