{"level":"warn","ts":"2026-06-10T09:51:27.646901Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-10T09:51:27.647005Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.132:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.132:2380","--initial-cluster=instance=https://199.204.45.132:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.132:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.132: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-06-10T09:51:27.647082Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-10T09:51:27.647096Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.132:2380"]} {"level":"info","ts":"2026-06-10T09:51:27.647119Z","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-06-10T09:51:27.647837Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.132:2379"]} {"level":"info","ts":"2026-06-10T09:51:27.647924Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.132:2380"],"listen-peer-urls":["https://199.204.45.132:2380"],"advertise-client-urls":["https://199.204.45.132:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.132:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.132: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-06-10T09:51:27.651592Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.404966ms"} {"level":"info","ts":"2026-06-10T09:51:27.658378Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"56c01ea8fdc90390","cluster-id":"c930fe821aab8609"} {"level":"info","ts":"2026-06-10T09:51:27.658502Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 switched to configuration voters=()"} {"level":"info","ts":"2026-06-10T09:51:27.658551Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became follower at term 0"} {"level":"info","ts":"2026-06-10T09:51:27.658582Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 56c01ea8fdc90390 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-10T09:51:27.658599Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became follower at term 1"} {"level":"info","ts":"2026-06-10T09:51:27.658661Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 switched to configuration voters=(6251029993951396752)"} {"level":"warn","ts":"2026-06-10T09:51:27.668381Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-10T09:51:27.670295Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-10T09:51:27.67166Z","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-06-10T09:51:27.674015Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"56c01ea8fdc90390","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-10T09:51:27.674276Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"56c01ea8fdc90390","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-10T09:51:27.674479Z","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-06-10T09:51:27.674621Z","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-06-10T09:51:27.674642Z","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-06-10T09:51:27.676145Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 switched to configuration voters=(6251029993951396752)"} {"level":"info","ts":"2026-06-10T09:51:27.676707Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c930fe821aab8609","local-member-id":"56c01ea8fdc90390","added-peer-id":"56c01ea8fdc90390","added-peer-peer-urls":["https://199.204.45.132:2380"]} {"level":"info","ts":"2026-06-10T09:51:27.67905Z","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-06-10T09:51:27.679234Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.132:2380"} {"level":"info","ts":"2026-06-10T09:51:27.679301Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.132:2380"} {"level":"info","ts":"2026-06-10T09:51:27.679456Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"56c01ea8fdc90390","initial-advertise-peer-urls":["https://199.204.45.132:2380"],"listen-peer-urls":["https://199.204.45.132:2380"],"advertise-client-urls":["https://199.204.45.132:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.132:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-10T09:51:27.679542Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-10T09:51:28.358907Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 is starting a new election at term 1"} {"level":"info","ts":"2026-06-10T09:51:28.358995Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-10T09:51:28.359023Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 received MsgPreVoteResp from 56c01ea8fdc90390 at term 1"} {"level":"info","ts":"2026-06-10T09:51:28.359047Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became candidate at term 2"} {"level":"info","ts":"2026-06-10T09:51:28.35906Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 received MsgVoteResp from 56c01ea8fdc90390 at term 2"} {"level":"info","ts":"2026-06-10T09:51:28.359084Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became leader at term 2"} {"level":"info","ts":"2026-06-10T09:51:28.359105Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 56c01ea8fdc90390 elected leader 56c01ea8fdc90390 at term 2"} {"level":"info","ts":"2026-06-10T09:51:28.360286Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-10T09:51:28.361278Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"56c01ea8fdc90390","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.132:2379]}","request-path":"/0/members/56c01ea8fdc90390/attributes","cluster-id":"c930fe821aab8609","publish-timeout":"7s"} {"level":"info","ts":"2026-06-10T09:51:28.361293Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-10T09:51:28.361371Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-10T09:51:28.361526Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-10T09:51:28.361607Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-10T09:51:28.363595Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c930fe821aab8609","local-member-id":"56c01ea8fdc90390","cluster-version":"3.5"} {"level":"info","ts":"2026-06-10T09:51:28.363741Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-10T09:51:28.36382Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-10T09:51:28.365215Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-10T09:51:28.374998Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.132:2379"} {"level":"info","ts":"2026-06-10T09:52:11.188202Z","caller":"traceutil/trace.go:171","msg":"trace[1262980979] linearizableReadLoop","detail":"{readStateIndex:661; appliedIndex:660; }","duration":"138.392606ms","start":"2026-06-10T09:52:11.04968Z","end":"2026-06-10T09:52:11.188073Z","steps":["trace[1262980979] 'read index received' (duration: 136.249309ms)","trace[1262980979] 'applied index is now lower than readState.Index' (duration: 2.140317ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T09:52:11.188545Z","caller":"traceutil/trace.go:171","msg":"trace[1093194331] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"156.477734ms","start":"2026-06-10T09:52:11.032034Z","end":"2026-06-10T09:52:11.188512Z","steps":["trace[1093194331] 'process raft request' (duration: 154.035841ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:52:11.188569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.858026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T09:52:11.188669Z","caller":"traceutil/trace.go:171","msg":"trace[231954258] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:635; }","duration":"139.037471ms","start":"2026-06-10T09:52:11.049605Z","end":"2026-06-10T09:52:11.188643Z","steps":["trace[231954258] 'agreement among raft nodes before linearized reading' (duration: 138.724743ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:52:11.265767Z","caller":"traceutil/trace.go:171","msg":"trace[142618503] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"152.187981ms","start":"2026-06-10T09:52:11.113549Z","end":"2026-06-10T09:52:11.265737Z","steps":["trace[142618503] 'process raft request' (duration: 123.401345ms)","trace[142618503] 'compare' (duration: 28.611261ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T09:52:11.724481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.772999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.132\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-10T09:52:11.724576Z","caller":"traceutil/trace.go:171","msg":"trace[291885833] range","detail":"{range_begin:/registry/masterleases/199.204.45.132; range_end:; response_count:1; response_revision:637; }","duration":"198.930772ms","start":"2026-06-10T09:52:11.525619Z","end":"2026-06-10T09:52:11.72455Z","steps":["trace[291885833] 'range keys from in-memory index tree' (duration: 198.482253ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:53:45.388941Z","caller":"traceutil/trace.go:171","msg":"trace[1349984302] transaction","detail":"{read_only:false; response_revision:1885; number_of_response:1; }","duration":"268.134131ms","start":"2026-06-10T09:53:45.120784Z","end":"2026-06-10T09:53:45.388918Z","steps":["trace[1349984302] 'process raft request' (duration: 267.972198ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:53:45.625513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.343523ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T09:53:45.625643Z","caller":"traceutil/trace.go:171","msg":"trace[1130304764] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1885; }","duration":"141.484236ms","start":"2026-06-10T09:53:45.484141Z","end":"2026-06-10T09:53:45.625625Z","steps":["trace[1130304764] 'range keys from in-memory index tree' (duration: 141.328993ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:53:45.625786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.2388ms","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-06-10T09:53:45.625871Z","caller":"traceutil/trace.go:171","msg":"trace[1844241304] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1885; }","duration":"122.376853ms","start":"2026-06-10T09:53:45.503475Z","end":"2026-06-10T09:53:45.625852Z","steps":["trace[1844241304] 'range keys from in-memory index tree' (duration: 122.064757ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:54:01.85013Z","caller":"traceutil/trace.go:171","msg":"trace[1229922794] transaction","detail":"{read_only:false; response_revision:2019; number_of_response:1; }","duration":"109.00427ms","start":"2026-06-10T09:54:01.7411Z","end":"2026-06-10T09:54:01.850104Z","steps":["trace[1229922794] 'process raft request' (duration: 108.813216ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:54:41.272655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.087416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-10T09:54:41.272756Z","caller":"traceutil/trace.go:171","msg":"trace[288135775] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2233; }","duration":"145.206859ms","start":"2026-06-10T09:54:41.127531Z","end":"2026-06-10T09:54:41.272738Z","steps":["trace[288135775] 'range keys from in-memory index tree' (duration: 144.884693ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:54:41.272872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.588772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T09:54:41.273099Z","caller":"traceutil/trace.go:171","msg":"trace[489064010] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2233; }","duration":"220.916577ms","start":"2026-06-10T09:54:41.052135Z","end":"2026-06-10T09:54:41.273052Z","steps":["trace[489064010] 'range keys from in-memory index tree' (duration: 220.446149ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:54:41.65786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.134638ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-10T09:54:41.658124Z","caller":"traceutil/trace.go:171","msg":"trace[81856419] transaction","detail":"{read_only:false; response_revision:2235; number_of_response:1; }","duration":"380.749506ms","start":"2026-06-10T09:54:41.277334Z","end":"2026-06-10T09:54:41.658084Z","steps":["trace[81856419] 'process raft request' (duration: 274.586939ms)","trace[81856419] 'compare' (duration: 104.73858ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T09:54:41.65815Z","caller":"traceutil/trace.go:171","msg":"trace[666348675] transaction","detail":"{read_only:false; response_revision:2236; number_of_response:1; }","duration":"380.518952ms","start":"2026-06-10T09:54:41.27761Z","end":"2026-06-10T09:54:41.658129Z","steps":["trace[666348675] 'process raft request' (duration: 380.382308ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:54:41.658258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T09:54:41.277602Z","time spent":"380.612474ms","remote":"127.0.0.1:55252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T09:54:41.658312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T09:54:41.277312Z","time spent":"380.900059ms","remote":"127.0.0.1:55252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T09:54:41.658451Z","caller":"traceutil/trace.go:171","msg":"trace[470756335] linearizableReadLoop","detail":"{readStateIndex:2324; appliedIndex:2321; }","duration":"246.048217ms","start":"2026-06-10T09:54:41.412391Z","end":"2026-06-10T09:54:41.658439Z","steps":["trace[470756335] 'read index received' (duration: 139.44729ms)","trace[470756335] 'applied index is now lower than readState.Index' (duration: 106.599867ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T09:54:41.658473Z","caller":"traceutil/trace.go:171","msg":"trace[1098366153] transaction","detail":"{read_only:false; response_revision:2237; number_of_response:1; }","duration":"379.659436ms","start":"2026-06-10T09:54:41.278805Z","end":"2026-06-10T09:54:41.658464Z","steps":["trace[1098366153] 'process raft request' (duration: 379.283938ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:54:41.658513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T09:54:41.278795Z","time spent":"379.694027ms","remote":"127.0.0.1:55252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T09:54:41.658574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.158499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterbackups/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterbackups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T09:54:41.658655Z","caller":"traceutil/trace.go:171","msg":"trace[1901503253] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterbackups/; range_end:/registry/pxc.percona.com/perconaxtradbclusterbackups0; response_count:0; response_revision:2237; }","duration":"246.284801ms","start":"2026-06-10T09:54:41.41235Z","end":"2026-06-10T09:54:41.658634Z","steps":["trace[1901503253] 'agreement among raft nodes before linearized reading' (duration: 246.128408ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:54:41.65866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.274769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-10T09:54:41.658716Z","caller":"traceutil/trace.go:171","msg":"trace[702080980] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2237; }","duration":"207.352081ms","start":"2026-06-10T09:54:41.451347Z","end":"2026-06-10T09:54:41.658699Z","steps":["trace[702080980] 'agreement among raft nodes before linearized reading' (duration: 207.193518ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:54:41.658799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.52333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.132\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-10T09:54:41.659211Z","caller":"traceutil/trace.go:171","msg":"trace[874560734] range","detail":"{range_begin:/registry/masterleases/199.204.45.132; range_end:; response_count:1; response_revision:2237; }","duration":"121.942608ms","start":"2026-06-10T09:54:41.537205Z","end":"2026-06-10T09:54:41.659148Z","steps":["trace[874560734] 'agreement among raft nodes before linearized reading' (duration: 121.368387ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:55:24.033636Z","caller":"traceutil/trace.go:171","msg":"trace[1173963253] transaction","detail":"{read_only:false; response_revision:2638; number_of_response:1; }","duration":"139.898104ms","start":"2026-06-10T09:55:23.893701Z","end":"2026-06-10T09:55:24.033599Z","steps":["trace[1173963253] 'process raft request' (duration: 139.66005ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:55:24.036294Z","caller":"traceutil/trace.go:171","msg":"trace[395814102] transaction","detail":"{read_only:false; response_revision:2640; number_of_response:1; }","duration":"141.719708ms","start":"2026-06-10T09:55:23.894551Z","end":"2026-06-10T09:55:24.03627Z","steps":["trace[395814102] 'process raft request' (duration: 141.654817ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:55:24.036571Z","caller":"traceutil/trace.go:171","msg":"trace[784837010] transaction","detail":"{read_only:false; response_revision:2639; number_of_response:1; }","duration":"142.245959ms","start":"2026-06-10T09:55:23.89426Z","end":"2026-06-10T09:55:24.036506Z","steps":["trace[784837010] 'process raft request' (duration: 141.79441ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:55:58.781807Z","caller":"traceutil/trace.go:171","msg":"trace[1436679613] transaction","detail":"{read_only:false; response_revision:2846; number_of_response:1; }","duration":"199.330666ms","start":"2026-06-10T09:55:58.582451Z","end":"2026-06-10T09:55:58.781782Z","steps":["trace[1436679613] 'process raft request' (duration: 199.166392ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:58:34.006105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.214567ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-10T09:58:34.006236Z","caller":"traceutil/trace.go:171","msg":"trace[385295313] linearizableReadLoop","detail":"{readStateIndex:4018; appliedIndex:4017; }","duration":"254.599365ms","start":"2026-06-10T09:58:33.751615Z","end":"2026-06-10T09:58:34.006214Z","steps":["trace[385295313] 'read index received' (duration: 104.281055ms)","trace[385295313] 'applied index is now lower than readState.Index' (duration: 150.31662ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T09:58:34.006364Z","caller":"traceutil/trace.go:171","msg":"trace[917507852] transaction","detail":"{read_only:false; response_revision:3868; number_of_response:1; }","duration":"274.381302ms","start":"2026-06-10T09:58:33.731971Z","end":"2026-06-10T09:58:34.006352Z","steps":["trace[917507852] 'process raft request' (duration: 123.826797ms)","trace[917507852] 'compare' (duration: 150.100715ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T09:58:34.006654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.007232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-10T09:58:34.006776Z","caller":"traceutil/trace.go:171","msg":"trace[265176244] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:3868; }","duration":"255.156545ms","start":"2026-06-10T09:58:33.7516Z","end":"2026-06-10T09:58:34.006757Z","steps":["trace[265176244] 'agreement among raft nodes before linearized reading' (duration: 254.936511ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:58:34.007315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.771693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-10T09:58:34.007449Z","caller":"traceutil/trace.go:171","msg":"trace[1025678523] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:3868; }","duration":"114.990407ms","start":"2026-06-10T09:58:33.892433Z","end":"2026-06-10T09:58:34.007423Z","steps":["trace[1025678523] 'agreement among raft nodes before linearized reading' (duration: 114.05291ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:00:05.846076Z","caller":"traceutil/trace.go:171","msg":"trace[2119706704] linearizableReadLoop","detail":"{readStateIndex:5307; appliedIndex:5306; }","duration":"234.37842ms","start":"2026-06-10T10:00:05.611671Z","end":"2026-06-10T10:00:05.846049Z","steps":["trace[2119706704] 'read index received' (duration: 234.226457ms)","trace[2119706704] 'applied index is now lower than readState.Index' (duration: 150.433µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:00:05.846142Z","caller":"traceutil/trace.go:171","msg":"trace[272380880] transaction","detail":"{read_only:false; response_revision:5110; number_of_response:1; }","duration":"237.905057ms","start":"2026-06-10T10:00:05.608203Z","end":"2026-06-10T10:00:05.846109Z","steps":["trace[272380880] 'process raft request' (duration: 237.675162ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:00:05.846306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.614794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-10T10:00:05.846344Z","caller":"traceutil/trace.go:171","msg":"trace[574523410] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5110; }","duration":"234.711845ms","start":"2026-06-10T10:00:05.611623Z","end":"2026-06-10T10:00:05.846335Z","steps":["trace[574523410] 'agreement among raft nodes before linearized reading' (duration: 234.562622ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:00:05.863574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.306956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-10T10:00:05.863645Z","caller":"traceutil/trace.go:171","msg":"trace[1366159573] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5112; }","duration":"247.400097ms","start":"2026-06-10T10:00:05.61623Z","end":"2026-06-10T10:00:05.86363Z","steps":["trace[1366159573] 'agreement among raft nodes before linearized reading' (duration: 247.165303ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:00:18.670333Z","caller":"traceutil/trace.go:171","msg":"trace[243132973] transaction","detail":"{read_only:false; response_revision:5356; number_of_response:1; }","duration":"119.450074ms","start":"2026-06-10T10:00:18.550846Z","end":"2026-06-10T10:00:18.670296Z","steps":["trace[243132973] 'process raft request' (duration: 20.536692ms)","trace[243132973] 'compare' (duration: 98.753908ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:00:18.743145Z","caller":"traceutil/trace.go:171","msg":"trace[870627130] linearizableReadLoop","detail":"{readStateIndex:5563; appliedIndex:5561; }","duration":"157.348834ms","start":"2026-06-10T10:00:18.585762Z","end":"2026-06-10T10:00:18.743111Z","steps":["trace[870627130] 'read index received' (duration: 157.021097ms)","trace[870627130] 'applied index is now lower than readState.Index' (duration: 326.347µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:00:18.743219Z","caller":"traceutil/trace.go:171","msg":"trace[1257100996] transaction","detail":"{read_only:false; response_revision:5357; number_of_response:1; }","duration":"191.488794ms","start":"2026-06-10T10:00:18.551674Z","end":"2026-06-10T10:00:18.743163Z","steps":["trace[1257100996] 'process raft request' (duration: 191.163867ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:00:18.743258Z","caller":"traceutil/trace.go:171","msg":"trace[1145293485] transaction","detail":"{read_only:false; response_revision:5358; number_of_response:1; }","duration":"188.249622ms","start":"2026-06-10T10:00:18.554964Z","end":"2026-06-10T10:00:18.743213Z","steps":["trace[1145293485] 'process raft request' (duration: 188.078509ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:00:18.743495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.64898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-10T10:00:18.743614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.568823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-06-10T10:00:18.743638Z","caller":"traceutil/trace.go:171","msg":"trace[2103924302] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:5358; }","duration":"157.861763ms","start":"2026-06-10T10:00:18.585709Z","end":"2026-06-10T10:00:18.743571Z","steps":["trace[2103924302] 'agreement among raft nodes before linearized reading' (duration: 157.6499ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:00:18.743672Z","caller":"traceutil/trace.go:171","msg":"trace[609539418] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:5358; }","duration":"151.673355ms","start":"2026-06-10T10:00:18.591984Z","end":"2026-06-10T10:00:18.743657Z","steps":["trace[609539418] 'agreement among raft nodes before linearized reading' (duration: 151.505392ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:00:26.624099Z","caller":"traceutil/trace.go:171","msg":"trace[1601985876] transaction","detail":"{read_only:false; response_revision:5516; number_of_response:1; }","duration":"153.657743ms","start":"2026-06-10T10:00:26.470404Z","end":"2026-06-10T10:00:26.624062Z","steps":["trace[1601985876] 'process raft request' (duration: 103.010169ms)","trace[1601985876] 'compare' (duration: 50.41646ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:00:26.624201Z","caller":"traceutil/trace.go:171","msg":"trace[1440285477] transaction","detail":"{read_only:false; response_revision:5517; number_of_response:1; }","duration":"109.027474ms","start":"2026-06-10T10:00:26.515157Z","end":"2026-06-10T10:00:26.624185Z","steps":["trace[1440285477] 'process raft request' (duration: 108.863971ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:00:26.6241Z","caller":"traceutil/trace.go:171","msg":"trace[1703484930] linearizableReadLoop","detail":"{readStateIndex:5725; appliedIndex:5724; }","duration":"144.757234ms","start":"2026-06-10T10:00:26.479311Z","end":"2026-06-10T10:00:26.624068Z","steps":["trace[1703484930] 'read index received' (duration: 94.09526ms)","trace[1703484930] 'applied index is now lower than readState.Index' (duration: 50.660314ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:00:26.624363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.031339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ae44b7eb-8e83-453f-ae08-c9190909bbeb\" ","response":"range_response_count:1 size:3763"} {"level":"info","ts":"2026-06-10T10:00:26.624824Z","caller":"traceutil/trace.go:171","msg":"trace[1516095695] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-ae44b7eb-8e83-453f-ae08-c9190909bbeb; range_end:; response_count:1; response_revision:5516; }","duration":"145.509469ms","start":"2026-06-10T10:00:26.479261Z","end":"2026-06-10T10:00:26.624771Z","steps":["trace[1516095695] 'agreement among raft nodes before linearized reading' (duration: 144.845576ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:01:28.418469Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3009} {"level":"info","ts":"2026-06-10T10:01:28.506267Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3009,"took":"85.410922ms","hash":2245487915,"current-db-size-bytes":57348096,"current-db-size":"57 MB","current-db-size-in-use-bytes":31784960,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-10T10:01:28.506342Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2245487915,"revision":3009,"compact-revision":-1} {"level":"info","ts":"2026-06-10T10:01:30.34364Z","caller":"traceutil/trace.go:171","msg":"trace[150370374] transaction","detail":"{read_only:false; response_revision:6109; number_of_response:1; }","duration":"121.053843ms","start":"2026-06-10T10:01:30.222555Z","end":"2026-06-10T10:01:30.343609Z","steps":["trace[150370374] 'process raft request' (duration: 120.85286ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:01:30.353457Z","caller":"traceutil/trace.go:171","msg":"trace[1930513483] transaction","detail":"{read_only:false; response_revision:6110; number_of_response:1; }","duration":"107.535055ms","start":"2026-06-10T10:01:30.245894Z","end":"2026-06-10T10:01:30.353429Z","steps":["trace[1930513483] 'process raft request' (duration: 107.24078ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:06:28.425654Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6099} {"level":"info","ts":"2026-06-10T10:06:28.551791Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6099,"took":"123.795461ms","hash":1551481160,"current-db-size-bytes":57348096,"current-db-size":"57 MB","current-db-size-in-use-bytes":21909504,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-06-10T10:06:28.551866Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1551481160,"revision":6099,"compact-revision":3009} {"level":"info","ts":"2026-06-10T10:06:37.31899Z","caller":"traceutil/trace.go:171","msg":"trace[1455166758] linearizableReadLoop","detail":"{readStateIndex:8668; appliedIndex:8667; }","duration":"162.070012ms","start":"2026-06-10T10:06:37.156894Z","end":"2026-06-10T10:06:37.318964Z","steps":["trace[1455166758] 'read index received' (duration: 161.861848ms)","trace[1455166758] 'applied index is now lower than readState.Index' (duration: 207.334µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:06:37.319144Z","caller":"traceutil/trace.go:171","msg":"trace[931068962] transaction","detail":"{read_only:false; response_revision:8369; number_of_response:1; }","duration":"211.335562ms","start":"2026-06-10T10:06:37.107734Z","end":"2026-06-10T10:06:37.31907Z","steps":["trace[931068962] 'process raft request' (duration: 211.047396ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:06:37.319383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.46137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-10T10:06:37.319446Z","caller":"traceutil/trace.go:171","msg":"trace[614609819] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8369; }","duration":"162.594482ms","start":"2026-06-10T10:06:37.156832Z","end":"2026-06-10T10:06:37.319426Z","steps":["trace[614609819] 'agreement among raft nodes before linearized reading' (duration: 162.258286ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:06:37.478455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.420429ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-10T10:06:37.478742Z","caller":"traceutil/trace.go:171","msg":"trace[676254469] transaction","detail":"{read_only:false; response_revision:8370; number_of_response:1; }","duration":"153.856665ms","start":"2026-06-10T10:06:37.324854Z","end":"2026-06-10T10:06:37.47871Z","steps":["trace[676254469] 'process raft request' (duration: 13.06891ms)","trace[676254469] 'compare' (duration: 140.273936ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:06:49.803368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.955402ms","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-06-10T10:06:49.803438Z","caller":"traceutil/trace.go:171","msg":"trace[534050586] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8432; }","duration":"268.391651ms","start":"2026-06-10T10:06:49.535031Z","end":"2026-06-10T10:06:49.803422Z","steps":["trace[534050586] 'range keys from in-memory index tree' (duration: 267.822269ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:06:49.810851Z","caller":"traceutil/trace.go:171","msg":"trace[77356884] transaction","detail":"{read_only:false; response_revision:8433; number_of_response:1; }","duration":"155.445065ms","start":"2026-06-10T10:06:49.655395Z","end":"2026-06-10T10:06:49.81084Z","steps":["trace[77356884] 'process raft request' (duration: 155.358554ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:06:49.868916Z","caller":"traceutil/trace.go:171","msg":"trace[1198987204] transaction","detail":"{read_only:false; response_revision:8434; number_of_response:1; }","duration":"212.512443ms","start":"2026-06-10T10:06:49.656375Z","end":"2026-06-10T10:06:49.868888Z","steps":["trace[1198987204] 'process raft request' (duration: 212.226488ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:06:49.869232Z","caller":"traceutil/trace.go:171","msg":"trace[267313174] linearizableReadLoop","detail":"{readStateIndex:8736; appliedIndex:8734; }","duration":"114.626087ms","start":"2026-06-10T10:06:49.754581Z","end":"2026-06-10T10:06:49.869207Z","steps":["trace[267313174] 'read index received' (duration: 56.250873ms)","trace[267313174] 'applied index is now lower than readState.Index' (duration: 58.374054ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:06:49.869415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.82322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:529"} {"level":"info","ts":"2026-06-10T10:06:49.869438Z","caller":"traceutil/trace.go:171","msg":"trace[28930396] transaction","detail":"{read_only:false; response_revision:8435; number_of_response:1; }","duration":"125.420543ms","start":"2026-06-10T10:06:49.743892Z","end":"2026-06-10T10:06:49.869313Z","steps":["trace[28930396] 'process raft request' (duration: 124.884752ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:06:49.869456Z","caller":"traceutil/trace.go:171","msg":"trace[2134179565] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:8436; }","duration":"114.906152ms","start":"2026-06-10T10:06:49.754539Z","end":"2026-06-10T10:06:49.869445Z","steps":["trace[2134179565] 'agreement among raft nodes before linearized reading' (duration: 114.75744ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:06:50.38231Z","caller":"traceutil/trace.go:171","msg":"trace[330755628] transaction","detail":"{read_only:false; response_revision:8441; number_of_response:1; }","duration":"169.191588ms","start":"2026-06-10T10:06:50.21309Z","end":"2026-06-10T10:06:50.382282Z","steps":["trace[330755628] 'process raft request' (duration: 168.927573ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:06:50.382518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.919176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-10T10:06:50.38263Z","caller":"traceutil/trace.go:171","msg":"trace[642923366] range","detail":"{range_begin:/registry/cert-manager.io/certificaterequests/; range_end:/registry/cert-manager.io/certificaterequests0; response_count:0; response_revision:8441; }","duration":"111.050349ms","start":"2026-06-10T10:06:50.271546Z","end":"2026-06-10T10:06:50.382596Z","steps":["trace[642923366] 'agreement among raft nodes before linearized reading' (duration: 110.843615ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:06:50.382311Z","caller":"traceutil/trace.go:171","msg":"trace[794094449] linearizableReadLoop","detail":"{readStateIndex:8742; appliedIndex:8742; }","duration":"110.706543ms","start":"2026-06-10T10:06:50.271563Z","end":"2026-06-10T10:06:50.38227Z","steps":["trace[794094449] 'read index received' (duration: 110.693622ms)","trace[794094449] 'applied index is now lower than readState.Index' (duration: 10.411µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:07:22.058147Z","caller":"traceutil/trace.go:171","msg":"trace[179727128] transaction","detail":"{read_only:false; response_revision:8660; number_of_response:1; }","duration":"132.336341ms","start":"2026-06-10T10:07:21.925779Z","end":"2026-06-10T10:07:22.058115Z","steps":["trace[179727128] 'process raft request' (duration: 132.063835ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:07:22.22005Z","caller":"traceutil/trace.go:171","msg":"trace[1990349139] linearizableReadLoop","detail":"{readStateIndex:8972; appliedIndex:8970; }","duration":"161.980653ms","start":"2026-06-10T10:07:22.058038Z","end":"2026-06-10T10:07:22.220019Z","steps":["trace[1990349139] 'read index received' (duration: 132.31772ms)","trace[1990349139] 'applied index is now lower than readState.Index' (duration: 29.661483ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:07:22.220098Z","caller":"traceutil/trace.go:171","msg":"trace[923028059] transaction","detail":"{read_only:false; response_revision:8662; number_of_response:1; }","duration":"188.532269ms","start":"2026-06-10T10:07:22.03153Z","end":"2026-06-10T10:07:22.220062Z","steps":["trace[923028059] 'process raft request' (duration: 188.427487ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:07:22.220226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.053777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:07:22.220304Z","caller":"traceutil/trace.go:171","msg":"trace[311094028] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8662; }","duration":"168.142058ms","start":"2026-06-10T10:07:22.052146Z","end":"2026-06-10T10:07:22.220288Z","steps":["trace[311094028] 'agreement among raft nodes before linearized reading' (duration: 167.998095ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:07:22.220059Z","caller":"traceutil/trace.go:171","msg":"trace[1439308290] transaction","detail":"{read_only:false; response_revision:8661; number_of_response:1; }","duration":"188.496428ms","start":"2026-06-10T10:07:22.031519Z","end":"2026-06-10T10:07:22.220015Z","steps":["trace[1439308290] 'process raft request' (duration: 158.828415ms)","trace[1439308290] 'compare' (duration: 29.431719ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:07:22.220424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.774291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-10T10:07:22.220473Z","caller":"traceutil/trace.go:171","msg":"trace[944718777] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8662; }","duration":"160.872253ms","start":"2026-06-10T10:07:22.05959Z","end":"2026-06-10T10:07:22.220462Z","steps":["trace[944718777] 'agreement among raft nodes before linearized reading' (duration: 160.694429ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:07:22.366429Z","caller":"traceutil/trace.go:171","msg":"trace[1583547969] linearizableReadLoop","detail":"{readStateIndex:8973; appliedIndex:8972; }","duration":"122.106379ms","start":"2026-06-10T10:07:22.244296Z","end":"2026-06-10T10:07:22.366403Z","steps":["trace[1583547969] 'read index received' (duration: 107.817343ms)","trace[1583547969] 'applied index is now lower than readState.Index' (duration: 14.287256ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:07:22.366477Z","caller":"traceutil/trace.go:171","msg":"trace[1379743268] transaction","detail":"{read_only:false; response_revision:8663; number_of_response:1; }","duration":"141.801307ms","start":"2026-06-10T10:07:22.224639Z","end":"2026-06-10T10:07:22.36644Z","steps":["trace[1379743268] 'process raft request' (duration: 127.456909ms)","trace[1379743268] 'compare' (duration: 14.177975ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:07:22.366766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.446865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-vxmh4\" ","response":"range_response_count:1 size:6451"} {"level":"info","ts":"2026-06-10T10:07:22.366866Z","caller":"traceutil/trace.go:171","msg":"trace[1504704979] range","detail":"{range_begin:/registry/pods/openstack/keepalived-vxmh4; range_end:; response_count:1; response_revision:8663; }","duration":"122.609518ms","start":"2026-06-10T10:07:22.244232Z","end":"2026-06-10T10:07:22.366842Z","steps":["trace[1504704979] 'agreement among raft nodes before linearized reading' (duration: 122.279182ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:07:31.764904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.064589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-06-10T10:07:31.765Z","caller":"traceutil/trace.go:171","msg":"trace[18910962] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:8755; }","duration":"106.209582ms","start":"2026-06-10T10:07:31.658771Z","end":"2026-06-10T10:07:31.76498Z","steps":["trace[18910962] 'range keys from in-memory index tree' (duration: 105.958177ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:07:32.299538Z","caller":"traceutil/trace.go:171","msg":"trace[848340630] transaction","detail":"{read_only:false; response_revision:8756; number_of_response:1; }","duration":"206.346491ms","start":"2026-06-10T10:07:32.093168Z","end":"2026-06-10T10:07:32.299514Z","steps":["trace[848340630] 'process raft request' (duration: 206.194929ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:07:32.48569Z","caller":"traceutil/trace.go:171","msg":"trace[1282180654] transaction","detail":"{read_only:false; response_revision:8757; number_of_response:1; }","duration":"390.471819ms","start":"2026-06-10T10:07:32.095192Z","end":"2026-06-10T10:07:32.485664Z","steps":["trace[1282180654] 'process raft request' (duration: 390.287566ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:07:32.485858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:07:32.095161Z","time spent":"390.604661ms","remote":"127.0.0.1:55252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:07:32.486119Z","caller":"traceutil/trace.go:171","msg":"trace[834973684] transaction","detail":"{read_only:false; response_revision:8758; number_of_response:1; }","duration":"229.959862ms","start":"2026-06-10T10:07:32.256121Z","end":"2026-06-10T10:07:32.486081Z","steps":["trace[834973684] 'process raft request' (duration: 229.498814ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:07:32.486151Z","caller":"traceutil/trace.go:171","msg":"trace[1112018728] transaction","detail":"{read_only:false; response_revision:8759; number_of_response:1; }","duration":"227.67213ms","start":"2026-06-10T10:07:32.258449Z","end":"2026-06-10T10:07:32.486121Z","steps":["trace[1112018728] 'process raft request' (duration: 227.472316ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:07:32.722154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.208626ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-10T10:07:32.722451Z","caller":"traceutil/trace.go:171","msg":"trace[1966010800] linearizableReadLoop","detail":"{readStateIndex:9076; appliedIndex:9075; }","duration":"151.806013ms","start":"2026-06-10T10:07:32.570619Z","end":"2026-06-10T10:07:32.722425Z","steps":["trace[1966010800] 'read index received' (duration: 10.18619ms)","trace[1966010800] 'applied index is now lower than readState.Index' (duration: 141.617803ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:07:32.722558Z","caller":"traceutil/trace.go:171","msg":"trace[1841274707] transaction","detail":"{read_only:false; response_revision:8762; number_of_response:1; }","duration":"172.131983ms","start":"2026-06-10T10:07:32.550409Z","end":"2026-06-10T10:07:32.722541Z","steps":["trace[1841274707] 'process raft request' (duration: 30.427158ms)","trace[1841274707] 'compare' (duration: 141.073324ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:07:32.722665Z","caller":"traceutil/trace.go:171","msg":"trace[2129504434] transaction","detail":"{read_only:false; response_revision:8763; number_of_response:1; }","duration":"146.26432ms","start":"2026-06-10T10:07:32.576368Z","end":"2026-06-10T10:07:32.722632Z","steps":["trace[2129504434] 'process raft request' (duration: 145.912433ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:07:32.723006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.321776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-vxmh4\" ","response":"range_response_count:1 size:6451"} {"level":"warn","ts":"2026-06-10T10:07:32.723038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.191382ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1781"} {"level":"info","ts":"2026-06-10T10:07:32.723063Z","caller":"traceutil/trace.go:171","msg":"trace[1555870838] range","detail":"{range_begin:/registry/pods/openstack/keepalived-vxmh4; range_end:; response_count:1; response_revision:8763; }","duration":"203.406028ms","start":"2026-06-10T10:07:32.519646Z","end":"2026-06-10T10:07:32.723052Z","steps":["trace[1555870838] 'agreement among raft nodes before linearized reading' (duration: 203.199215ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:07:32.723079Z","caller":"traceutil/trace.go:171","msg":"trace[1255628901] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:8763; }","duration":"227.281154ms","start":"2026-06-10T10:07:32.495786Z","end":"2026-06-10T10:07:32.723067Z","steps":["trace[1255628901] 'agreement among raft nodes before linearized reading' (duration: 226.722503ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:07:32.723301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.176327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-10T10:07:32.723341Z","caller":"traceutil/trace.go:171","msg":"trace[933984131] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8763; }","duration":"215.247688ms","start":"2026-06-10T10:07:32.508084Z","end":"2026-06-10T10:07:32.723332Z","steps":["trace[933984131] 'agreement among raft nodes before linearized reading' (duration: 215.153697ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:07:44.198108Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023d0.wal"} {"level":"info","ts":"2026-06-10T10:09:07.500692Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"56c01ea8fdc90390","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-10T10:09:07.506493Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-06-10T10:09:07.506667Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-06-10T10:11:28.434532Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8188} {"level":"info","ts":"2026-06-10T10:11:28.504423Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8188,"took":"66.492393ms","hash":2630061201,"current-db-size-bytes":57348096,"current-db-size":"57 MB","current-db-size-in-use-bytes":28352512,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-06-10T10:11:28.504539Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2630061201,"revision":8188,"compact-revision":6099} {"level":"info","ts":"2026-06-10T10:14:05.068015Z","caller":"traceutil/trace.go:171","msg":"trace[48386304] transaction","detail":"{read_only:false; response_revision:11819; number_of_response:1; }","duration":"122.952947ms","start":"2026-06-10T10:14:04.945029Z","end":"2026-06-10T10:14:05.067982Z","steps":["trace[48386304] 'process raft request' (duration: 122.812874ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:14:28.384997Z","caller":"traceutil/trace.go:171","msg":"trace[408691660] transaction","detail":"{read_only:false; response_revision:11945; number_of_response:1; }","duration":"193.223151ms","start":"2026-06-10T10:14:28.191742Z","end":"2026-06-10T10:14:28.384965Z","steps":["trace[408691660] 'process raft request' (duration: 182.075978ms)","trace[408691660] 'compare' (duration: 10.676664ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:14:28.385229Z","caller":"traceutil/trace.go:171","msg":"trace[1572666386] transaction","detail":"{read_only:false; response_revision:11946; number_of_response:1; }","duration":"191.680191ms","start":"2026-06-10T10:14:28.193506Z","end":"2026-06-10T10:14:28.385187Z","steps":["trace[1572666386] 'process raft request' (duration: 191.401796ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:14:28.98927Z","caller":"traceutil/trace.go:171","msg":"trace[156382705] linearizableReadLoop","detail":"{readStateIndex:12358; appliedIndex:12357; }","duration":"105.693158ms","start":"2026-06-10T10:14:28.883542Z","end":"2026-06-10T10:14:28.989235Z","steps":["trace[156382705] 'read index received' (duration: 105.435413ms)","trace[156382705] 'applied index is now lower than readState.Index' (duration: 256.115µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:14:28.989364Z","caller":"traceutil/trace.go:171","msg":"trace[2037809064] transaction","detail":"{read_only:false; response_revision:11948; number_of_response:1; }","duration":"112.156642ms","start":"2026-06-10T10:14:28.877156Z","end":"2026-06-10T10:14:28.989312Z","steps":["trace[2037809064] 'process raft request' (duration: 111.854526ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:14:28.98955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.978604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-06-10T10:14:28.989603Z","caller":"traceutil/trace.go:171","msg":"trace[1506035684] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:11948; }","duration":"106.115667ms","start":"2026-06-10T10:14:28.883474Z","end":"2026-06-10T10:14:28.98959Z","steps":["trace[1506035684] 'agreement among raft nodes before linearized reading' (duration: 105.899613ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:16:28.443502Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10551} {"level":"info","ts":"2026-06-10T10:16:28.53549Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10551,"took":"88.509058ms","hash":2371843371,"current-db-size-bytes":57348096,"current-db-size":"57 MB","current-db-size-in-use-bytes":26316800,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-06-10T10:16:28.535588Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2371843371,"revision":10551,"compact-revision":8188} {"level":"info","ts":"2026-06-10T10:20:48.072392Z","caller":"traceutil/trace.go:171","msg":"trace[2110073001] transaction","detail":"{read_only:false; response_revision:14496; number_of_response:1; }","duration":"111.197966ms","start":"2026-06-10T10:20:47.961166Z","end":"2026-06-10T10:20:48.072364Z","steps":["trace[2110073001] 'process raft request' (duration: 110.712178ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:20:48.157347Z","caller":"traceutil/trace.go:171","msg":"trace[1998219596] transaction","detail":"{read_only:false; response_revision:14497; number_of_response:1; }","duration":"105.159732ms","start":"2026-06-10T10:20:48.052123Z","end":"2026-06-10T10:20:48.157282Z","steps":["trace[1998219596] 'process raft request' (duration: 104.716244ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:20:48.157549Z","caller":"traceutil/trace.go:171","msg":"trace[200309324] transaction","detail":"{read_only:false; response_revision:14498; number_of_response:1; }","duration":"104.911618ms","start":"2026-06-10T10:20:48.052597Z","end":"2026-06-10T10:20:48.157508Z","steps":["trace[200309324] 'process raft request' (duration: 104.653043ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:21:01.969978Z","caller":"traceutil/trace.go:171","msg":"trace[467960802] transaction","detail":"{read_only:false; response_revision:14568; number_of_response:1; }","duration":"134.337198ms","start":"2026-06-10T10:21:01.835603Z","end":"2026-06-10T10:21:01.96994Z","steps":["trace[467960802] 'process raft request' (duration: 90.255969ms)","trace[467960802] 'compare' (duration: 43.885075ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:21:28.520586Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12763} {"level":"info","ts":"2026-06-10T10:21:28.934657Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12763,"took":"410.494415ms","hash":1899907844,"current-db-size-bytes":57348096,"current-db-size":"57 MB","current-db-size-in-use-bytes":29020160,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-06-10T10:21:28.934737Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1899907844,"revision":12763,"compact-revision":10551} {"level":"info","ts":"2026-06-10T10:22:56.006197Z","caller":"traceutil/trace.go:171","msg":"trace[988949306] transaction","detail":"{read_only:false; response_revision:15731; number_of_response:1; }","duration":"135.312557ms","start":"2026-06-10T10:22:55.870826Z","end":"2026-06-10T10:22:56.006138Z","steps":["trace[988949306] 'process raft request' (duration: 135.065282ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:22:56.009943Z","caller":"traceutil/trace.go:171","msg":"trace[1648786073] transaction","detail":"{read_only:false; response_revision:15732; number_of_response:1; }","duration":"137.745003ms","start":"2026-06-10T10:22:55.87216Z","end":"2026-06-10T10:22:56.009905Z","steps":["trace[1648786073] 'process raft request' (duration: 137.371625ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:26:28.527131Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14917} {"level":"info","ts":"2026-06-10T10:26:28.622117Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14917,"took":"91.428536ms","hash":123841516,"current-db-size-bytes":57348096,"current-db-size":"57 MB","current-db-size-in-use-bytes":30568448,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-06-10T10:26:28.622181Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":123841516,"revision":14917,"compact-revision":12763} {"level":"info","ts":"2026-06-10T10:28:53.744618Z","caller":"traceutil/trace.go:171","msg":"trace[1013286874] transaction","detail":"{read_only:false; response_revision:18367; number_of_response:1; }","duration":"133.389995ms","start":"2026-06-10T10:28:53.611198Z","end":"2026-06-10T10:28:53.744588Z","steps":["trace[1013286874] 'process raft request' (duration: 133.175071ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:28:54.146199Z","caller":"traceutil/trace.go:171","msg":"trace[1017067298] transaction","detail":"{read_only:false; response_revision:18368; number_of_response:1; }","duration":"231.294316ms","start":"2026-06-10T10:28:53.914868Z","end":"2026-06-10T10:28:54.146162Z","steps":["trace[1017067298] 'process raft request' (duration: 231.087802ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:28:54.146472Z","caller":"traceutil/trace.go:171","msg":"trace[636678857] linearizableReadLoop","detail":"{readStateIndex:18999; appliedIndex:18999; }","duration":"231.206895ms","start":"2026-06-10T10:28:53.915229Z","end":"2026-06-10T10:28:54.146436Z","steps":["trace[636678857] 'read index received' (duration: 231.194984ms)","trace[636678857] 'applied index is now lower than readState.Index' (duration: 9.611µs)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:28:54.146867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.615632ms","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-06-10T10:28:54.146921Z","caller":"traceutil/trace.go:171","msg":"trace[1984530846] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:18368; }","duration":"231.706903ms","start":"2026-06-10T10:28:53.9152Z","end":"2026-06-10T10:28:54.146907Z","steps":["trace[1984530846] 'agreement among raft nodes before linearized reading' (duration: 231.431868ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:28:54.426585Z","caller":"traceutil/trace.go:171","msg":"trace[1323646359] linearizableReadLoop","detail":"{readStateIndex:19004; appliedIndex:18999; }","duration":"279.955081ms","start":"2026-06-10T10:28:54.146596Z","end":"2026-06-10T10:28:54.426551Z","steps":["trace[1323646359] 'read index received' (duration: 279.559453ms)","trace[1323646359] 'applied index is now lower than readState.Index' (duration: 394.418µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:28:54.426996Z","caller":"traceutil/trace.go:171","msg":"trace[1425952348] transaction","detail":"{read_only:false; response_revision:18373; number_of_response:1; }","duration":"379.518853ms","start":"2026-06-10T10:28:54.047448Z","end":"2026-06-10T10:28:54.426967Z","steps":["trace[1425952348] 'process raft request' (duration: 379.056145ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:28:54.427045Z","caller":"traceutil/trace.go:171","msg":"trace[1086661866] transaction","detail":"{read_only:false; response_revision:18370; number_of_response:1; }","duration":"490.88489ms","start":"2026-06-10T10:28:53.93611Z","end":"2026-06-10T10:28:54.426995Z","steps":["trace[1086661866] 'process raft request' (duration: 490.252078ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:28:54.427243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:28:53.936087Z","time spent":"491.042232ms","remote":"127.0.0.1:55252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:28:54.427266Z","caller":"traceutil/trace.go:171","msg":"trace[808299302] transaction","detail":"{read_only:false; response_revision:18371; number_of_response:1; }","duration":"480.86114ms","start":"2026-06-10T10:28:53.946383Z","end":"2026-06-10T10:28:54.427244Z","steps":["trace[808299302] 'process raft request' (duration: 480.032354ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:28:54.427572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.642798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-10T10:28:54.427654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:28:53.946368Z","time spent":"481.242447ms","remote":"127.0.0.1:55252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:28:54.427716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.515116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-qkgxg\" ","response":"range_response_count:1 size:20778"} {"level":"warn","ts":"2026-06-10T10:28:54.427709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.32161ms","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-06-10T10:28:54.427756Z","caller":"traceutil/trace.go:171","msg":"trace[501208015] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-qkgxg; range_end:; response_count:1; response_revision:18373; }","duration":"336.558647ms","start":"2026-06-10T10:28:54.091188Z","end":"2026-06-10T10:28:54.427746Z","steps":["trace[501208015] 'agreement among raft nodes before linearized reading' (duration: 336.369303ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:28:54.427781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:28:54.091109Z","time spent":"336.666839ms","remote":"127.0.0.1:55140","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":20801,"request content":"key:\"/registry/pods/openstack/libvirt-libvirt-default-qkgxg\" "} {"level":"info","ts":"2026-06-10T10:28:54.427775Z","caller":"traceutil/trace.go:171","msg":"trace[2066123281] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:18373; }","duration":"419.440503ms","start":"2026-06-10T10:28:54.008322Z","end":"2026-06-10T10:28:54.427763Z","steps":["trace[2066123281] 'agreement among raft nodes before linearized reading' (duration: 419.079446ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:28:54.427833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:28:54.008308Z","time spent":"419.507774ms","remote":"127.0.0.1:55252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-10T10:28:54.427693Z","caller":"traceutil/trace.go:171","msg":"trace[1172847757] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:18373; }","duration":"376.816392ms","start":"2026-06-10T10:28:54.050848Z","end":"2026-06-10T10:28:54.427664Z","steps":["trace[1172847757] 'agreement among raft nodes before linearized reading' (duration: 376.461676ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:28:54.427321Z","caller":"traceutil/trace.go:171","msg":"trace[1708480642] transaction","detail":"{read_only:false; response_revision:18372; number_of_response:1; }","duration":"380.495482ms","start":"2026-06-10T10:28:54.046792Z","end":"2026-06-10T10:28:54.427288Z","steps":["trace[1708480642] 'process raft request' (duration: 379.669196ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:28:54.427986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:28:54.050838Z","time spent":"377.133108ms","remote":"127.0.0.1:54994","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-10T10:28:54.427383Z","caller":"traceutil/trace.go:171","msg":"trace[1009112436] transaction","detail":"{read_only:false; response_revision:18369; number_of_response:1; }","duration":"511.508143ms","start":"2026-06-10T10:28:53.91584Z","end":"2026-06-10T10:28:54.427348Z","steps":["trace[1009112436] 'process raft request' (duration: 510.32215ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:28:54.428103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:28:54.046763Z","time spent":"381.220576ms","remote":"127.0.0.1:55252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:28:54.428151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:28:53.915826Z","time spent":"512.297887ms","remote":"127.0.0.1:55252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:28:54.427493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"480.705578ms","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-06-10T10:28:54.428201Z","caller":"traceutil/trace.go:171","msg":"trace[120312851] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:18373; }","duration":"481.456931ms","start":"2026-06-10T10:28:53.946733Z","end":"2026-06-10T10:28:54.42819Z","steps":["trace[120312851] 'agreement among raft nodes before linearized reading' (duration: 480.702947ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:28:54.428249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:28:53.946718Z","time spent":"481.519693ms","remote":"127.0.0.1:55390","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":29,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"warn","ts":"2026-06-10T10:28:54.427562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.073889ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T10:28:54.42847Z","caller":"traceutil/trace.go:171","msg":"trace[409626135] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:18373; }","duration":"305.016286ms","start":"2026-06-10T10:28:54.123435Z","end":"2026-06-10T10:28:54.428451Z","steps":["trace[409626135] 'agreement among raft nodes before linearized reading' (duration: 304.09456ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:28:54.428538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:28:54.123415Z","time spent":"305.102068ms","remote":"127.0.0.1:37578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-10T10:28:54.429068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:28:54.047424Z","time spent":"379.629365ms","remote":"127.0.0.1:55252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:28:54.452089Z","caller":"traceutil/trace.go:171","msg":"trace[576728836] transaction","detail":"{read_only:false; response_revision:18374; number_of_response:1; }","duration":"301.176145ms","start":"2026-06-10T10:28:54.150896Z","end":"2026-06-10T10:28:54.452072Z","steps":["trace[576728836] 'process raft request' (duration: 301.053552ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:28:54.452192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:28:54.150872Z","time spent":"301.269096ms","remote":"127.0.0.1:55252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:28:54.452227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.199591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-06-10T10:28:54.452308Z","caller":"traceutil/trace.go:171","msg":"trace[1018479841] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:18374; }","duration":"274.305103ms","start":"2026-06-10T10:28:54.177985Z","end":"2026-06-10T10:28:54.45229Z","steps":["trace[1018479841] 'agreement among raft nodes before linearized reading' (duration: 274.103179ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:30:29.855112Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"56c01ea8fdc90390","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-10T10:30:29.864534Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-06-10T10:30:29.864645Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-06-10T10:31:28.535211Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17394} {"level":"info","ts":"2026-06-10T10:31:28.640546Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17394,"took":"100.369137ms","hash":1073089280,"current-db-size-bytes":57348096,"current-db-size":"57 MB","current-db-size-in-use-bytes":34197504,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-06-10T10:31:28.640624Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1073089280,"revision":17394,"compact-revision":14917} {"level":"info","ts":"2026-06-10T10:34:43.258363Z","caller":"traceutil/trace.go:171","msg":"trace[1210682573] transaction","detail":"{read_only:false; response_revision:21071; number_of_response:1; }","duration":"166.579076ms","start":"2026-06-10T10:34:43.091749Z","end":"2026-06-10T10:34:43.258328Z","steps":["trace[1210682573] 'process raft request' (duration: 166.366533ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:34:43.507869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.510828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T10:34:43.508006Z","caller":"traceutil/trace.go:171","msg":"trace[1819840838] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:21071; }","duration":"163.741672ms","start":"2026-06-10T10:34:43.344229Z","end":"2026-06-10T10:34:43.507971Z","steps":["trace[1819840838] 'count revisions from in-memory index tree' (duration: 163.377445ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:34:43.683146Z","caller":"traceutil/trace.go:171","msg":"trace[1230553902] linearizableReadLoop","detail":"{readStateIndex:21792; appliedIndex:21791; }","duration":"147.209758ms","start":"2026-06-10T10:34:43.535908Z","end":"2026-06-10T10:34:43.683118Z","steps":["trace[1230553902] 'read index received' (duration: 120.671073ms)","trace[1230553902] 'applied index is now lower than readState.Index' (duration: 26.537425ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:34:43.683426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.499873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2083"} {"level":"info","ts":"2026-06-10T10:34:43.683461Z","caller":"traceutil/trace.go:171","msg":"trace[719427715] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:21072; }","duration":"147.595786ms","start":"2026-06-10T10:34:43.535852Z","end":"2026-06-10T10:34:43.683448Z","steps":["trace[719427715] 'agreement among raft nodes before linearized reading' (duration: 147.369561ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:34:43.683471Z","caller":"traceutil/trace.go:171","msg":"trace[1861156169] transaction","detail":"{read_only:false; response_revision:21072; number_of_response:1; }","duration":"160.049533ms","start":"2026-06-10T10:34:43.523385Z","end":"2026-06-10T10:34:43.683435Z","steps":["trace[1861156169] 'process raft request' (duration: 133.266833ms)","trace[1861156169] 'compare' (duration: 26.32079ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:34:43.868014Z","caller":"traceutil/trace.go:171","msg":"trace[1023300801] transaction","detail":"{read_only:false; response_revision:21074; number_of_response:1; }","duration":"124.15082ms","start":"2026-06-10T10:34:43.743829Z","end":"2026-06-10T10:34:43.86798Z","steps":["trace[1023300801] 'process raft request' (duration: 123.751652ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:34:44.007885Z","caller":"traceutil/trace.go:171","msg":"trace[693155518] transaction","detail":"{read_only:false; response_revision:21075; number_of_response:1; }","duration":"222.183782ms","start":"2026-06-10T10:34:43.785664Z","end":"2026-06-10T10:34:44.007848Z","steps":["trace[693155518] 'process raft request' (duration: 212.539369ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:34:44.00808Z","caller":"traceutil/trace.go:171","msg":"trace[593352324] transaction","detail":"{read_only:false; response_revision:21076; number_of_response:1; }","duration":"219.306127ms","start":"2026-06-10T10:34:43.78874Z","end":"2026-06-10T10:34:44.008046Z","steps":["trace[593352324] 'process raft request' (duration: 219.016912ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:34:44.008004Z","caller":"traceutil/trace.go:171","msg":"trace[1334006148] linearizableReadLoop","detail":"{readStateIndex:21796; appliedIndex:21793; }","duration":"194.558898ms","start":"2026-06-10T10:34:43.813414Z","end":"2026-06-10T10:34:44.007973Z","steps":["trace[1334006148] 'read index received' (duration: 54.247952ms)","trace[1334006148] 'applied index is now lower than readState.Index' (duration: 140.307956ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:34:44.008628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.776292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T10:34:44.009483Z","caller":"traceutil/trace.go:171","msg":"trace[681229611] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:21076; }","duration":"195.301183ms","start":"2026-06-10T10:34:43.813362Z","end":"2026-06-10T10:34:44.008663Z","steps":["trace[681229611] 'agreement among raft nodes before linearized reading' (duration: 194.765012ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:34:44.452833Z","caller":"traceutil/trace.go:171","msg":"trace[548082093] transaction","detail":"{read_only:false; response_revision:21078; number_of_response:1; }","duration":"126.439803ms","start":"2026-06-10T10:34:44.326331Z","end":"2026-06-10T10:34:44.452771Z","steps":["trace[548082093] 'process raft request' (duration: 126.250629ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:34:44.454082Z","caller":"traceutil/trace.go:171","msg":"trace[1223464319] transaction","detail":"{read_only:false; response_revision:21079; number_of_response:1; }","duration":"126.905112ms","start":"2026-06-10T10:34:44.327147Z","end":"2026-06-10T10:34:44.454052Z","steps":["trace[1223464319] 'process raft request' (duration: 126.675258ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:34:44.454235Z","caller":"traceutil/trace.go:171","msg":"trace[158287605] transaction","detail":"{read_only:false; response_revision:21080; number_of_response:1; }","duration":"125.897533ms","start":"2026-06-10T10:34:44.328317Z","end":"2026-06-10T10:34:44.454214Z","steps":["trace[158287605] 'process raft request' (duration: 125.680889ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:34:44.607386Z","caller":"traceutil/trace.go:171","msg":"trace[885977402] transaction","detail":"{read_only:false; response_revision:21081; number_of_response:1; }","duration":"134.881423ms","start":"2026-06-10T10:34:44.472462Z","end":"2026-06-10T10:34:44.607344Z","steps":["trace[885977402] 'process raft request' (duration: 134.400214ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:36:28.543123Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19711} {"level":"info","ts":"2026-06-10T10:36:28.65318Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19711,"took":"105.73797ms","hash":1494593942,"current-db-size-bytes":57348096,"current-db-size":"57 MB","current-db-size-in-use-bytes":30429184,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-10T10:36:28.653272Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1494593942,"revision":19711,"compact-revision":17394} {"level":"info","ts":"2026-06-10T10:36:49.245545Z","caller":"traceutil/trace.go:171","msg":"trace[663779858] transaction","detail":"{read_only:false; response_revision:22128; number_of_response:1; }","duration":"106.702068ms","start":"2026-06-10T10:36:49.138814Z","end":"2026-06-10T10:36:49.245516Z","steps":["trace[663779858] 'process raft request' (duration: 106.088746ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:38:40.858041Z","caller":"traceutil/trace.go:171","msg":"trace[289730188] transaction","detail":"{read_only:false; response_revision:23541; number_of_response:1; }","duration":"123.891724ms","start":"2026-06-10T10:38:40.734116Z","end":"2026-06-10T10:38:40.858008Z","steps":["trace[289730188] 'process raft request' (duration: 89.462304ms)","trace[289730188] 'compare' (duration: 34.230136ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:38:41.209307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.673486ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-10T10:38:41.209469Z","caller":"traceutil/trace.go:171","msg":"trace[1185508536] transaction","detail":"{read_only:false; response_revision:23542; number_of_response:1; }","duration":"292.126935ms","start":"2026-06-10T10:38:40.917293Z","end":"2026-06-10T10:38:41.20942Z","steps":["trace[1185508536] 'process raft request' (duration: 177.205494ms)","trace[1185508536] 'compare' (duration: 113.903171ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:38:41.210264Z","caller":"traceutil/trace.go:171","msg":"trace[2049741520] linearizableReadLoop","detail":"{readStateIndex:24337; appliedIndex:24334; }","duration":"158.626418ms","start":"2026-06-10T10:38:41.051591Z","end":"2026-06-10T10:38:41.210217Z","steps":["trace[2049741520] 'read index received' (duration: 42.926462ms)","trace[2049741520] 'applied index is now lower than readState.Index' (duration: 115.698586ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:38:41.210291Z","caller":"traceutil/trace.go:171","msg":"trace[1782785868] transaction","detail":"{read_only:false; response_revision:23543; number_of_response:1; }","duration":"290.059165ms","start":"2026-06-10T10:38:40.920193Z","end":"2026-06-10T10:38:41.210252Z","steps":["trace[1782785868] 'process raft request' (duration: 289.815531ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:38:41.210512Z","caller":"traceutil/trace.go:171","msg":"trace[558215595] transaction","detail":"{read_only:false; response_revision:23544; number_of_response:1; }","duration":"163.690175ms","start":"2026-06-10T10:38:41.04678Z","end":"2026-06-10T10:38:41.21047Z","steps":["trace[558215595] 'process raft request' (duration: 163.382419ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:38:41.210724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.071916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T10:38:41.210855Z","caller":"traceutil/trace.go:171","msg":"trace[328768423] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:23544; }","duration":"159.25526ms","start":"2026-06-10T10:38:41.051549Z","end":"2026-06-10T10:38:41.210804Z","steps":["trace[328768423] 'agreement among raft nodes before linearized reading' (duration: 158.960145ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:41:28.548645Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21976} {"level":"info","ts":"2026-06-10T10:41:28.65499Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21976,"took":"103.287688ms","hash":1591419777,"current-db-size-bytes":57348096,"current-db-size":"57 MB","current-db-size-in-use-bytes":43651072,"current-db-size-in-use":"44 MB"} {"level":"info","ts":"2026-06-10T10:41:28.655079Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1591419777,"revision":21976,"compact-revision":19711} {"level":"info","ts":"2026-06-10T10:42:07.125927Z","caller":"traceutil/trace.go:171","msg":"trace[1295591441] transaction","detail":"{read_only:false; response_revision:25639; number_of_response:1; }","duration":"162.259318ms","start":"2026-06-10T10:42:06.963633Z","end":"2026-06-10T10:42:07.125892Z","steps":["trace[1295591441] 'process raft request' (duration: 162.046714ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:42:07.126013Z","caller":"traceutil/trace.go:171","msg":"trace[749615034] linearizableReadLoop","detail":"{readStateIndex:26486; appliedIndex:26485; }","duration":"160.058405ms","start":"2026-06-10T10:42:06.965919Z","end":"2026-06-10T10:42:07.125978Z","steps":["trace[749615034] 'read index received' (duration: 159.725519ms)","trace[749615034] 'applied index is now lower than readState.Index' (duration: 327.486µs)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:42:07.12621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.267579ms","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-06-10T10:42:07.126252Z","caller":"traceutil/trace.go:171","msg":"trace[1153976318] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25639; }","duration":"160.359801ms","start":"2026-06-10T10:42:06.965883Z","end":"2026-06-10T10:42:07.126243Z","steps":["trace[1153976318] 'agreement among raft nodes before linearized reading' (duration: 160.187148ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:42:07.238483Z","caller":"traceutil/trace.go:171","msg":"trace[262081960] transaction","detail":"{read_only:false; response_revision:25640; number_of_response:1; }","duration":"139.542662ms","start":"2026-06-10T10:42:07.098915Z","end":"2026-06-10T10:42:07.238457Z","steps":["trace[262081960] 'process raft request' (duration: 136.32331ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:42:07.238503Z","caller":"traceutil/trace.go:171","msg":"trace[2064712912] linearizableReadLoop","detail":"{readStateIndex:26487; appliedIndex:26486; }","duration":"112.393332ms","start":"2026-06-10T10:42:07.126072Z","end":"2026-06-10T10:42:07.238466Z","steps":["trace[2064712912] 'read index received' (duration: 109.183941ms)","trace[2064712912] 'applied index is now lower than readState.Index' (duration: 3.208611ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:42:07.238627Z","caller":"traceutil/trace.go:171","msg":"trace[69191403] transaction","detail":"{read_only:false; response_revision:25641; number_of_response:1; }","duration":"109.12944ms","start":"2026-06-10T10:42:07.129472Z","end":"2026-06-10T10:42:07.238601Z","steps":["trace[69191403] 'process raft request' (duration: 108.959557ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:42:07.23874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.925702ms","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-06-10T10:42:07.238781Z","caller":"traceutil/trace.go:171","msg":"trace[123573410] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25641; }","duration":"269.012422ms","start":"2026-06-10T10:42:06.969756Z","end":"2026-06-10T10:42:07.238768Z","steps":["trace[123573410] 'agreement among raft nodes before linearized reading' (duration: 268.848288ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:42:07.238835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.31411ms","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-06-10T10:42:07.238894Z","caller":"traceutil/trace.go:171","msg":"trace[940271946] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:25641; }","duration":"196.388432ms","start":"2026-06-10T10:42:07.042492Z","end":"2026-06-10T10:42:07.238881Z","steps":["trace[940271946] 'agreement among raft nodes before linearized reading' (duration: 196.034444ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:42:07.238908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.480808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterrestores/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterrestores0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T10:42:07.238936Z","caller":"traceutil/trace.go:171","msg":"trace[2009874279] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterrestores/; range_end:/registry/pxc.percona.com/perconaxtradbclusterrestores0; response_count:0; response_revision:25641; }","duration":"261.533398ms","start":"2026-06-10T10:42:06.977394Z","end":"2026-06-10T10:42:07.238927Z","steps":["trace[2009874279] 'agreement among raft nodes before linearized reading' (duration: 261.14324ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:42:07.238919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.592971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-10T10:42:07.239004Z","caller":"traceutil/trace.go:171","msg":"trace[25256947] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:25641; }","duration":"143.724793ms","start":"2026-06-10T10:42:07.095263Z","end":"2026-06-10T10:42:07.238988Z","steps":["trace[25256947] 'agreement among raft nodes before linearized reading' (duration: 143.270083ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:42:07.239082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.952898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T10:42:07.239114Z","caller":"traceutil/trace.go:171","msg":"trace[1394403178] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25641; }","duration":"188.99613ms","start":"2026-06-10T10:42:07.050109Z","end":"2026-06-10T10:42:07.239105Z","steps":["trace[1394403178] 'agreement among raft nodes before linearized reading' (duration: 188.386107ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:42:07.239219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.91049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/glance-api\" ","response":"range_response_count:1 size:11714"} {"level":"warn","ts":"2026-06-10T10:42:07.239339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.50534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/networks/\" range_end:\"/registry/openstack.k-orc.cloud/networks0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T10:42:07.239351Z","caller":"traceutil/trace.go:171","msg":"trace[940284889] range","detail":"{range_begin:/registry/deployments/openstack/glance-api; range_end:; response_count:1; response_revision:25641; }","duration":"116.087433ms","start":"2026-06-10T10:42:07.12325Z","end":"2026-06-10T10:42:07.239337Z","steps":["trace[940284889] 'agreement among raft nodes before linearized reading' (duration: 115.271597ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:42:07.239378Z","caller":"traceutil/trace.go:171","msg":"trace[1136605292] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/networks/; range_end:/registry/openstack.k-orc.cloud/networks0; response_count:0; response_revision:25641; }","duration":"259.55237ms","start":"2026-06-10T10:42:06.979805Z","end":"2026-06-10T10:42:07.239357Z","steps":["trace[1136605292] 'agreement among raft nodes before linearized reading' (duration: 258.704224ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:42:11.974117Z","caller":"traceutil/trace.go:171","msg":"trace[368775259] transaction","detail":"{read_only:false; response_revision:25674; number_of_response:1; }","duration":"126.534684ms","start":"2026-06-10T10:42:11.847559Z","end":"2026-06-10T10:42:11.974094Z","steps":["trace[368775259] 'process raft request' (duration: 126.406622ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:42:12.359504Z","caller":"traceutil/trace.go:171","msg":"trace[1723210498] transaction","detail":"{read_only:false; response_revision:25676; number_of_response:1; }","duration":"228.574997ms","start":"2026-06-10T10:42:12.130896Z","end":"2026-06-10T10:42:12.359471Z","steps":["trace[1723210498] 'process raft request' (duration: 201.371226ms)","trace[1723210498] 'compare' (duration: 26.933776ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:42:12.359823Z","caller":"traceutil/trace.go:171","msg":"trace[109098273] transaction","detail":"{read_only:false; response_revision:25677; number_of_response:1; }","duration":"228.894913ms","start":"2026-06-10T10:42:12.1309Z","end":"2026-06-10T10:42:12.359795Z","steps":["trace[109098273] 'process raft request' (duration: 228.472455ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:42:12.527463Z","caller":"traceutil/trace.go:171","msg":"trace[334105492] transaction","detail":"{read_only:false; response_revision:25678; number_of_response:1; }","duration":"151.007302ms","start":"2026-06-10T10:42:12.376433Z","end":"2026-06-10T10:42:12.527441Z","steps":["trace[334105492] 'process raft request' (duration: 128.944349ms)","trace[334105492] 'compare' (duration: 21.961831ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:42:12.940326Z","caller":"traceutil/trace.go:171","msg":"trace[559668679] transaction","detail":"{read_only:false; response_revision:25679; number_of_response:1; }","duration":"136.538155ms","start":"2026-06-10T10:42:12.803762Z","end":"2026-06-10T10:42:12.9403Z","steps":["trace[559668679] 'process raft request' (duration: 136.367302ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:42:13.214217Z","caller":"traceutil/trace.go:171","msg":"trace[1914897939] linearizableReadLoop","detail":"{readStateIndex:26529; appliedIndex:26527; }","duration":"257.998891ms","start":"2026-06-10T10:42:12.956194Z","end":"2026-06-10T10:42:13.214193Z","steps":["trace[1914897939] 'read index received' (duration: 257.635184ms)","trace[1914897939] 'applied index is now lower than readState.Index' (duration: 362.867µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:42:13.214491Z","caller":"traceutil/trace.go:171","msg":"trace[13152724] transaction","detail":"{read_only:false; response_revision:25680; number_of_response:1; }","duration":"361.733458ms","start":"2026-06-10T10:42:12.852745Z","end":"2026-06-10T10:42:13.214479Z","steps":["trace[13152724] 'process raft request' (duration: 361.215228ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:42:13.214598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:42:12.852723Z","time spent":"361.805109ms","remote":"127.0.0.1:55252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:42:13.21482Z","caller":"traceutil/trace.go:171","msg":"trace[1013985839] transaction","detail":"{read_only:false; response_revision:25681; number_of_response:1; }","duration":"279.448692ms","start":"2026-06-10T10:42:12.935358Z","end":"2026-06-10T10:42:13.214807Z","steps":["trace[1013985839] 'process raft request' (duration: 278.787409ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:42:13.215041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.827527ms","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-06-10T10:42:13.215124Z","caller":"traceutil/trace.go:171","msg":"trace[831616784] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25681; }","duration":"258.922669ms","start":"2026-06-10T10:42:12.95618Z","end":"2026-06-10T10:42:13.215103Z","steps":["trace[831616784] 'agreement among raft nodes before linearized reading' (duration: 258.667894ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:42:13.215276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.418498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T10:42:13.215322Z","caller":"traceutil/trace.go:171","msg":"trace[1886032102] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25681; }","duration":"166.5309ms","start":"2026-06-10T10:42:13.048782Z","end":"2026-06-10T10:42:13.215312Z","steps":["trace[1886032102] 'agreement among raft nodes before linearized reading' (duration: 166.456968ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:42:13.621612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.957033ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-10T10:42:13.622014Z","caller":"traceutil/trace.go:171","msg":"trace[846443042] transaction","detail":"{read_only:false; response_revision:25684; number_of_response:1; }","duration":"354.410018ms","start":"2026-06-10T10:42:13.267559Z","end":"2026-06-10T10:42:13.621969Z","steps":["trace[846443042] 'process raft request' (duration: 171.015966ms)","trace[846443042] 'compare' (duration: 182.452634ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:42:13.622129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:42:13.267536Z","time spent":"354.55617ms","remote":"127.0.0.1:55252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":496,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:42:13.623214Z","caller":"traceutil/trace.go:171","msg":"trace[1403611222] linearizableReadLoop","detail":"{readStateIndex:26533; appliedIndex:26531; }","duration":"334.067458ms","start":"2026-06-10T10:42:13.289115Z","end":"2026-06-10T10:42:13.623183Z","steps":["trace[1403611222] 'read index received' (duration: 149.471173ms)","trace[1403611222] 'applied index is now lower than readState.Index' (duration: 184.595235ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:42:13.62334Z","caller":"traceutil/trace.go:171","msg":"trace[1961525533] transaction","detail":"{read_only:false; response_revision:25685; number_of_response:1; }","duration":"352.301907ms","start":"2026-06-10T10:42:13.271027Z","end":"2026-06-10T10:42:13.623329Z","steps":["trace[1961525533] 'process raft request' (duration: 351.767416ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:42:13.623448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:42:13.271016Z","time spent":"352.354968ms","remote":"127.0.0.1:55252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:42:13.623961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.249457ms","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-06-10T10:42:13.624054Z","caller":"traceutil/trace.go:171","msg":"trace[97915439] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25686; }","duration":"292.391919ms","start":"2026-06-10T10:42:13.331647Z","end":"2026-06-10T10:42:13.624039Z","steps":["trace[97915439] 'agreement among raft nodes before linearized reading' (duration: 292.198196ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:42:13.624139Z","caller":"traceutil/trace.go:171","msg":"trace[699036505] transaction","detail":"{read_only:false; response_revision:25686; number_of_response:1; }","duration":"212.800145ms","start":"2026-06-10T10:42:13.411331Z","end":"2026-06-10T10:42:13.624132Z","steps":["trace[699036505] 'process raft request' (duration: 211.772405ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:42:13.624109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.998805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectrealms/\" range_end:\"/registry/ceph.rook.io/cephobjectrealms0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T10:42:13.624248Z","caller":"traceutil/trace.go:171","msg":"trace[601328731] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectrealms/; range_end:/registry/ceph.rook.io/cephobjectrealms0; response_count:0; response_revision:25686; }","duration":"335.160609ms","start":"2026-06-10T10:42:13.289068Z","end":"2026-06-10T10:42:13.624229Z","steps":["trace[601328731] 'agreement among raft nodes before linearized reading' (duration: 334.996286ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:42:13.624315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:42:13.28905Z","time spent":"335.24065ms","remote":"127.0.0.1:54504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephobjectrealms/\" range_end:\"/registry/ceph.rook.io/cephobjectrealms0\" count_only:true "} {"level":"warn","ts":"2026-06-10T10:42:13.969306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.111211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclients/\" range_end:\"/registry/ceph.rook.io/cephclients0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T10:42:13.969393Z","caller":"traceutil/trace.go:171","msg":"trace[1115274484] range","detail":"{range_begin:/registry/ceph.rook.io/cephclients/; range_end:/registry/ceph.rook.io/cephclients0; response_count:0; response_revision:25687; }","duration":"107.221203ms","start":"2026-06-10T10:42:13.862154Z","end":"2026-06-10T10:42:13.969375Z","steps":["trace[1115274484] 'count revisions from in-memory index tree' (duration: 107.02294ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:42:14.284137Z","caller":"traceutil/trace.go:171","msg":"trace[1779519455] transaction","detail":"{read_only:false; response_revision:25688; number_of_response:1; }","duration":"302.898521ms","start":"2026-06-10T10:42:13.981188Z","end":"2026-06-10T10:42:14.284087Z","steps":["trace[1779519455] 'process raft request' (duration: 302.762448ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:42:14.284319Z","caller":"traceutil/trace.go:171","msg":"trace[1641440315] linearizableReadLoop","detail":"{readStateIndex:26536; appliedIndex:26536; }","duration":"234.654404ms","start":"2026-06-10T10:42:14.049613Z","end":"2026-06-10T10:42:14.284267Z","steps":["trace[1641440315] 'read index received' (duration: 234.635554ms)","trace[1641440315] 'applied index is now lower than readState.Index' (duration: 15.51µs)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:42:14.284357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:42:13.981171Z","time spent":"303.106005ms","remote":"127.0.0.1:55252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:42:14.284484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.875148ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T10:42:14.284568Z","caller":"traceutil/trace.go:171","msg":"trace[70025255] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25688; }","duration":"234.983221ms","start":"2026-06-10T10:42:14.049573Z","end":"2026-06-10T10:42:14.284556Z","steps":["trace[70025255] 'agreement among raft nodes before linearized reading' (duration: 234.875369ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:42:14.342092Z","caller":"traceutil/trace.go:171","msg":"trace[2117649914] transaction","detail":"{read_only:false; response_revision:25689; number_of_response:1; }","duration":"191.020959ms","start":"2026-06-10T10:42:14.151044Z","end":"2026-06-10T10:42:14.342065Z","steps":["trace[2117649914] 'process raft request' (duration: 190.626922ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:42:14.616247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.038535ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-10T10:42:14.616694Z","caller":"traceutil/trace.go:171","msg":"trace[1178275502] transaction","detail":"{read_only:false; response_revision:25690; number_of_response:1; }","duration":"252.251701ms","start":"2026-06-10T10:42:14.364418Z","end":"2026-06-10T10:42:14.61667Z","steps":["trace[1178275502] 'process raft request' (duration: 128.514332ms)","trace[1178275502] 'compare' (duration: 122.909052ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:42:14.616708Z","caller":"traceutil/trace.go:171","msg":"trace[1855295502] transaction","detail":"{read_only:false; response_revision:25691; number_of_response:1; }","duration":"251.950366ms","start":"2026-06-10T10:42:14.364718Z","end":"2026-06-10T10:42:14.616668Z","steps":["trace[1855295502] 'process raft request' (duration: 251.64464ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:42:15.242809Z","caller":"traceutil/trace.go:171","msg":"trace[1786875834] linearizableReadLoop","detail":"{readStateIndex:26541; appliedIndex:26540; }","duration":"231.421402ms","start":"2026-06-10T10:42:15.011367Z","end":"2026-06-10T10:42:15.242788Z","steps":["trace[1786875834] 'read index received' (duration: 231.30425ms)","trace[1786875834] 'applied index is now lower than readState.Index' (duration: 116.302µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:42:15.24293Z","caller":"traceutil/trace.go:171","msg":"trace[1949825957] transaction","detail":"{read_only:false; response_revision:25693; number_of_response:1; }","duration":"298.11317ms","start":"2026-06-10T10:42:14.944778Z","end":"2026-06-10T10:42:15.242891Z","steps":["trace[1949825957] 'process raft request' (duration: 297.853225ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:42:15.242976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.590295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/podmonitors/\" range_end:\"/registry/monitoring.coreos.com/podmonitors0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-10T10:42:15.243033Z","caller":"traceutil/trace.go:171","msg":"trace[1190093539] range","detail":"{range_begin:/registry/monitoring.coreos.com/podmonitors/; range_end:/registry/monitoring.coreos.com/podmonitors0; response_count:0; response_revision:25693; }","duration":"231.690357ms","start":"2026-06-10T10:42:15.01133Z","end":"2026-06-10T10:42:15.24302Z","steps":["trace[1190093539] 'agreement among raft nodes before linearized reading' (duration: 231.565145ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:42:15.378406Z","caller":"traceutil/trace.go:171","msg":"trace[1982968832] transaction","detail":"{read_only:false; response_revision:25694; number_of_response:1; }","duration":"158.74287ms","start":"2026-06-10T10:42:15.219645Z","end":"2026-06-10T10:42:15.378388Z","steps":["trace[1982968832] 'process raft request' (duration: 145.268242ms)","trace[1982968832] 'compare' (duration: 13.363906ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:42:15.378549Z","caller":"traceutil/trace.go:171","msg":"trace[38122850] linearizableReadLoop","detail":"{readStateIndex:26543; appliedIndex:26541; }","duration":"135.651858ms","start":"2026-06-10T10:42:15.242872Z","end":"2026-06-10T10:42:15.378524Z","steps":["trace[38122850] 'read index received' (duration: 121.987367ms)","trace[38122850] 'applied index is now lower than readState.Index' (duration: 13.663631ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:42:15.378742Z","caller":"traceutil/trace.go:171","msg":"trace[1807247415] transaction","detail":"{read_only:false; response_revision:25695; number_of_response:1; }","duration":"157.845592ms","start":"2026-06-10T10:42:15.220883Z","end":"2026-06-10T10:42:15.378729Z","steps":["trace[1807247415] 'process raft request' (duration: 157.474865ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:42:15.378873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.080456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T10:42:15.378903Z","caller":"traceutil/trace.go:171","msg":"trace[8736043] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0; response_count:0; response_revision:25695; }","duration":"288.158458ms","start":"2026-06-10T10:42:15.090736Z","end":"2026-06-10T10:42:15.378894Z","steps":["trace[8736043] 'agreement among raft nodes before linearized reading' (duration: 288.093937ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:42:15.378977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.052066ms","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-06-10T10:42:15.379034Z","caller":"traceutil/trace.go:171","msg":"trace[1595431158] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25695; }","duration":"134.153079ms","start":"2026-06-10T10:42:15.244871Z","end":"2026-06-10T10:42:15.379024Z","steps":["trace[1595431158] 'agreement among raft nodes before linearized reading' (duration: 133.976835ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:42:15.379055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.384598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T10:42:15.379122Z","caller":"traceutil/trace.go:171","msg":"trace[541741674] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25695; }","duration":"329.489541ms","start":"2026-06-10T10:42:15.049618Z","end":"2026-06-10T10:42:15.379108Z","steps":["trace[541741674] 'agreement among raft nodes before linearized reading' (duration: 329.348048ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:42:15.37913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.094118ms","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-06-10T10:42:15.379153Z","caller":"traceutil/trace.go:171","msg":"trace[378716400] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25695; }","duration":"134.147259ms","start":"2026-06-10T10:42:15.244999Z","end":"2026-06-10T10:42:15.379146Z","steps":["trace[378716400] 'agreement among raft nodes before linearized reading' (duration: 134.061746ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:42:15.379761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:42:15.049605Z","time spent":"330.127363ms","remote":"127.0.0.1:54994","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-10T10:42:15.540354Z","caller":"traceutil/trace.go:171","msg":"trace[1506943572] transaction","detail":"{read_only:false; response_revision:25696; number_of_response:1; }","duration":"157.861434ms","start":"2026-06-10T10:42:15.382468Z","end":"2026-06-10T10:42:15.540329Z","steps":["trace[1506943572] 'process raft request' (duration: 152.270827ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:42:15.540623Z","caller":"traceutil/trace.go:171","msg":"trace[399801495] transaction","detail":"{read_only:false; response_revision:25697; number_of_response:1; }","duration":"157.822623ms","start":"2026-06-10T10:42:15.382779Z","end":"2026-06-10T10:42:15.540602Z","steps":["trace[399801495] 'process raft request' (duration: 157.508537ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:42:15.540878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.579117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T10:42:15.540973Z","caller":"traceutil/trace.go:171","msg":"trace[202148122] range","detail":"{range_begin:/registry/services/specs/magnum-system/; range_end:/registry/services/specs/magnum-system0; response_count:0; response_revision:25698; }","duration":"157.693091ms","start":"2026-06-10T10:42:15.383245Z","end":"2026-06-10T10:42:15.540938Z","steps":["trace[202148122] 'agreement among raft nodes before linearized reading' (duration: 157.569609ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:42:15.540725Z","caller":"traceutil/trace.go:171","msg":"trace[1774055379] linearizableReadLoop","detail":"{readStateIndex:26545; appliedIndex:26543; }","duration":"157.419664ms","start":"2026-06-10T10:42:15.383277Z","end":"2026-06-10T10:42:15.540696Z","steps":["trace[1774055379] 'read index received' (duration: 151.474441ms)","trace[1774055379] 'applied index is now lower than readState.Index' (duration: 5.944283ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:42:15.939782Z","caller":"traceutil/trace.go:171","msg":"trace[761631558] linearizableReadLoop","detail":"{readStateIndex:26547; appliedIndex:26546; }","duration":"309.889564ms","start":"2026-06-10T10:42:15.629867Z","end":"2026-06-10T10:42:15.939757Z","steps":["trace[761631558] 'read index received' (duration: 309.548788ms)","trace[761631558] 'applied index is now lower than readState.Index' (duration: 339.596µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:42:15.93991Z","caller":"traceutil/trace.go:171","msg":"trace[1020309528] transaction","detail":"{read_only:false; response_revision:25699; number_of_response:1; }","duration":"311.425044ms","start":"2026-06-10T10:42:15.62844Z","end":"2026-06-10T10:42:15.939865Z","steps":["trace[1020309528] 'process raft request' (duration: 311.140339ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:42:15.940061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:42:15.628415Z","time spent":"311.565086ms","remote":"127.0.0.1:55252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:42:15.940056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.18545ms","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-06-10T10:42:15.940132Z","caller":"traceutil/trace.go:171","msg":"trace[816243636] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25699; }","duration":"310.332352ms","start":"2026-06-10T10:42:15.629779Z","end":"2026-06-10T10:42:15.940111Z","steps":["trace[816243636] 'agreement among raft nodes before linearized reading' (duration: 310.115718ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:42:15.940107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.874097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"warn","ts":"2026-06-10T10:42:15.940181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:42:15.629745Z","time spent":"310.428254ms","remote":"127.0.0.1:55252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-10T10:42:15.940208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.866753ms","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-06-10T10:42:15.940268Z","caller":"traceutil/trace.go:171","msg":"trace[201156502] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25699; }","duration":"205.972295ms","start":"2026-06-10T10:42:15.734278Z","end":"2026-06-10T10:42:15.94025Z","steps":["trace[201156502] 'agreement among raft nodes before linearized reading' (duration: 205.809492ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:42:15.940393Z","caller":"traceutil/trace.go:171","msg":"trace[557000432] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25699; }","duration":"248.052921ms","start":"2026-06-10T10:42:15.692124Z","end":"2026-06-10T10:42:15.940177Z","steps":["trace[557000432] 'agreement among raft nodes before linearized reading' (duration: 247.766205ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:42:16.204807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.531483ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-10T10:42:16.205044Z","caller":"traceutil/trace.go:171","msg":"trace[290860867] linearizableReadLoop","detail":"{readStateIndex:26549; appliedIndex:26547; }","duration":"259.027491ms","start":"2026-06-10T10:42:15.946Z","end":"2026-06-10T10:42:16.205028Z","steps":["trace[290860867] 'read index received' (duration: 155.188782ms)","trace[290860867] 'applied index is now lower than readState.Index' (duration: 103.837429ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:42:16.205125Z","caller":"traceutil/trace.go:171","msg":"trace[1368155881] transaction","detail":"{read_only:false; response_revision:25701; number_of_response:1; }","duration":"260.293154ms","start":"2026-06-10T10:42:15.944822Z","end":"2026-06-10T10:42:16.205115Z","steps":["trace[1368155881] 'process raft request' (duration: 260.132771ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:42:16.205246Z","caller":"traceutil/trace.go:171","msg":"trace[2023903538] transaction","detail":"{read_only:false; response_revision:25700; number_of_response:1; }","duration":"260.409617ms","start":"2026-06-10T10:42:15.944798Z","end":"2026-06-10T10:42:16.205208Z","steps":["trace[2023903538] 'process raft request' (duration: 156.396964ms)","trace[2023903538] 'compare' (duration: 103.36019ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:42:16.205493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.539061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T10:42:16.205586Z","caller":"traceutil/trace.go:171","msg":"trace[162727605] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25701; }","duration":"153.679294ms","start":"2026-06-10T10:42:16.051884Z","end":"2026-06-10T10:42:16.205563Z","steps":["trace[162727605] 'agreement among raft nodes before linearized reading' (duration: 153.529231ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:42:16.205943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.423509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18542"} {"level":"info","ts":"2026-06-10T10:42:16.206006Z","caller":"traceutil/trace.go:171","msg":"trace[736899983] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:25701; }","duration":"260.037001ms","start":"2026-06-10T10:42:15.945958Z","end":"2026-06-10T10:42:16.205995Z","steps":["trace[736899983] 'agreement among raft nodes before linearized reading' (duration: 259.360138ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:42:16.550461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.172866ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-10T10:42:16.550539Z","caller":"traceutil/trace.go:171","msg":"trace[1206817455] linearizableReadLoop","detail":"{readStateIndex:26550; appliedIndex:26549; }","duration":"257.621994ms","start":"2026-06-10T10:42:16.292904Z","end":"2026-06-10T10:42:16.550526Z","steps":["trace[1206817455] 'read index received' (duration: 108.328485ms)","trace[1206817455] 'applied index is now lower than readState.Index' (duration: 149.292589ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:42:16.550595Z","caller":"traceutil/trace.go:171","msg":"trace[359945651] transaction","detail":"{read_only:false; response_revision:25702; number_of_response:1; }","duration":"262.241672ms","start":"2026-06-10T10:42:16.288343Z","end":"2026-06-10T10:42:16.550585Z","steps":["trace[359945651] 'process raft request' (duration: 112.877492ms)","trace[359945651] 'compare' (duration: 148.967043ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:42:16.550832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.915089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5652"} {"level":"info","ts":"2026-06-10T10:42:16.550923Z","caller":"traceutil/trace.go:171","msg":"trace[1879170535] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:25702; }","duration":"258.082432ms","start":"2026-06-10T10:42:16.292801Z","end":"2026-06-10T10:42:16.550883Z","steps":["trace[1879170535] 'agreement among raft nodes before linearized reading' (duration: 257.881819ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:42:16.553595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.358418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/servergroups/\" range_end:\"/registry/openstack.k-orc.cloud/servergroups0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T10:42:16.553643Z","caller":"traceutil/trace.go:171","msg":"trace[1958407932] transaction","detail":"{read_only:false; response_revision:25704; number_of_response:1; }","duration":"207.592316ms","start":"2026-06-10T10:42:16.346015Z","end":"2026-06-10T10:42:16.553607Z","steps":["trace[1958407932] 'process raft request' (duration: 207.455303ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:42:16.553683Z","caller":"traceutil/trace.go:171","msg":"trace[1170283503] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/servergroups/; range_end:/registry/openstack.k-orc.cloud/servergroups0; response_count:0; response_revision:25704; }","duration":"211.49262ms","start":"2026-06-10T10:42:16.342176Z","end":"2026-06-10T10:42:16.553668Z","steps":["trace[1170283503] 'agreement among raft nodes before linearized reading' (duration: 211.326047ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:42:16.553859Z","caller":"traceutil/trace.go:171","msg":"trace[1270051506] transaction","detail":"{read_only:false; response_revision:25703; number_of_response:1; }","duration":"248.514239ms","start":"2026-06-10T10:42:16.305062Z","end":"2026-06-10T10:42:16.553576Z","steps":["trace[1270051506] 'process raft request' (duration: 248.280425ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:42:16.744142Z","caller":"traceutil/trace.go:171","msg":"trace[1333812229] transaction","detail":"{read_only:false; response_revision:25705; number_of_response:1; }","duration":"122.252711ms","start":"2026-06-10T10:42:16.621856Z","end":"2026-06-10T10:42:16.744109Z","steps":["trace[1333812229] 'process raft request' (duration: 119.622322ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:42:16.744164Z","caller":"traceutil/trace.go:171","msg":"trace[481015656] transaction","detail":"{read_only:false; response_revision:25706; number_of_response:1; }","duration":"121.517996ms","start":"2026-06-10T10:42:16.622613Z","end":"2026-06-10T10:42:16.744131Z","steps":["trace[481015656] 'process raft request' (duration: 121.397714ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:42:17.238347Z","caller":"traceutil/trace.go:171","msg":"trace[430100545] linearizableReadLoop","detail":"{readStateIndex:26556; appliedIndex:26555; }","duration":"186.019842ms","start":"2026-06-10T10:42:17.052299Z","end":"2026-06-10T10:42:17.238319Z","steps":["trace[430100545] 'read index received' (duration: 140.707685ms)","trace[430100545] 'applied index is now lower than readState.Index' (duration: 45.310727ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:42:17.238526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.203056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T10:42:17.238626Z","caller":"traceutil/trace.go:171","msg":"trace[83737190] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25707; }","duration":"186.348309ms","start":"2026-06-10T10:42:17.052255Z","end":"2026-06-10T10:42:17.238603Z","steps":["trace[83737190] 'agreement among raft nodes before linearized reading' (duration: 186.166455ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:42:17.552033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.911391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/sshkeys/\" range_end:\"/registry/secretgen.k14s.io/sshkeys0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-10T10:42:17.552138Z","caller":"traceutil/trace.go:171","msg":"trace[215187090] range","detail":"{range_begin:/registry/secretgen.k14s.io/sshkeys/; range_end:/registry/secretgen.k14s.io/sshkeys0; response_count:0; response_revision:25708; }","duration":"173.120387ms","start":"2026-06-10T10:42:17.378996Z","end":"2026-06-10T10:42:17.552117Z","steps":["trace[215187090] 'count revisions from in-memory index tree' (duration: 172.81961ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:42:17.719698Z","caller":"traceutil/trace.go:171","msg":"trace[2050641562] transaction","detail":"{read_only:false; response_revision:25709; number_of_response:1; }","duration":"336.038706ms","start":"2026-06-10T10:42:17.383618Z","end":"2026-06-10T10:42:17.719657Z","steps":["trace[2050641562] 'process raft request' (duration: 335.781691ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:42:17.719901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:42:17.383601Z","time spent":"336.201648ms","remote":"127.0.0.1:55252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:42:17.918016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.617404ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-10T10:42:17.918119Z","caller":"traceutil/trace.go:171","msg":"trace[295853505] linearizableReadLoop","detail":"{readStateIndex:26559; appliedIndex:26557; }","duration":"373.137427ms","start":"2026-06-10T10:42:17.544965Z","end":"2026-06-10T10:42:17.918103Z","steps":["trace[295853505] 'read index received' (duration: 174.487563ms)","trace[295853505] 'applied index is now lower than readState.Index' (duration: 198.648734ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:42:17.918341Z","caller":"traceutil/trace.go:171","msg":"trace[658598996] transaction","detail":"{read_only:false; response_revision:25710; number_of_response:1; }","duration":"533.825263ms","start":"2026-06-10T10:42:17.3845Z","end":"2026-06-10T10:42:17.918326Z","steps":["trace[658598996] 'process raft request' (duration: 370.818012ms)","trace[658598996] 'compare' (duration: 162.499672ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:42:17.918411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:42:17.384447Z","time spent":"533.931185ms","remote":"127.0.0.1:55252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:42:17.91867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.707638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-06-10T10:42:17.918707Z","caller":"traceutil/trace.go:171","msg":"trace[587167826] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25710; }","duration":"373.744808ms","start":"2026-06-10T10:42:17.544953Z","end":"2026-06-10T10:42:17.918698Z","steps":["trace[587167826] 'agreement among raft nodes before linearized reading' (duration: 373.623256ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:42:17.918735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:42:17.544939Z","time spent":"373.789429ms","remote":"127.0.0.1:55252","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-06-10T10:42:17.919154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.406781ms","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-06-10T10:42:17.919197Z","caller":"traceutil/trace.go:171","msg":"trace[1932764998] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25710; }","duration":"373.463843ms","start":"2026-06-10T10:42:17.545721Z","end":"2026-06-10T10:42:17.919185Z","steps":["trace[1932764998] 'agreement among raft nodes before linearized reading' (duration: 373.30115ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:42:17.919226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:42:17.545718Z","time spent":"373.501904ms","remote":"127.0.0.1:55252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-10T10:42:17.919368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.542001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/clusters/\" range_end:\"/registry/cluster.x-k8s.io/clusters0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T10:42:17.919407Z","caller":"traceutil/trace.go:171","msg":"trace[4264522] range","detail":"{range_begin:/registry/cluster.x-k8s.io/clusters/; range_end:/registry/cluster.x-k8s.io/clusters0; response_count:0; response_revision:25710; }","duration":"165.655112ms","start":"2026-06-10T10:42:17.753741Z","end":"2026-06-10T10:42:17.919396Z","steps":["trace[4264522] 'agreement among raft nodes before linearized reading' (duration: 165.55411ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:42:18.146165Z","caller":"traceutil/trace.go:171","msg":"trace[863401075] transaction","detail":"{read_only:false; response_revision:25712; number_of_response:1; }","duration":"220.285769ms","start":"2026-06-10T10:42:17.925839Z","end":"2026-06-10T10:42:18.146125Z","steps":["trace[863401075] 'process raft request' (duration: 161.887671ms)","trace[863401075] 'compare' (duration: 58.060122ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:42:18.146417Z","caller":"traceutil/trace.go:171","msg":"trace[1485454833] transaction","detail":"{read_only:false; response_revision:25713; number_of_response:1; }","duration":"200.569231ms","start":"2026-06-10T10:42:17.94582Z","end":"2026-06-10T10:42:18.146389Z","steps":["trace[1485454833] 'process raft request' (duration: 200.245905ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:42:18.415381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.313308ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-10T10:42:18.415552Z","caller":"traceutil/trace.go:171","msg":"trace[1602510203] transaction","detail":"{read_only:false; response_revision:25715; number_of_response:1; }","duration":"202.317334ms","start":"2026-06-10T10:42:18.213218Z","end":"2026-06-10T10:42:18.415535Z","steps":["trace[1602510203] 'process raft request' (duration: 202.259663ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:42:18.415595Z","caller":"traceutil/trace.go:171","msg":"trace[753590376] transaction","detail":"{read_only:false; response_revision:25714; number_of_response:1; }","duration":"204.083579ms","start":"2026-06-10T10:42:18.211487Z","end":"2026-06-10T10:42:18.41557Z","steps":["trace[753590376] 'process raft request' (duration: 40.497516ms)","trace[753590376] 'compare' (duration: 163.183966ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:42:18.776673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.206406ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-10T10:42:18.776761Z","caller":"traceutil/trace.go:171","msg":"trace[694602403] linearizableReadLoop","detail":"{readStateIndex:26565; appliedIndex:26564; }","duration":"299.18813ms","start":"2026-06-10T10:42:18.477558Z","end":"2026-06-10T10:42:18.776746Z","steps":["trace[694602403] 'read index received' (duration: 112.841592ms)","trace[694602403] 'applied index is now lower than readState.Index' (duration: 186.345068ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:42:18.77687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.312242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T10:42:18.776867Z","caller":"traceutil/trace.go:171","msg":"trace[928176798] transaction","detail":"{read_only:false; response_revision:25716; number_of_response:1; }","duration":"317.845567ms","start":"2026-06-10T10:42:18.458986Z","end":"2026-06-10T10:42:18.776832Z","steps":["trace[928176798] 'process raft request' (duration: 131.404086ms)","trace[928176798] 'compare' (duration: 185.947262ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:42:18.776901Z","caller":"traceutil/trace.go:171","msg":"trace[1975796879] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:25716; }","duration":"299.382554ms","start":"2026-06-10T10:42:18.477507Z","end":"2026-06-10T10:42:18.77689Z","steps":["trace[1975796879] 'agreement among raft nodes before linearized reading' (duration: 299.320033ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:42:18.776996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:42:18.458967Z","time spent":"317.96989ms","remote":"127.0.0.1:55252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:42:18.77806Z","caller":"traceutil/trace.go:171","msg":"trace[2125529283] transaction","detail":"{read_only:false; response_revision:25717; number_of_response:1; }","duration":"222.862348ms","start":"2026-06-10T10:42:18.55518Z","end":"2026-06-10T10:42:18.778042Z","steps":["trace[2125529283] 'process raft request' (duration: 222.688575ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:42:18.778236Z","caller":"traceutil/trace.go:171","msg":"trace[508525735] transaction","detail":"{read_only:false; response_revision:25718; number_of_response:1; }","duration":"220.988642ms","start":"2026-06-10T10:42:18.557232Z","end":"2026-06-10T10:42:18.778221Z","steps":["trace[508525735] 'process raft request' (duration: 220.756668ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:42:25.684784Z","caller":"traceutil/trace.go:171","msg":"trace[951627263] transaction","detail":"{read_only:false; response_revision:25770; number_of_response:1; }","duration":"408.696377ms","start":"2026-06-10T10:42:25.276062Z","end":"2026-06-10T10:42:25.684758Z","steps":["trace[951627263] 'process raft request' (duration: 408.534014ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:42:25.684953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:42:25.276036Z","time spent":"408.84113ms","remote":"127.0.0.1:55252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:42:26.061242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.844886ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-10T10:42:26.061384Z","caller":"traceutil/trace.go:171","msg":"trace[1122066958] linearizableReadLoop","detail":"{readStateIndex:26621; appliedIndex:26619; }","duration":"498.894424ms","start":"2026-06-10T10:42:25.562464Z","end":"2026-06-10T10:42:26.061359Z","steps":["trace[1122066958] 'read index received' (duration: 122.137609ms)","trace[1122066958] 'applied index is now lower than readState.Index' (duration: 376.755055ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:42:26.061397Z","caller":"traceutil/trace.go:171","msg":"trace[1820168269] transaction","detail":"{read_only:false; response_revision:25771; number_of_response:1; }","duration":"507.832626ms","start":"2026-06-10T10:42:25.55353Z","end":"2026-06-10T10:42:26.061363Z","steps":["trace[1820168269] 'process raft request' (duration: 152.757286ms)","trace[1820168269] 'compare' (duration: 354.739694ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:42:26.061507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:42:25.553503Z","time spent":"507.943978ms","remote":"127.0.0.1:55252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":626,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:42:26.061548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"499.081717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T10:42:26.061601Z","caller":"traceutil/trace.go:171","msg":"trace[1127276599] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0; response_count:0; response_revision:25771; }","duration":"499.173589ms","start":"2026-06-10T10:42:25.56241Z","end":"2026-06-10T10:42:26.061584Z","steps":["trace[1127276599] 'agreement among raft nodes before linearized reading' (duration: 499.053407ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:42:26.061654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:42:25.562389Z","time spent":"499.24867ms","remote":"127.0.0.1:38688","response type":"/etcdserverpb.KV/Range","request count":0,"request size":152,"response count":0,"response size":29,"request content":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" "} {"level":"info","ts":"2026-06-10T10:42:26.062988Z","caller":"traceutil/trace.go:171","msg":"trace[1075022879] transaction","detail":"{read_only:false; response_revision:25772; number_of_response:1; }","duration":"314.928001ms","start":"2026-06-10T10:42:25.748049Z","end":"2026-06-10T10:42:26.062977Z","steps":["trace[1075022879] 'process raft request' (duration: 314.85056ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:42:26.063049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:42:25.748021Z","time spent":"315.000043ms","remote":"127.0.0.1:55252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:42:26.086523Z","caller":"traceutil/trace.go:171","msg":"trace[1687239676] transaction","detail":"{read_only:false; response_revision:25773; number_of_response:1; }","duration":"135.349583ms","start":"2026-06-10T10:42:25.951153Z","end":"2026-06-10T10:42:26.086503Z","steps":["trace[1687239676] 'process raft request' (duration: 135.19237ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:42:26.087098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.544456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T10:42:26.087175Z","caller":"traceutil/trace.go:171","msg":"trace[2099167804] range","detail":"{range_begin:/registry/rabbitmq.com/users/; range_end:/registry/rabbitmq.com/users0; response_count:0; response_revision:25773; }","duration":"264.667579ms","start":"2026-06-10T10:42:25.822491Z","end":"2026-06-10T10:42:26.087158Z","steps":["trace[2099167804] 'agreement among raft nodes before linearized reading' (duration: 264.523346ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:42:26.08737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.91647ms","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-06-10T10:42:26.087487Z","caller":"traceutil/trace.go:171","msg":"trace[1281824200] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25773; }","duration":"116.247187ms","start":"2026-06-10T10:42:25.971178Z","end":"2026-06-10T10:42:26.087425Z","steps":["trace[1281824200] 'agreement among raft nodes before linearized reading' (duration: 115.806938ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:42:26.683043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.714244ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-10T10:42:26.68326Z","caller":"traceutil/trace.go:171","msg":"trace[1854565948] linearizableReadLoop","detail":"{readStateIndex:26624; appliedIndex:26623; }","duration":"585.771678ms","start":"2026-06-10T10:42:26.097465Z","end":"2026-06-10T10:42:26.683237Z","steps":["trace[1854565948] 'read index received' (duration: 113.786329ms)","trace[1854565948] 'applied index is now lower than readState.Index' (duration: 471.982959ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:42:26.6833Z","caller":"traceutil/trace.go:171","msg":"trace[1211031683] transaction","detail":"{read_only:false; response_revision:25775; number_of_response:1; }","duration":"511.814442ms","start":"2026-06-10T10:42:26.171464Z","end":"2026-06-10T10:42:26.683279Z","steps":["trace[1211031683] 'process raft request' (duration: 511.685819ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:42:26.683403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:42:26.17144Z","time spent":"511.926553ms","remote":"127.0.0.1:55252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":496,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:42:26.683433Z","caller":"traceutil/trace.go:171","msg":"trace[1354243911] transaction","detail":"{read_only:false; response_revision:25776; number_of_response:1; }","duration":"400.800666ms","start":"2026-06-10T10:42:26.282605Z","end":"2026-06-10T10:42:26.683406Z","steps":["trace[1354243911] 'process raft request' (duration: 400.631153ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:42:26.683283Z","caller":"traceutil/trace.go:171","msg":"trace[692719587] transaction","detail":"{read_only:false; response_revision:25774; number_of_response:1; }","duration":"590.121341ms","start":"2026-06-10T10:42:26.09313Z","end":"2026-06-10T10:42:26.683252Z","steps":["trace[692719587] 'process raft request' (duration: 118.104051ms)","trace[692719587] 'compare' (duration: 471.550962ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:42:26.683576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:42:26.282574Z","time spent":"400.926638ms","remote":"127.0.0.1:55252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:42:26.683594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:42:26.093108Z","time spent":"590.406257ms","remote":"127.0.0.1:55252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:42:26.683603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.946667ms","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-06-10T10:42:26.683701Z","caller":"traceutil/trace.go:171","msg":"trace[534421177] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25776; }","duration":"508.075249ms","start":"2026-06-10T10:42:26.175616Z","end":"2026-06-10T10:42:26.683692Z","steps":["trace[534421177] 'agreement among raft nodes before linearized reading' (duration: 507.809824ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:42:26.683762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:42:26.175605Z","time spent":"508.149211ms","remote":"127.0.0.1:55252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-10T10:42:26.683822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.161127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-glance-server-0\" ","response":"range_response_count:1 size:1858"} {"level":"info","ts":"2026-06-10T10:42:26.683891Z","caller":"traceutil/trace.go:171","msg":"trace[2107805252] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-glance-server-0; range_end:; response_count:1; response_revision:25776; }","duration":"185.269389ms","start":"2026-06-10T10:42:26.498603Z","end":"2026-06-10T10:42:26.683873Z","steps":["trace[2107805252] 'agreement among raft nodes before linearized reading' (duration: 185.032963ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:42:26.6839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.200061ms","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-06-10T10:42:26.68393Z","caller":"traceutil/trace.go:171","msg":"trace[303594183] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25776; }","duration":"240.273582ms","start":"2026-06-10T10:42:26.443649Z","end":"2026-06-10T10:42:26.683923Z","steps":["trace[303594183] 'agreement among raft nodes before linearized reading' (duration: 240.19758ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:42:26.683946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.167834ms","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-06-10T10:42:26.684003Z","caller":"traceutil/trace.go:171","msg":"trace[293532154] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25776; }","duration":"235.241155ms","start":"2026-06-10T10:42:26.448744Z","end":"2026-06-10T10:42:26.683985Z","steps":["trace[293532154] 'agreement among raft nodes before linearized reading' (duration: 235.097902ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:42:26.684313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"586.233366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/magnum-system/\" range_end:\"/registry/endpointslices/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T10:42:26.684372Z","caller":"traceutil/trace.go:171","msg":"trace[839889059] range","detail":"{range_begin:/registry/endpointslices/magnum-system/; range_end:/registry/endpointslices/magnum-system0; response_count:0; response_revision:25775; }","duration":"586.9091ms","start":"2026-06-10T10:42:26.097434Z","end":"2026-06-10T10:42:26.684343Z","steps":["trace[839889059] 'agreement among raft nodes before linearized reading' (duration: 585.88542ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:42:26.684411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:42:26.097421Z","time spent":"586.979241ms","remote":"127.0.0.1:55262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":29,"request content":"key:\"/registry/endpointslices/magnum-system/\" range_end:\"/registry/endpointslices/magnum-system0\" "} {"level":"info","ts":"2026-06-10T10:42:26.846488Z","caller":"traceutil/trace.go:171","msg":"trace[1547048986] transaction","detail":"{read_only:false; response_revision:25778; number_of_response:1; }","duration":"157.615108ms","start":"2026-06-10T10:42:26.688843Z","end":"2026-06-10T10:42:26.846458Z","steps":["trace[1547048986] 'process raft request' (duration: 157.391114ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:42:26.846678Z","caller":"traceutil/trace.go:171","msg":"trace[1177815259] linearizableReadLoop","detail":"{readStateIndex:26629; appliedIndex:26626; }","duration":"157.627099ms","start":"2026-06-10T10:42:26.689014Z","end":"2026-06-10T10:42:26.846641Z","steps":["trace[1177815259] 'read index received' (duration: 18.372531ms)","trace[1177815259] 'applied index is now lower than readState.Index' (duration: 139.252148ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:42:26.846717Z","caller":"traceutil/trace.go:171","msg":"trace[408680089] transaction","detail":"{read_only:false; response_revision:25779; number_of_response:1; }","duration":"157.740542ms","start":"2026-06-10T10:42:26.688949Z","end":"2026-06-10T10:42:26.84669Z","steps":["trace[408680089] 'process raft request' (duration: 157.461017ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:42:26.846988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.922704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18542"} {"level":"info","ts":"2026-06-10T10:42:26.847034Z","caller":"traceutil/trace.go:171","msg":"trace[1872888433] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:25779; }","duration":"158.031777ms","start":"2026-06-10T10:42:26.688992Z","end":"2026-06-10T10:42:26.847023Z","steps":["trace[1872888433] 'agreement among raft nodes before linearized reading' (duration: 157.801433ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:42:27.347849Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":256879661565919706,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-10T10:42:27.361788Z","caller":"traceutil/trace.go:171","msg":"trace[1675631592] transaction","detail":"{read_only:false; response_revision:25784; number_of_response:1; }","duration":"543.683203ms","start":"2026-06-10T10:42:26.818082Z","end":"2026-06-10T10:42:27.361766Z","steps":["trace[1675631592] 'process raft request' (duration: 543.643072ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:42:27.361817Z","caller":"traceutil/trace.go:171","msg":"trace[493679393] transaction","detail":"{read_only:false; response_revision:25781; number_of_response:1; }","duration":"558.805751ms","start":"2026-06-10T10:42:26.802981Z","end":"2026-06-10T10:42:27.361787Z","steps":["trace[493679393] 'process raft request' (duration: 558.619178ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:42:27.361844Z","caller":"traceutil/trace.go:171","msg":"trace[874621738] transaction","detail":"{read_only:false; response_revision:25782; number_of_response:1; }","duration":"554.887797ms","start":"2026-06-10T10:42:26.806928Z","end":"2026-06-10T10:42:27.361816Z","steps":["trace[874621738] 'process raft request' (duration: 554.719774ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:42:27.361975Z","caller":"traceutil/trace.go:171","msg":"trace[255072188] transaction","detail":"{read_only:false; response_revision:25783; number_of_response:1; }","duration":"549.82211ms","start":"2026-06-10T10:42:26.812143Z","end":"2026-06-10T10:42:27.361965Z","steps":["trace[255072188] 'process raft request' (duration: 549.542165ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:42:27.361976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:42:26.802959Z","time spent":"558.918494ms","remote":"127.0.0.1:55252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:42:27.361925Z","caller":"traceutil/trace.go:171","msg":"trace[1239779784] transaction","detail":"{read_only:false; response_revision:25780; number_of_response:1; }","duration":"613.052731ms","start":"2026-06-10T10:42:26.748851Z","end":"2026-06-10T10:42:27.361904Z","steps":["trace[1239779784] 'process raft request' (duration: 612.592712ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:42:27.362042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:42:26.812127Z","time spent":"549.886652ms","remote":"127.0.0.1:55252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:42:27.3621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:42:26.806909Z","time spent":"555.102502ms","remote":"127.0.0.1:55252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:42:27.361927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:42:26.818038Z","time spent":"543.816036ms","remote":"127.0.0.1:55252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:42:27.362136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:42:26.748827Z","time spent":"613.276325ms","remote":"127.0.0.1:55252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:42:27.365948Z","caller":"traceutil/trace.go:171","msg":"trace[1496016736] linearizableReadLoop","detail":"{readStateIndex:26635; appliedIndex:26629; }","duration":"519.174503ms","start":"2026-06-10T10:42:26.846738Z","end":"2026-06-10T10:42:27.365912Z","steps":["trace[1496016736] 'read index received' (duration: 514.761238ms)","trace[1496016736] 'applied index is now lower than readState.Index' (duration: 4.411875ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:42:27.36611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.29582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-10T10:42:27.366118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"546.539956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"warn","ts":"2026-06-10T10:42:27.366118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.79347ms","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-06-10T10:42:27.366141Z","caller":"traceutil/trace.go:171","msg":"trace[2070756276] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:25784; }","duration":"396.370361ms","start":"2026-06-10T10:42:26.969763Z","end":"2026-06-10T10:42:27.366133Z","steps":["trace[2070756276] 'agreement among raft nodes before linearized reading' (duration: 396.294599ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:42:27.366167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:42:26.969747Z","time spent":"396.414902ms","remote":"127.0.0.1:55390","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":29,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"info","ts":"2026-06-10T10:42:27.366166Z","caller":"traceutil/trace.go:171","msg":"trace[1443948052] 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:25784; }","duration":"360.870001ms","start":"2026-06-10T10:42:27.005282Z","end":"2026-06-10T10:42:27.366153Z","steps":["trace[1443948052] 'agreement among raft nodes before linearized reading' (duration: 360.783269ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:42:27.366156Z","caller":"traceutil/trace.go:171","msg":"trace[1019508909] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25784; }","duration":"546.605009ms","start":"2026-06-10T10:42:26.819541Z","end":"2026-06-10T10:42:27.366146Z","steps":["trace[1019508909] 'agreement among raft nodes before linearized reading' (duration: 546.447756ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:42:27.366208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:42:27.005272Z","time spent":"360.924903ms","remote":"127.0.0.1:38668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":29,"request content":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddresses/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddresses0\" count_only:true "} {"level":"warn","ts":"2026-06-10T10:42:27.366216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:42:26.81953Z","time spent":"546.66925ms","remote":"127.0.0.1:55252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-10T10:42:29.972759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.982034ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-10T10:42:29.972908Z","caller":"traceutil/trace.go:171","msg":"trace[1655145270] linearizableReadLoop","detail":"{readStateIndex:26709; appliedIndex:26708; }","duration":"250.481897ms","start":"2026-06-10T10:42:29.72241Z","end":"2026-06-10T10:42:29.972892Z","steps":["trace[1655145270] 'read index received' (duration: 48.081µs)","trace[1655145270] 'applied index is now lower than readState.Index' (duration: 250.432426ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:42:29.972995Z","caller":"traceutil/trace.go:171","msg":"trace[1020307258] transaction","detail":"{read_only:false; response_revision:25857; number_of_response:1; }","duration":"277.200259ms","start":"2026-06-10T10:42:29.695783Z","end":"2026-06-10T10:42:29.972983Z","steps":["trace[1020307258] 'process raft request' (duration: 22.896628ms)","trace[1020307258] 'compare' (duration: 253.477245ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:42:29.973287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.878174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a09dc4f5-dcda-4df1-a55e-aa8beea4698e\" ","response":"range_response_count:1 size:3644"} {"level":"info","ts":"2026-06-10T10:42:29.973327Z","caller":"traceutil/trace.go:171","msg":"trace[779448533] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a09dc4f5-dcda-4df1-a55e-aa8beea4698e; range_end:; response_count:1; response_revision:25857; }","duration":"250.949016ms","start":"2026-06-10T10:42:29.722368Z","end":"2026-06-10T10:42:29.973317Z","steps":["trace[779448533] 'agreement among raft nodes before linearized reading' (duration: 250.803063ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:42:30.129368Z","caller":"traceutil/trace.go:171","msg":"trace[1611981508] linearizableReadLoop","detail":"{readStateIndex:26710; appliedIndex:26709; }","duration":"149.087825ms","start":"2026-06-10T10:42:29.980249Z","end":"2026-06-10T10:42:30.129337Z","steps":["trace[1611981508] 'read index received' (duration: 148.999103ms)","trace[1611981508] 'applied index is now lower than readState.Index' (duration: 87.202µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:42:30.129433Z","caller":"traceutil/trace.go:171","msg":"trace[1893351305] transaction","detail":"{read_only:false; response_revision:25858; number_of_response:1; }","duration":"150.137095ms","start":"2026-06-10T10:42:29.979267Z","end":"2026-06-10T10:42:30.129404Z","steps":["trace[1893351305] 'process raft request' (duration: 149.909831ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:42:30.129601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.3278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:119"} {"level":"info","ts":"2026-06-10T10:42:30.129649Z","caller":"traceutil/trace.go:171","msg":"trace[1685143420] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:25858; }","duration":"149.399902ms","start":"2026-06-10T10:42:29.980233Z","end":"2026-06-10T10:42:30.129633Z","steps":["trace[1685143420] 'agreement among raft nodes before linearized reading' (duration: 149.232938ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:42:30.175158Z","caller":"traceutil/trace.go:171","msg":"trace[1435537406] transaction","detail":"{read_only:false; response_revision:25859; number_of_response:1; }","duration":"104.43592ms","start":"2026-06-10T10:42:30.070692Z","end":"2026-06-10T10:42:30.175128Z","steps":["trace[1435537406] 'process raft request' (duration: 104.210916ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:42:30.175586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.917352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:130952"} {"level":"info","ts":"2026-06-10T10:42:30.175631Z","caller":"traceutil/trace.go:171","msg":"trace[488991520] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:25860; }","duration":"184.996203ms","start":"2026-06-10T10:42:29.990624Z","end":"2026-06-10T10:42:30.17562Z","steps":["trace[488991520] 'agreement among raft nodes before linearized reading' (duration: 184.760678ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:42:30.175837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.118087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T10:42:30.175907Z","caller":"traceutil/trace.go:171","msg":"trace[1170636553] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25860; }","duration":"124.25072ms","start":"2026-06-10T10:42:30.05164Z","end":"2026-06-10T10:42:30.17589Z","steps":["trace[1170636553] 'agreement among raft nodes before linearized reading' (duration: 124.092667ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:42:32.277458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.649732ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T10:42:32.277549Z","caller":"traceutil/trace.go:171","msg":"trace[1063049877] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:25878; }","duration":"236.801795ms","start":"2026-06-10T10:42:32.040723Z","end":"2026-06-10T10:42:32.277525Z","steps":["trace[1063049877] 'count revisions from in-memory index tree' (duration: 236.5343ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:42:32.278095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.367016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T10:42:32.278219Z","caller":"traceutil/trace.go:171","msg":"trace[1936507287] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25878; }","duration":"226.540268ms","start":"2026-06-10T10:42:32.051651Z","end":"2026-06-10T10:42:32.278192Z","steps":["trace[1936507287] 'range keys from in-memory index tree' (duration: 226.273684ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:42:36.303753Z","caller":"traceutil/trace.go:171","msg":"trace[1956081853] linearizableReadLoop","detail":"{readStateIndex:26778; appliedIndex:26777; }","duration":"252.517106ms","start":"2026-06-10T10:42:36.051206Z","end":"2026-06-10T10:42:36.303723Z","steps":["trace[1956081853] 'read index received' (duration: 221.656575ms)","trace[1956081853] 'applied index is now lower than readState.Index' (duration: 30.858861ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:42:36.303794Z","caller":"traceutil/trace.go:171","msg":"trace[1506229922] transaction","detail":"{read_only:false; response_revision:25924; number_of_response:1; }","duration":"287.257211ms","start":"2026-06-10T10:42:36.016491Z","end":"2026-06-10T10:42:36.303748Z","steps":["trace[1506229922] 'process raft request' (duration: 256.280008ms)","trace[1506229922] 'compare' (duration: 30.535965ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:42:36.30387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.651638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T10:42:36.303925Z","caller":"traceutil/trace.go:171","msg":"trace[1791105308] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25924; }","duration":"252.737999ms","start":"2026-06-10T10:42:36.051175Z","end":"2026-06-10T10:42:36.303913Z","steps":["trace[1791105308] 'agreement among raft nodes before linearized reading' (duration: 252.647678ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:42:36.308652Z","caller":"traceutil/trace.go:171","msg":"trace[1546499984] transaction","detail":"{read_only:false; response_revision:25925; number_of_response:1; }","duration":"233.910659ms","start":"2026-06-10T10:42:36.074716Z","end":"2026-06-10T10:42:36.308627Z","steps":["trace[1546499984] 'process raft request' (duration: 233.791247ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:42:36.395145Z","caller":"traceutil/trace.go:171","msg":"trace[1533061499] transaction","detail":"{read_only:false; response_revision:25926; number_of_response:1; }","duration":"106.648443ms","start":"2026-06-10T10:42:36.288467Z","end":"2026-06-10T10:42:36.395115Z","steps":["trace[1533061499] 'process raft request' (duration: 106.442348ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:42:36.395301Z","caller":"traceutil/trace.go:171","msg":"trace[946639750] transaction","detail":"{read_only:false; response_revision:25927; number_of_response:1; }","duration":"105.695164ms","start":"2026-06-10T10:42:36.28959Z","end":"2026-06-10T10:42:36.395286Z","steps":["trace[946639750] 'process raft request' (duration: 105.48091ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:42:36.672657Z","caller":"traceutil/trace.go:171","msg":"trace[895648993] transaction","detail":"{read_only:false; response_revision:25929; number_of_response:1; }","duration":"362.503013ms","start":"2026-06-10T10:42:36.310132Z","end":"2026-06-10T10:42:36.672635Z","steps":["trace[895648993] 'process raft request' (duration: 362.395361ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:42:36.672662Z","caller":"traceutil/trace.go:171","msg":"trace[1894533187] transaction","detail":"{read_only:false; response_revision:25928; number_of_response:1; }","duration":"363.3863ms","start":"2026-06-10T10:42:36.30924Z","end":"2026-06-10T10:42:36.672626Z","steps":["trace[1894533187] 'process raft request' (duration: 363.136695ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:42:36.672885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:42:36.309219Z","time spent":"363.614345ms","remote":"127.0.0.1:55128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:42:36.672854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:42:36.310123Z","time spent":"362.614995ms","remote":"127.0.0.1:55128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":885,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:42:36.672983Z","caller":"traceutil/trace.go:171","msg":"trace[1475900477] transaction","detail":"{read_only:false; response_revision:25930; number_of_response:1; }","duration":"362.488313ms","start":"2026-06-10T10:42:36.310467Z","end":"2026-06-10T10:42:36.672955Z","steps":["trace[1475900477] 'process raft request' (duration: 362.111166ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:42:36.673148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:42:36.310458Z","time spent":"362.612105ms","remote":"127.0.0.1:55262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1415,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:42:36.673327Z","caller":"traceutil/trace.go:171","msg":"trace[2142151968] transaction","detail":"{read_only:false; response_revision:25931; number_of_response:1; }","duration":"362.423501ms","start":"2026-06-10T10:42:36.310887Z","end":"2026-06-10T10:42:36.67331Z","steps":["trace[2142151968] 'process raft request' (duration: 361.931302ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:42:36.673441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:42:36.310878Z","time spent":"362.516813ms","remote":"127.0.0.1:55262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1490,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:42:41.471513Z","caller":"traceutil/trace.go:171","msg":"trace[732624265] transaction","detail":"{read_only:false; response_revision:25971; number_of_response:1; }","duration":"155.836264ms","start":"2026-06-10T10:42:41.315644Z","end":"2026-06-10T10:42:41.47148Z","steps":["trace[732624265] 'process raft request' (duration: 155.656431ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:42:41.665088Z","caller":"traceutil/trace.go:171","msg":"trace[660026582] transaction","detail":"{read_only:false; response_revision:25976; number_of_response:1; }","duration":"151.583053ms","start":"2026-06-10T10:42:41.513473Z","end":"2026-06-10T10:42:41.665056Z","steps":["trace[660026582] 'process raft request' (duration: 95.207254ms)","trace[660026582] 'compare' (duration: 56.250197ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:42:41.927245Z","caller":"traceutil/trace.go:171","msg":"trace[2014353773] transaction","detail":"{read_only:false; response_revision:25977; number_of_response:1; }","duration":"233.330839ms","start":"2026-06-10T10:42:41.693887Z","end":"2026-06-10T10:42:41.927218Z","steps":["trace[2014353773] 'process raft request' (duration: 233.152355ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:42:45.754417Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-00000000000068ee.wal"} {"level":"info","ts":"2026-06-10T10:42:48.963109Z","caller":"traceutil/trace.go:171","msg":"trace[986816525] transaction","detail":"{read_only:false; response_revision:26027; number_of_response:1; }","duration":"167.263223ms","start":"2026-06-10T10:42:48.795808Z","end":"2026-06-10T10:42:48.963072Z","steps":["trace[986816525] 'process raft request' (duration: 116.476471ms)","trace[986816525] 'compare' (duration: 50.405015ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:42:48.963526Z","caller":"traceutil/trace.go:171","msg":"trace[1598413240] linearizableReadLoop","detail":"{readStateIndex:26884; appliedIndex:26883; }","duration":"154.832924ms","start":"2026-06-10T10:42:48.808676Z","end":"2026-06-10T10:42:48.963509Z","steps":["trace[1598413240] 'read index received' (duration: 103.619484ms)","trace[1598413240] 'applied index is now lower than readState.Index' (duration: 51.21221ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:42:48.963774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.081749ms","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-06-10T10:42:48.963815Z","caller":"traceutil/trace.go:171","msg":"trace[1294171599] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26027; }","duration":"155.170772ms","start":"2026-06-10T10:42:48.808633Z","end":"2026-06-10T10:42:48.963804Z","steps":["trace[1294171599] 'agreement among raft nodes before linearized reading' (duration: 154.972998ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:42:51.863881Z","caller":"traceutil/trace.go:171","msg":"trace[81866862] transaction","detail":"{read_only:false; response_revision:26052; number_of_response:1; }","duration":"149.32746ms","start":"2026-06-10T10:42:51.714522Z","end":"2026-06-10T10:42:51.863849Z","steps":["trace[81866862] 'process raft request' (duration: 148.993453ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:42:51.895581Z","caller":"traceutil/trace.go:171","msg":"trace[1261030142] transaction","detail":"{read_only:false; response_revision:26053; number_of_response:1; }","duration":"174.632075ms","start":"2026-06-10T10:42:51.720913Z","end":"2026-06-10T10:42:51.895546Z","steps":["trace[1261030142] 'process raft request' (duration: 174.38392ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:42:52.029748Z","caller":"traceutil/trace.go:171","msg":"trace[890418297] linearizableReadLoop","detail":"{readStateIndex:26912; appliedIndex:26911; }","duration":"130.373047ms","start":"2026-06-10T10:42:51.899348Z","end":"2026-06-10T10:42:52.029721Z","steps":["trace[890418297] 'read index received' (duration: 72.672272ms)","trace[890418297] 'applied index is now lower than readState.Index' (duration: 57.699735ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:42:52.029799Z","caller":"traceutil/trace.go:171","msg":"trace[1706338786] transaction","detail":"{read_only:false; response_revision:26054; number_of_response:1; }","duration":"131.095451ms","start":"2026-06-10T10:42:51.898666Z","end":"2026-06-10T10:42:52.029762Z","steps":["trace[1706338786] 'process raft request' (duration: 73.403577ms)","trace[1706338786] 'compare' (duration: 57.544422ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:42:52.029958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.58596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:140"} {"level":"info","ts":"2026-06-10T10:42:52.029999Z","caller":"traceutil/trace.go:171","msg":"trace[811985801] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:26054; }","duration":"130.643672ms","start":"2026-06-10T10:42:51.899345Z","end":"2026-06-10T10:42:52.029989Z","steps":["trace[811985801] 'agreement among raft nodes before linearized reading' (duration: 130.478869ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:42:53.23229Z","caller":"traceutil/trace.go:171","msg":"trace[372699105] transaction","detail":"{read_only:false; response_revision:26060; number_of_response:1; }","duration":"213.270304ms","start":"2026-06-10T10:42:53.018991Z","end":"2026-06-10T10:42:53.232261Z","steps":["trace[372699105] 'process raft request' (duration: 190.834215ms)","trace[372699105] 'compare' (duration: 22.102493ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:42:53.232434Z","caller":"traceutil/trace.go:171","msg":"trace[250792211] linearizableReadLoop","detail":"{readStateIndex:26920; appliedIndex:26917; }","duration":"182.793501ms","start":"2026-06-10T10:42:53.049616Z","end":"2026-06-10T10:42:53.232409Z","steps":["trace[250792211] 'read index received' (duration: 160.2759ms)","trace[250792211] 'applied index is now lower than readState.Index' (duration: 22.516581ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:42:53.232673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.043835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T10:42:53.232746Z","caller":"traceutil/trace.go:171","msg":"trace[1827513103] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26062; }","duration":"183.156848ms","start":"2026-06-10T10:42:53.049572Z","end":"2026-06-10T10:42:53.232729Z","steps":["trace[1827513103] 'agreement among raft nodes before linearized reading' (duration: 183.010125ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:42:53.233009Z","caller":"traceutil/trace.go:171","msg":"trace[36676095] transaction","detail":"{read_only:false; response_revision:26061; number_of_response:1; }","duration":"213.983218ms","start":"2026-06-10T10:42:53.019013Z","end":"2026-06-10T10:42:53.232996Z","steps":["trace[36676095] 'process raft request' (duration: 213.192083ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:42:53.233164Z","caller":"traceutil/trace.go:171","msg":"trace[321900232] transaction","detail":"{read_only:false; response_revision:26062; number_of_response:1; }","duration":"212.96261ms","start":"2026-06-10T10:42:53.020188Z","end":"2026-06-10T10:42:53.233151Z","steps":["trace[321900232] 'process raft request' (duration: 212.156634ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:42:56.232317Z","caller":"traceutil/trace.go:171","msg":"trace[802292238] transaction","detail":"{read_only:false; response_revision:26091; number_of_response:1; }","duration":"157.212122ms","start":"2026-06-10T10:42:56.075082Z","end":"2026-06-10T10:42:56.232294Z","steps":["trace[802292238] 'process raft request' (duration: 157.069988ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:42:56.403752Z","caller":"traceutil/trace.go:171","msg":"trace[1839704389] linearizableReadLoop","detail":"{readStateIndex:26950; appliedIndex:26949; }","duration":"111.222699ms","start":"2026-06-10T10:42:56.292504Z","end":"2026-06-10T10:42:56.403726Z","steps":["trace[1839704389] 'read index received' (duration: 48.784393ms)","trace[1839704389] 'applied index is now lower than readState.Index' (duration: 62.437396ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:42:56.404031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.507305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-10T10:42:56.404082Z","caller":"traceutil/trace.go:171","msg":"trace[1995819365] transaction","detail":"{read_only:false; response_revision:26092; number_of_response:1; }","duration":"287.005257ms","start":"2026-06-10T10:42:56.117045Z","end":"2026-06-10T10:42:56.40405Z","steps":["trace[1995819365] 'process raft request' (duration: 224.334588ms)","trace[1995819365] 'compare' (duration: 62.231491ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:42:56.40413Z","caller":"traceutil/trace.go:171","msg":"trace[768205696] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:26092; }","duration":"111.650007ms","start":"2026-06-10T10:42:56.292459Z","end":"2026-06-10T10:42:56.404109Z","steps":["trace[768205696] 'agreement among raft nodes before linearized reading' (duration: 111.469404ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:43:12.641436Z","caller":"traceutil/trace.go:171","msg":"trace[55643832] transaction","detail":"{read_only:false; response_revision:26213; number_of_response:1; }","duration":"119.901686ms","start":"2026-06-10T10:43:12.521504Z","end":"2026-06-10T10:43:12.641405Z","steps":["trace[55643832] 'process raft request' (duration: 118.687632ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:43:12.641479Z","caller":"traceutil/trace.go:171","msg":"trace[1563629071] transaction","detail":"{read_only:false; response_revision:26214; number_of_response:1; }","duration":"117.600262ms","start":"2026-06-10T10:43:12.523852Z","end":"2026-06-10T10:43:12.641452Z","steps":["trace[1563629071] 'process raft request' (duration: 117.49321ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:43:17.802064Z","caller":"traceutil/trace.go:171","msg":"trace[1739629331] transaction","detail":"{read_only:false; response_revision:26248; number_of_response:1; }","duration":"168.225592ms","start":"2026-06-10T10:43:17.633816Z","end":"2026-06-10T10:43:17.802042Z","steps":["trace[1739629331] 'process raft request' (duration: 168.027378ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:43:17.802278Z","caller":"traceutil/trace.go:171","msg":"trace[890133400] transaction","detail":"{read_only:false; response_revision:26249; number_of_response:1; }","duration":"164.382798ms","start":"2026-06-10T10:43:17.637875Z","end":"2026-06-10T10:43:17.802258Z","steps":["trace[890133400] 'process raft request' (duration: 164.121613ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:43:17.802384Z","caller":"traceutil/trace.go:171","msg":"trace[1698950005] transaction","detail":"{read_only:false; response_revision:26250; number_of_response:1; }","duration":"164.425689ms","start":"2026-06-10T10:43:17.637948Z","end":"2026-06-10T10:43:17.802374Z","steps":["trace[1698950005] 'process raft request' (duration: 164.226585ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:43:17.80251Z","caller":"traceutil/trace.go:171","msg":"trace[1169140236] linearizableReadLoop","detail":"{readStateIndex:27114; appliedIndex:27110; }","duration":"163.395928ms","start":"2026-06-10T10:43:17.639106Z","end":"2026-06-10T10:43:17.802502Z","steps":["trace[1169140236] 'read index received' (duration: 160.177027ms)","trace[1169140236] 'applied index is now lower than readState.Index' (duration: 3.218361ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:43:17.802586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.453799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterrestores/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterrestores0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T10:43:17.802614Z","caller":"traceutil/trace.go:171","msg":"trace[1569840453] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterrestores/; range_end:/registry/pxc.percona.com/perconaxtradbclusterrestores0; response_count:0; response_revision:26251; }","duration":"163.521841ms","start":"2026-06-10T10:43:17.639084Z","end":"2026-06-10T10:43:17.802606Z","steps":["trace[1569840453] 'agreement among raft nodes before linearized reading' (duration: 163.45212ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:43:17.802591Z","caller":"traceutil/trace.go:171","msg":"trace[832206782] transaction","detail":"{read_only:false; response_revision:26251; number_of_response:1; }","duration":"164.592272ms","start":"2026-06-10T10:43:17.637981Z","end":"2026-06-10T10:43:17.802573Z","steps":["trace[832206782] 'process raft request' (duration: 164.352697ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:43:18.688596Z","caller":"traceutil/trace.go:171","msg":"trace[1300010944] linearizableReadLoop","detail":"{readStateIndex:27116; appliedIndex:27115; }","duration":"162.696976ms","start":"2026-06-10T10:43:18.525877Z","end":"2026-06-10T10:43:18.688574Z","steps":["trace[1300010944] 'read index received' (duration: 162.577274ms)","trace[1300010944] 'applied index is now lower than readState.Index' (duration: 118.832µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:43:18.68864Z","caller":"traceutil/trace.go:171","msg":"trace[910848752] transaction","detail":"{read_only:false; response_revision:26253; number_of_response:1; }","duration":"180.471116ms","start":"2026-06-10T10:43:18.508146Z","end":"2026-06-10T10:43:18.688617Z","steps":["trace[910848752] 'process raft request' (duration: 180.278882ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:43:18.688732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.833629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-nova-server-0\" ","response":"range_response_count:1 size:1850"} {"level":"info","ts":"2026-06-10T10:43:18.688828Z","caller":"traceutil/trace.go:171","msg":"trace[1173769099] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-nova-server-0; range_end:; response_count:1; response_revision:26253; }","duration":"162.88817ms","start":"2026-06-10T10:43:18.525872Z","end":"2026-06-10T10:43:18.68876Z","steps":["trace[1173769099] 'agreement among raft nodes before linearized reading' (duration: 162.795828ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:43:19.162976Z","caller":"traceutil/trace.go:171","msg":"trace[6348484] transaction","detail":"{read_only:false; response_revision:26258; number_of_response:1; }","duration":"261.574599ms","start":"2026-06-10T10:43:18.901381Z","end":"2026-06-10T10:43:19.162955Z","steps":["trace[6348484] 'process raft request' (duration: 200.53899ms)","trace[6348484] 'compare' (duration: 60.794365ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:43:23.308118Z","caller":"traceutil/trace.go:171","msg":"trace[1374921627] linearizableReadLoop","detail":"{readStateIndex:27165; appliedIndex:27164; }","duration":"125.017955ms","start":"2026-06-10T10:43:23.183074Z","end":"2026-06-10T10:43:23.308092Z","steps":["trace[1374921627] 'read index received' (duration: 124.80163ms)","trace[1374921627] 'applied index is now lower than readState.Index' (duration: 214.965µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:43:23.308217Z","caller":"traceutil/trace.go:171","msg":"trace[196856643] transaction","detail":"{read_only:false; response_revision:26301; number_of_response:1; }","duration":"131.532229ms","start":"2026-06-10T10:43:23.176653Z","end":"2026-06-10T10:43:23.308185Z","steps":["trace[196856643] 'process raft request' (duration: 131.236222ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:43:23.308413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.31672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-06-10T10:43:23.308492Z","caller":"traceutil/trace.go:171","msg":"trace[1549721207] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26301; }","duration":"125.442433ms","start":"2026-06-10T10:43:23.183035Z","end":"2026-06-10T10:43:23.308477Z","steps":["trace[1549721207] 'agreement among raft nodes before linearized reading' (duration: 125.202399ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:43:23.417192Z","caller":"traceutil/trace.go:171","msg":"trace[1822105427] transaction","detail":"{read_only:false; response_revision:26302; number_of_response:1; }","duration":"105.202105ms","start":"2026-06-10T10:43:23.311946Z","end":"2026-06-10T10:43:23.417148Z","steps":["trace[1822105427] 'process raft request' (duration: 40.312873ms)","trace[1822105427] 'compare' (duration: 64.590916ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:43:23.673618Z","caller":"traceutil/trace.go:171","msg":"trace[429228823] transaction","detail":"{read_only:false; response_revision:26304; number_of_response:1; }","duration":"160.108997ms","start":"2026-06-10T10:43:23.513484Z","end":"2026-06-10T10:43:23.673593Z","steps":["trace[429228823] 'process raft request' (duration: 159.950334ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:43:23.783631Z","caller":"traceutil/trace.go:171","msg":"trace[1101592693] linearizableReadLoop","detail":"{readStateIndex:27169; appliedIndex:27167; }","duration":"218.087747ms","start":"2026-06-10T10:43:23.565508Z","end":"2026-06-10T10:43:23.783596Z","steps":["trace[1101592693] 'read index received' (duration: 107.991049ms)","trace[1101592693] 'applied index is now lower than readState.Index' (duration: 110.094538ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:43:23.783747Z","caller":"traceutil/trace.go:171","msg":"trace[490543818] transaction","detail":"{read_only:false; response_revision:26305; number_of_response:1; }","duration":"270.102783ms","start":"2026-06-10T10:43:23.513602Z","end":"2026-06-10T10:43:23.783704Z","steps":["trace[490543818] 'process raft request' (duration: 211.538901ms)","trace[490543818] 'compare' (duration: 57.518313ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:43:23.783794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.26738ms","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-06-10T10:43:23.783859Z","caller":"traceutil/trace.go:171","msg":"trace[2119798327] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:26305; }","duration":"218.377633ms","start":"2026-06-10T10:43:23.565465Z","end":"2026-06-10T10:43:23.783843Z","steps":["trace[2119798327] 'agreement among raft nodes before linearized reading' (duration: 218.25135ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:43:24.024727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.163743ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-10T10:43:24.024938Z","caller":"traceutil/trace.go:171","msg":"trace[1864751902] linearizableReadLoop","detail":"{readStateIndex:27173; appliedIndex:27169; }","duration":"111.348122ms","start":"2026-06-10T10:43:23.913578Z","end":"2026-06-10T10:43:24.024927Z","steps":["trace[1864751902] 'read index received' (duration: 108.717882ms)","trace[1864751902] 'applied index is now lower than readState.Index' (duration: 2.62964ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:43:24.025141Z","caller":"traceutil/trace.go:171","msg":"trace[105493519] transaction","detail":"{read_only:false; response_revision:26307; number_of_response:1; }","duration":"197.503572ms","start":"2026-06-10T10:43:23.827622Z","end":"2026-06-10T10:43:24.025125Z","steps":["trace[105493519] 'process raft request' (duration: 197.199666ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:43:24.025143Z","caller":"traceutil/trace.go:171","msg":"trace[1094017402] transaction","detail":"{read_only:false; response_revision:26309; number_of_response:1; }","duration":"195.560335ms","start":"2026-06-10T10:43:23.82953Z","end":"2026-06-10T10:43:24.025091Z","steps":["trace[1094017402] 'process raft request' (duration: 195.360642ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:43:24.025181Z","caller":"traceutil/trace.go:171","msg":"trace[1527955510] transaction","detail":"{read_only:false; response_revision:26308; number_of_response:1; }","duration":"196.397552ms","start":"2026-06-10T10:43:23.828765Z","end":"2026-06-10T10:43:24.025162Z","steps":["trace[1527955510] 'process raft request' (duration: 196.100686ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:43:24.025242Z","caller":"traceutil/trace.go:171","msg":"trace[1949525636] transaction","detail":"{read_only:false; response_revision:26306; number_of_response:1; }","duration":"200.926068ms","start":"2026-06-10T10:43:23.824309Z","end":"2026-06-10T10:43:24.025235Z","steps":["trace[1949525636] 'process raft request' (duration: 83.189873ms)","trace[1949525636] 'compare' (duration: 117.069552ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:43:24.025467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.794571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/certificates/\" range_end:\"/registry/secretgen.k14s.io/certificates0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T10:43:24.025892Z","caller":"traceutil/trace.go:171","msg":"trace[246709590] range","detail":"{range_begin:/registry/secretgen.k14s.io/certificates/; range_end:/registry/secretgen.k14s.io/certificates0; response_count:0; response_revision:26309; }","duration":"112.328141ms","start":"2026-06-10T10:43:23.913536Z","end":"2026-06-10T10:43:24.025865Z","steps":["trace[246709590] 'agreement among raft nodes before linearized reading' (duration: 111.73438ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:43:24.304473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.875306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/podmonitors/\" range_end:\"/registry/monitoring.coreos.com/podmonitors0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-10T10:43:24.304567Z","caller":"traceutil/trace.go:171","msg":"trace[49620792] range","detail":"{range_begin:/registry/monitoring.coreos.com/podmonitors/; range_end:/registry/monitoring.coreos.com/podmonitors0; response_count:0; response_revision:26309; }","duration":"131.022689ms","start":"2026-06-10T10:43:24.173524Z","end":"2026-06-10T10:43:24.304546Z","steps":["trace[49620792] 'count revisions from in-memory index tree' (duration: 130.730964ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:43:24.630381Z","caller":"traceutil/trace.go:171","msg":"trace[1158407227] transaction","detail":"{read_only:false; response_revision:26310; number_of_response:1; }","duration":"183.905462ms","start":"2026-06-10T10:43:24.446446Z","end":"2026-06-10T10:43:24.630352Z","steps":["trace[1158407227] 'process raft request' (duration: 183.673318ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:43:25.029474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.968761ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-10T10:43:25.029585Z","caller":"traceutil/trace.go:171","msg":"trace[1546087811] transaction","detail":"{read_only:false; response_revision:26312; number_of_response:1; }","duration":"279.439741ms","start":"2026-06-10T10:43:24.750127Z","end":"2026-06-10T10:43:25.029566Z","steps":["trace[1546087811] 'process raft request' (duration: 163.299367ms)","trace[1546087811] 'compare' (duration: 115.860389ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:43:25.039559Z","caller":"traceutil/trace.go:171","msg":"trace[416814567] transaction","detail":"{read_only:false; response_revision:26313; number_of_response:1; }","duration":"288.035075ms","start":"2026-06-10T10:43:24.751511Z","end":"2026-06-10T10:43:25.039546Z","steps":["trace[416814567] 'process raft request' (duration: 287.73847ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:43:25.32372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.256058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-10T10:43:25.323796Z","caller":"traceutil/trace.go:171","msg":"trace[1656991259] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:26313; }","duration":"185.401771ms","start":"2026-06-10T10:43:25.138375Z","end":"2026-06-10T10:43:25.323777Z","steps":["trace[1656991259] 'count revisions from in-memory index tree' (duration: 185.153945ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:43:25.324198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.833028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinesets/\" range_end:\"/registry/cluster.x-k8s.io/machinesets0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T10:43:25.324243Z","caller":"traceutil/trace.go:171","msg":"trace[312241501] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinesets/; range_end:/registry/cluster.x-k8s.io/machinesets0; response_count:0; response_revision:26313; }","duration":"152.883159ms","start":"2026-06-10T10:43:25.17135Z","end":"2026-06-10T10:43:25.324233Z","steps":["trace[312241501] 'count revisions from in-memory index tree' (duration: 152.764237ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:43:25.591264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.654731ms","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-06-10T10:43:25.591457Z","caller":"traceutil/trace.go:171","msg":"trace[832772756] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:26314; }","duration":"108.866304ms","start":"2026-06-10T10:43:25.482566Z","end":"2026-06-10T10:43:25.591432Z","steps":["trace[832772756] 'range keys from in-memory index tree' (duration: 108.63718ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:43:25.664863Z","caller":"traceutil/trace.go:171","msg":"trace[153863122] linearizableReadLoop","detail":"{readStateIndex:27179; appliedIndex:27178; }","duration":"237.959827ms","start":"2026-06-10T10:43:25.426881Z","end":"2026-06-10T10:43:25.664841Z","steps":["trace[153863122] 'read index received' (duration: 237.737963ms)","trace[153863122] 'applied index is now lower than readState.Index' (duration: 220.884µs)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:43:25.665004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.11256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T10:43:25.665042Z","caller":"traceutil/trace.go:171","msg":"trace[638096623] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26315; }","duration":"238.201801ms","start":"2026-06-10T10:43:25.42683Z","end":"2026-06-10T10:43:25.665032Z","steps":["trace[638096623] 'agreement among raft nodes before linearized reading' (duration: 238.12514ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:43:25.665187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.355799ms","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-06-10T10:43:25.665156Z","caller":"traceutil/trace.go:171","msg":"trace[701879181] transaction","detail":"{read_only:false; response_revision:26315; number_of_response:1; }","duration":"240.347583ms","start":"2026-06-10T10:43:25.424616Z","end":"2026-06-10T10:43:25.664963Z","steps":["trace[701879181] 'process raft request' (duration: 240.067798ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:43:25.665265Z","caller":"traceutil/trace.go:171","msg":"trace[155934264] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26315; }","duration":"151.47508ms","start":"2026-06-10T10:43:25.513773Z","end":"2026-06-10T10:43:25.665248Z","steps":["trace[155934264] 'agreement among raft nodes before linearized reading' (duration: 151.261916ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:43:25.66535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.671105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-06-10T10:43:25.665433Z","caller":"traceutil/trace.go:171","msg":"trace[280283090] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:26315; }","duration":"138.821428ms","start":"2026-06-10T10:43:25.526591Z","end":"2026-06-10T10:43:25.665412Z","steps":["trace[280283090] 'agreement among raft nodes before linearized reading' (duration: 138.517423ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:43:25.817098Z","caller":"traceutil/trace.go:171","msg":"trace[179186211] linearizableReadLoop","detail":"{readStateIndex:27180; appliedIndex:27179; }","duration":"138.79156ms","start":"2026-06-10T10:43:25.67827Z","end":"2026-06-10T10:43:25.817062Z","steps":["trace[179186211] 'read index received' (duration: 113.582967ms)","trace[179186211] 'applied index is now lower than readState.Index' (duration: 25.202633ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:43:25.81716Z","caller":"traceutil/trace.go:171","msg":"trace[406452950] transaction","detail":"{read_only:false; response_revision:26316; number_of_response:1; }","duration":"146.829282ms","start":"2026-06-10T10:43:25.670256Z","end":"2026-06-10T10:43:25.817085Z","steps":["trace[406452950] 'process raft request' (duration: 121.610589ms)","trace[406452950] 'compare' (duration: 24.789744ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:43:25.817315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.021784ms","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-06-10T10:43:25.817423Z","caller":"traceutil/trace.go:171","msg":"trace[1341563778] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26316; }","duration":"139.165046ms","start":"2026-06-10T10:43:25.67823Z","end":"2026-06-10T10:43:25.817395Z","steps":["trace[1341563778] 'agreement among raft nodes before linearized reading' (duration: 138.925761ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:45:09.225209Z","caller":"traceutil/trace.go:171","msg":"trace[1825148599] transaction","detail":"{read_only:false; response_revision:27378; number_of_response:1; }","duration":"104.213865ms","start":"2026-06-10T10:45:09.120962Z","end":"2026-06-10T10:45:09.225176Z","steps":["trace[1825148599] 'process raft request' (duration: 104.027241ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:46:28.554874Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25219} {"level":"info","ts":"2026-06-10T10:46:28.699405Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25219,"took":"138.95456ms","hash":656299060,"current-db-size-bytes":57348096,"current-db-size":"57 MB","current-db-size-in-use-bytes":38477824,"current-db-size-in-use":"38 MB"} {"level":"info","ts":"2026-06-10T10:46:28.699454Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":656299060,"revision":25219,"compact-revision":21976} {"level":"info","ts":"2026-06-10T10:48:07.979006Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"56c01ea8fdc90390","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-10T10:48:07.984583Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-06-10T10:48:07.984657Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-06-10T10:51:28.560506Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28201} {"level":"info","ts":"2026-06-10T10:51:28.699657Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28201,"took":"134.944705ms","hash":3716301428,"current-db-size-bytes":57348096,"current-db-size":"57 MB","current-db-size-in-use-bytes":33103872,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-06-10T10:51:28.699731Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3716301428,"revision":28201,"compact-revision":25219} {"level":"info","ts":"2026-06-10T10:56:28.568109Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30574} {"level":"info","ts":"2026-06-10T10:56:28.704753Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30574,"took":"132.044187ms","hash":2333147231,"current-db-size-bytes":57348096,"current-db-size":"57 MB","current-db-size-in-use-bytes":31039488,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-06-10T10:56:28.704851Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2333147231,"revision":30574,"compact-revision":28201} {"level":"info","ts":"2026-06-10T11:01:28.574809Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32833} {"level":"info","ts":"2026-06-10T11:01:28.734146Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32833,"took":"154.965794ms","hash":3299699952,"current-db-size-bytes":58392576,"current-db-size":"58 MB","current-db-size-in-use-bytes":32010240,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-10T11:01:28.734224Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3299699952,"revision":32833,"compact-revision":30574} {"level":"info","ts":"2026-06-10T11:06:28.581885Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35196} {"level":"info","ts":"2026-06-10T11:06:28.722633Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35196,"took":"136.346918ms","hash":2264491897,"current-db-size-bytes":58392576,"current-db-size":"58 MB","current-db-size-in-use-bytes":31645696,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-10T11:06:28.722712Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2264491897,"revision":35196,"compact-revision":32833} {"level":"info","ts":"2026-06-10T11:09:23.957262Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"56c01ea8fdc90390","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-10T11:09:23.961293Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-06-10T11:09:23.961395Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-06-10T11:11:28.587904Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37460} {"level":"info","ts":"2026-06-10T11:11:28.711126Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37460,"took":"118.567009ms","hash":3784613241,"current-db-size-bytes":58814464,"current-db-size":"59 MB","current-db-size-in-use-bytes":32243712,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-10T11:11:28.711195Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3784613241,"revision":37460,"compact-revision":35196}