{"level":"warn","ts":"2026-10-15T19:02:50.817479Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-15T19:02:50.817649Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.215:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.215:2380","--initial-cluster=instance=https://162.253.55.215:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.215:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.215:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-10-15T19:02:50.817767Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-15T19:02:50.817786Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.215:2380"]} {"level":"info","ts":"2026-10-15T19:02:50.817831Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-10-15T19:02:50.818824Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.215:2379"]} {"level":"info","ts":"2026-10-15T19:02:50.818968Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.215:2380"],"listen-peer-urls":["https://162.253.55.215:2380"],"advertise-client-urls":["https://162.253.55.215:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.215:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.215:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-10-15T19:02:50.822058Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.768937ms"} {"level":"info","ts":"2026-10-15T19:02:50.828761Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"4b019b7871d5da9a","cluster-id":"608f860684155cc8"} {"level":"info","ts":"2026-10-15T19:02:50.828858Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4b019b7871d5da9a switched to configuration voters=()"} {"level":"info","ts":"2026-10-15T19:02:50.828892Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4b019b7871d5da9a became follower at term 0"} {"level":"info","ts":"2026-10-15T19:02:50.828909Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 4b019b7871d5da9a [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-15T19:02:50.828922Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4b019b7871d5da9a became follower at term 1"} {"level":"info","ts":"2026-10-15T19:02:50.828966Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4b019b7871d5da9a switched to configuration voters=(5404771969429527194)"} {"level":"warn","ts":"2026-10-15T19:02:50.833581Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-15T19:02:50.835297Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-15T19:02:50.837205Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-10-15T19:02:50.839616Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"4b019b7871d5da9a","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-15T19:02:50.840836Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"4b019b7871d5da9a","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-15T19:02:50.841089Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-10-15T19:02:50.841197Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-10-15T19:02:50.841216Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-10-15T19:02:50.843913Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4b019b7871d5da9a switched to configuration voters=(5404771969429527194)"} {"level":"info","ts":"2026-10-15T19:02:50.844118Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"608f860684155cc8","local-member-id":"4b019b7871d5da9a","added-peer-id":"4b019b7871d5da9a","added-peer-peer-urls":["https://162.253.55.215:2380"]} {"level":"info","ts":"2026-10-15T19:02:50.845927Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-10-15T19:02:50.84604Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.215:2380"} {"level":"info","ts":"2026-10-15T19:02:50.846089Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.215:2380"} {"level":"info","ts":"2026-10-15T19:02:50.846456Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"4b019b7871d5da9a","initial-advertise-peer-urls":["https://162.253.55.215:2380"],"listen-peer-urls":["https://162.253.55.215:2380"],"advertise-client-urls":["https://162.253.55.215:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.215:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-15T19:02:50.846541Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-15T19:02:51.529592Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4b019b7871d5da9a is starting a new election at term 1"} {"level":"info","ts":"2026-10-15T19:02:51.52969Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4b019b7871d5da9a became pre-candidate at term 1"} {"level":"info","ts":"2026-10-15T19:02:51.529731Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4b019b7871d5da9a received MsgPreVoteResp from 4b019b7871d5da9a at term 1"} {"level":"info","ts":"2026-10-15T19:02:51.529754Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4b019b7871d5da9a became candidate at term 2"} {"level":"info","ts":"2026-10-15T19:02:51.529766Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4b019b7871d5da9a received MsgVoteResp from 4b019b7871d5da9a at term 2"} {"level":"info","ts":"2026-10-15T19:02:51.529798Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4b019b7871d5da9a became leader at term 2"} {"level":"info","ts":"2026-10-15T19:02:51.529813Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 4b019b7871d5da9a elected leader 4b019b7871d5da9a at term 2"} {"level":"info","ts":"2026-10-15T19:02:51.531371Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"4b019b7871d5da9a","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.215:2379]}","request-path":"/0/members/4b019b7871d5da9a/attributes","cluster-id":"608f860684155cc8","publish-timeout":"7s"} {"level":"info","ts":"2026-10-15T19:02:51.531491Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-15T19:02:51.53204Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-15T19:02:51.53208Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-15T19:02:51.531555Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-15T19:02:51.5316Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T19:02:51.534823Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"608f860684155cc8","local-member-id":"4b019b7871d5da9a","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T19:02:51.534915Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T19:02:51.534993Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T19:02:51.536395Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-15T19:02:51.536498Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.215:2379"} {"level":"info","ts":"2026-10-15T19:03:18.472422Z","caller":"traceutil/trace.go:171","msg":"trace[1566516678] transaction","detail":"{read_only:false; response_revision:439; number_of_response:1; }","duration":"215.652564ms","start":"2026-10-15T19:03:18.256728Z","end":"2026-10-15T19:03:18.47238Z","steps":["trace[1566516678] 'process raft request' (duration: 215.367567ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:03:42.971026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.808979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-10-15T19:03:42.971182Z","caller":"traceutil/trace.go:171","msg":"trace[402879599] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:648; }","duration":"172.035285ms","start":"2026-10-15T19:03:42.799124Z","end":"2026-10-15T19:03:42.971159Z","steps":["trace[402879599] 'range keys from in-memory index tree' (duration: 171.541153ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:03:43.02879Z","caller":"traceutil/trace.go:171","msg":"trace[682759771] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"229.199579ms","start":"2026-10-15T19:03:42.799548Z","end":"2026-10-15T19:03:43.028747Z","steps":["trace[682759771] 'process raft request' (duration: 228.283657ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:03:43.131127Z","caller":"traceutil/trace.go:171","msg":"trace[1644537137] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"154.568573ms","start":"2026-10-15T19:03:42.976506Z","end":"2026-10-15T19:03:43.131074Z","steps":["trace[1644537137] 'process raft request' (duration: 122.485596ms)","trace[1644537137] 'compare' (duration: 31.739118ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T19:03:43.741575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.113543ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T19:03:43.741689Z","caller":"traceutil/trace.go:171","msg":"trace[463993591] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:651; }","duration":"342.265506ms","start":"2026-10-15T19:03:43.399406Z","end":"2026-10-15T19:03:43.741671Z","steps":["trace[463993591] 'range keys from in-memory index tree' (duration: 342.096542ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:03:43.741951Z","caller":"traceutil/trace.go:171","msg":"trace[224226705] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"588.1672ms","start":"2026-10-15T19:03:43.153773Z","end":"2026-10-15T19:03:43.74194Z","steps":["trace[224226705] 'process raft request' (duration: 579.001818ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:03:43.743585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:03:43.153741Z","time spent":"588.239962ms","remote":"127.0.0.1:44678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T19:03:43.75785Z","caller":"traceutil/trace.go:171","msg":"trace[65150397] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"202.779468ms","start":"2026-10-15T19:03:43.555035Z","end":"2026-10-15T19:03:43.757815Z","steps":["trace[65150397] 'process raft request' (duration: 201.974189ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:03:58.723679Z","caller":"traceutil/trace.go:171","msg":"trace[1062059707] transaction","detail":"{read_only:false; response_revision:821; number_of_response:1; }","duration":"189.705013ms","start":"2026-10-15T19:03:58.533935Z","end":"2026-10-15T19:03:58.72364Z","steps":["trace[1062059707] 'process raft request' (duration: 172.408544ms)","trace[1062059707] 'compare' (duration: 16.989092ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:04:27.619552Z","caller":"traceutil/trace.go:171","msg":"trace[1128184720] transaction","detail":"{read_only:false; response_revision:1217; number_of_response:1; }","duration":"245.772711ms","start":"2026-10-15T19:04:27.373749Z","end":"2026-10-15T19:04:27.619522Z","steps":["trace[1128184720] 'process raft request' (duration: 245.608127ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:04:27.65941Z","caller":"traceutil/trace.go:171","msg":"trace[1688154340] transaction","detail":"{read_only:false; response_revision:1218; number_of_response:1; }","duration":"285.170334ms","start":"2026-10-15T19:04:27.374209Z","end":"2026-10-15T19:04:27.65938Z","steps":["trace[1688154340] 'process raft request' (duration: 285.03315ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:04:51.9788Z","caller":"traceutil/trace.go:171","msg":"trace[1516552446] transaction","detail":"{read_only:false; response_revision:1487; number_of_response:1; }","duration":"170.486751ms","start":"2026-10-15T19:04:51.808286Z","end":"2026-10-15T19:04:51.978772Z","steps":["trace[1516552446] 'process raft request' (duration: 158.215525ms)","trace[1516552446] 'compare' (duration: 12.179004ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T19:05:19.544492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.298342ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-15T19:05:19.544755Z","caller":"traceutil/trace.go:171","msg":"trace[235883515] linearizableReadLoop","detail":"{readStateIndex:1988; appliedIndex:1987; }","duration":"340.223526ms","start":"2026-10-15T19:05:19.204511Z","end":"2026-10-15T19:05:19.544734Z","steps":["trace[235883515] 'read index received' (duration: 58.742µs)","trace[235883515] 'applied index is now lower than readState.Index' (duration: 340.163234ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:05:19.544835Z","caller":"traceutil/trace.go:171","msg":"trace[1412841974] transaction","detail":"{read_only:false; response_revision:1908; number_of_response:1; }","duration":"420.320102ms","start":"2026-10-15T19:05:19.124468Z","end":"2026-10-15T19:05:19.544788Z","steps":["trace[1412841974] 'process raft request' (duration: 42.361454ms)","trace[1412841974] 'compare' (duration: 377.112078ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T19:05:19.544979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.472381ms","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-10-15T19:05:19.545024Z","caller":"traceutil/trace.go:171","msg":"trace[2110653448] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1908; }","duration":"340.555873ms","start":"2026-10-15T19:05:19.204453Z","end":"2026-10-15T19:05:19.545009Z","steps":["trace[2110653448] 'agreement among raft nodes before linearized reading' (duration: 340.366259ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:05:19.545075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:05:19.204425Z","time spent":"340.642016ms","remote":"127.0.0.1:44768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-10-15T19:05:19.545305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:05:19.124444Z","time spent":"420.552718ms","remote":"127.0.0.1:44768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T19:05:19.545675Z","caller":"traceutil/trace.go:171","msg":"trace[858112709] transaction","detail":"{read_only:false; response_revision:1909; number_of_response:1; }","duration":"167.646223ms","start":"2026-10-15T19:05:19.377968Z","end":"2026-10-15T19:05:19.545614Z","steps":["trace[858112709] 'process raft request' (duration: 167.332375ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:05:19.545869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.582557ms","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-10-15T19:05:19.54599Z","caller":"traceutil/trace.go:171","msg":"trace[655947859] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1909; }","duration":"264.740271ms","start":"2026-10-15T19:05:19.281223Z","end":"2026-10-15T19:05:19.545964Z","steps":["trace[655947859] 'agreement among raft nodes before linearized reading' (duration: 264.30911ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:05:19.54591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.884058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-10-15T19:05:19.546116Z","caller":"traceutil/trace.go:171","msg":"trace[613439677] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1909; }","duration":"242.106034ms","start":"2026-10-15T19:05:19.303996Z","end":"2026-10-15T19:05:19.546102Z","steps":["trace[613439677] 'agreement among raft nodes before linearized reading' (duration: 241.838987ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:05:19.90942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.957709ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-15T19:05:19.909526Z","caller":"traceutil/trace.go:171","msg":"trace[1739042901] transaction","detail":"{read_only:false; response_revision:1912; number_of_response:1; }","duration":"280.42914ms","start":"2026-10-15T19:05:19.629078Z","end":"2026-10-15T19:05:19.909507Z","steps":["trace[1739042901] 'process raft request' (duration: 67.303117ms)","trace[1739042901] 'compare' (duration: 212.819466ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T19:05:32.764969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.630222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"warn","ts":"2026-10-15T19:05:32.765035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.412259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-10-15T19:05:32.765107Z","caller":"traceutil/trace.go:171","msg":"trace[1716612953] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2023; }","duration":"119.847638ms","start":"2026-10-15T19:05:32.645229Z","end":"2026-10-15T19:05:32.765077Z","steps":["trace[1716612953] 'range keys from in-memory index tree' (duration: 119.357566ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:05:32.765187Z","caller":"traceutil/trace.go:171","msg":"trace[1757084944] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2023; }","duration":"146.612324ms","start":"2026-10-15T19:05:32.61852Z","end":"2026-10-15T19:05:32.765132Z","steps":["trace[1757084944] 'range keys from in-memory index tree' (duration: 146.135433ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:06:05.255465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.973195ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:39"} {"level":"info","ts":"2026-10-15T19:06:05.256146Z","caller":"traceutil/trace.go:171","msg":"trace[465827703] transaction","detail":"{read_only:false; response_revision:2208; number_of_response:1; }","duration":"181.280552ms","start":"2026-10-15T19:06:05.07483Z","end":"2026-10-15T19:06:05.25611Z","steps":["trace[465827703] 'process raft request' (duration: 180.843252ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:06:10.842928Z","caller":"traceutil/trace.go:171","msg":"trace[1505689616] transaction","detail":"{read_only:false; response_revision:2238; number_of_response:1; }","duration":"300.014763ms","start":"2026-10-15T19:06:10.542869Z","end":"2026-10-15T19:06:10.842883Z","steps":["trace[1505689616] 'process raft request' (duration: 200.899613ms)","trace[1505689616] 'compare' (duration: 98.875225ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T19:06:10.843185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:06:10.54284Z","time spent":"300.252819ms","remote":"127.0.0.1:44768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T19:06:11.421002Z","caller":"traceutil/trace.go:171","msg":"trace[205576104] linearizableReadLoop","detail":"{readStateIndex:2332; appliedIndex:2331; }","duration":"360.581348ms","start":"2026-10-15T19:06:11.06039Z","end":"2026-10-15T19:06:11.420971Z","steps":["trace[205576104] 'read index received' (duration: 360.520946ms)","trace[205576104] 'applied index is now lower than readState.Index' (duration: 59.122µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:06:11.421097Z","caller":"traceutil/trace.go:171","msg":"trace[1359356879] transaction","detail":"{read_only:false; response_revision:2239; number_of_response:1; }","duration":"401.274975ms","start":"2026-10-15T19:06:11.019782Z","end":"2026-10-15T19:06:11.421057Z","steps":["trace[1359356879] 'process raft request' (duration: 401.024289ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:06:11.421375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.964687ms","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-10-15T19:06:11.421494Z","caller":"traceutil/trace.go:171","msg":"trace[203720480] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2239; }","duration":"361.147141ms","start":"2026-10-15T19:06:11.060316Z","end":"2026-10-15T19:06:11.421463Z","steps":["trace[203720480] 'agreement among raft nodes before linearized reading' (duration: 360.827124ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:06:11.421558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:06:11.060267Z","time spent":"361.276404ms","remote":"127.0.0.1:43358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5434,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-10-15T19:06:11.421487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:06:11.019766Z","time spent":"401.416059ms","remote":"127.0.0.1:44768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T19:06:11.748003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.759144ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-15T19:06:11.74814Z","caller":"traceutil/trace.go:171","msg":"trace[2090812724] linearizableReadLoop","detail":"{readStateIndex:2333; appliedIndex:2332; }","duration":"327.016872ms","start":"2026-10-15T19:06:11.421106Z","end":"2026-10-15T19:06:11.748122Z","steps":["trace[2090812724] 'read index received' (duration: 144.978651ms)","trace[2090812724] 'applied index is now lower than readState.Index' (duration: 182.036691ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:06:11.748223Z","caller":"traceutil/trace.go:171","msg":"trace[1946386056] transaction","detail":"{read_only:false; response_revision:2240; number_of_response:1; }","duration":"481.699076ms","start":"2026-10-15T19:06:11.266487Z","end":"2026-10-15T19:06:11.748186Z","steps":["trace[1946386056] 'process raft request' (duration: 299.650905ms)","trace[1946386056] 'compare' (duration: 181.57511ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T19:06:11.748352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.393352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-10-15T19:06:11.748367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.802563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-10-15T19:06:11.748375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:06:11.266456Z","time spent":"481.843889ms","remote":"127.0.0.1:44768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T19:06:11.748389Z","caller":"traceutil/trace.go:171","msg":"trace[593841845] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2240; }","duration":"467.471534ms","start":"2026-10-15T19:06:11.280906Z","end":"2026-10-15T19:06:11.748378Z","steps":["trace[593841845] 'agreement among raft nodes before linearized reading' (duration: 467.30205ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:06:11.748412Z","caller":"traceutil/trace.go:171","msg":"trace[110850447] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:2240; }","duration":"350.895155ms","start":"2026-10-15T19:06:11.397504Z","end":"2026-10-15T19:06:11.748399Z","steps":["trace[110850447] 'agreement among raft nodes before linearized reading' (duration: 350.634769ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:06:11.74842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:06:11.280886Z","time spent":"467.527136ms","remote":"127.0.0.1:44768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-10-15T19:06:11.74845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:06:11.397484Z","time spent":"350.956956ms","remote":"127.0.0.1:44572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":274,"response size":30,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"warn","ts":"2026-10-15T19:06:11.748544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.563725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T19:06:11.74862Z","caller":"traceutil/trace.go:171","msg":"trace[114621163] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:2240; }","duration":"292.696408ms","start":"2026-10-15T19:06:11.455907Z","end":"2026-10-15T19:06:11.748603Z","steps":["trace[114621163] 'agreement among raft nodes before linearized reading' (duration: 292.556265ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:06:11.748574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.374159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/queues/\" range_end:\"/registry/rabbitmq.com/queues0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-15T19:06:11.748794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"642.742483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T19:06:11.748818Z","caller":"traceutil/trace.go:171","msg":"trace[1265866766] range","detail":"{range_begin:/registry/rabbitmq.com/queues/; range_end:/registry/rabbitmq.com/queues0; response_count:0; response_revision:2240; }","duration":"252.618475ms","start":"2026-10-15T19:06:11.496147Z","end":"2026-10-15T19:06:11.74874Z","steps":["trace[1265866766] 'agreement among raft nodes before linearized reading' (duration: 252.39172ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:06:11.749191Z","caller":"traceutil/trace.go:171","msg":"trace[1057131907] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2240; }","duration":"643.02989ms","start":"2026-10-15T19:06:11.10592Z","end":"2026-10-15T19:06:11.74895Z","steps":["trace[1057131907] 'agreement among raft nodes before linearized reading' (duration: 642.677801ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:06:11.749256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:06:11.105898Z","time spent":"643.344787ms","remote":"127.0.0.1:44498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-10-15T19:07:02.686089Z","caller":"traceutil/trace.go:171","msg":"trace[240479399] transaction","detail":"{read_only:false; response_revision:2686; number_of_response:1; }","duration":"106.884925ms","start":"2026-10-15T19:07:02.579174Z","end":"2026-10-15T19:07:02.686059Z","steps":["trace[240479399] 'process raft request' (duration: 106.690091ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:07:36.122743Z","caller":"traceutil/trace.go:171","msg":"trace[1111933707] transaction","detail":"{read_only:false; response_revision:2889; number_of_response:1; }","duration":"231.217022ms","start":"2026-10-15T19:07:35.891489Z","end":"2026-10-15T19:07:36.122706Z","steps":["trace[1111933707] 'process raft request' (duration: 230.975326ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:07:36.28788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.073275ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-15T19:07:36.288081Z","caller":"traceutil/trace.go:171","msg":"trace[539526391] transaction","detail":"{read_only:false; response_revision:2890; number_of_response:1; }","duration":"172.519126ms","start":"2026-10-15T19:07:36.115528Z","end":"2026-10-15T19:07:36.288047Z","steps":["trace[539526391] 'process raft request' (duration: 47.156694ms)","trace[539526391] 'compare' (duration: 124.903761ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:07:36.288166Z","caller":"traceutil/trace.go:171","msg":"trace[1885566848] transaction","detail":"{read_only:false; response_revision:2891; number_of_response:1; }","duration":"156.890467ms","start":"2026-10-15T19:07:36.131252Z","end":"2026-10-15T19:07:36.288142Z","steps":["trace[1885566848] 'process raft request' (duration: 156.803615ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:07:36.288216Z","caller":"traceutil/trace.go:171","msg":"trace[1598799085] linearizableReadLoop","detail":"{readStateIndex:3008; appliedIndex:3007; }","duration":"164.104177ms","start":"2026-10-15T19:07:36.12403Z","end":"2026-10-15T19:07:36.288134Z","steps":["trace[1598799085] 'read index received' (duration: 38.811127ms)","trace[1598799085] 'applied index is now lower than readState.Index' (duration: 125.28819ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T19:07:36.288365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.344272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T19:07:36.288458Z","caller":"traceutil/trace.go:171","msg":"trace[1823835720] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2891; }","duration":"164.489056ms","start":"2026-10-15T19:07:36.123945Z","end":"2026-10-15T19:07:36.288434Z","steps":["trace[1823835720] 'agreement among raft nodes before linearized reading' (duration: 164.350712ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:10:21.103583Z","caller":"traceutil/trace.go:171","msg":"trace[1987986506] linearizableReadLoop","detail":"{readStateIndex:4070; appliedIndex:4068; }","duration":"113.918085ms","start":"2026-10-15T19:10:20.989634Z","end":"2026-10-15T19:10:21.103552Z","steps":["trace[1987986506] 'read index received' (duration: 107.917232ms)","trace[1987986506] 'applied index is now lower than readState.Index' (duration: 5.999503ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:10:21.10373Z","caller":"traceutil/trace.go:171","msg":"trace[1223598473] transaction","detail":"{read_only:false; response_revision:3912; number_of_response:1; }","duration":"115.161744ms","start":"2026-10-15T19:10:20.988558Z","end":"2026-10-15T19:10:21.10372Z","steps":["trace[1223598473] 'process raft request' (duration: 114.936988ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:10:21.104191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.548289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/secretgen-controller/secretgen-controller-5cf976ccc7\" ","response":"range_response_count:1 size:2827"} {"level":"info","ts":"2026-10-15T19:10:21.104237Z","caller":"traceutil/trace.go:171","msg":"trace[2001342406] range","detail":"{range_begin:/registry/replicasets/secretgen-controller/secretgen-controller-5cf976ccc7; range_end:; response_count:1; response_revision:3912; }","duration":"114.683963ms","start":"2026-10-15T19:10:20.98954Z","end":"2026-10-15T19:10:21.104224Z","steps":["trace[2001342406] 'agreement among raft nodes before linearized reading' (duration: 114.498248ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:10:21.104389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.958775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/secretgen-controller/secretgen-controller-5cf976ccc7-zwpc4\" ","response":"range_response_count:1 size:2097"} {"level":"info","ts":"2026-10-15T19:10:21.104507Z","caller":"traceutil/trace.go:171","msg":"trace[317200618] range","detail":"{range_begin:/registry/pods/secretgen-controller/secretgen-controller-5cf976ccc7-zwpc4; range_end:; response_count:1; response_revision:3912; }","duration":"114.117289ms","start":"2026-10-15T19:10:20.990365Z","end":"2026-10-15T19:10:21.104482Z","steps":["trace[317200618] 'agreement among raft nodes before linearized reading' (duration: 113.824642ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:10:21.103607Z","caller":"traceutil/trace.go:171","msg":"trace[890180115] transaction","detail":"{read_only:false; response_revision:3911; number_of_response:1; }","duration":"120.840068ms","start":"2026-10-15T19:10:20.982735Z","end":"2026-10-15T19:10:21.103575Z","steps":["trace[890180115] 'process raft request' (duration: 114.720103ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:10:53.538698Z","caller":"traceutil/trace.go:171","msg":"trace[757797101] transaction","detail":"{read_only:false; response_revision:4128; number_of_response:1; }","duration":"104.735277ms","start":"2026-10-15T19:10:53.433931Z","end":"2026-10-15T19:10:53.538666Z","steps":["trace[757797101] 'process raft request' (duration: 104.531052ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:10:53.538684Z","caller":"traceutil/trace.go:171","msg":"trace[546828425] transaction","detail":"{read_only:false; response_revision:4129; number_of_response:1; }","duration":"104.725378ms","start":"2026-10-15T19:10:53.433929Z","end":"2026-10-15T19:10:53.538654Z","steps":["trace[546828425] 'process raft request' (duration: 104.675956ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:12:24.287957Z","caller":"traceutil/trace.go:171","msg":"trace[2055099988] transaction","detail":"{read_only:false; response_revision:5210; number_of_response:1; }","duration":"143.989076ms","start":"2026-10-15T19:12:24.143939Z","end":"2026-10-15T19:12:24.287928Z","steps":["trace[2055099988] 'process raft request' (duration: 107.645416ms)","trace[2055099988] 'compare' (duration: 35.761237ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:12:25.108073Z","caller":"traceutil/trace.go:171","msg":"trace[39835060] transaction","detail":"{read_only:false; response_revision:5216; number_of_response:1; }","duration":"150.223983ms","start":"2026-10-15T19:12:24.957806Z","end":"2026-10-15T19:12:25.10803Z","steps":["trace[39835060] 'process raft request' (duration: 149.939907ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:12:28.313742Z","caller":"traceutil/trace.go:171","msg":"trace[2026610439] linearizableReadLoop","detail":"{readStateIndex:5543; appliedIndex:5542; }","duration":"406.758793ms","start":"2026-10-15T19:12:27.906964Z","end":"2026-10-15T19:12:28.313723Z","steps":["trace[2026610439] 'read index received' (duration: 406.603489ms)","trace[2026610439] 'applied index is now lower than readState.Index' (duration: 154.304µs)"],"step_count":2} {"level":"warn","ts":"2026-10-15T19:12:28.313974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.22513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-03231f45-d6fd-4483-8835-bd1a9e70b7c9\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-10-15T19:12:28.314006Z","caller":"traceutil/trace.go:171","msg":"trace[2104520554] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-03231f45-d6fd-4483-8835-bd1a9e70b7c9; range_end:; response_count:1; response_revision:5333; }","duration":"332.325323ms","start":"2026-10-15T19:12:27.98167Z","end":"2026-10-15T19:12:28.313995Z","steps":["trace[2104520554] 'agreement among raft nodes before linearized reading' (duration: 332.21001ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:12:28.314033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:12:27.981457Z","time spent":"332.569948ms","remote":"127.0.0.1:44678","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3623,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-03231f45-d6fd-4483-8835-bd1a9e70b7c9\" "} {"level":"info","ts":"2026-10-15T19:12:28.313972Z","caller":"traceutil/trace.go:171","msg":"trace[2114591973] transaction","detail":"{read_only:false; response_revision:5333; number_of_response:1; }","duration":"442.12131ms","start":"2026-10-15T19:12:27.871723Z","end":"2026-10-15T19:12:28.313844Z","steps":["trace[2114591973] 'process raft request' (duration: 441.840363ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:12:28.3142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.769815ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-15T19:12:28.314181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"407.192993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-03231f45-d6fd-4483-8835-bd1a9e70b7c9\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-10-15T19:12:28.314291Z","caller":"traceutil/trace.go:171","msg":"trace[99483322] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5333; }","duration":"204.919278ms","start":"2026-10-15T19:12:28.109354Z","end":"2026-10-15T19:12:28.314273Z","steps":["trace[99483322] 'agreement among raft nodes before linearized reading' (duration: 204.756474ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:12:28.314312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.987678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-10-15T19:12:28.31435Z","caller":"traceutil/trace.go:171","msg":"trace[724179537] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-03231f45-d6fd-4483-8835-bd1a9e70b7c9; range_end:; response_count:1; response_revision:5333; }","duration":"407.443539ms","start":"2026-10-15T19:12:27.906871Z","end":"2026-10-15T19:12:28.314315Z","steps":["trace[724179537] 'agreement among raft nodes before linearized reading' (duration: 407.004469ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:12:28.314198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.532479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-10-15T19:12:28.314414Z","caller":"traceutil/trace.go:171","msg":"trace[1572844408] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5333; }","duration":"158.144922ms","start":"2026-10-15T19:12:28.156243Z","end":"2026-10-15T19:12:28.314388Z","steps":["trace[1572844408] 'agreement among raft nodes before linearized reading' (duration: 157.812024ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:12:28.314432Z","caller":"traceutil/trace.go:171","msg":"trace[725577043] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5333; }","duration":"130.810816ms","start":"2026-10-15T19:12:28.183601Z","end":"2026-10-15T19:12:28.314412Z","steps":["trace[725577043] 'agreement among raft nodes before linearized reading' (duration: 130.331044ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:12:28.314443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:12:27.906846Z","time spent":"407.568483ms","remote":"127.0.0.1:44678","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3623,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-03231f45-d6fd-4483-8835-bd1a9e70b7c9\" "} {"level":"warn","ts":"2026-10-15T19:12:28.31424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:12:27.871666Z","time spent":"442.437667ms","remote":"127.0.0.1:44674","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18196,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T19:12:28.314469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.622819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-fbn6c-tls\" ","response":"range_response_count:1 size:2184"} {"level":"info","ts":"2026-10-15T19:12:28.314567Z","caller":"traceutil/trace.go:171","msg":"trace[868294420] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-fbn6c-tls; range_end:; response_count:1; response_revision:5333; }","duration":"143.786373ms","start":"2026-10-15T19:12:28.170758Z","end":"2026-10-15T19:12:28.314545Z","steps":["trace[868294420] 'agreement among raft nodes before linearized reading' (duration: 143.447075ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:12:30.293468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.086001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T19:12:30.29361Z","caller":"traceutil/trace.go:171","msg":"trace[1779284858] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5371; }","duration":"183.295736ms","start":"2026-10-15T19:12:30.110285Z","end":"2026-10-15T19:12:30.293581Z","steps":["trace[1779284858] 'range keys from in-memory index tree' (duration: 182.993929ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:12:43.64564Z","caller":"traceutil/trace.go:171","msg":"trace[1425495234] transaction","detail":"{read_only:false; response_revision:5605; number_of_response:1; }","duration":"105.66856ms","start":"2026-10-15T19:12:43.539936Z","end":"2026-10-15T19:12:43.645604Z","steps":["trace[1425495234] 'process raft request' (duration: 77.989975ms)","trace[1425495234] 'compare' (duration: 27.523421ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T19:12:44.146677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.140877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/probes/\" range_end:\"/registry/monitoring.coreos.com/probes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T19:12:44.146805Z","caller":"traceutil/trace.go:171","msg":"trace[234884526] range","detail":"{range_begin:/registry/monitoring.coreos.com/probes/; range_end:/registry/monitoring.coreos.com/probes0; response_count:0; response_revision:5606; }","duration":"258.343872ms","start":"2026-10-15T19:12:43.888438Z","end":"2026-10-15T19:12:44.146782Z","steps":["trace[234884526] 'count revisions from in-memory index tree' (duration: 258.035134ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:12:44.146925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.564788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T19:12:44.147042Z","caller":"traceutil/trace.go:171","msg":"trace[996842084] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:5606; }","duration":"209.757612ms","start":"2026-10-15T19:12:43.937263Z","end":"2026-10-15T19:12:44.147021Z","steps":["trace[996842084] 'count revisions from in-memory index tree' (duration: 209.483375ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:12:51.55878Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2976} {"level":"info","ts":"2026-10-15T19:12:51.655506Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2976,"took":"95.10314ms","hash":2234936239,"current-db-size-bytes":56283136,"current-db-size":"56 MB","current-db-size-in-use-bytes":31956992,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-15T19:12:51.655581Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2234936239,"revision":2976,"compact-revision":-1} {"level":"warn","ts":"2026-10-15T19:12:51.978499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.643367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-10-15T19:12:51.978575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.072927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-10-15T19:12:51.978604Z","caller":"traceutil/trace.go:171","msg":"trace[2112454463] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:5775; }","duration":"159.844981ms","start":"2026-10-15T19:12:51.818735Z","end":"2026-10-15T19:12:51.97858Z","steps":["trace[2112454463] 'count revisions from in-memory index tree' (duration: 159.414931ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:12:51.978615Z","caller":"traceutil/trace.go:171","msg":"trace[2011045804] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5775; }","duration":"130.18666ms","start":"2026-10-15T19:12:51.848417Z","end":"2026-10-15T19:12:51.978603Z","steps":["trace[2011045804] 'range keys from in-memory index tree' (duration: 129.866312ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:12:52.231262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.219275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T19:12:52.231367Z","caller":"traceutil/trace.go:171","msg":"trace[252997067] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5776; }","duration":"123.40481ms","start":"2026-10-15T19:12:52.107941Z","end":"2026-10-15T19:12:52.231346Z","steps":["trace[252997067] 'range keys from in-memory index tree' (duration: 122.493328ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:12:52.43652Z","caller":"traceutil/trace.go:171","msg":"trace[1694805677] linearizableReadLoop","detail":"{readStateIndex:6002; appliedIndex:6001; }","duration":"118.960844ms","start":"2026-10-15T19:12:52.317522Z","end":"2026-10-15T19:12:52.436483Z","steps":["trace[1694805677] 'read index received' (duration: 118.710778ms)","trace[1694805677] 'applied index is now lower than readState.Index' (duration: 248.516µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:12:52.436623Z","caller":"traceutil/trace.go:171","msg":"trace[878279758] transaction","detail":"{read_only:false; response_revision:5777; number_of_response:1; }","duration":"120.139542ms","start":"2026-10-15T19:12:52.316439Z","end":"2026-10-15T19:12:52.436579Z","steps":["trace[878279758] 'process raft request' (duration: 119.790874ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:12:52.437076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.515048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-03231f45-d6fd-4483-8835-bd1a9e70b7c9\" ","response":"range_response_count:1 size:1275"} {"level":"info","ts":"2026-10-15T19:12:52.437208Z","caller":"traceutil/trace.go:171","msg":"trace[1136207556] range","detail":"{range_begin:/registry/persistentvolumes/pvc-03231f45-d6fd-4483-8835-bd1a9e70b7c9; range_end:; response_count:1; response_revision:5777; }","duration":"119.717792ms","start":"2026-10-15T19:12:52.31745Z","end":"2026-10-15T19:12:52.437168Z","steps":["trace[1136207556] 'agreement among raft nodes before linearized reading' (duration: 119.19561ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:12:52.620545Z","caller":"traceutil/trace.go:171","msg":"trace[1232028064] transaction","detail":"{read_only:false; response_revision:5780; number_of_response:1; }","duration":"137.898272ms","start":"2026-10-15T19:12:52.482588Z","end":"2026-10-15T19:12:52.620486Z","steps":["trace[1232028064] 'process raft request' (duration: 136.285924ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:12:52.620569Z","caller":"traceutil/trace.go:171","msg":"trace[677261658] transaction","detail":"{read_only:false; response_revision:5781; number_of_response:1; }","duration":"137.850871ms","start":"2026-10-15T19:12:52.482672Z","end":"2026-10-15T19:12:52.620522Z","steps":["trace[677261658] 'process raft request' (duration: 137.670107ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:12:52.620973Z","caller":"traceutil/trace.go:171","msg":"trace[2058620532] linearizableReadLoop","detail":"{readStateIndex:6010; appliedIndex:6004; }","duration":"114.353755ms","start":"2026-10-15T19:12:52.506603Z","end":"2026-10-15T19:12:52.620957Z","steps":["trace[2058620532] 'read index received' (duration: 3.173085ms)","trace[2058620532] 'applied index is now lower than readState.Index' (duration: 111.17914ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:12:52.621094Z","caller":"traceutil/trace.go:171","msg":"trace[187072366] transaction","detail":"{read_only:false; response_revision:5785; number_of_response:1; }","duration":"115.723938ms","start":"2026-10-15T19:12:52.50536Z","end":"2026-10-15T19:12:52.621083Z","steps":["trace[187072366] 'process raft request' (duration: 115.471122ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:12:52.62123Z","caller":"traceutil/trace.go:171","msg":"trace[868017329] transaction","detail":"{read_only:false; response_revision:5784; number_of_response:1; }","duration":"136.683324ms","start":"2026-10-15T19:12:52.484505Z","end":"2026-10-15T19:12:52.621189Z","steps":["trace[868017329] 'process raft request' (duration: 136.007598ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:12:52.620669Z","caller":"traceutil/trace.go:171","msg":"trace[1950614581] transaction","detail":"{read_only:false; response_revision:5782; number_of_response:1; }","duration":"137.479332ms","start":"2026-10-15T19:12:52.483178Z","end":"2026-10-15T19:12:52.620657Z","steps":["trace[1950614581] 'process raft request' (duration: 137.222096ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:12:52.620653Z","caller":"traceutil/trace.go:171","msg":"trace[8161157] transaction","detail":"{read_only:false; response_revision:5783; number_of_response:1; }","duration":"137.328089ms","start":"2026-10-15T19:12:52.483299Z","end":"2026-10-15T19:12:52.620627Z","steps":["trace[8161157] 'process raft request' (duration: 137.166616ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:12:52.621617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.973469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-10-15T19:12:52.62162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.607541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-10-15T19:12:52.621703Z","caller":"traceutil/trace.go:171","msg":"trace[1746330054] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:5785; }","duration":"115.130893ms","start":"2026-10-15T19:12:52.506549Z","end":"2026-10-15T19:12:52.62168Z","steps":["trace[1746330054] 'agreement among raft nodes before linearized reading' (duration: 114.954619ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:12:52.621727Z","caller":"traceutil/trace.go:171","msg":"trace[1131748518] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5785; }","duration":"111.760184ms","start":"2026-10-15T19:12:52.509939Z","end":"2026-10-15T19:12:52.621699Z","steps":["trace[1131748518] 'agreement among raft nodes before linearized reading' (duration: 111.444206ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:17:51.565494Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5767} {"level":"info","ts":"2026-10-15T19:17:51.658688Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5767,"took":"90.686936ms","hash":345393320,"current-db-size-bytes":56283136,"current-db-size":"56 MB","current-db-size-in-use-bytes":26763264,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-10-15T19:17:51.658764Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":345393320,"revision":5767,"compact-revision":2976} {"level":"info","ts":"2026-10-15T19:19:09.726708Z","caller":"traceutil/trace.go:171","msg":"trace[397191257] linearizableReadLoop","detail":"{readStateIndex:8991; appliedIndex:8990; }","duration":"165.022392ms","start":"2026-10-15T19:19:09.561657Z","end":"2026-10-15T19:19:09.726679Z","steps":["trace[397191257] 'read index received' (duration: 164.881748ms)","trace[397191257] 'applied index is now lower than readState.Index' (duration: 139.574µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:19:09.726812Z","caller":"traceutil/trace.go:171","msg":"trace[666508514] transaction","detail":"{read_only:false; response_revision:8675; number_of_response:1; }","duration":"350.829913ms","start":"2026-10-15T19:19:09.375953Z","end":"2026-10-15T19:19:09.726783Z","steps":["trace[666508514] 'process raft request' (duration: 350.523056ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:19:09.726924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.221147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T19:19:09.727007Z","caller":"traceutil/trace.go:171","msg":"trace[1015176236] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:8675; }","duration":"165.37258ms","start":"2026-10-15T19:19:09.561613Z","end":"2026-10-15T19:19:09.726986Z","steps":["trace[1015176236] 'agreement among raft nodes before linearized reading' (duration: 165.220346ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:19:09.727367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:19:09.375921Z","time spent":"351.11912ms","remote":"127.0.0.1:44768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T19:19:21.51249Z","caller":"traceutil/trace.go:171","msg":"trace[2864490] transaction","detail":"{read_only:false; response_revision:8736; number_of_response:1; }","duration":"291.2377ms","start":"2026-10-15T19:19:21.221223Z","end":"2026-10-15T19:19:21.51246Z","steps":["trace[2864490] 'process raft request' (duration: 291.046015ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:19:21.584463Z","caller":"traceutil/trace.go:171","msg":"trace[877373845] transaction","detail":"{read_only:false; response_revision:8737; number_of_response:1; }","duration":"348.951828ms","start":"2026-10-15T19:19:21.235477Z","end":"2026-10-15T19:19:21.584429Z","steps":["trace[877373845] 'process raft request' (duration: 340.605881ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:19:21.584672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:19:21.235449Z","time spent":"349.102701ms","remote":"127.0.0.1:44768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T19:19:22.333837Z","caller":"traceutil/trace.go:171","msg":"trace[783846585] transaction","detail":"{read_only:false; response_revision:8739; number_of_response:1; }","duration":"117.33447ms","start":"2026-10-15T19:19:22.216467Z","end":"2026-10-15T19:19:22.333801Z","steps":["trace[783846585] 'process raft request' (duration: 117.112564ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:19:22.389524Z","caller":"traceutil/trace.go:171","msg":"trace[2079280551] transaction","detail":"{read_only:false; response_revision:8740; number_of_response:1; }","duration":"152.837235ms","start":"2026-10-15T19:19:22.23666Z","end":"2026-10-15T19:19:22.389497Z","steps":["trace[2079280551] 'process raft request' (duration: 152.683671ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:19:23.266885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.332405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T19:19:23.26703Z","caller":"traceutil/trace.go:171","msg":"trace[1627049554] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8746; }","duration":"161.505699ms","start":"2026-10-15T19:19:23.105488Z","end":"2026-10-15T19:19:23.266993Z","steps":["trace[1627049554] 'range keys from in-memory index tree' (duration: 161.217592ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:19:23.267245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.553435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-qq85s\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-10-15T19:19:23.267342Z","caller":"traceutil/trace.go:171","msg":"trace[597965785] range","detail":"{range_begin:/registry/pods/openstack/keepalived-qq85s; range_end:; response_count:1; response_revision:8746; }","duration":"100.717889ms","start":"2026-10-15T19:19:23.1666Z","end":"2026-10-15T19:19:23.267318Z","steps":["trace[597965785] 'range keys from in-memory index tree' (duration: 100.32752ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:19:51.643281Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15752079946993574606,"retry-timeout":"500ms"} {"level":"info","ts":"2026-10-15T19:19:51.846366Z","caller":"traceutil/trace.go:171","msg":"trace[1536121271] linearizableReadLoop","detail":"{readStateIndex:9275; appliedIndex:9274; }","duration":"703.198992ms","start":"2026-10-15T19:19:51.143137Z","end":"2026-10-15T19:19:51.846336Z","steps":["trace[1536121271] 'read index received' (duration: 702.983407ms)","trace[1536121271] 'applied index is now lower than readState.Index' (duration: 213.995µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:19:51.846501Z","caller":"traceutil/trace.go:171","msg":"trace[1883641244] transaction","detail":"{read_only:false; response_revision:8948; number_of_response:1; }","duration":"705.295772ms","start":"2026-10-15T19:19:51.141191Z","end":"2026-10-15T19:19:51.846487Z","steps":["trace[1883641244] 'process raft request' (duration: 704.935673ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:19:51.846629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:19:51.141173Z","time spent":"705.357603ms","remote":"127.0.0.1:44768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T19:19:51.846711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"703.56134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-10-15T19:19:51.846795Z","caller":"traceutil/trace.go:171","msg":"trace[1245864865] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8948; }","duration":"703.687033ms","start":"2026-10-15T19:19:51.143086Z","end":"2026-10-15T19:19:51.846773Z","steps":["trace[1245864865] 'agreement among raft nodes before linearized reading' (duration: 703.496409ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:19:51.846837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:19:51.143056Z","time spent":"703.773096ms","remote":"127.0.0.1:44768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":576,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-10-15T19:19:51.849808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.735447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-15T19:19:51.84991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"632.225863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/barbican-api-5b74bbb79c-jqn46.18deca20291f0fcd\" ","response":"range_response_count:1 size:1135"} {"level":"info","ts":"2026-10-15T19:19:51.849987Z","caller":"traceutil/trace.go:171","msg":"trace[331315812] range","detail":"{range_begin:/registry/events/openstack/barbican-api-5b74bbb79c-jqn46.18deca20291f0fcd; range_end:; response_count:1; response_revision:8949; }","duration":"632.320894ms","start":"2026-10-15T19:19:51.217642Z","end":"2026-10-15T19:19:51.849963Z","steps":["trace[331315812] 'agreement among raft nodes before linearized reading' (duration: 632.114139ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:19:51.849968Z","caller":"traceutil/trace.go:171","msg":"trace[197302846] transaction","detail":"{read_only:false; response_revision:8949; number_of_response:1; }","duration":"149.692681ms","start":"2026-10-15T19:19:51.700223Z","end":"2026-10-15T19:19:51.849915Z","steps":["trace[197302846] 'process raft request' (duration: 149.285992ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:19:51.850034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:19:51.217629Z","time spent":"632.396016ms","remote":"127.0.0.1:44572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":1157,"request content":"key:\"/registry/events/openstack/barbican-api-5b74bbb79c-jqn46.18deca20291f0fcd\" "} {"level":"warn","ts":"2026-10-15T19:19:51.850031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.654116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-qq85s\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-10-15T19:19:51.849917Z","caller":"traceutil/trace.go:171","msg":"trace[804995283] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8949; }","duration":"346.85706ms","start":"2026-10-15T19:19:51.503039Z","end":"2026-10-15T19:19:51.849896Z","steps":["trace[804995283] 'agreement among raft nodes before linearized reading' (duration: 346.690796ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:19:51.850111Z","caller":"traceutil/trace.go:171","msg":"trace[715203753] range","detail":"{range_begin:/registry/pods/openstack/keepalived-qq85s; range_end:; response_count:1; response_revision:8949; }","duration":"403.762608ms","start":"2026-10-15T19:19:51.446332Z","end":"2026-10-15T19:19:51.850095Z","steps":["trace[715203753] 'agreement among raft nodes before linearized reading' (duration: 403.594244ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:19:51.850156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:19:51.446316Z","time spent":"403.82829ms","remote":"127.0.0.1:44678","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6546,"request content":"key:\"/registry/pods/openstack/keepalived-qq85s\" "} {"level":"warn","ts":"2026-10-15T19:19:51.850208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:19:51.503Z","time spent":"347.146716ms","remote":"127.0.0.1:44498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-15T19:19:51.850293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"690.619326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-10-15T19:19:51.85101Z","caller":"traceutil/trace.go:171","msg":"trace[1119611915] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8949; }","duration":"691.626009ms","start":"2026-10-15T19:19:51.159361Z","end":"2026-10-15T19:19:51.850987Z","steps":["trace[1119611915] 'agreement among raft nodes before linearized reading' (duration: 690.461532ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:19:51.851147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:19:51.159352Z","time spent":"691.778113ms","remote":"127.0.0.1:44768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-10-15T19:19:51.850608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"695.863819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-10-15T19:19:51.851313Z","caller":"traceutil/trace.go:171","msg":"trace[267448553] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8949; }","duration":"696.604287ms","start":"2026-10-15T19:19:51.154687Z","end":"2026-10-15T19:19:51.851291Z","steps":["trace[267448553] 'agreement among raft nodes before linearized reading' (duration: 694.985848ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:19:51.851368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:19:51.154665Z","time spent":"696.687429ms","remote":"127.0.0.1:44768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-10-15T19:20:00.655314Z","caller":"traceutil/trace.go:171","msg":"trace[372062414] linearizableReadLoop","detail":"{readStateIndex:9326; appliedIndex:9325; }","duration":"121.826786ms","start":"2026-10-15T19:20:00.533461Z","end":"2026-10-15T19:20:00.655288Z","steps":["trace[372062414] 'read index received' (duration: 121.642761ms)","trace[372062414] 'applied index is now lower than readState.Index' (duration: 182.664µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:20:00.655394Z","caller":"traceutil/trace.go:171","msg":"trace[1927924025] transaction","detail":"{read_only:false; response_revision:8997; number_of_response:1; }","duration":"128.578524ms","start":"2026-10-15T19:20:00.526784Z","end":"2026-10-15T19:20:00.655362Z","steps":["trace[1927924025] 'process raft request' (duration: 128.350239ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:20:00.655523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.04409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-10-15T19:20:00.655555Z","caller":"traceutil/trace.go:171","msg":"trace[1009580680] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8997; }","duration":"122.122843ms","start":"2026-10-15T19:20:00.533422Z","end":"2026-10-15T19:20:00.655545Z","steps":["trace[1009580680] 'agreement among raft nodes before linearized reading' (duration: 121.957889ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:20:00.762851Z","caller":"traceutil/trace.go:171","msg":"trace[686950462] transaction","detail":"{read_only:false; response_revision:8998; number_of_response:1; }","duration":"102.161533ms","start":"2026-10-15T19:20:00.660663Z","end":"2026-10-15T19:20:00.762824Z","steps":["trace[686950462] 'process raft request' (duration: 101.938278ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:20:01.289333Z","caller":"traceutil/trace.go:171","msg":"trace[716874919] linearizableReadLoop","detail":"{readStateIndex:9329; appliedIndex:9328; }","duration":"104.869197ms","start":"2026-10-15T19:20:01.184441Z","end":"2026-10-15T19:20:01.28931Z","steps":["trace[716874919] 'read index received' (duration: 104.699853ms)","trace[716874919] 'applied index is now lower than readState.Index' (duration: 168.084µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:20:01.289462Z","caller":"traceutil/trace.go:171","msg":"trace[1896608958] transaction","detail":"{read_only:false; response_revision:8999; number_of_response:1; }","duration":"148.267078ms","start":"2026-10-15T19:20:01.141147Z","end":"2026-10-15T19:20:01.289414Z","steps":["trace[1896608958] 'process raft request' (duration: 148.011512ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:20:01.289724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.266356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-10-15T19:20:01.289783Z","caller":"traceutil/trace.go:171","msg":"trace[1371419117] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8999; }","duration":"105.376859ms","start":"2026-10-15T19:20:01.18439Z","end":"2026-10-15T19:20:01.289767Z","steps":["trace[1371419117] 'agreement among raft nodes before linearized reading' (duration: 105.048821ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:20:01.451475Z","caller":"traceutil/trace.go:171","msg":"trace[618731872] linearizableReadLoop","detail":"{readStateIndex:9330; appliedIndex:9329; }","duration":"157.368932ms","start":"2026-10-15T19:20:01.294075Z","end":"2026-10-15T19:20:01.451444Z","steps":["trace[618731872] 'read index received' (duration: 88.237996ms)","trace[618731872] 'applied index is now lower than readState.Index' (duration: 69.129646ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:20:01.451654Z","caller":"traceutil/trace.go:171","msg":"trace[1674777312] transaction","detail":"{read_only:false; response_revision:9000; number_of_response:1; }","duration":"158.786765ms","start":"2026-10-15T19:20:01.292849Z","end":"2026-10-15T19:20:01.451636Z","steps":["trace[1674777312] 'process raft request' (duration: 89.519136ms)","trace[1674777312] 'compare' (duration: 68.89343ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T19:20:01.452017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.916415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-10-15T19:20:01.452108Z","caller":"traceutil/trace.go:171","msg":"trace[400367683] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:9000; }","duration":"158.088448ms","start":"2026-10-15T19:20:01.294003Z","end":"2026-10-15T19:20:01.452092Z","steps":["trace[400367683] 'agreement among raft nodes before linearized reading' (duration: 157.827772ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:20:05.463152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.224916ms","expected-duration":"100ms","prefix":"","request":"header: txn: success: > failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-15T19:20:05.463274Z","caller":"traceutil/trace.go:171","msg":"trace[211520229] linearizableReadLoop","detail":"{readStateIndex:9361; appliedIndex:9360; }","duration":"157.900155ms","start":"2026-10-15T19:20:05.305352Z","end":"2026-10-15T19:20:05.463252Z","steps":["trace[211520229] 'read index received' (duration: 9.287149ms)","trace[211520229] 'applied index is now lower than readState.Index' (duration: 148.611156ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:20:05.463367Z","caller":"traceutil/trace.go:171","msg":"trace[20016072] transaction","detail":"{read_only:false; number_of_response:1; response_revision:9030; }","duration":"158.135879ms","start":"2026-10-15T19:20:05.305188Z","end":"2026-10-15T19:20:05.463324Z","steps":["trace[20016072] 'compare' (duration: 148.095183ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:20:05.463571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.209192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-n7mkn\" ","response":"range_response_count:1 size:4668"} {"level":"warn","ts":"2026-10-15T19:20:05.46359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.13833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-n7mkn\" ","response":"range_response_count:1 size:4668"} {"level":"warn","ts":"2026-10-15T19:20:05.463622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.14711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-n7mkn\" ","response":"range_response_count:1 size:4668"} {"level":"info","ts":"2026-10-15T19:20:05.46363Z","caller":"traceutil/trace.go:171","msg":"trace[2003533295] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-n7mkn; range_end:; response_count:1; response_revision:9030; }","duration":"158.301403ms","start":"2026-10-15T19:20:05.305312Z","end":"2026-10-15T19:20:05.463613Z","steps":["trace[2003533295] 'agreement among raft nodes before linearized reading' (duration: 158.080268ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:20:05.463638Z","caller":"traceutil/trace.go:171","msg":"trace[1199065785] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-n7mkn; range_end:; response_count:1; response_revision:9030; }","duration":"158.215302ms","start":"2026-10-15T19:20:05.305409Z","end":"2026-10-15T19:20:05.463624Z","steps":["trace[1199065785] 'agreement among raft nodes before linearized reading' (duration: 158.031837ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:20:05.463648Z","caller":"traceutil/trace.go:171","msg":"trace[761429536] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-n7mkn; range_end:; response_count:1; response_revision:9030; }","duration":"158.186341ms","start":"2026-10-15T19:20:05.305453Z","end":"2026-10-15T19:20:05.463639Z","steps":["trace[761429536] 'agreement among raft nodes before linearized reading' (duration: 158.116769ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:20:05.463665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.561929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-10-15T19:20:05.463717Z","caller":"traceutil/trace.go:171","msg":"trace[776651919] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:9030; }","duration":"155.684682ms","start":"2026-10-15T19:20:05.308019Z","end":"2026-10-15T19:20:05.463704Z","steps":["trace[776651919] 'agreement among raft nodes before linearized reading' (duration: 155.549229ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:20:05.653518Z","caller":"traceutil/trace.go:171","msg":"trace[1901018440] transaction","detail":"{read_only:false; number_of_response:1; response_revision:9033; }","duration":"181.271164ms","start":"2026-10-15T19:20:05.472224Z","end":"2026-10-15T19:20:05.653495Z","steps":["trace[1901018440] 'process raft request' (duration: 181.234263ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:20:05.653664Z","caller":"traceutil/trace.go:171","msg":"trace[584638383] transaction","detail":"{read_only:false; number_of_response:1; response_revision:9032; }","duration":"183.65965ms","start":"2026-10-15T19:20:05.469935Z","end":"2026-10-15T19:20:05.653594Z","steps":["trace[584638383] 'process raft request' (duration: 146.899876ms)","trace[584638383] 'compare' (duration: 36.389516ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:20:05.653752Z","caller":"traceutil/trace.go:171","msg":"trace[1428626720] transaction","detail":"{read_only:false; response_revision:9033; number_of_response:1; }","duration":"181.916589ms","start":"2026-10-15T19:20:05.471802Z","end":"2026-10-15T19:20:05.653719Z","steps":["trace[1428626720] 'process raft request' (duration: 181.590872ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:20:05.84463Z","caller":"traceutil/trace.go:171","msg":"trace[890163454] linearizableReadLoop","detail":"{readStateIndex:9366; appliedIndex:9365; }","duration":"182.592826ms","start":"2026-10-15T19:20:05.662012Z","end":"2026-10-15T19:20:05.844605Z","steps":["trace[890163454] 'read index received' (duration: 182.302419ms)","trace[890163454] 'applied index is now lower than readState.Index' (duration: 289.467µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:20:05.844732Z","caller":"traceutil/trace.go:171","msg":"trace[990126282] transaction","detail":"{read_only:false; response_revision:9034; number_of_response:1; }","duration":"184.781476ms","start":"2026-10-15T19:20:05.659894Z","end":"2026-10-15T19:20:05.844676Z","steps":["trace[990126282] 'process raft request' (duration: 184.50347ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:20:05.844756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.716399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-n7mkn\" ","response":"range_response_count:1 size:4653"} {"level":"info","ts":"2026-10-15T19:20:05.844802Z","caller":"traceutil/trace.go:171","msg":"trace[1360122526] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-n7mkn; range_end:; response_count:1; response_revision:9034; }","duration":"182.81669ms","start":"2026-10-15T19:20:05.661975Z","end":"2026-10-15T19:20:05.844792Z","steps":["trace[1360122526] 'agreement among raft nodes before linearized reading' (duration: 182.722058ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:20:07.707126Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000024c4.wal"} {"level":"info","ts":"2026-10-15T19:20:18.406435Z","caller":"traceutil/trace.go:171","msg":"trace[499878744] transaction","detail":"{read_only:false; response_revision:9165; number_of_response:1; }","duration":"132.208ms","start":"2026-10-15T19:20:18.2742Z","end":"2026-10-15T19:20:18.406408Z","steps":["trace[499878744] 'process raft request' (duration: 121.115839ms)","trace[499878744] 'compare' (duration: 10.980469ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:21:05.373884Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"4b019b7871d5da9a","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-15T19:21:05.383169Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-10-15T19:21:05.383309Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-10-15T19:21:30.174277Z","caller":"traceutil/trace.go:171","msg":"trace[1668999774] transaction","detail":"{read_only:false; response_revision:9855; number_of_response:1; }","duration":"195.486607ms","start":"2026-10-15T19:21:29.978473Z","end":"2026-10-15T19:21:30.17396Z","steps":["trace[1668999774] 'process raft request' (duration: 195.058336ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:21:30.373317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.345336ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-10-15T19:22:51.573209Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8032} {"level":"info","ts":"2026-10-15T19:22:51.661412Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8032,"took":"85.73297ms","hash":3473141568,"current-db-size-bytes":56283136,"current-db-size":"56 MB","current-db-size-in-use-bytes":24907776,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-10-15T19:22:51.661497Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3473141568,"revision":8032,"compact-revision":5767} {"level":"warn","ts":"2026-10-15T19:25:19.526304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.66324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-user\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-15T19:25:19.526335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.985355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-15T19:25:19.526389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.592258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-storage-init\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-15T19:25:19.526443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.255078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-endpoints\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T19:25:19.52647Z","caller":"traceutil/trace.go:171","msg":"trace[5846375] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-endpoints; range_end:; response_count:0; response_revision:11734; }","duration":"105.331829ms","start":"2026-10-15T19:25:19.42113Z","end":"2026-10-15T19:25:19.526462Z","steps":["trace[5846375] 'range keys from in-memory index tree' (duration: 105.119405ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:25:19.526475Z","caller":"traceutil/trace.go:171","msg":"trace[464350054] range","detail":"{range_begin:/registry/jobs/openstack/cinder-storage-init; range_end:; response_count:0; response_revision:11734; }","duration":"103.747081ms","start":"2026-10-15T19:25:19.422705Z","end":"2026-10-15T19:25:19.526452Z","steps":["trace[464350054] 'range keys from in-memory index tree' (duration: 103.496876ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:25:19.526477Z","caller":"traceutil/trace.go:171","msg":"trace[1702553362] range","detail":"{range_begin:/registry/jobs/openstack/cinder-rabbit-init; range_end:; response_count:0; response_revision:11734; }","duration":"106.18322ms","start":"2026-10-15T19:25:19.42026Z","end":"2026-10-15T19:25:19.526443Z","steps":["trace[1702553362] 'range keys from in-memory index tree' (duration: 105.7627ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:25:19.526401Z","caller":"traceutil/trace.go:171","msg":"trace[286083535] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-user; range_end:; response_count:0; response_revision:11734; }","duration":"103.817993ms","start":"2026-10-15T19:25:19.422563Z","end":"2026-10-15T19:25:19.526381Z","steps":["trace[286083535] 'range keys from in-memory index tree' (duration: 103.561438ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:25:19.526822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.511672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/cinder-api\" ","response":"range_response_count:1 size:668"} {"level":"info","ts":"2026-10-15T19:25:19.526922Z","caller":"traceutil/trace.go:171","msg":"trace[176489161] range","detail":"{range_begin:/registry/services/endpoints/openstack/cinder-api; range_end:; response_count:1; response_revision:11734; }","duration":"102.639655ms","start":"2026-10-15T19:25:19.424259Z","end":"2026-10-15T19:25:19.526898Z","steps":["trace[176489161] 'range keys from in-memory index tree' (duration: 102.309988ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:27:51.581481Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10426} {"level":"info","ts":"2026-10-15T19:27:51.671086Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10426,"took":"87.131661ms","hash":162744564,"current-db-size-bytes":56283136,"current-db-size":"56 MB","current-db-size-in-use-bytes":27910144,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-15T19:27:51.671163Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":162744564,"revision":10426,"compact-revision":8032} {"level":"warn","ts":"2026-10-15T19:31:04.524418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.5869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-10-15T19:31:04.524513Z","caller":"traceutil/trace.go:171","msg":"trace[1366399711] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:14097; }","duration":"172.743264ms","start":"2026-10-15T19:31:04.351751Z","end":"2026-10-15T19:31:04.524494Z","steps":["trace[1366399711] 'range keys from in-memory index tree' (duration: 172.353745ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:31:29.896512Z","caller":"traceutil/trace.go:171","msg":"trace[541320627] transaction","detail":"{read_only:false; response_revision:14237; number_of_response:1; }","duration":"151.440629ms","start":"2026-10-15T19:31:29.745043Z","end":"2026-10-15T19:31:29.896484Z","steps":["trace[541320627] 'process raft request' (duration: 151.279725ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:31:38.798899Z","caller":"traceutil/trace.go:171","msg":"trace[1761172196] transaction","detail":"{read_only:false; response_revision:14281; number_of_response:1; }","duration":"105.454302ms","start":"2026-10-15T19:31:38.693422Z","end":"2026-10-15T19:31:38.798877Z","steps":["trace[1761172196] 'process raft request' (duration: 105.226007ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:31:47.137564Z","caller":"traceutil/trace.go:171","msg":"trace[210967106] transaction","detail":"{read_only:false; response_revision:14335; number_of_response:1; }","duration":"498.08565ms","start":"2026-10-15T19:31:46.639452Z","end":"2026-10-15T19:31:47.137538Z","steps":["trace[210967106] 'process raft request' (duration: 497.921376ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:31:47.137727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:31:46.639419Z","time spent":"498.228924ms","remote":"127.0.0.1:44678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12483,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T19:31:47.138486Z","caller":"traceutil/trace.go:171","msg":"trace[635614793] linearizableReadLoop","detail":"{readStateIndex:14838; appliedIndex:14838; }","duration":"455.017703ms","start":"2026-10-15T19:31:46.683422Z","end":"2026-10-15T19:31:47.13844Z","steps":["trace[635614793] 'read index received' (duration: 455.003482ms)","trace[635614793] 'applied index is now lower than readState.Index' (duration: 11.531µs)"],"step_count":2} {"level":"warn","ts":"2026-10-15T19:31:47.138693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.30639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-15T19:31:47.138785Z","caller":"traceutil/trace.go:171","msg":"trace[1489136705] range","detail":"{range_begin:/registry/cert-manager.io/certificates/; range_end:/registry/cert-manager.io/certificates0; response_count:0; response_revision:14335; }","duration":"455.445343ms","start":"2026-10-15T19:31:46.683318Z","end":"2026-10-15T19:31:47.138763Z","steps":["trace[1489136705] 'agreement among raft nodes before linearized reading' (duration: 455.237488ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:31:47.138829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:31:46.683306Z","time spent":"455.513735ms","remote":"127.0.0.1:49592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":17,"response size":29,"request content":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" count_only:true "} {"level":"info","ts":"2026-10-15T19:31:47.155823Z","caller":"traceutil/trace.go:171","msg":"trace[630061004] transaction","detail":"{read_only:false; response_revision:14336; number_of_response:1; }","duration":"331.454102ms","start":"2026-10-15T19:31:46.824343Z","end":"2026-10-15T19:31:47.155797Z","steps":["trace[630061004] 'process raft request' (duration: 331.289658ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:31:47.156155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.725408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-10-15T19:31:47.156239Z","caller":"traceutil/trace.go:171","msg":"trace[1842086482] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:14337; }","duration":"182.82839ms","start":"2026-10-15T19:31:46.97337Z","end":"2026-10-15T19:31:47.156198Z","steps":["trace[1842086482] 'agreement among raft nodes before linearized reading' (duration: 182.646906ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:31:47.156187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:31:46.824322Z","time spent":"331.613236ms","remote":"127.0.0.1:44768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T19:31:47.156317Z","caller":"traceutil/trace.go:171","msg":"trace[281865955] transaction","detail":"{read_only:false; response_revision:14337; number_of_response:1; }","duration":"152.836041ms","start":"2026-10-15T19:31:47.003454Z","end":"2026-10-15T19:31:47.15629Z","steps":["trace[281865955] 'process raft request' (duration: 152.305929ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:31:47.156651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.086121ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0\" ","response":"range_response_count:1 size:1633"} {"level":"info","ts":"2026-10-15T19:31:47.156696Z","caller":"traceutil/trace.go:171","msg":"trace[1531144723] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0; range_end:; response_count:1; response_revision:14337; }","duration":"242.167393ms","start":"2026-10-15T19:31:46.914516Z","end":"2026-10-15T19:31:47.156684Z","steps":["trace[1531144723] 'agreement among raft nodes before linearized reading' (duration: 242.05388ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:31:47.157008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.058507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-10-15T19:31:47.157104Z","caller":"traceutil/trace.go:171","msg":"trace[1478426873] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:14337; }","duration":"255.21249ms","start":"2026-10-15T19:31:46.901869Z","end":"2026-10-15T19:31:47.157081Z","steps":["trace[1478426873] 'agreement among raft nodes before linearized reading' (duration: 255.001645ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:31:57.667011Z","caller":"traceutil/trace.go:171","msg":"trace[355854390] linearizableReadLoop","detail":"{readStateIndex:15020; appliedIndex:15019; }","duration":"266.61741ms","start":"2026-10-15T19:31:57.40037Z","end":"2026-10-15T19:31:57.666987Z","steps":["trace[355854390] 'read index received' (duration: 197.507367ms)","trace[355854390] 'applied index is now lower than readState.Index' (duration: 69.108663ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:31:57.667032Z","caller":"traceutil/trace.go:171","msg":"trace[1319639529] transaction","detail":"{read_only:false; response_revision:14513; number_of_response:1; }","duration":"292.777348ms","start":"2026-10-15T19:31:57.374227Z","end":"2026-10-15T19:31:57.667004Z","steps":["trace[1319639529] 'process raft request' (duration: 223.592193ms)","trace[1319639529] 'compare' (duration: 68.802596ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T19:31:57.667217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.818034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-10-15T19:31:57.667242Z","caller":"traceutil/trace.go:171","msg":"trace[1199578872] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:14513; }","duration":"266.936388ms","start":"2026-10-15T19:31:57.400299Z","end":"2026-10-15T19:31:57.667235Z","steps":["trace[1199578872] 'agreement among raft nodes before linearized reading' (duration: 266.770504ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:32:51.590351Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12760} {"level":"info","ts":"2026-10-15T19:32:51.672648Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12760,"took":"77.911282ms","hash":4208872884,"current-db-size-bytes":56283136,"current-db-size":"56 MB","current-db-size-in-use-bytes":31174656,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-15T19:32:51.672708Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4208872884,"revision":12760,"compact-revision":10426} {"level":"info","ts":"2026-10-15T19:33:06.778678Z","caller":"traceutil/trace.go:171","msg":"trace[764738639] linearizableReadLoop","detail":"{readStateIndex:15994; appliedIndex:15993; }","duration":"153.664442ms","start":"2026-10-15T19:33:06.624987Z","end":"2026-10-15T19:33:06.778651Z","steps":["trace[764738639] 'read index received' (duration: 153.501308ms)","trace[764738639] 'applied index is now lower than readState.Index' (duration: 162.144µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:33:06.778725Z","caller":"traceutil/trace.go:171","msg":"trace[689162434] transaction","detail":"{read_only:false; response_revision:15457; number_of_response:1; }","duration":"160.281628ms","start":"2026-10-15T19:33:06.618411Z","end":"2026-10-15T19:33:06.778693Z","steps":["trace[689162434] 'process raft request' (duration: 160.087203ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:33:06.778876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.873206ms","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-10-15T19:33:06.778922Z","caller":"traceutil/trace.go:171","msg":"trace[2072505112] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:15457; }","duration":"153.957919ms","start":"2026-10-15T19:33:06.624947Z","end":"2026-10-15T19:33:06.778905Z","steps":["trace[2072505112] 'agreement among raft nodes before linearized reading' (duration: 153.804495ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:33:30.500288Z","caller":"traceutil/trace.go:171","msg":"trace[84371202] transaction","detail":"{read_only:false; response_revision:15582; number_of_response:1; }","duration":"138.330928ms","start":"2026-10-15T19:33:30.361939Z","end":"2026-10-15T19:33:30.50027Z","steps":["trace[84371202] 'process raft request' (duration: 138.180674ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:33:30.675072Z","caller":"traceutil/trace.go:171","msg":"trace[1203631523] transaction","detail":"{read_only:false; response_revision:15583; number_of_response:1; }","duration":"309.576305ms","start":"2026-10-15T19:33:30.365457Z","end":"2026-10-15T19:33:30.675033Z","steps":["trace[1203631523] 'process raft request' (duration: 264.208222ms)","trace[1203631523] 'compare' (duration: 45.102566ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:33:30.675197Z","caller":"traceutil/trace.go:171","msg":"trace[498991412] linearizableReadLoop","detail":"{readStateIndex:16124; appliedIndex:16122; }","duration":"221.601576ms","start":"2026-10-15T19:33:30.453549Z","end":"2026-10-15T19:33:30.67515Z","steps":["trace[498991412] 'read index received' (duration: 46.602871ms)","trace[498991412] 'applied index is now lower than readState.Index' (duration: 174.990655ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T19:33:30.675485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:33:30.36545Z","time spent":"309.716758ms","remote":"127.0.0.1:44768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T19:33:30.747556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.811881ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-10-15T19:33:30.747604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.51946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"} {"level":"warn","ts":"2026-10-15T19:33:30.747643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.083289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:667"} {"level":"info","ts":"2026-10-15T19:33:30.747682Z","caller":"traceutil/trace.go:171","msg":"trace[573501554] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:15583; }","duration":"210.983586ms","start":"2026-10-15T19:33:30.536665Z","end":"2026-10-15T19:33:30.747649Z","steps":["trace[573501554] 'agreement among raft nodes before linearized reading' (duration: 210.680568ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:33:30.747709Z","caller":"traceutil/trace.go:171","msg":"trace[1755246424] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15583; }","duration":"129.662093ms","start":"2026-10-15T19:33:30.618022Z","end":"2026-10-15T19:33:30.747685Z","steps":["trace[1755246424] 'agreement among raft nodes before linearized reading' (duration: 129.303505ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:33:30.747731Z","caller":"traceutil/trace.go:171","msg":"trace[714162896] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15583; }","duration":"294.225602ms","start":"2026-10-15T19:33:30.453488Z","end":"2026-10-15T19:33:30.747714Z","steps":["trace[714162896] 'agreement among raft nodes before linearized reading' (duration: 221.843632ms)","trace[714162896] 'range keys from in-memory index tree' (duration: 72.022742ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:33:31.801238Z","caller":"traceutil/trace.go:171","msg":"trace[1295621385] transaction","detail":"{read_only:false; response_revision:15586; number_of_response:1; }","duration":"120.072698ms","start":"2026-10-15T19:33:31.681139Z","end":"2026-10-15T19:33:31.801212Z","steps":["trace[1295621385] 'process raft request' (duration: 119.914134ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:33:31.801812Z","caller":"traceutil/trace.go:171","msg":"trace[706642273] linearizableReadLoop","detail":"{readStateIndex:16128; appliedIndex:16128; }","duration":"118.543382ms","start":"2026-10-15T19:33:31.683256Z","end":"2026-10-15T19:33:31.801799Z","steps":["trace[706642273] 'read index received' (duration: 118.535361ms)","trace[706642273] 'applied index is now lower than readState.Index' (duration: 6.861µs)"],"step_count":2} {"level":"warn","ts":"2026-10-15T19:33:31.801992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.719125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T19:33:31.802096Z","caller":"traceutil/trace.go:171","msg":"trace[1772953389] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15586; }","duration":"118.836908ms","start":"2026-10-15T19:33:31.683244Z","end":"2026-10-15T19:33:31.802081Z","steps":["trace[1772953389] 'agreement among raft nodes before linearized reading' (duration: 118.688535ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:33:31.80216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.884889ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:667"} {"level":"info","ts":"2026-10-15T19:33:31.802269Z","caller":"traceutil/trace.go:171","msg":"trace[1847906305] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15586; }","duration":"119.038163ms","start":"2026-10-15T19:33:31.6832Z","end":"2026-10-15T19:33:31.802238Z","steps":["trace[1847906305] 'agreement among raft nodes before linearized reading' (duration: 118.707065ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:33:31.811416Z","caller":"traceutil/trace.go:171","msg":"trace[415304105] transaction","detail":"{read_only:false; response_revision:15587; number_of_response:1; }","duration":"127.767809ms","start":"2026-10-15T19:33:31.683624Z","end":"2026-10-15T19:33:31.811392Z","steps":["trace[415304105] 'process raft request' (duration: 127.501573ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:33:31.811433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.948284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"} {"level":"info","ts":"2026-10-15T19:33:31.811558Z","caller":"traceutil/trace.go:171","msg":"trace[1540562234] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15587; }","duration":"128.101157ms","start":"2026-10-15T19:33:31.683444Z","end":"2026-10-15T19:33:31.811545Z","steps":["trace[1540562234] 'agreement among raft nodes before linearized reading' (duration: 127.853941ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:37:51.597793Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15284} {"level":"info","ts":"2026-10-15T19:37:51.700551Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15284,"took":"98.607328ms","hash":520780786,"current-db-size-bytes":56283136,"current-db-size":"56 MB","current-db-size-in-use-bytes":31547392,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-15T19:37:51.700618Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":520780786,"revision":15284,"compact-revision":12760} {"level":"warn","ts":"2026-10-15T19:39:20.012423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.803659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-10-15T19:39:20.012492Z","caller":"traceutil/trace.go:171","msg":"trace[670204326] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:18213; }","duration":"459.915732ms","start":"2026-10-15T19:39:19.552562Z","end":"2026-10-15T19:39:20.012478Z","steps":["trace[670204326] 'range keys from in-memory index tree' (duration: 459.634375ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:39:20.012518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:39:19.552538Z","time spent":"459.975184ms","remote":"127.0.0.1:44768","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-10-15T19:39:20.01307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.674248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-10-15T19:39:20.013162Z","caller":"traceutil/trace.go:171","msg":"trace[1713682730] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:18213; }","duration":"412.814912ms","start":"2026-10-15T19:39:19.600325Z","end":"2026-10-15T19:39:20.013139Z","steps":["trace[1713682730] 'range keys from in-memory index tree' (duration: 412.482553ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:39:20.013203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:39:19.600294Z","time spent":"412.899153ms","remote":"127.0.0.1:44768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-10-15T19:39:20.013499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.530304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-cc876e67-7fc9-4781-83e2-28eb52893077\" ","response":"range_response_count:1 size:3946"} {"level":"info","ts":"2026-10-15T19:39:20.013578Z","caller":"traceutil/trace.go:171","msg":"trace[911938216] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-cc876e67-7fc9-4781-83e2-28eb52893077; range_end:; response_count:1; response_revision:18213; }","duration":"276.668277ms","start":"2026-10-15T19:39:19.736888Z","end":"2026-10-15T19:39:20.013556Z","steps":["trace[911938216] 'range keys from in-memory index tree' (duration: 276.338469ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:39:20.020374Z","caller":"traceutil/trace.go:171","msg":"trace[1691529235] transaction","detail":"{read_only:false; response_revision:18214; number_of_response:1; }","duration":"239.964247ms","start":"2026-10-15T19:39:19.780394Z","end":"2026-10-15T19:39:20.020359Z","steps":["trace[1691529235] 'process raft request' (duration: 239.837154ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:41:24.171959Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"4b019b7871d5da9a","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-15T19:41:24.182673Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-10-15T19:41:24.182809Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-10-15T19:42:51.607167Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17519} {"level":"info","ts":"2026-10-15T19:42:51.71692Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17519,"took":"106.314304ms","hash":3379985438,"current-db-size-bytes":56283136,"current-db-size":"56 MB","current-db-size-in-use-bytes":34951168,"current-db-size-in-use":"35 MB"} {"level":"info","ts":"2026-10-15T19:42:51.716987Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3379985438,"revision":17519,"compact-revision":15284} {"level":"info","ts":"2026-10-15T19:44:35.491634Z","caller":"traceutil/trace.go:171","msg":"trace[1563508895] transaction","detail":"{read_only:false; response_revision:20676; number_of_response:1; }","duration":"101.745814ms","start":"2026-10-15T19:44:35.389859Z","end":"2026-10-15T19:44:35.491605Z","steps":["trace[1563508895] 'process raft request' (duration: 101.55003ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:44:52.234585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.453966ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-15T19:44:52.234678Z","caller":"traceutil/trace.go:171","msg":"trace[565332307] linearizableReadLoop","detail":"{readStateIndex:21471; appliedIndex:21470; }","duration":"124.017047ms","start":"2026-10-15T19:44:52.110646Z","end":"2026-10-15T19:44:52.234663Z","steps":["trace[565332307] 'read index received' (duration: 37.541µs)","trace[565332307] 'applied index is now lower than readState.Index' (duration: 123.978436ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T19:44:52.234751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.102929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-15T19:44:52.23478Z","caller":"traceutil/trace.go:171","msg":"trace[1357831625] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:20760; }","duration":"124.163601ms","start":"2026-10-15T19:44:52.110607Z","end":"2026-10-15T19:44:52.234771Z","steps":["trace[1357831625] 'agreement among raft nodes before linearized reading' (duration: 124.094269ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:44:52.23507Z","caller":"traceutil/trace.go:171","msg":"trace[300505449] transaction","detail":"{read_only:false; response_revision:20760; number_of_response:1; }","duration":"369.954421ms","start":"2026-10-15T19:44:51.865101Z","end":"2026-10-15T19:44:52.235055Z","steps":["trace[300505449] 'process raft request' (duration: 178.960992ms)","trace[300505449] 'compare' (duration: 189.870963ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T19:44:52.23513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:44:51.865084Z","time spent":"370.015863ms","remote":"127.0.0.1:44768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T19:44:52.596244Z","caller":"traceutil/trace.go:171","msg":"trace[1117422411] transaction","detail":"{read_only:false; response_revision:20761; number_of_response:1; }","duration":"270.584413ms","start":"2026-10-15T19:44:52.325639Z","end":"2026-10-15T19:44:52.596223Z","steps":["trace[1117422411] 'process raft request' (duration: 270.4358ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:44:52.966641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.71287ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-15T19:44:52.966804Z","caller":"traceutil/trace.go:171","msg":"trace[967917352] transaction","detail":"{read_only:false; response_revision:20763; number_of_response:1; }","duration":"206.285625ms","start":"2026-10-15T19:44:52.7605Z","end":"2026-10-15T19:44:52.966785Z","steps":["trace[967917352] 'process raft request' (duration: 206.232684ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:44:52.966894Z","caller":"traceutil/trace.go:171","msg":"trace[514887831] transaction","detail":"{read_only:false; response_revision:20762; number_of_response:1; }","duration":"622.544204ms","start":"2026-10-15T19:44:52.34428Z","end":"2026-10-15T19:44:52.966825Z","steps":["trace[514887831] 'process raft request' (duration: 373.557007ms)","trace[514887831] 'compare' (duration: 248.474815ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:44:52.967047Z","caller":"traceutil/trace.go:171","msg":"trace[885421164] linearizableReadLoop","detail":"{readStateIndex:21473; appliedIndex:21471; }","duration":"616.755596ms","start":"2026-10-15T19:44:52.350146Z","end":"2026-10-15T19:44:52.966901Z","steps":["trace[885421164] 'read index received' (duration: 245.909753ms)","trace[885421164] 'applied index is now lower than readState.Index' (duration: 370.842213ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T19:44:52.96722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"617.064523ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"warn","ts":"2026-10-15T19:44:52.967234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:44:52.344261Z","time spent":"622.757569ms","remote":"127.0.0.1:44768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T19:44:52.967294Z","caller":"traceutil/trace.go:171","msg":"trace[1109929741] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:20763; }","duration":"617.149465ms","start":"2026-10-15T19:44:52.350108Z","end":"2026-10-15T19:44:52.967257Z","steps":["trace[1109929741] 'agreement among raft nodes before linearized reading' (duration: 616.969031ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:44:52.967329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:44:52.350092Z","time spent":"617.228977ms","remote":"127.0.0.1:44768","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-10-15T19:44:52.977447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"626.265624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-10-15T19:44:52.977467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.120947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-15T19:44:52.977491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.893526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/cinder-api-648c9c976c-crfq4.18deca9736555614\" ","response":"range_response_count:1 size:1178"} {"level":"info","ts":"2026-10-15T19:44:52.977546Z","caller":"traceutil/trace.go:171","msg":"trace[631041345] range","detail":"{range_begin:/registry/events/openstack/cinder-api-648c9c976c-crfq4.18deca9736555614; range_end:; response_count:1; response_revision:20764; }","duration":"429.986508ms","start":"2026-10-15T19:44:52.547544Z","end":"2026-10-15T19:44:52.977531Z","steps":["trace[631041345] 'agreement among raft nodes before linearized reading' (duration: 429.842345ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:44:52.977586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"526.708051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-15T19:44:52.977499Z","caller":"traceutil/trace.go:171","msg":"trace[457299032] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:20764; }","duration":"626.345665ms","start":"2026-10-15T19:44:52.351143Z","end":"2026-10-15T19:44:52.977488Z","steps":["trace[457299032] 'agreement among raft nodes before linearized reading' (duration: 626.200202ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:44:52.977611Z","caller":"traceutil/trace.go:171","msg":"trace[720740732] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:20764; }","duration":"526.769223ms","start":"2026-10-15T19:44:52.450832Z","end":"2026-10-15T19:44:52.977601Z","steps":["trace[720740732] 'agreement among raft nodes before linearized reading' (duration: 526.734072ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:44:52.977638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:44:52.450813Z","time spent":"526.817384ms","remote":"127.0.0.1:46600","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true "} {"level":"warn","ts":"2026-10-15T19:44:52.977636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:44:52.351132Z","time spent":"626.490559ms","remote":"127.0.0.1:44768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-10-15T19:44:52.977657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.545692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-10-15T19:44:52.977683Z","caller":"traceutil/trace.go:171","msg":"trace[2072830453] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:20764; }","duration":"415.590583ms","start":"2026-10-15T19:44:52.562084Z","end":"2026-10-15T19:44:52.977675Z","steps":["trace[2072830453] 'agreement among raft nodes before linearized reading' (duration: 415.517352ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:44:52.977704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:44:52.562073Z","time spent":"415.625064ms","remote":"127.0.0.1:44768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-10-15T19:44:52.97755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.00034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/objectbucket.io/objectbucketclaims/\" range_end:\"/registry/objectbucket.io/objectbucketclaims0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-15T19:44:52.977819Z","caller":"traceutil/trace.go:171","msg":"trace[1369168627] range","detail":"{range_begin:/registry/objectbucket.io/objectbucketclaims/; range_end:/registry/objectbucket.io/objectbucketclaims0; response_count:0; response_revision:20764; }","duration":"456.278416ms","start":"2026-10-15T19:44:52.521519Z","end":"2026-10-15T19:44:52.977798Z","steps":["trace[1369168627] 'agreement among raft nodes before linearized reading' (duration: 456.00345ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:44:52.977831Z","caller":"traceutil/trace.go:171","msg":"trace[1607601073] transaction","detail":"{read_only:false; response_revision:20764; number_of_response:1; }","duration":"217.184816ms","start":"2026-10-15T19:44:52.760631Z","end":"2026-10-15T19:44:52.977816Z","steps":["trace[1607601073] 'process raft request' (duration: 216.622422ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:44:52.977872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:44:52.521508Z","time spent":"456.344748ms","remote":"127.0.0.1:32974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/objectbucket.io/objectbucketclaims/\" range_end:\"/registry/objectbucket.io/objectbucketclaims0\" count_only:true "} {"level":"warn","ts":"2026-10-15T19:44:52.977585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:44:52.547523Z","time spent":"430.054879ms","remote":"127.0.0.1:44572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":1,"response size":1200,"request content":"key:\"/registry/events/openstack/cinder-api-648c9c976c-crfq4.18deca9736555614\" "} {"level":"info","ts":"2026-10-15T19:44:52.977545Z","caller":"traceutil/trace.go:171","msg":"trace[792382035] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:20764; }","duration":"238.25498ms","start":"2026-10-15T19:44:52.73927Z","end":"2026-10-15T19:44:52.977525Z","steps":["trace[792382035] 'agreement among raft nodes before linearized reading' (duration: 238.114427ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:44:53.17019Z","caller":"traceutil/trace.go:171","msg":"trace[559250682] transaction","detail":"{read_only:false; response_revision:20765; number_of_response:1; }","duration":"197.595068ms","start":"2026-10-15T19:44:52.972567Z","end":"2026-10-15T19:44:53.170162Z","steps":["trace[559250682] 'process raft request' (duration: 172.677672ms)","trace[559250682] 'compare' (duration: 24.798723ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T19:44:53.286477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:44:52.9805Z","time spent":"305.9582ms","remote":"127.0.0.1:44572","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-10-15T19:44:53.28661Z","caller":"traceutil/trace.go:171","msg":"trace[462583038] transaction","detail":"{read_only:false; response_revision:20766; number_of_response:1; }","duration":"304.622478ms","start":"2026-10-15T19:44:52.981964Z","end":"2026-10-15T19:44:53.286587Z","steps":["trace[462583038] 'process raft request' (duration: 304.420754ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:44:53.286765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:44:52.981952Z","time spent":"304.739581ms","remote":"127.0.0.1:44768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T19:44:53.286974Z","caller":"traceutil/trace.go:171","msg":"trace[1489196495] transaction","detail":"{read_only:false; response_revision:20767; number_of_response:1; }","duration":"304.987007ms","start":"2026-10-15T19:44:52.981969Z","end":"2026-10-15T19:44:53.286956Z","steps":["trace[1489196495] 'process raft request' (duration: 304.573327ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:44:53.28708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:44:52.981946Z","time spent":"305.076739ms","remote":"127.0.0.1:44768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T19:44:53.287046Z","caller":"traceutil/trace.go:171","msg":"trace[2143818563] transaction","detail":"{read_only:false; response_revision:20768; number_of_response:1; }","duration":"304.170358ms","start":"2026-10-15T19:44:52.982844Z","end":"2026-10-15T19:44:53.287014Z","steps":["trace[2143818563] 'process raft request' (duration: 303.942342ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:44:53.28726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:44:52.982815Z","time spent":"304.324022ms","remote":"127.0.0.1:44768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T19:44:53.287378Z","caller":"traceutil/trace.go:171","msg":"trace[1602339290] transaction","detail":"{read_only:false; response_revision:20769; number_of_response:1; }","duration":"225.101346ms","start":"2026-10-15T19:44:53.062188Z","end":"2026-10-15T19:44:53.287289Z","steps":["trace[1602339290] 'process raft request' (duration: 224.735778ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:47:51.621624Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19948} {"level":"info","ts":"2026-10-15T19:47:51.743584Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19948,"took":"118.11889ms","hash":3300255936,"current-db-size-bytes":56283136,"current-db-size":"56 MB","current-db-size-in-use-bytes":30621696,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-15T19:47:51.743635Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3300255936,"revision":19948,"compact-revision":17519} {"level":"info","ts":"2026-10-15T19:48:51.922477Z","caller":"traceutil/trace.go:171","msg":"trace[312543307] transaction","detail":"{read_only:false; response_revision:23244; number_of_response:1; }","duration":"156.271763ms","start":"2026-10-15T19:48:51.766179Z","end":"2026-10-15T19:48:51.922451Z","steps":["trace[312543307] 'process raft request' (duration: 156.082579ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:48:52.404855Z","caller":"traceutil/trace.go:171","msg":"trace[1135326100] linearizableReadLoop","detail":"{readStateIndex:24035; appliedIndex:24034; }","duration":"431.217361ms","start":"2026-10-15T19:48:51.973609Z","end":"2026-10-15T19:48:52.404826Z","steps":["trace[1135326100] 'read index received' (duration: 431.111598ms)","trace[1135326100] 'applied index is now lower than readState.Index' (duration: 104.473µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:48:52.404912Z","caller":"traceutil/trace.go:171","msg":"trace[918609459] transaction","detail":"{read_only:false; response_revision:23245; number_of_response:1; }","duration":"439.929424ms","start":"2026-10-15T19:48:51.964954Z","end":"2026-10-15T19:48:52.404883Z","steps":["trace[918609459] 'process raft request' (duration: 439.695379ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:48:52.405172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.55211ms","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-10-15T19:48:52.405233Z","caller":"traceutil/trace.go:171","msg":"trace[126234423] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-glance-server-0; range_end:; response_count:1; response_revision:23245; }","duration":"431.659872ms","start":"2026-10-15T19:48:51.973557Z","end":"2026-10-15T19:48:52.405217Z","steps":["trace[126234423] 'agreement among raft nodes before linearized reading' (duration: 431.450236ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:48:52.405275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:48:51.973537Z","time spent":"431.730224ms","remote":"127.0.0.1:44650","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":1,"response size":1880,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-glance-server-0\" "} {"level":"warn","ts":"2026-10-15T19:48:52.405377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:48:51.96493Z","time spent":"440.219391ms","remote":"127.0.0.1:46598","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3859,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T19:48:52.409955Z","caller":"traceutil/trace.go:171","msg":"trace[1590504406] transaction","detail":"{read_only:false; response_revision:23246; number_of_response:1; }","duration":"408.998477ms","start":"2026-10-15T19:48:52.000935Z","end":"2026-10-15T19:48:52.409934Z","steps":["trace[1590504406] 'process raft request' (duration: 408.474474ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:48:52.410124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:48:52.000911Z","time spent":"409.140171ms","remote":"127.0.0.1:44768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T19:48:52.410371Z","caller":"traceutil/trace.go:171","msg":"trace[1184608844] transaction","detail":"{read_only:false; response_revision:23247; number_of_response:1; }","duration":"389.682694ms","start":"2026-10-15T19:48:52.020673Z","end":"2026-10-15T19:48:52.410356Z","steps":["trace[1184608844] 'process raft request' (duration: 388.928456ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:48:52.410457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:48:52.020647Z","time spent":"389.763936ms","remote":"127.0.0.1:44768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T19:48:52.41058Z","caller":"traceutil/trace.go:171","msg":"trace[583158436] transaction","detail":"{read_only:false; response_revision:23248; number_of_response:1; }","duration":"380.977112ms","start":"2026-10-15T19:48:52.029572Z","end":"2026-10-15T19:48:52.410549Z","steps":["trace[583158436] 'process raft request' (duration: 380.07596ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:48:52.410651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:48:52.029547Z","time spent":"381.067333ms","remote":"127.0.0.1:44768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T19:48:52.411023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.130791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-15T19:48:52.411089Z","caller":"traceutil/trace.go:171","msg":"trace[1232101152] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:23248; }","duration":"304.225754ms","start":"2026-10-15T19:48:52.106846Z","end":"2026-10-15T19:48:52.411072Z","steps":["trace[1232101152] 'agreement among raft nodes before linearized reading' (duration: 304.114641ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:48:52.411137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:48:52.106778Z","time spent":"304.348567ms","remote":"127.0.0.1:44498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-10-15T19:52:21.13588Z","caller":"traceutil/trace.go:171","msg":"trace[1841310148] linearizableReadLoop","detail":"{readStateIndex:26140; appliedIndex:26139; }","duration":"118.358474ms","start":"2026-10-15T19:52:21.017486Z","end":"2026-10-15T19:52:21.135845Z","steps":["trace[1841310148] 'read index received' (duration: 117.841381ms)","trace[1841310148] 'applied index is now lower than readState.Index' (duration: 515.963µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:52:21.135971Z","caller":"traceutil/trace.go:171","msg":"trace[1131252755] transaction","detail":"{read_only:false; response_revision:25301; number_of_response:1; }","duration":"146.496112ms","start":"2026-10-15T19:52:20.989442Z","end":"2026-10-15T19:52:21.135938Z","steps":["trace[1131252755] 'process raft request' (duration: 146.181834ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:52:21.13625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.719642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-10-15T19:52:21.136297Z","caller":"traceutil/trace.go:171","msg":"trace[277128181] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:25301; }","duration":"118.852586ms","start":"2026-10-15T19:52:21.017432Z","end":"2026-10-15T19:52:21.136285Z","steps":["trace[277128181] 'agreement among raft nodes before linearized reading' (duration: 118.59185ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:52:26.589105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.040556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterctl.cluster.x-k8s.io/providers/\" range_end:\"/registry/clusterctl.cluster.x-k8s.io/providers0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-10-15T19:52:26.589211Z","caller":"traceutil/trace.go:171","msg":"trace[148430282] range","detail":"{range_begin:/registry/clusterctl.cluster.x-k8s.io/providers/; range_end:/registry/clusterctl.cluster.x-k8s.io/providers0; response_count:0; response_revision:25352; }","duration":"152.21909ms","start":"2026-10-15T19:52:26.43696Z","end":"2026-10-15T19:52:26.589179Z","steps":["trace[148430282] 'count revisions from in-memory index tree' (duration: 151.929064ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:52:26.801606Z","caller":"traceutil/trace.go:171","msg":"trace[228293510] linearizableReadLoop","detail":"{readStateIndex:26193; appliedIndex:26192; }","duration":"136.376558ms","start":"2026-10-15T19:52:26.6652Z","end":"2026-10-15T19:52:26.801577Z","steps":["trace[228293510] 'read index received' (duration: 136.007469ms)","trace[228293510] 'applied index is now lower than readState.Index' (duration: 367.759µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:52:26.801685Z","caller":"traceutil/trace.go:171","msg":"trace[605754578] transaction","detail":"{read_only:false; response_revision:25353; number_of_response:1; }","duration":"201.883208ms","start":"2026-10-15T19:52:26.599747Z","end":"2026-10-15T19:52:26.80163Z","steps":["trace[605754578] 'process raft request' (duration: 201.595251ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:52:26.801928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.660055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-10-15T19:52:26.801978Z","caller":"traceutil/trace.go:171","msg":"trace[2061143267] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25353; }","duration":"136.817319ms","start":"2026-10-15T19:52:26.665147Z","end":"2026-10-15T19:52:26.801964Z","steps":["trace[2061143267] 'agreement among raft nodes before linearized reading' (duration: 136.580063ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:52:26.997479Z","caller":"traceutil/trace.go:171","msg":"trace[1460503924] transaction","detail":"{read_only:false; response_revision:25354; number_of_response:1; }","duration":"191.540568ms","start":"2026-10-15T19:52:26.805913Z","end":"2026-10-15T19:52:26.997453Z","steps":["trace[1460503924] 'process raft request' (duration: 189.259963ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:52:27.216043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.482476ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-15T19:52:27.216141Z","caller":"traceutil/trace.go:171","msg":"trace[783830881] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25354; }","duration":"108.63863ms","start":"2026-10-15T19:52:27.107481Z","end":"2026-10-15T19:52:27.21612Z","steps":["trace[783830881] 'range keys from in-memory index tree' (duration: 108.404963ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:52:27.554434Z","caller":"traceutil/trace.go:171","msg":"trace[1640684014] transaction","detail":"{read_only:false; response_revision:25355; number_of_response:1; }","duration":"309.426991ms","start":"2026-10-15T19:52:27.244969Z","end":"2026-10-15T19:52:27.554396Z","steps":["trace[1640684014] 'process raft request' (duration: 309.255167ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:52:27.554595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:52:27.244945Z","time spent":"309.566484ms","remote":"127.0.0.1:44768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T19:52:27.555757Z","caller":"traceutil/trace.go:171","msg":"trace[2107808695] transaction","detail":"{read_only:false; response_revision:25358; number_of_response:1; }","duration":"141.755467ms","start":"2026-10-15T19:52:27.413978Z","end":"2026-10-15T19:52:27.555733Z","steps":["trace[2107808695] 'process raft request' (duration: 141.418129ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:52:27.555743Z","caller":"traceutil/trace.go:171","msg":"trace[1837446939] transaction","detail":"{read_only:false; response_revision:25357; number_of_response:1; }","duration":"301.10053ms","start":"2026-10-15T19:52:27.254599Z","end":"2026-10-15T19:52:27.555699Z","steps":["trace[1837446939] 'process raft request' (duration: 300.730491ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:52:27.555824Z","caller":"traceutil/trace.go:171","msg":"trace[932085885] transaction","detail":"{read_only:false; response_revision:25356; number_of_response:1; }","duration":"310.069836ms","start":"2026-10-15T19:52:27.245743Z","end":"2026-10-15T19:52:27.555813Z","steps":["trace[932085885] 'process raft request' (duration: 309.443011ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:52:27.556144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:52:27.245722Z","time spent":"310.369573ms","remote":"127.0.0.1:44768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T19:52:27.556162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:52:27.254586Z","time spent":"301.407768ms","remote":"127.0.0.1:44768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T19:52:51.629613Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":22167} {"level":"info","ts":"2026-10-15T19:52:51.745219Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":22167,"took":"110.690999ms","hash":2117721043,"current-db-size-bytes":56283136,"current-db-size":"56 MB","current-db-size-in-use-bytes":45740032,"current-db-size-in-use":"46 MB"} {"level":"info","ts":"2026-10-15T19:52:51.745357Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2117721043,"revision":22167,"compact-revision":19948} {"level":"info","ts":"2026-10-15T19:53:23.730551Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006866.wal"} {"level":"info","ts":"2026-10-15T19:53:24.176239Z","caller":"traceutil/trace.go:171","msg":"trace[556215210] linearizableReadLoop","detail":"{readStateIndex:26731; appliedIndex:26730; }","duration":"140.52176ms","start":"2026-10-15T19:53:24.035682Z","end":"2026-10-15T19:53:24.176204Z","steps":["trace[556215210] 'read index received' (duration: 140.380127ms)","trace[556215210] 'applied index is now lower than readState.Index' (duration: 140.803µs)"],"step_count":2} {"level":"warn","ts":"2026-10-15T19:53:24.176369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.665614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeatures0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-10-15T19:53:24.176321Z","caller":"traceutil/trace.go:171","msg":"trace[746617690] transaction","detail":"{read_only:false; response_revision:25878; number_of_response:1; }","duration":"151.016973ms","start":"2026-10-15T19:53:24.025269Z","end":"2026-10-15T19:53:24.176286Z","steps":["trace[746617690] 'process raft request' (duration: 150.829149ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:53:24.176438Z","caller":"traceutil/trace.go:171","msg":"trace[957157694] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/; range_end:/registry/nfd.k8s-sigs.io/nodefeatures0; response_count:0; response_revision:25878; }","duration":"140.725245ms","start":"2026-10-15T19:53:24.035677Z","end":"2026-10-15T19:53:24.176402Z","steps":["trace[957157694] 'agreement among raft nodes before linearized reading' (duration: 140.644263ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:53:24.176811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.527299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-10-15T19:53:24.176991Z","caller":"traceutil/trace.go:171","msg":"trace[185877094] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25878; }","duration":"113.798895ms","start":"2026-10-15T19:53:24.063143Z","end":"2026-10-15T19:53:24.176942Z","steps":["trace[185877094] 'agreement among raft nodes before linearized reading' (duration: 113.290703ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:53:29.492905Z","caller":"traceutil/trace.go:171","msg":"trace[1370048448] transaction","detail":"{read_only:false; response_revision:25915; number_of_response:1; }","duration":"125.145149ms","start":"2026-10-15T19:53:29.367735Z","end":"2026-10-15T19:53:29.49288Z","steps":["trace[1370048448] 'process raft request' (duration: 125.005725ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:53:30.027996Z","caller":"traceutil/trace.go:171","msg":"trace[1630209621] transaction","detail":"{read_only:false; response_revision:25916; number_of_response:1; }","duration":"224.170708ms","start":"2026-10-15T19:53:29.803801Z","end":"2026-10-15T19:53:30.027972Z","steps":["trace[1630209621] 'process raft request' (duration: 224.017504ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:53:30.367005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.432662ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-15T19:53:30.367169Z","caller":"traceutil/trace.go:171","msg":"trace[899916302] transaction","detail":"{read_only:false; response_revision:25918; number_of_response:1; }","duration":"527.472475ms","start":"2026-10-15T19:53:29.83968Z","end":"2026-10-15T19:53:30.367152Z","steps":["trace[899916302] 'process raft request' (duration: 527.410013ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:53:30.367228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:53:29.839656Z","time spent":"527.543417ms","remote":"127.0.0.1:44768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T19:53:30.367278Z","caller":"traceutil/trace.go:171","msg":"trace[387284263] linearizableReadLoop","detail":"{readStateIndex:26773; appliedIndex:26769; }","duration":"452.604579ms","start":"2026-10-15T19:53:29.914647Z","end":"2026-10-15T19:53:30.367252Z","steps":["trace[387284263] 'read index received' (duration: 113.16287ms)","trace[387284263] 'applied index is now lower than readState.Index' (duration: 339.440739ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:53:30.367418Z","caller":"traceutil/trace.go:171","msg":"trace[415768554] transaction","detail":"{read_only:false; response_revision:25919; number_of_response:1; }","duration":"464.738882ms","start":"2026-10-15T19:53:29.902668Z","end":"2026-10-15T19:53:30.367407Z","steps":["trace[415768554] 'process raft request' (duration: 464.469505ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:53:30.367544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:53:29.902645Z","time spent":"464.819663ms","remote":"127.0.0.1:44768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T19:53:30.367548Z","caller":"traceutil/trace.go:171","msg":"trace[320845919] transaction","detail":"{read_only:false; response_revision:25917; number_of_response:1; }","duration":"554.090018ms","start":"2026-10-15T19:53:29.81344Z","end":"2026-10-15T19:53:30.36753Z","steps":["trace[320845919] 'process raft request' (duration: 320.033521ms)","trace[320845919] 'compare' (duration: 233.306799ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T19:53:30.367667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:53:29.81341Z","time spent":"554.22317ms","remote":"127.0.0.1:44768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T19:53:30.367792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.141862ms","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-10-15T19:53:30.368052Z","caller":"traceutil/trace.go:171","msg":"trace[27138521] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25919; }","duration":"453.437229ms","start":"2026-10-15T19:53:29.914604Z","end":"2026-10-15T19:53:30.368041Z","steps":["trace[27138521] 'agreement among raft nodes before linearized reading' (duration: 453.089071ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:53:30.368084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:53:29.914587Z","time spent":"453.48817ms","remote":"127.0.0.1:44768","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":"info","ts":"2026-10-15T19:53:30.405522Z","caller":"traceutil/trace.go:171","msg":"trace[1533358430] transaction","detail":"{read_only:false; response_revision:25920; number_of_response:1; }","duration":"126.727767ms","start":"2026-10-15T19:53:30.278767Z","end":"2026-10-15T19:53:30.405494Z","steps":["trace[1533358430] 'process raft request' (duration: 126.521312ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:53:30.405554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.708588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-10-15T19:53:30.405623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.738787ms","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-10-15T19:53:30.405612Z","caller":"traceutil/trace.go:171","msg":"trace[1776009245] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25920; }","duration":"194.80301ms","start":"2026-10-15T19:53:30.210789Z","end":"2026-10-15T19:53:30.405592Z","steps":["trace[1776009245] 'agreement among raft nodes before linearized reading' (duration: 194.658077ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:53:30.405661Z","caller":"traceutil/trace.go:171","msg":"trace[1918839944] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25920; }","duration":"201.84502ms","start":"2026-10-15T19:53:30.203804Z","end":"2026-10-15T19:53:30.405649Z","steps":["trace[1918839944] 'agreement among raft nodes before linearized reading' (duration: 201.765478ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:53:30.405738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.660279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"warn","ts":"2026-10-15T19:53:30.405772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.179742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-15T19:53:30.405795Z","caller":"traceutil/trace.go:171","msg":"trace[126447143] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25920; }","duration":"190.748092ms","start":"2026-10-15T19:53:30.215032Z","end":"2026-10-15T19:53:30.40578Z","steps":["trace[126447143] 'agreement among raft nodes before linearized reading' (duration: 190.586408ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:53:30.405801Z","caller":"traceutil/trace.go:171","msg":"trace[1259548010] range","detail":"{range_begin:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs/; range_end:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs0; response_count:0; response_revision:25920; }","duration":"203.246704ms","start":"2026-10-15T19:53:30.202545Z","end":"2026-10-15T19:53:30.405792Z","steps":["trace[1259548010] 'agreement among raft nodes before linearized reading' (duration: 203.194273ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:53:30.405834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.944955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbuckettopics/\" range_end:\"/registry/ceph.rook.io/cephbuckettopics0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-15T19:53:30.405875Z","caller":"traceutil/trace.go:171","msg":"trace[182665355] range","detail":"{range_begin:/registry/ceph.rook.io/cephbuckettopics/; range_end:/registry/ceph.rook.io/cephbuckettopics0; response_count:0; response_revision:25920; }","duration":"227.053278ms","start":"2026-10-15T19:53:30.178811Z","end":"2026-10-15T19:53:30.405864Z","steps":["trace[182665355] 'agreement among raft nodes before linearized reading' (duration: 226.960316ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:53:30.405538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.068674ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-cinder-server-0\" ","response":"range_response_count:1 size:1858"} {"level":"info","ts":"2026-10-15T19:53:30.406121Z","caller":"traceutil/trace.go:171","msg":"trace[651730055] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-cinder-server-0; range_end:; response_count:1; response_revision:25920; }","duration":"449.71993ms","start":"2026-10-15T19:53:29.956391Z","end":"2026-10-15T19:53:30.406111Z","steps":["trace[651730055] 'agreement among raft nodes before linearized reading' (duration: 448.989222ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:53:30.406172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:53:29.956371Z","time spent":"449.789921ms","remote":"127.0.0.1:44650","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":1,"response size":1880,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-cinder-server-0\" "} {"level":"info","ts":"2026-10-15T19:53:30.782573Z","caller":"traceutil/trace.go:171","msg":"trace[713082230] linearizableReadLoop","detail":"{readStateIndex:26776; appliedIndex:26774; }","duration":"373.4621ms","start":"2026-10-15T19:53:30.409096Z","end":"2026-10-15T19:53:30.782558Z","steps":["trace[713082230] 'read index received' (duration: 373.259835ms)","trace[713082230] 'applied index is now lower than readState.Index' (duration: 201.725µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:53:30.782626Z","caller":"traceutil/trace.go:171","msg":"trace[357969484] transaction","detail":"{read_only:false; response_revision:25921; number_of_response:1; }","duration":"409.708404ms","start":"2026-10-15T19:53:30.37288Z","end":"2026-10-15T19:53:30.782588Z","steps":["trace[357969484] 'process raft request' (duration: 409.505269ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:53:30.782868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:53:30.372858Z","time spent":"409.897578ms","remote":"127.0.0.1:44768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T19:53:30.782886Z","caller":"traceutil/trace.go:171","msg":"trace[1217856888] transaction","detail":"{read_only:false; response_revision:25922; number_of_response:1; }","duration":"399.463467ms","start":"2026-10-15T19:53:30.383411Z","end":"2026-10-15T19:53:30.782874Z","steps":["trace[1217856888] 'process raft request' (duration: 399.113439ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:53:30.783181Z","caller":"traceutil/trace.go:171","msg":"trace[1236113327] transaction","detail":"{read_only:false; response_revision:25924; number_of_response:1; }","duration":"373.097591ms","start":"2026-10-15T19:53:30.410074Z","end":"2026-10-15T19:53:30.783171Z","steps":["trace[1236113327] 'process raft request' (duration: 373.03213ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:53:30.783183Z","caller":"traceutil/trace.go:171","msg":"trace[1161174768] transaction","detail":"{read_only:false; response_revision:25923; number_of_response:1; }","duration":"373.270825ms","start":"2026-10-15T19:53:30.409884Z","end":"2026-10-15T19:53:30.783154Z","steps":["trace[1161174768] 'process raft request' (duration: 373.181093ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:53:30.783279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:53:30.410054Z","time spent":"373.162093ms","remote":"127.0.0.1:44768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T19:53:30.783349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:53:30.409869Z","time spent":"373.412419ms","remote":"127.0.0.1:44768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T19:53:30.783355Z","caller":"traceutil/trace.go:171","msg":"trace[1487761533] transaction","detail":"{read_only:false; response_revision:25925; number_of_response:1; }","duration":"373.174053ms","start":"2026-10-15T19:53:30.410151Z","end":"2026-10-15T19:53:30.783325Z","steps":["trace[1487761533] 'process raft request' (duration: 372.995029ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:53:30.783523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:53:30.410142Z","time spent":"373.303826ms","remote":"127.0.0.1:44768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":538,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T19:53:30.783651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.549686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-8d02b6fe-644f-4a25-97b5-b5fa8324bab1\" ","response":"range_response_count:1 size:1320"} {"level":"info","ts":"2026-10-15T19:53:30.783687Z","caller":"traceutil/trace.go:171","msg":"trace[1119862598] range","detail":"{range_begin:/registry/persistentvolumes/pvc-8d02b6fe-644f-4a25-97b5-b5fa8324bab1; range_end:; response_count:1; response_revision:25922; }","duration":"374.607848ms","start":"2026-10-15T19:53:30.40907Z","end":"2026-10-15T19:53:30.783677Z","steps":["trace[1119862598] 'agreement among raft nodes before linearized reading' (duration: 373.830009ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:53:30.783659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:53:30.383384Z","time spent":"400.237125ms","remote":"127.0.0.1:44768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T19:53:30.783707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:53:30.409051Z","time spent":"374.651368ms","remote":"127.0.0.1:44634","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":1342,"request content":"key:\"/registry/persistentvolumes/pvc-8d02b6fe-644f-4a25-97b5-b5fa8324bab1\" "} {"level":"warn","ts":"2026-10-15T19:53:30.786218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.828562ms","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-10-15T19:53:30.786274Z","caller":"traceutil/trace.go:171","msg":"trace[867902966] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinesets/; range_end:/registry/cluster.x-k8s.io/machinesets0; response_count:0; response_revision:25925; }","duration":"197.935775ms","start":"2026-10-15T19:53:30.588324Z","end":"2026-10-15T19:53:30.78626Z","steps":["trace[867902966] 'agreement among raft nodes before linearized reading' (duration: 197.852093ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:53:30.786544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.488517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-10-15T19:53:30.78658Z","caller":"traceutil/trace.go:171","msg":"trace[1953453061] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25925; }","duration":"130.551849ms","start":"2026-10-15T19:53:30.656019Z","end":"2026-10-15T19:53:30.786571Z","steps":["trace[1953453061] 'agreement among raft nodes before linearized reading' (duration: 130.452197ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:57:51.639656Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25620} {"level":"info","ts":"2026-10-15T19:57:51.805875Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25620,"took":"162.128156ms","hash":1580012908,"current-db-size-bytes":57135104,"current-db-size":"57 MB","current-db-size-in-use-bytes":36233216,"current-db-size-in-use":"36 MB"} {"level":"info","ts":"2026-10-15T19:57:51.80594Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1580012908,"revision":25620,"compact-revision":22167} {"level":"info","ts":"2026-10-15T19:59:07.805378Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"4b019b7871d5da9a","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-15T19:59:07.811368Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-10-15T19:59:07.811518Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-10-15T20:02:51.649704Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28495} {"level":"info","ts":"2026-10-15T20:02:51.801451Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28495,"took":"148.903197ms","hash":1981063038,"current-db-size-bytes":57135104,"current-db-size":"57 MB","current-db-size-in-use-bytes":31502336,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-15T20:02:51.801532Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1981063038,"revision":28495,"compact-revision":25620} {"level":"info","ts":"2026-10-15T20:07:51.662358Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30792} {"level":"info","ts":"2026-10-15T20:07:51.80481Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30792,"took":"137.764586ms","hash":181403353,"current-db-size-bytes":57135104,"current-db-size":"57 MB","current-db-size-in-use-bytes":30711808,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-15T20:07:51.804902Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":181403353,"revision":30792,"compact-revision":28495} {"level":"info","ts":"2026-10-15T20:12:51.669597Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33080} {"level":"info","ts":"2026-10-15T20:12:51.834291Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33080,"took":"159.473994ms","hash":3265784093,"current-db-size-bytes":58179584,"current-db-size":"58 MB","current-db-size-in-use-bytes":30588928,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-15T20:12:51.834592Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3265784093,"revision":33080,"compact-revision":30792} {"level":"info","ts":"2026-10-15T20:17:51.677212Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35343} {"level":"info","ts":"2026-10-15T20:17:51.821823Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35343,"took":"141.509196ms","hash":3599397606,"current-db-size-bytes":58179584,"current-db-size":"58 MB","current-db-size-in-use-bytes":32165888,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-15T20:17:51.821871Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3599397606,"revision":35343,"compact-revision":33080} {"level":"info","ts":"2026-10-15T20:20:22.634257Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"4b019b7871d5da9a","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-15T20:20:22.640498Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-10-15T20:20:22.640715Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-10-15T20:22:51.685056Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37602} {"level":"info","ts":"2026-10-15T20:22:51.817974Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37602,"took":"126.684651ms","hash":3193652253,"current-db-size-bytes":58179584,"current-db-size":"58 MB","current-db-size-in-use-bytes":33173504,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-10-15T20:22:51.818022Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3193652253,"revision":37602,"compact-revision":35343} {"level":"info","ts":"2026-10-15T20:27:51.691936Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":39879} {"level":"info","ts":"2026-10-15T20:27:51.832819Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":39879,"took":"136.84758ms","hash":1082488992,"current-db-size-bytes":58179584,"current-db-size":"58 MB","current-db-size-in-use-bytes":30912512,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-15T20:27:51.832892Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1082488992,"revision":39879,"compact-revision":37602}