{"level":"warn","ts":"2026-10-07T22:04:20.190234Z","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-07T22:04:20.190346Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.105: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.105:2380","--initial-cluster=instance=https://162.253.55.105:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.105:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.105: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-07T22:04:20.190426Z","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-07T22:04:20.190442Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.105:2380"]} {"level":"info","ts":"2026-10-07T22:04:20.190465Z","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-07T22:04:20.191295Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.105:2379"]} {"level":"info","ts":"2026-10-07T22:04:20.191416Z","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.105:2380"],"listen-peer-urls":["https://162.253.55.105:2380"],"advertise-client-urls":["https://162.253.55.105:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.105:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.105: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-07T22:04:20.193852Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.14738ms"} {"level":"info","ts":"2026-10-07T22:04:20.199353Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"15a19459cc268924","cluster-id":"9aaad1c0fc15509e"} {"level":"info","ts":"2026-10-07T22:04:20.199456Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"15a19459cc268924 switched to configuration voters=()"} {"level":"info","ts":"2026-10-07T22:04:20.199478Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"15a19459cc268924 became follower at term 0"} {"level":"info","ts":"2026-10-07T22:04:20.199488Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 15a19459cc268924 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-07T22:04:20.199501Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"15a19459cc268924 became follower at term 1"} {"level":"info","ts":"2026-10-07T22:04:20.199544Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"15a19459cc268924 switched to configuration voters=(1558690059444980004)"} {"level":"warn","ts":"2026-10-07T22:04:20.206427Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-07T22:04:20.208176Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-07T22:04:20.209764Z","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-07T22:04:20.212074Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"15a19459cc268924","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-07T22:04:20.212193Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"15a19459cc268924","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-07T22:04:20.212428Z","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-07T22:04:20.212625Z","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-07T22:04:20.212646Z","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-07T22:04:20.214401Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"15a19459cc268924 switched to configuration voters=(1558690059444980004)"} {"level":"info","ts":"2026-10-07T22:04:20.214816Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9aaad1c0fc15509e","local-member-id":"15a19459cc268924","added-peer-id":"15a19459cc268924","added-peer-peer-urls":["https://162.253.55.105:2380"]} {"level":"info","ts":"2026-10-07T22:04:20.218944Z","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-07T22:04:20.219096Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.105:2380"} {"level":"info","ts":"2026-10-07T22:04:20.219163Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.105:2380"} {"level":"info","ts":"2026-10-07T22:04:20.219318Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"15a19459cc268924","initial-advertise-peer-urls":["https://162.253.55.105:2380"],"listen-peer-urls":["https://162.253.55.105:2380"],"advertise-client-urls":["https://162.253.55.105:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.105:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-07T22:04:20.219382Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-07T22:04:20.80024Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"15a19459cc268924 is starting a new election at term 1"} {"level":"info","ts":"2026-10-07T22:04:20.800347Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"15a19459cc268924 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-07T22:04:20.800414Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"15a19459cc268924 received MsgPreVoteResp from 15a19459cc268924 at term 1"} {"level":"info","ts":"2026-10-07T22:04:20.800445Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"15a19459cc268924 became candidate at term 2"} {"level":"info","ts":"2026-10-07T22:04:20.800463Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"15a19459cc268924 received MsgVoteResp from 15a19459cc268924 at term 2"} {"level":"info","ts":"2026-10-07T22:04:20.800481Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"15a19459cc268924 became leader at term 2"} {"level":"info","ts":"2026-10-07T22:04:20.800503Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 15a19459cc268924 elected leader 15a19459cc268924 at term 2"} {"level":"info","ts":"2026-10-07T22:04:20.801937Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"15a19459cc268924","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.105:2379]}","request-path":"/0/members/15a19459cc268924/attributes","cluster-id":"9aaad1c0fc15509e","publish-timeout":"7s"} {"level":"info","ts":"2026-10-07T22:04:20.802Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-07T22:04:20.80198Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-07T22:04:20.802184Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-07T22:04:20.802429Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-07T22:04:20.802522Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-07T22:04:20.803545Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9aaad1c0fc15509e","local-member-id":"15a19459cc268924","cluster-version":"3.5"} {"level":"info","ts":"2026-10-07T22:04:20.803668Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-07T22:04:20.803703Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-07T22:04:20.806258Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.105:2379"} {"level":"info","ts":"2026-10-07T22:04:20.806487Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-07T22:04:38.923302Z","caller":"traceutil/trace.go:171","msg":"trace[509776076] transaction","detail":"{read_only:false; response_revision:416; number_of_response:1; }","duration":"142.294559ms","start":"2026-10-07T22:04:38.780976Z","end":"2026-10-07T22:04:38.92327Z","steps":["trace[509776076] 'process raft request' (duration: 141.95675ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:04:39.030465Z","caller":"traceutil/trace.go:171","msg":"trace[68725180] transaction","detail":"{read_only:false; response_revision:417; number_of_response:1; }","duration":"101.27856ms","start":"2026-10-07T22:04:38.929157Z","end":"2026-10-07T22:04:39.030436Z","steps":["trace[68725180] 'process raft request' (duration: 100.344155ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:05:03.580641Z","caller":"traceutil/trace.go:171","msg":"trace[1335598126] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"122.663374ms","start":"2026-10-07T22:05:03.457956Z","end":"2026-10-07T22:05:03.580619Z","steps":["trace[1335598126] 'process raft request' (duration: 122.50348ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:05:10.126203Z","caller":"traceutil/trace.go:171","msg":"trace[2144053326] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"287.16366ms","start":"2026-10-07T22:05:09.839014Z","end":"2026-10-07T22:05:10.126178Z","steps":["trace[2144053326] 'process raft request' (duration: 286.640235ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:05:10.787087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.918757ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-07T22:05:10.787207Z","caller":"traceutil/trace.go:171","msg":"trace[1589179038] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"485.046051ms","start":"2026-10-07T22:05:10.302141Z","end":"2026-10-07T22:05:10.787188Z","steps":["trace[1589179038] 'process raft request' (duration: 88.26951ms)","trace[1589179038] 'compare' (duration: 395.768593ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T22:05:10.787265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:05:10.302105Z","time spent":"485.131153ms","remote":"127.0.0.1:56092","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-07T22:05:25.815821Z","caller":"traceutil/trace.go:171","msg":"trace[2028956469] transaction","detail":"{read_only:false; response_revision:813; number_of_response:1; }","duration":"125.250755ms","start":"2026-10-07T22:05:25.69054Z","end":"2026-10-07T22:05:25.81579Z","steps":["trace[2028956469] 'process raft request' (duration: 125.051369ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:05:25.965439Z","caller":"traceutil/trace.go:171","msg":"trace[1105980835] transaction","detail":"{read_only:false; response_revision:814; number_of_response:1; }","duration":"144.623214ms","start":"2026-10-07T22:05:25.820787Z","end":"2026-10-07T22:05:25.96541Z","steps":["trace[1105980835] 'process raft request' (duration: 132.017424ms)","trace[1105980835] 'compare' (duration: 12.491687ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:05:55.334591Z","caller":"traceutil/trace.go:171","msg":"trace[2084723568] transaction","detail":"{read_only:false; response_revision:1212; number_of_response:1; }","duration":"181.329416ms","start":"2026-10-07T22:05:55.153234Z","end":"2026-10-07T22:05:55.334563Z","steps":["trace[2084723568] 'process raft request' (duration: 181.157382ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:06:46.002227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.910072ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-07T22:06:46.002388Z","caller":"traceutil/trace.go:171","msg":"trace[322168561] linearizableReadLoop","detail":"{readStateIndex:1973; appliedIndex:1972; }","duration":"295.691373ms","start":"2026-10-07T22:06:45.706671Z","end":"2026-10-07T22:06:46.002362Z","steps":["trace[322168561] 'read index received' (duration: 45.537155ms)","trace[322168561] 'applied index is now lower than readState.Index' (duration: 250.151798ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:06:46.002568Z","caller":"traceutil/trace.go:171","msg":"trace[443141865] transaction","detail":"{read_only:false; response_revision:1901; number_of_response:1; }","duration":"320.222366ms","start":"2026-10-07T22:06:45.682294Z","end":"2026-10-07T22:06:46.002516Z","steps":["trace[443141865] 'process raft request' (duration: 69.899882ms)","trace[443141865] 'compare' (duration: 249.746307ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T22:06:46.00266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.993752ms","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-07T22:06:46.0027Z","caller":"traceutil/trace.go:171","msg":"trace[1808474081] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1901; }","duration":"296.077595ms","start":"2026-10-07T22:06:45.70661Z","end":"2026-10-07T22:06:46.002688Z","steps":["trace[1808474081] 'agreement among raft nodes before linearized reading' (duration: 295.869239ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:06:46.002733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.664131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" ","response":"range_response_count:1 size:10668"} {"level":"warn","ts":"2026-10-07T22:06:46.002724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.899494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-07T22:06:46.002812Z","caller":"traceutil/trace.go:171","msg":"trace[1881633991] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-haproxy-0; range_end:; response_count:1; response_revision:1901; }","duration":"223.807976ms","start":"2026-10-07T22:06:45.778985Z","end":"2026-10-07T22:06:46.002793Z","steps":["trace[1881633991] 'agreement among raft nodes before linearized reading' (duration: 223.62105ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:06:46.002856Z","caller":"traceutil/trace.go:171","msg":"trace[1328254499] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1901; }","duration":"271.051639ms","start":"2026-10-07T22:06:45.731755Z","end":"2026-10-07T22:06:46.002807Z","steps":["trace[1328254499] 'agreement among raft nodes before linearized reading' (duration: 270.810462ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:06:46.002911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:06:45.682273Z","time spent":"320.413412ms","remote":"127.0.0.1:56174","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-07T22:06:46.158869Z","caller":"traceutil/trace.go:171","msg":"trace[426979437] transaction","detail":"{read_only:false; response_revision:1903; number_of_response:1; }","duration":"142.738468ms","start":"2026-10-07T22:06:46.016101Z","end":"2026-10-07T22:06:46.15884Z","steps":["trace[426979437] 'process raft request' (duration: 104.52932ms)","trace[426979437] 'compare' (duration: 38.042823ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:06:46.35857Z","caller":"traceutil/trace.go:171","msg":"trace[877431615] transaction","detail":"{read_only:false; response_revision:1905; number_of_response:1; }","duration":"191.643978ms","start":"2026-10-07T22:06:46.166889Z","end":"2026-10-07T22:06:46.358533Z","steps":["trace[877431615] 'process raft request' (duration: 191.530365ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:06:46.358572Z","caller":"traceutil/trace.go:171","msg":"trace[1471007286] transaction","detail":"{read_only:false; response_revision:1904; number_of_response:1; }","duration":"191.655338ms","start":"2026-10-07T22:06:46.166889Z","end":"2026-10-07T22:06:46.358544Z","steps":["trace[1471007286] 'process raft request' (duration: 170.500162ms)","trace[1471007286] 'compare' (duration: 20.840327ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:06:46.362063Z","caller":"traceutil/trace.go:171","msg":"trace[2072441702] transaction","detail":"{read_only:false; response_revision:1907; number_of_response:1; }","duration":"195.123026ms","start":"2026-10-07T22:06:46.166915Z","end":"2026-10-07T22:06:46.362038Z","steps":["trace[2072441702] 'process raft request' (duration: 195.006213ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:06:46.362067Z","caller":"traceutil/trace.go:171","msg":"trace[1642445797] transaction","detail":"{read_only:false; response_revision:1906; number_of_response:1; }","duration":"195.109606ms","start":"2026-10-07T22:06:46.166924Z","end":"2026-10-07T22:06:46.362033Z","steps":["trace[1642445797] 'process raft request' (duration: 194.846478ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:06:46.362432Z","caller":"traceutil/trace.go:171","msg":"trace[1938658978] transaction","detail":"{read_only:false; response_revision:1909; number_of_response:1; }","duration":"186.967076ms","start":"2026-10-07T22:06:46.175449Z","end":"2026-10-07T22:06:46.362416Z","steps":["trace[1938658978] 'process raft request' (duration: 186.828582ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:06:46.362486Z","caller":"traceutil/trace.go:171","msg":"trace[1473239954] transaction","detail":"{read_only:false; response_revision:1908; number_of_response:1; }","duration":"194.287353ms","start":"2026-10-07T22:06:46.168178Z","end":"2026-10-07T22:06:46.362465Z","steps":["trace[1473239954] 'process raft request' (duration: 193.798809ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:07:30.75947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.270639ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-07T22:07:30.759887Z","caller":"traceutil/trace.go:171","msg":"trace[1068420773] transaction","detail":"{read_only:false; response_revision:2200; number_of_response:1; }","duration":"134.066404ms","start":"2026-10-07T22:07:30.625548Z","end":"2026-10-07T22:07:30.759614Z","steps":["trace[1068420773] 'process raft request' (duration: 17.531398ms)","trace[1068420773] 'compare' (duration: 116.084813ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T22:07:36.63514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.567084ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-07T22:07:36.635455Z","caller":"traceutil/trace.go:171","msg":"trace[84580959] transaction","detail":"{read_only:false; response_revision:2229; number_of_response:1; }","duration":"278.013363ms","start":"2026-10-07T22:07:36.357409Z","end":"2026-10-07T22:07:36.635422Z","steps":["trace[84580959] 'process raft request' (duration: 30.066938ms)","trace[84580959] 'compare' (duration: 247.324158ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:07:36.635486Z","caller":"traceutil/trace.go:171","msg":"trace[961007121] linearizableReadLoop","detail":"{readStateIndex:2314; appliedIndex:2311; }","duration":"120.384962ms","start":"2026-10-07T22:07:36.515083Z","end":"2026-10-07T22:07:36.635468Z","steps":["trace[961007121] 'read index received' (duration: 65.421µs)","trace[961007121] 'applied index is now lower than readState.Index' (duration: 120.318161ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:07:36.635597Z","caller":"traceutil/trace.go:171","msg":"trace[68378937] transaction","detail":"{read_only:false; response_revision:2230; number_of_response:1; }","duration":"273.669791ms","start":"2026-10-07T22:07:36.361913Z","end":"2026-10-07T22:07:36.635583Z","steps":["trace[68378937] 'process raft request' (duration: 273.370693ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:07:36.635824Z","caller":"traceutil/trace.go:171","msg":"trace[1493211194] transaction","detail":"{read_only:false; response_revision:2231; number_of_response:1; }","duration":"256.234056ms","start":"2026-10-07T22:07:36.379518Z","end":"2026-10-07T22:07:36.635752Z","steps":["trace[1493211194] 'process raft request' (duration: 255.847315ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:07:36.635821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.707052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-07T22:07:36.635964Z","caller":"traceutil/trace.go:171","msg":"trace[1035148630] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2231; }","duration":"120.909767ms","start":"2026-10-07T22:07:36.515023Z","end":"2026-10-07T22:07:36.635932Z","steps":["trace[1035148630] 'agreement among raft nodes before linearized reading' (duration: 120.66833ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:08:27.865331Z","caller":"traceutil/trace.go:171","msg":"trace[1588302113] transaction","detail":"{read_only:false; response_revision:2680; number_of_response:1; }","duration":"103.712352ms","start":"2026-10-07T22:08:27.761601Z","end":"2026-10-07T22:08:27.865313Z","steps":["trace[1588302113] 'process raft request' (duration: 103.646531ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:08:27.865357Z","caller":"traceutil/trace.go:171","msg":"trace[1731185655] transaction","detail":"{read_only:false; response_revision:2679; number_of_response:1; }","duration":"187.730355ms","start":"2026-10-07T22:08:27.677602Z","end":"2026-10-07T22:08:27.865332Z","steps":["trace[1731185655] 'process raft request' (duration: 185.76918ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:13:29.135058Z","caller":"traceutil/trace.go:171","msg":"trace[920278813] transaction","detail":"{read_only:false; response_revision:5109; number_of_response:1; }","duration":"100.972278ms","start":"2026-10-07T22:13:29.034067Z","end":"2026-10-07T22:13:29.135039Z","steps":["trace[920278813] 'process raft request' (duration: 100.856835ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:13:33.492244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.252837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9c1e483c-55a6-4fa0-b69c-c8c9b3cb8f08\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-10-07T22:13:33.492423Z","caller":"traceutil/trace.go:171","msg":"trace[1574015958] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-9c1e483c-55a6-4fa0-b69c-c8c9b3cb8f08; range_end:; response_count:1; response_revision:5257; }","duration":"178.482733ms","start":"2026-10-07T22:13:33.313918Z","end":"2026-10-07T22:13:33.492401Z","steps":["trace[1574015958] 'range keys from in-memory index tree' (duration: 178.070291ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:13:33.492453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.599825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:786948"} {"level":"info","ts":"2026-10-07T22:13:33.49253Z","caller":"traceutil/trace.go:171","msg":"trace[1232055224] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:5257; }","duration":"133.717809ms","start":"2026-10-07T22:13:33.358792Z","end":"2026-10-07T22:13:33.49251Z","steps":["trace[1232055224] 'range keys from in-memory index tree' (duration: 133.172723ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:13:33.899182Z","caller":"traceutil/trace.go:171","msg":"trace[1187402936] transaction","detail":"{read_only:false; response_revision:5259; number_of_response:1; }","duration":"131.327092ms","start":"2026-10-07T22:13:33.767829Z","end":"2026-10-07T22:13:33.899156Z","steps":["trace[1187402936] 'process raft request' (duration: 131.098626ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:13:47.681514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.679376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-07T22:13:47.681618Z","caller":"traceutil/trace.go:171","msg":"trace[235764104] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5509; }","duration":"166.819649ms","start":"2026-10-07T22:13:47.514783Z","end":"2026-10-07T22:13:47.681602Z","steps":["trace[235764104] 'range keys from in-memory index tree' (duration: 166.587443ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:13:55.459483Z","caller":"traceutil/trace.go:171","msg":"trace[745130338] transaction","detail":"{read_only:false; response_revision:5685; number_of_response:1; }","duration":"178.00764ms","start":"2026-10-07T22:13:55.281452Z","end":"2026-10-07T22:13:55.459459Z","steps":["trace[745130338] 'process raft request' (duration: 152.439609ms)","trace[745130338] 'compare' (duration: 25.268212ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:13:55.459959Z","caller":"traceutil/trace.go:171","msg":"trace[351659048] transaction","detail":"{read_only:false; response_revision:5686; number_of_response:1; }","duration":"178.041981ms","start":"2026-10-07T22:13:55.28189Z","end":"2026-10-07T22:13:55.459932Z","steps":["trace[351659048] 'process raft request' (duration: 177.509676ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:13:55.460253Z","caller":"traceutil/trace.go:171","msg":"trace[495300184] transaction","detail":"{read_only:false; response_revision:5687; number_of_response:1; }","duration":"178.188985ms","start":"2026-10-07T22:13:55.282011Z","end":"2026-10-07T22:13:55.4602Z","steps":["trace[495300184] 'process raft request' (duration: 177.762044ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:13:55.460319Z","caller":"traceutil/trace.go:171","msg":"trace[463477220] transaction","detail":"{read_only:false; response_revision:5688; number_of_response:1; }","duration":"177.959859ms","start":"2026-10-07T22:13:55.282302Z","end":"2026-10-07T22:13:55.460262Z","steps":["trace[463477220] 'process raft request' (duration: 177.805855ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:13:55.460641Z","caller":"traceutil/trace.go:171","msg":"trace[589004017] transaction","detail":"{read_only:false; response_revision:5689; number_of_response:1; }","duration":"175.629334ms","start":"2026-10-07T22:13:55.284991Z","end":"2026-10-07T22:13:55.46062Z","steps":["trace[589004017] 'process raft request' (duration: 175.208682ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:13:55.460713Z","caller":"traceutil/trace.go:171","msg":"trace[768993082] transaction","detail":"{read_only:false; response_revision:5690; number_of_response:1; }","duration":"172.735113ms","start":"2026-10-07T22:13:55.287966Z","end":"2026-10-07T22:13:55.460701Z","steps":["trace[768993082] 'process raft request' (duration: 172.504867ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:13:55.460663Z","caller":"traceutil/trace.go:171","msg":"trace[424932093] transaction","detail":"{read_only:false; response_revision:5691; number_of_response:1; }","duration":"118.484455ms","start":"2026-10-07T22:13:55.342154Z","end":"2026-10-07T22:13:55.460639Z","steps":["trace[424932093] 'process raft request' (duration: 118.439003ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:14:20.839271Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2989} {"level":"info","ts":"2026-10-07T22:14:20.918407Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2989,"took":"77.65069ms","hash":1753700334,"current-db-size-bytes":57090048,"current-db-size":"57 MB","current-db-size-in-use-bytes":32333824,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-07T22:14:20.918484Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1753700334,"revision":2989,"compact-revision":-1} {"level":"info","ts":"2026-10-07T22:19:20.858883Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5926} {"level":"info","ts":"2026-10-07T22:19:20.970226Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5926,"took":"109.275076ms","hash":517564799,"current-db-size-bytes":57090048,"current-db-size":"57 MB","current-db-size-in-use-bytes":26542080,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-10-07T22:19:20.970278Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":517564799,"revision":5926,"compact-revision":2989} {"level":"info","ts":"2026-10-07T22:20:12.302454Z","caller":"traceutil/trace.go:171","msg":"trace[1831357792] transaction","detail":"{read_only:false; response_revision:8547; number_of_response:1; }","duration":"124.711079ms","start":"2026-10-07T22:20:12.177724Z","end":"2026-10-07T22:20:12.302435Z","steps":["trace[1831357792] 'process raft request' (duration: 124.306517ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:20:12.408152Z","caller":"traceutil/trace.go:171","msg":"trace[552210526] transaction","detail":"{read_only:false; response_revision:8548; number_of_response:1; }","duration":"101.781086ms","start":"2026-10-07T22:20:12.306351Z","end":"2026-10-07T22:20:12.408132Z","steps":["trace[552210526] 'process raft request' (duration: 92.286369ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:20:24.059773Z","caller":"traceutil/trace.go:171","msg":"trace[1548757451] transaction","detail":"{read_only:false; response_revision:8611; number_of_response:1; }","duration":"169.451794ms","start":"2026-10-07T22:20:23.890285Z","end":"2026-10-07T22:20:24.059737Z","steps":["trace[1548757451] 'process raft request' (duration: 169.263428ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:20:24.180016Z","caller":"traceutil/trace.go:171","msg":"trace[1804837837] transaction","detail":"{read_only:false; response_revision:8612; number_of_response:1; }","duration":"118.064792ms","start":"2026-10-07T22:20:24.061913Z","end":"2026-10-07T22:20:24.179978Z","steps":["trace[1804837837] 'process raft request' (duration: 66.576297ms)","trace[1804837837] 'compare' (duration: 51.31396ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:20:24.850845Z","caller":"traceutil/trace.go:171","msg":"trace[319599027] linearizableReadLoop","detail":"{readStateIndex:8919; appliedIndex:8918; }","duration":"173.328322ms","start":"2026-10-07T22:20:24.677492Z","end":"2026-10-07T22:20:24.85082Z","steps":["trace[319599027] 'read index received' (duration: 166.635624ms)","trace[319599027] 'applied index is now lower than readState.Index' (duration: 6.691368ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:20:24.85086Z","caller":"traceutil/trace.go:171","msg":"trace[464460834] transaction","detail":"{read_only:false; response_revision:8616; number_of_response:1; }","duration":"176.884602ms","start":"2026-10-07T22:20:24.673949Z","end":"2026-10-07T22:20:24.850833Z","steps":["trace[464460834] 'process raft request' (duration: 170.242466ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:20:24.85094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.838747ms","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-07T22:20:24.851017Z","caller":"traceutil/trace.go:171","msg":"trace[1253501384] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8615; }","duration":"296.965001ms","start":"2026-10-07T22:20:24.554032Z","end":"2026-10-07T22:20:24.850997Z","steps":["trace[1253501384] 'range keys from in-memory index tree' (duration: 296.625441ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:20:24.851084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.326777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-10-07T22:20:24.851128Z","caller":"traceutil/trace.go:171","msg":"trace[1120910746] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8616; }","duration":"171.419859ms","start":"2026-10-07T22:20:24.679695Z","end":"2026-10-07T22:20:24.851114Z","steps":["trace[1120910746] 'agreement among raft nodes before linearized reading' (duration: 171.271975ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:20:24.85119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.846111ms","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-07T22:20:24.8513Z","caller":"traceutil/trace.go:171","msg":"trace[30795290] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8616; }","duration":"156.986394ms","start":"2026-10-07T22:20:24.694293Z","end":"2026-10-07T22:20:24.851279Z","steps":["trace[30795290] 'agreement among raft nodes before linearized reading' (duration: 156.704216ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:20:24.851818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.327971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-10-07T22:20:24.851872Z","caller":"traceutil/trace.go:171","msg":"trace[1388987000] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8616; }","duration":"174.413153ms","start":"2026-10-07T22:20:24.677446Z","end":"2026-10-07T22:20:24.851859Z","steps":["trace[1388987000] 'agreement among raft nodes before linearized reading' (duration: 173.496498ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:20:25.008888Z","caller":"traceutil/trace.go:171","msg":"trace[547852607] transaction","detail":"{read_only:false; response_revision:8618; number_of_response:1; }","duration":"153.122206ms","start":"2026-10-07T22:20:24.855741Z","end":"2026-10-07T22:20:25.008864Z","steps":["trace[547852607] 'process raft request' (duration: 99.533623ms)","trace[547852607] 'compare' (duration: 53.447609ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:20:25.009116Z","caller":"traceutil/trace.go:171","msg":"trace[1691910932] transaction","detail":"{read_only:false; response_revision:8619; number_of_response:1; }","duration":"153.301651ms","start":"2026-10-07T22:20:24.85578Z","end":"2026-10-07T22:20:25.009081Z","steps":["trace[1691910932] 'process raft request' (duration: 153.040674ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:20:25.009533Z","caller":"traceutil/trace.go:171","msg":"trace[206370799] transaction","detail":"{read_only:false; response_revision:8620; number_of_response:1; }","duration":"152.407396ms","start":"2026-10-07T22:20:24.857091Z","end":"2026-10-07T22:20:25.009498Z","steps":["trace[206370799] 'process raft request' (duration: 151.919922ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:20:53.680612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.575545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-07T22:20:53.680692Z","caller":"traceutil/trace.go:171","msg":"trace[1440083259] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8824; }","duration":"165.694698ms","start":"2026-10-07T22:20:53.514981Z","end":"2026-10-07T22:20:53.680675Z","steps":["trace[1440083259] 'range keys from in-memory index tree' (duration: 165.512504ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:20:53.681066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.779506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/schemareplications/\" range_end:\"/registry/rabbitmq.com/schemareplications0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-07T22:20:53.681119Z","caller":"traceutil/trace.go:171","msg":"trace[422639200] range","detail":"{range_begin:/registry/rabbitmq.com/schemareplications/; range_end:/registry/rabbitmq.com/schemareplications0; response_count:0; response_revision:8824; }","duration":"106.858407ms","start":"2026-10-07T22:20:53.574247Z","end":"2026-10-07T22:20:53.681106Z","steps":["trace[422639200] 'count revisions from in-memory index tree' (duration: 106.731644ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:20:56.246186Z","caller":"traceutil/trace.go:171","msg":"trace[308631623] transaction","detail":"{read_only:false; response_revision:8837; number_of_response:1; }","duration":"115.782968ms","start":"2026-10-07T22:20:56.13038Z","end":"2026-10-07T22:20:56.246163Z","steps":["trace[308631623] 'process raft request' (duration: 115.550472ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:21:03.421659Z","caller":"traceutil/trace.go:171","msg":"trace[463012536] transaction","detail":"{read_only:false; response_revision:8877; number_of_response:1; }","duration":"161.810949ms","start":"2026-10-07T22:21:03.259816Z","end":"2026-10-07T22:21:03.421627Z","steps":["trace[463012536] 'process raft request' (duration: 120.213392ms)","trace[463012536] 'compare' (duration: 41.33669ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T22:21:03.668745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.691958ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-07T22:21:03.668851Z","caller":"traceutil/trace.go:171","msg":"trace[930970950] linearizableReadLoop","detail":"{readStateIndex:9191; appliedIndex:9190; }","duration":"151.414567ms","start":"2026-10-07T22:21:03.517418Z","end":"2026-10-07T22:21:03.668833Z","steps":["trace[930970950] 'read index received' (duration: 21.436561ms)","trace[930970950] 'applied index is now lower than readState.Index' (duration: 129.976286ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T22:21:03.668908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.49963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-07T22:21:03.668929Z","caller":"traceutil/trace.go:171","msg":"trace[559759011] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8878; }","duration":"151.575112ms","start":"2026-10-07T22:21:03.517346Z","end":"2026-10-07T22:21:03.668921Z","steps":["trace[559759011] 'agreement among raft nodes before linearized reading' (duration: 151.530531ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:21:03.66895Z","caller":"traceutil/trace.go:171","msg":"trace[1477119924] transaction","detail":"{read_only:false; response_revision:8878; number_of_response:1; }","duration":"243.038048ms","start":"2026-10-07T22:21:03.425896Z","end":"2026-10-07T22:21:03.668934Z","steps":["trace[1477119924] 'process raft request' (duration: 113.056842ms)","trace[1477119924] 'compare' (duration: 129.572955ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:21:04.331865Z","caller":"traceutil/trace.go:171","msg":"trace[1340324127] transaction","detail":"{read_only:false; response_revision:8882; number_of_response:1; }","duration":"113.679569ms","start":"2026-10-07T22:21:04.218164Z","end":"2026-10-07T22:21:04.331843Z","steps":["trace[1340324127] 'process raft request' (duration: 113.083253ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:21:06.592373Z","caller":"traceutil/trace.go:171","msg":"trace[2046110882] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8902; }","duration":"113.028702ms","start":"2026-10-07T22:21:06.479316Z","end":"2026-10-07T22:21:06.592344Z","steps":["trace[2046110882] 'compare' (duration: 98.792262ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:21:06.689858Z","caller":"traceutil/trace.go:171","msg":"trace[1807975666] transaction","detail":"{read_only:false; response_revision:8903; number_of_response:1; }","duration":"209.041345ms","start":"2026-10-07T22:21:06.480782Z","end":"2026-10-07T22:21:06.689823Z","steps":["trace[1807975666] 'process raft request' (duration: 208.789598ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:21:06.725406Z","caller":"traceutil/trace.go:171","msg":"trace[1378230644] transaction","detail":"{read_only:false; response_revision:8904; number_of_response:1; }","duration":"133.443903ms","start":"2026-10-07T22:21:06.591929Z","end":"2026-10-07T22:21:06.725373Z","steps":["trace[1378230644] 'process raft request' (duration: 113.205686ms)","trace[1378230644] 'compare' (duration: 20.003161ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:21:06.725436Z","caller":"traceutil/trace.go:171","msg":"trace[2102604025] transaction","detail":"{read_only:false; response_revision:8905; number_of_response:1; }","duration":"130.371747ms","start":"2026-10-07T22:21:06.595043Z","end":"2026-10-07T22:21:06.725414Z","steps":["trace[2102604025] 'process raft request' (duration: 130.262694ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:21:09.813429Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000243c.wal"} {"level":"info","ts":"2026-10-07T22:22:20.626019Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"15a19459cc268924","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-07T22:22:20.631887Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-10-07T22:22:20.631973Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-10-07T22:24:20.87735Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8080} {"level":"info","ts":"2026-10-07T22:24:20.948559Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8080,"took":"68.067566ms","hash":8396360,"current-db-size-bytes":57090048,"current-db-size":"57 MB","current-db-size-in-use-bytes":28729344,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-10-07T22:24:20.948656Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":8396360,"revision":8080,"compact-revision":5926} {"level":"info","ts":"2026-10-07T22:26:02.806809Z","caller":"traceutil/trace.go:171","msg":"trace[996234084] transaction","detail":"{read_only:false; response_revision:11508; number_of_response:1; }","duration":"101.81685ms","start":"2026-10-07T22:26:02.704905Z","end":"2026-10-07T22:26:02.806722Z","steps":["trace[996234084] 'process raft request' (duration: 101.521632ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:29:20.886443Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10511} {"level":"info","ts":"2026-10-07T22:29:20.976312Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10511,"took":"88.079937ms","hash":2230300079,"current-db-size-bytes":57090048,"current-db-size":"57 MB","current-db-size-in-use-bytes":27725824,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-07T22:29:20.976385Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2230300079,"revision":10511,"compact-revision":8080} {"level":"info","ts":"2026-10-07T22:32:41.811819Z","caller":"traceutil/trace.go:171","msg":"trace[840312914] transaction","detail":"{read_only:false; response_revision:14168; number_of_response:1; }","duration":"135.044129ms","start":"2026-10-07T22:32:41.676744Z","end":"2026-10-07T22:32:41.811788Z","steps":["trace[840312914] 'process raft request' (duration: 35.408248ms)","trace[840312914] 'compare' (duration: 99.345342ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:32:51.25586Z","caller":"traceutil/trace.go:171","msg":"trace[1505428355] transaction","detail":"{read_only:false; response_revision:14216; number_of_response:1; }","duration":"127.224051ms","start":"2026-10-07T22:32:51.128605Z","end":"2026-10-07T22:32:51.255829Z","steps":["trace[1505428355] 'process raft request' (duration: 120.896274ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:32:59.022926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.866328ms","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-07T22:32:59.023125Z","caller":"traceutil/trace.go:171","msg":"trace[1543392379] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:14266; }","duration":"128.147236ms","start":"2026-10-07T22:32:58.894955Z","end":"2026-10-07T22:32:59.023102Z","steps":["trace[1543392379] 'count revisions from in-memory index tree' (duration: 127.775516ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:32:59.741043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:32:59.360412Z","time spent":"380.620301ms","remote":"127.0.0.1:36928","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-10-07T22:32:59.742093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.463789ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-10-07T22:32:59.768628Z","caller":"traceutil/trace.go:171","msg":"trace[861970466] linearizableReadLoop","detail":"{readStateIndex:14760; appliedIndex:14759; }","duration":"253.69716ms","start":"2026-10-07T22:32:59.514896Z","end":"2026-10-07T22:32:59.768594Z","steps":["trace[861970466] 'read index received' (duration: 253.457463ms)","trace[861970466] 'applied index is now lower than readState.Index' (duration: 237.687µs)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:32:59.768786Z","caller":"traceutil/trace.go:171","msg":"trace[951650242] transaction","detail":"{read_only:false; response_revision:14273; number_of_response:1; }","duration":"402.813151ms","start":"2026-10-07T22:32:59.365959Z","end":"2026-10-07T22:32:59.768772Z","steps":["trace[951650242] 'process raft request' (duration: 402.380839ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:32:59.76884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.930006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-07T22:32:59.768923Z","caller":"traceutil/trace.go:171","msg":"trace[1990868763] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14273; }","duration":"254.06673ms","start":"2026-10-07T22:32:59.514835Z","end":"2026-10-07T22:32:59.768902Z","steps":["trace[1990868763] 'agreement among raft nodes before linearized reading' (duration: 253.938517ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:32:59.768966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:32:59.365926Z","time spent":"402.905433ms","remote":"127.0.0.1:56174","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-07T22:32:59.821827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.160042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-07T22:32:59.821817Z","caller":"traceutil/trace.go:171","msg":"trace[305163967] transaction","detail":"{read_only:false; response_revision:14274; number_of_response:1; }","duration":"235.651146ms","start":"2026-10-07T22:32:59.586133Z","end":"2026-10-07T22:32:59.821784Z","steps":["trace[305163967] 'process raft request' (duration: 235.426409ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:32:59.821902Z","caller":"traceutil/trace.go:171","msg":"trace[1173976983] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:14274; }","duration":"211.291037ms","start":"2026-10-07T22:32:59.610593Z","end":"2026-10-07T22:32:59.821884Z","steps":["trace[1173976983] 'agreement among raft nodes before linearized reading' (duration: 211.183474ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:33:09.920215Z","caller":"traceutil/trace.go:171","msg":"trace[1597073909] transaction","detail":"{read_only:false; response_revision:14443; number_of_response:1; }","duration":"107.691015ms","start":"2026-10-07T22:33:09.812501Z","end":"2026-10-07T22:33:09.920192Z","steps":["trace[1597073909] 'process raft request' (duration: 107.5274ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:33:10.110958Z","caller":"traceutil/trace.go:171","msg":"trace[671367856] transaction","detail":"{read_only:false; response_revision:14444; number_of_response:1; }","duration":"290.962639ms","start":"2026-10-07T22:33:09.819953Z","end":"2026-10-07T22:33:10.110916Z","steps":["trace[671367856] 'process raft request' (duration: 263.704769ms)","trace[671367856] 'compare' (duration: 26.973552ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:33:10.111021Z","caller":"traceutil/trace.go:171","msg":"trace[817427890] transaction","detail":"{read_only:false; response_revision:14445; number_of_response:1; }","duration":"259.80959ms","start":"2026-10-07T22:33:09.851138Z","end":"2026-10-07T22:33:10.110947Z","steps":["trace[817427890] 'process raft request' (duration: 259.683997ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:33:10.111208Z","caller":"traceutil/trace.go:171","msg":"trace[1053513336] transaction","detail":"{read_only:false; response_revision:14446; number_of_response:1; }","duration":"194.307352ms","start":"2026-10-07T22:33:09.916862Z","end":"2026-10-07T22:33:10.11117Z","steps":["trace[1053513336] 'process raft request' (duration: 194.038575ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:34:20.894819Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12787} {"level":"info","ts":"2026-10-07T22:34:20.9802Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12787,"took":"83.390727ms","hash":1324203957,"current-db-size-bytes":57090048,"current-db-size":"57 MB","current-db-size-in-use-bytes":31567872,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-07T22:34:20.980293Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1324203957,"revision":12787,"compact-revision":10511} {"level":"warn","ts":"2026-10-07T22:34:40.755754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.520051ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-07T22:34:40.755863Z","caller":"traceutil/trace.go:171","msg":"trace[2060038911] linearizableReadLoop","detail":"{readStateIndex:16012; appliedIndex:16011; }","duration":"240.49015ms","start":"2026-10-07T22:34:40.515357Z","end":"2026-10-07T22:34:40.755847Z","steps":["trace[2060038911] 'read index received' (duration: 94.711303ms)","trace[2060038911] 'applied index is now lower than readState.Index' (duration: 145.777397ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:34:40.75602Z","caller":"traceutil/trace.go:171","msg":"trace[124872258] transaction","detail":"{read_only:false; response_revision:15489; number_of_response:1; }","duration":"273.123831ms","start":"2026-10-07T22:34:40.482859Z","end":"2026-10-07T22:34:40.755983Z","steps":["trace[124872258] 'process raft request' (duration: 127.277302ms)","trace[124872258] 'compare' (duration: 145.334375ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T22:34:40.756179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.81325ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-07T22:34:40.756239Z","caller":"traceutil/trace.go:171","msg":"trace[2110446628] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:15489; }","duration":"240.929423ms","start":"2026-10-07T22:34:40.515294Z","end":"2026-10-07T22:34:40.756223Z","steps":["trace[2110446628] 'agreement among raft nodes before linearized reading' (duration: 240.81452ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:34:40.75629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.108636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-j85ng\" ","response":"range_response_count:1 size:22125"} {"level":"info","ts":"2026-10-07T22:34:40.756385Z","caller":"traceutil/trace.go:171","msg":"trace[2095859926] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-j85ng; range_end:; response_count:1; response_revision:15489; }","duration":"113.204679ms","start":"2026-10-07T22:34:40.643168Z","end":"2026-10-07T22:34:40.756373Z","steps":["trace[2095859926] 'agreement among raft nodes before linearized reading' (duration: 112.955502ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:34:41.647283Z","caller":"traceutil/trace.go:171","msg":"trace[901190898] linearizableReadLoop","detail":"{readStateIndex:16014; appliedIndex:16013; }","duration":"130.301646ms","start":"2026-10-07T22:34:41.516939Z","end":"2026-10-07T22:34:41.647241Z","steps":["trace[901190898] 'read index received' (duration: 130.179002ms)","trace[901190898] 'applied index is now lower than readState.Index' (duration: 121.634µs)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:34:41.647322Z","caller":"traceutil/trace.go:171","msg":"trace[1837239845] transaction","detail":"{read_only:false; response_revision:15491; number_of_response:1; }","duration":"136.555731ms","start":"2026-10-07T22:34:41.510731Z","end":"2026-10-07T22:34:41.647286Z","steps":["trace[1837239845] 'process raft request' (duration: 136.288124ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:34:41.647462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.514052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-07T22:34:41.647553Z","caller":"traceutil/trace.go:171","msg":"trace[94723129] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:15491; }","duration":"130.645036ms","start":"2026-10-07T22:34:41.516879Z","end":"2026-10-07T22:34:41.647524Z","steps":["trace[94723129] 'agreement among raft nodes before linearized reading' (duration: 130.505602ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:34:41.815103Z","caller":"traceutil/trace.go:171","msg":"trace[1898621833] transaction","detail":"{read_only:false; response_revision:15492; number_of_response:1; }","duration":"162.562626ms","start":"2026-10-07T22:34:41.652509Z","end":"2026-10-07T22:34:41.815071Z","steps":["trace[1898621833] 'process raft request' (duration: 139.76543ms)","trace[1898621833] 'compare' (duration: 22.503437ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:34:41.815147Z","caller":"traceutil/trace.go:171","msg":"trace[1110815761] transaction","detail":"{read_only:false; response_revision:15493; number_of_response:1; }","duration":"161.437255ms","start":"2026-10-07T22:34:41.653679Z","end":"2026-10-07T22:34:41.815116Z","steps":["trace[1110815761] 'process raft request' (duration: 161.27032ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:34:41.81533Z","caller":"traceutil/trace.go:171","msg":"trace[1083702643] transaction","detail":"{read_only:false; response_revision:15494; number_of_response:1; }","duration":"161.496627ms","start":"2026-10-07T22:34:41.65382Z","end":"2026-10-07T22:34:41.815317Z","steps":["trace[1083702643] 'process raft request' (duration: 161.197498ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:39:20.902318Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15380} {"level":"info","ts":"2026-10-07T22:39:21.010129Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15380,"took":"103.479234ms","hash":3588278212,"current-db-size-bytes":57090048,"current-db-size":"57 MB","current-db-size-in-use-bytes":31674368,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-07T22:39:21.010176Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3588278212,"revision":15380,"compact-revision":12787} {"level":"info","ts":"2026-10-07T22:40:33.23194Z","caller":"traceutil/trace.go:171","msg":"trace[1733839132] linearizableReadLoop","detail":"{readStateIndex:18652; appliedIndex:18651; }","duration":"186.191357ms","start":"2026-10-07T22:40:33.045722Z","end":"2026-10-07T22:40:33.231914Z","steps":["trace[1733839132] 'read index received' (duration: 185.916209ms)","trace[1733839132] 'applied index is now lower than readState.Index' (duration: 274.128µs)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:40:33.232281Z","caller":"traceutil/trace.go:171","msg":"trace[1500074907] transaction","detail":"{read_only:false; response_revision:18042; number_of_response:1; }","duration":"237.495586ms","start":"2026-10-07T22:40:32.994754Z","end":"2026-10-07T22:40:33.23225Z","steps":["trace[1500074907] 'process raft request' (duration: 236.961101ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:40:33.232421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.109471ms","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-07T22:40:33.232493Z","caller":"traceutil/trace.go:171","msg":"trace[2114013953] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:18042; }","duration":"118.231275ms","start":"2026-10-07T22:40:33.114249Z","end":"2026-10-07T22:40:33.23248Z","steps":["trace[2114013953] 'agreement among raft nodes before linearized reading' (duration: 118.08203ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:40:33.232506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.770654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" ","response":"range_response_count:1 size:418021"} {"level":"info","ts":"2026-10-07T22:40:33.232593Z","caller":"traceutil/trace.go:171","msg":"trace[1103771765] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance; range_end:; response_count:1; response_revision:18042; }","duration":"186.870106ms","start":"2026-10-07T22:40:33.045705Z","end":"2026-10-07T22:40:33.232575Z","steps":["trace[1103771765] 'agreement among raft nodes before linearized reading' (duration: 186.497876ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:40:33.875725Z","caller":"traceutil/trace.go:171","msg":"trace[602990421] linearizableReadLoop","detail":"{readStateIndex:18654; appliedIndex:18653; }","duration":"186.341532ms","start":"2026-10-07T22:40:33.689365Z","end":"2026-10-07T22:40:33.875706Z","steps":["trace[602990421] 'read index received' (duration: 173.356141ms)","trace[602990421] 'applied index is now lower than readState.Index' (duration: 12.984661ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:40:33.876131Z","caller":"traceutil/trace.go:171","msg":"trace[2096487158] transaction","detail":"{read_only:false; response_revision:18044; number_of_response:1; }","duration":"188.823341ms","start":"2026-10-07T22:40:33.687271Z","end":"2026-10-07T22:40:33.876094Z","steps":["trace[2096487158] 'process raft request' (duration: 175.438708ms)","trace[2096487158] 'compare' (duration: 12.827628ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T22:40:33.876314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.914048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-j85ng\" ","response":"range_response_count:1 size:22126"} {"level":"info","ts":"2026-10-07T22:40:33.876356Z","caller":"traceutil/trace.go:171","msg":"trace[161945271] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-j85ng; range_end:; response_count:1; response_revision:18044; }","duration":"187.014651ms","start":"2026-10-07T22:40:33.689332Z","end":"2026-10-07T22:40:33.876346Z","steps":["trace[161945271] 'agreement among raft nodes before linearized reading' (duration: 186.863867ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:40:33.890946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.682094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-10-07T22:40:33.890995Z","caller":"traceutil/trace.go:171","msg":"trace[1109545887] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:18045; }","duration":"185.756476ms","start":"2026-10-07T22:40:33.705227Z","end":"2026-10-07T22:40:33.890984Z","steps":["trace[1109545887] 'agreement among raft nodes before linearized reading' (duration: 185.652133ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:42:56.744212Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"15a19459cc268924","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-07T22:42:56.753614Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-10-07T22:42:56.753733Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-10-07T22:44:20.909865Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17514} {"level":"info","ts":"2026-10-07T22:44:21.004Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17514,"took":"90.539096ms","hash":1543934223,"current-db-size-bytes":57090048,"current-db-size":"57 MB","current-db-size-in-use-bytes":34185216,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-10-07T22:44:21.004072Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1543934223,"revision":17514,"compact-revision":15380} {"level":"info","ts":"2026-10-07T22:46:27.173223Z","caller":"traceutil/trace.go:171","msg":"trace[786434733] transaction","detail":"{read_only:false; response_revision:20786; number_of_response:1; }","duration":"137.359731ms","start":"2026-10-07T22:46:27.035829Z","end":"2026-10-07T22:46:27.173189Z","steps":["trace[786434733] 'process raft request' (duration: 137.159846ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:46:33.02816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.903713ms","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-07T22:46:33.028274Z","caller":"traceutil/trace.go:171","msg":"trace[2101338249] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:20815; }","duration":"201.058868ms","start":"2026-10-07T22:46:32.827176Z","end":"2026-10-07T22:46:33.028235Z","steps":["trace[2101338249] 'range keys from in-memory index tree' (duration: 200.707558ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:46:33.183215Z","caller":"traceutil/trace.go:171","msg":"trace[2116667664] linearizableReadLoop","detail":"{readStateIndex:21514; appliedIndex:21513; }","duration":"147.073282ms","start":"2026-10-07T22:46:33.036111Z","end":"2026-10-07T22:46:33.183184Z","steps":["trace[2116667664] 'read index received' (duration: 146.909927ms)","trace[2116667664] 'applied index is now lower than readState.Index' (duration: 162.155µs)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:46:33.183545Z","caller":"traceutil/trace.go:171","msg":"trace[1601767775] transaction","detail":"{read_only:false; response_revision:20816; number_of_response:1; }","duration":"150.988862ms","start":"2026-10-07T22:46:33.032543Z","end":"2026-10-07T22:46:33.183531Z","steps":["trace[1601767775] 'process raft request' (duration: 150.458907ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:46:33.183942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.823853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" ","response":"range_response_count:1 size:418246"} {"level":"info","ts":"2026-10-07T22:46:33.183995Z","caller":"traceutil/trace.go:171","msg":"trace[1305782278] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance; range_end:; response_count:1; response_revision:20816; }","duration":"147.930166ms","start":"2026-10-07T22:46:33.036049Z","end":"2026-10-07T22:46:33.183979Z","steps":["trace[1305782278] 'agreement among raft nodes before linearized reading' (duration: 147.669619ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:46:33.420996Z","caller":"traceutil/trace.go:171","msg":"trace[1181657356] transaction","detail":"{read_only:false; response_revision:20818; number_of_response:1; }","duration":"226.306392ms","start":"2026-10-07T22:46:33.194652Z","end":"2026-10-07T22:46:33.420958Z","steps":["trace[1181657356] 'process raft request' (duration: 186.104381ms)","trace[1181657356] 'compare' (duration: 39.760159ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:46:33.67037Z","caller":"traceutil/trace.go:171","msg":"trace[405798478] transaction","detail":"{read_only:false; response_revision:20819; number_of_response:1; }","duration":"259.678563ms","start":"2026-10-07T22:46:33.410637Z","end":"2026-10-07T22:46:33.670315Z","steps":["trace[405798478] 'process raft request' (duration: 198.457035ms)","trace[405798478] 'compare' (duration: 60.911069ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:46:33.676025Z","caller":"traceutil/trace.go:171","msg":"trace[728238077] linearizableReadLoop","detail":"{readStateIndex:21518; appliedIndex:21516; }","duration":"161.124624ms","start":"2026-10-07T22:46:33.514875Z","end":"2026-10-07T22:46:33.675999Z","steps":["trace[728238077] 'read index received' (duration: 94.233788ms)","trace[728238077] 'applied index is now lower than readState.Index' (duration: 66.889376ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:46:33.676049Z","caller":"traceutil/trace.go:171","msg":"trace[344227413] transaction","detail":"{read_only:false; response_revision:20820; number_of_response:1; }","duration":"260.466145ms","start":"2026-10-07T22:46:33.415549Z","end":"2026-10-07T22:46:33.676015Z","steps":["trace[344227413] 'process raft request' (duration: 260.242359ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:46:33.67615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.269008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-07T22:46:33.676184Z","caller":"traceutil/trace.go:171","msg":"trace[138721381] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:20821; }","duration":"161.36196ms","start":"2026-10-07T22:46:33.514811Z","end":"2026-10-07T22:46:33.676173Z","steps":["trace[138721381] 'agreement among raft nodes before linearized reading' (duration: 161.286328ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:46:33.676144Z","caller":"traceutil/trace.go:171","msg":"trace[1211459736] transaction","detail":"{read_only:false; response_revision:20821; number_of_response:1; }","duration":"123.491625ms","start":"2026-10-07T22:46:33.55261Z","end":"2026-10-07T22:46:33.676102Z","steps":["trace[1211459736] 'process raft request' (duration: 123.33449ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:46:34.273472Z","caller":"traceutil/trace.go:171","msg":"trace[5769231] transaction","detail":"{read_only:false; response_revision:20824; number_of_response:1; }","duration":"344.074176ms","start":"2026-10-07T22:46:33.929367Z","end":"2026-10-07T22:46:34.273441Z","steps":["trace[5769231] 'process raft request' (duration: 248.428889ms)","trace[5769231] 'compare' (duration: 95.474853ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T22:46:34.273675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:46:33.929341Z","time spent":"344.19944ms","remote":"127.0.0.1:56174","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-07T22:46:34.273845Z","caller":"traceutil/trace.go:171","msg":"trace[2032348910] transaction","detail":"{read_only:false; response_revision:20825; number_of_response:1; }","duration":"344.294782ms","start":"2026-10-07T22:46:33.929471Z","end":"2026-10-07T22:46:34.273765Z","steps":["trace[2032348910] 'process raft request' (duration: 343.912532ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:46:34.274106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:46:33.929461Z","time spent":"344.505729ms","remote":"127.0.0.1:56174","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-07T22:46:34.469107Z","caller":"traceutil/trace.go:171","msg":"trace[543055496] transaction","detail":"{read_only:false; response_revision:20826; number_of_response:1; }","duration":"128.431162ms","start":"2026-10-07T22:46:34.340645Z","end":"2026-10-07T22:46:34.469076Z","steps":["trace[543055496] 'process raft request' (duration: 122.562608ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:49:20.917458Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19906} {"level":"info","ts":"2026-10-07T22:49:21.032586Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19906,"took":"111.212072ms","hash":3589706644,"current-db-size-bytes":57090048,"current-db-size":"57 MB","current-db-size-in-use-bytes":30011392,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-10-07T22:49:21.032658Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3589706644,"revision":19906,"compact-revision":17514} {"level":"info","ts":"2026-10-07T22:54:10.598543Z","caller":"traceutil/trace.go:171","msg":"trace[1764567961] transaction","detail":"{read_only:false; response_revision:25440; number_of_response:1; }","duration":"216.854991ms","start":"2026-10-07T22:54:10.381654Z","end":"2026-10-07T22:54:10.598509Z","steps":["trace[1764567961] 'process raft request' (duration: 215.73711ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:54:10.598581Z","caller":"traceutil/trace.go:171","msg":"trace[1343800806] transaction","detail":"{read_only:false; response_revision:25441; number_of_response:1; }","duration":"180.702929ms","start":"2026-10-07T22:54:10.417838Z","end":"2026-10-07T22:54:10.598541Z","steps":["trace[1343800806] 'process raft request' (duration: 180.255777ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:54:15.629947Z","caller":"traceutil/trace.go:171","msg":"trace[1338020431] transaction","detail":"{read_only:false; response_revision:25478; number_of_response:1; }","duration":"112.800316ms","start":"2026-10-07T22:54:15.517126Z","end":"2026-10-07T22:54:15.629927Z","steps":["trace[1338020431] 'process raft request' (duration: 112.621601ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:54:15.629927Z","caller":"traceutil/trace.go:171","msg":"trace[459566354] linearizableReadLoop","detail":"{readStateIndex:26307; appliedIndex:26306; }","duration":"111.686086ms","start":"2026-10-07T22:54:15.518219Z","end":"2026-10-07T22:54:15.629905Z","steps":["trace[459566354] 'read index received' (duration: 111.540552ms)","trace[459566354] 'applied index is now lower than readState.Index' (duration: 144.384µs)"],"step_count":2} {"level":"warn","ts":"2026-10-07T22:54:15.63016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.926503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-07T22:54:15.630249Z","caller":"traceutil/trace.go:171","msg":"trace[19957763] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25478; }","duration":"112.068367ms","start":"2026-10-07T22:54:15.518168Z","end":"2026-10-07T22:54:15.630236Z","steps":["trace[19957763] 'agreement among raft nodes before linearized reading' (duration: 111.885462ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:54:15.922243Z","caller":"traceutil/trace.go:171","msg":"trace[1640091564] linearizableReadLoop","detail":"{readStateIndex:26308; appliedIndex:26307; }","duration":"292.182319ms","start":"2026-10-07T22:54:15.630024Z","end":"2026-10-07T22:54:15.922206Z","steps":["trace[1640091564] 'read index received' (duration: 280.29967ms)","trace[1640091564] 'applied index is now lower than readState.Index' (duration: 11.881149ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:54:15.922317Z","caller":"traceutil/trace.go:171","msg":"trace[264538441] transaction","detail":"{read_only:false; response_revision:25479; number_of_response:1; }","duration":"384.391395ms","start":"2026-10-07T22:54:15.537894Z","end":"2026-10-07T22:54:15.922285Z","steps":["trace[264538441] 'process raft request' (duration: 372.414733ms)","trace[264538441] 'compare' (duration: 11.566681ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T22:54:15.922419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.324412ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-07T22:54:15.922416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.551294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-07T22:54:15.922465Z","caller":"traceutil/trace.go:171","msg":"trace[313775465] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:25479; }","duration":"323.424405ms","start":"2026-10-07T22:54:15.599026Z","end":"2026-10-07T22:54:15.922451Z","steps":["trace[313775465] 'agreement among raft nodes before linearized reading' (duration: 323.316362ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:54:15.922472Z","caller":"traceutil/trace.go:171","msg":"trace[176225034] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25479; }","duration":"290.648077ms","start":"2026-10-07T22:54:15.631811Z","end":"2026-10-07T22:54:15.922459Z","steps":["trace[176225034] 'agreement among raft nodes before linearized reading' (duration: 290.550354ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:54:15.922471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:54:15.537882Z","time spent":"384.505318ms","remote":"127.0.0.1:56174","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-07T22:54:15.9225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:54:15.599007Z","time spent":"323.483457ms","remote":"127.0.0.1:59346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"warn","ts":"2026-10-07T22:54:15.922502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.835145ms","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-07T22:54:15.922556Z","caller":"traceutil/trace.go:171","msg":"trace[1380188138] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25479; }","duration":"280.937867ms","start":"2026-10-07T22:54:15.641604Z","end":"2026-10-07T22:54:15.922542Z","steps":["trace[1380188138] 'agreement among raft nodes before linearized reading' (duration: 280.794003ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:54:16.869482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.896133ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-07T22:54:16.869687Z","caller":"traceutil/trace.go:171","msg":"trace[497142330] transaction","detail":"{read_only:false; response_revision:25482; number_of_response:1; }","duration":"252.284253ms","start":"2026-10-07T22:54:16.617284Z","end":"2026-10-07T22:54:16.869568Z","steps":["trace[497142330] 'process raft request' (duration: 123.226606ms)","trace[497142330] 'compare' (duration: 128.78416ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:54:17.057603Z","caller":"traceutil/trace.go:171","msg":"trace[1594093588] transaction","detail":"{read_only:false; response_revision:25483; number_of_response:1; }","duration":"437.23864ms","start":"2026-10-07T22:54:16.620281Z","end":"2026-10-07T22:54:17.057519Z","steps":["trace[1594093588] 'process raft request' (duration: 396.83788ms)","trace[1594093588] 'compare' (duration: 40.0413ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:54:17.057802Z","caller":"traceutil/trace.go:171","msg":"trace[1709422480] linearizableReadLoop","detail":"{readStateIndex:26312; appliedIndex:26310; }","duration":"431.547712ms","start":"2026-10-07T22:54:16.626201Z","end":"2026-10-07T22:54:17.057749Z","steps":["trace[1709422480] 'read index received' (duration: 114.326789ms)","trace[1709422480] 'applied index is now lower than readState.Index' (duration: 317.205943ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:54:17.057853Z","caller":"traceutil/trace.go:171","msg":"trace[597651690] transaction","detail":"{read_only:false; response_revision:25484; number_of_response:1; }","duration":"419.392575ms","start":"2026-10-07T22:54:16.63844Z","end":"2026-10-07T22:54:17.057833Z","steps":["trace[597651690] 'process raft request' (duration: 418.968243ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:54:17.057859Z","caller":"traceutil/trace.go:171","msg":"trace[379495483] transaction","detail":"{read_only:false; response_revision:25485; number_of_response:1; }","duration":"235.802627ms","start":"2026-10-07T22:54:16.822033Z","end":"2026-10-07T22:54:17.057836Z","steps":["trace[379495483] 'process raft request' (duration: 235.470258ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:54:17.057911Z","caller":"traceutil/trace.go:171","msg":"trace[1660053092] transaction","detail":"{read_only:false; response_revision:25486; number_of_response:1; }","duration":"200.257071ms","start":"2026-10-07T22:54:16.857629Z","end":"2026-10-07T22:54:17.057886Z","steps":["trace[1660053092] 'process raft request' (duration: 199.930342ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:54:17.057961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:54:16.638427Z","time spent":"419.474638ms","remote":"127.0.0.1:56174","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-07T22:54:17.058087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.800723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-07T22:54:17.058122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.877131ms","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-07T22:54:17.05813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.914842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-10-07T22:54:17.058146Z","caller":"traceutil/trace.go:171","msg":"trace[1407354557] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:25487; }","duration":"232.904076ms","start":"2026-10-07T22:54:16.825224Z","end":"2026-10-07T22:54:17.058128Z","steps":["trace[1407354557] 'agreement among raft nodes before linearized reading' (duration: 232.794863ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:54:17.058164Z","caller":"traceutil/trace.go:171","msg":"trace[661565061] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25487; }","duration":"124.932194ms","start":"2026-10-07T22:54:16.933219Z","end":"2026-10-07T22:54:17.058152Z","steps":["trace[661565061] 'agreement among raft nodes before linearized reading' (duration: 124.79629ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:54:17.058172Z","caller":"traceutil/trace.go:171","msg":"trace[1954141222] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25487; }","duration":"431.997345ms","start":"2026-10-07T22:54:16.626159Z","end":"2026-10-07T22:54:17.058156Z","steps":["trace[1954141222] 'agreement among raft nodes before linearized reading' (duration: 431.778159ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:54:17.058208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:54:16.626148Z","time spent":"432.052666ms","remote":"127.0.0.1:56174","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-10-07T22:54:17.05824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.210679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-10-07T22:54:17.058294Z","caller":"traceutil/trace.go:171","msg":"trace[1824137808] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25487; }","duration":"126.293271ms","start":"2026-10-07T22:54:16.931985Z","end":"2026-10-07T22:54:17.058278Z","steps":["trace[1824137808] 'agreement among raft nodes before linearized reading' (duration: 126.116416ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:54:17.058366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:54:16.620246Z","time spent":"437.463566ms","remote":"127.0.0.1:56174","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-07T22:54:17.317207Z","caller":"traceutil/trace.go:171","msg":"trace[600468208] linearizableReadLoop","detail":"{readStateIndex:26320; appliedIndex:26317; }","duration":"137.674746ms","start":"2026-10-07T22:54:17.179511Z","end":"2026-10-07T22:54:17.317186Z","steps":["trace[600468208] 'read index received' (duration: 52.550466ms)","trace[600468208] 'applied index is now lower than readState.Index' (duration: 85.12335ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:54:17.317276Z","caller":"traceutil/trace.go:171","msg":"trace[2059435824] transaction","detail":"{read_only:false; response_revision:25490; number_of_response:1; }","duration":"252.179591ms","start":"2026-10-07T22:54:17.06507Z","end":"2026-10-07T22:54:17.31725Z","steps":["trace[2059435824] 'process raft request' (duration: 251.975105ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:54:17.317395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.872802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-octavia-server-0\" ","response":"range_response_count:1 size:1864"} {"level":"info","ts":"2026-10-07T22:54:17.317372Z","caller":"traceutil/trace.go:171","msg":"trace[2109859398] transaction","detail":"{read_only:false; response_revision:25491; number_of_response:1; }","duration":"141.522163ms","start":"2026-10-07T22:54:17.175823Z","end":"2026-10-07T22:54:17.317345Z","steps":["trace[2109859398] 'process raft request' (duration: 141.324328ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:54:17.31743Z","caller":"traceutil/trace.go:171","msg":"trace[1145582593] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-octavia-server-0; range_end:; response_count:1; response_revision:25491; }","duration":"137.961104ms","start":"2026-10-07T22:54:17.179457Z","end":"2026-10-07T22:54:17.317419Z","steps":["trace[1145582593] 'agreement among raft nodes before linearized reading' (duration: 137.8114ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:54:17.317501Z","caller":"traceutil/trace.go:171","msg":"trace[1543246408] transaction","detail":"{read_only:false; response_revision:25489; number_of_response:1; }","duration":"253.731863ms","start":"2026-10-07T22:54:17.063711Z","end":"2026-10-07T22:54:17.317442Z","steps":["trace[1543246408] 'process raft request' (duration: 168.354416ms)","trace[1543246408] 'compare' (duration: 84.661547ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:54:17.744094Z","caller":"traceutil/trace.go:171","msg":"trace[1661174227] transaction","detail":"{read_only:false; response_revision:25493; number_of_response:1; }","duration":"108.893189ms","start":"2026-10-07T22:54:17.635172Z","end":"2026-10-07T22:54:17.744065Z","steps":["trace[1661174227] 'process raft request' (duration: 105.762362ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:54:18.293199Z","caller":"traceutil/trace.go:171","msg":"trace[1713759031] linearizableReadLoop","detail":"{readStateIndex:26324; appliedIndex:26323; }","duration":"202.585275ms","start":"2026-10-07T22:54:18.090591Z","end":"2026-10-07T22:54:18.293177Z","steps":["trace[1713759031] 'read index received' (duration: 202.366679ms)","trace[1713759031] 'applied index is now lower than readState.Index' (duration: 217.706µs)"],"step_count":2} {"level":"warn","ts":"2026-10-07T22:54:18.293384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.76635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-10-07T22:54:18.293422Z","caller":"traceutil/trace.go:171","msg":"trace[639132469] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:25495; }","duration":"202.826852ms","start":"2026-10-07T22:54:18.090585Z","end":"2026-10-07T22:54:18.293412Z","steps":["trace[639132469] 'agreement among raft nodes before linearized reading' (duration: 202.679548ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:54:18.293498Z","caller":"traceutil/trace.go:171","msg":"trace[475769329] transaction","detail":"{read_only:false; response_revision:25495; number_of_response:1; }","duration":"267.968767ms","start":"2026-10-07T22:54:18.025497Z","end":"2026-10-07T22:54:18.293466Z","steps":["trace[475769329] 'process raft request' (duration: 267.529885ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:54:18.599709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.646086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephrbdmirrors/\" range_end:\"/registry/ceph.rook.io/cephrbdmirrors0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-07T22:54:18.599781Z","caller":"traceutil/trace.go:171","msg":"trace[344996439] range","detail":"{range_begin:/registry/ceph.rook.io/cephrbdmirrors/; range_end:/registry/ceph.rook.io/cephrbdmirrors0; response_count:0; response_revision:25495; }","duration":"207.761299ms","start":"2026-10-07T22:54:18.392001Z","end":"2026-10-07T22:54:18.599763Z","steps":["trace[344996439] 'count revisions from in-memory index tree' (duration: 207.534412ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:54:18.600007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.831955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-10-07T22:54:18.600054Z","caller":"traceutil/trace.go:171","msg":"trace[716385966] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:25495; }","duration":"135.925748ms","start":"2026-10-07T22:54:18.464113Z","end":"2026-10-07T22:54:18.600039Z","steps":["trace[716385966] 'count revisions from in-memory index tree' (duration: 135.675911ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:54:19.339448Z","caller":"traceutil/trace.go:171","msg":"trace[2145795338] transaction","detail":"{read_only:false; response_revision:25500; number_of_response:1; }","duration":"275.460056ms","start":"2026-10-07T22:54:19.063957Z","end":"2026-10-07T22:54:19.339417Z","steps":["trace[2145795338] 'process raft request' (duration: 275.27109ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:54:19.360558Z","caller":"traceutil/trace.go:171","msg":"trace[58851806] transaction","detail":"{read_only:false; response_revision:25501; number_of_response:1; }","duration":"296.435087ms","start":"2026-10-07T22:54:19.064064Z","end":"2026-10-07T22:54:19.360499Z","steps":["trace[58851806] 'process raft request' (duration: 295.272795ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:54:19.36085Z","caller":"traceutil/trace.go:171","msg":"trace[1947324429] transaction","detail":"{read_only:false; response_revision:25502; number_of_response:1; }","duration":"296.431287ms","start":"2026-10-07T22:54:19.064379Z","end":"2026-10-07T22:54:19.360811Z","steps":["trace[1947324429] 'process raft request' (duration: 296.051866ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:54:19.361308Z","caller":"traceutil/trace.go:171","msg":"trace[2056757241] linearizableReadLoop","detail":"{readStateIndex:26331; appliedIndex:26328; }","duration":"285.831123ms","start":"2026-10-07T22:54:19.075332Z","end":"2026-10-07T22:54:19.361163Z","steps":["trace[2056757241] 'read index received' (duration: 263.974148ms)","trace[2056757241] 'applied index is now lower than readState.Index' (duration: 21.855925ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T22:54:19.361925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.07903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-07T22:54:19.362029Z","caller":"traceutil/trace.go:171","msg":"trace[1668715406] range","detail":"{range_begin:/registry/services/specs/magnum-system/; range_end:/registry/services/specs/magnum-system0; response_count:0; response_revision:25503; }","duration":"216.249164ms","start":"2026-10-07T22:54:19.145763Z","end":"2026-10-07T22:54:19.362013Z","steps":["trace[1668715406] 'agreement among raft nodes before linearized reading' (duration: 216.068819ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:54:19.361924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.43351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-10-07T22:54:19.362166Z","caller":"traceutil/trace.go:171","msg":"trace[1064988973] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25503; }","duration":"286.852491ms","start":"2026-10-07T22:54:19.075283Z","end":"2026-10-07T22:54:19.362136Z","steps":["trace[1064988973] 'agreement among raft nodes before linearized reading' (duration: 286.353868ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:54:19.573891Z","caller":"traceutil/trace.go:171","msg":"trace[2080436929] linearizableReadLoop","detail":"{readStateIndex:26335; appliedIndex:26332; }","duration":"205.189637ms","start":"2026-10-07T22:54:19.368673Z","end":"2026-10-07T22:54:19.573863Z","steps":["trace[2080436929] 'read index received' (duration: 44.01596ms)","trace[2080436929] 'applied index is now lower than readState.Index' (duration: 161.172337ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:54:19.573928Z","caller":"traceutil/trace.go:171","msg":"trace[1587876906] transaction","detail":"{read_only:false; response_revision:25505; number_of_response:1; }","duration":"206.961797ms","start":"2026-10-07T22:54:19.366921Z","end":"2026-10-07T22:54:19.573882Z","steps":["trace[1587876906] 'process raft request' (duration: 206.618837ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:54:19.573953Z","caller":"traceutil/trace.go:171","msg":"trace[180795868] transaction","detail":"{read_only:false; response_revision:25506; number_of_response:1; }","duration":"205.373433ms","start":"2026-10-07T22:54:19.368553Z","end":"2026-10-07T22:54:19.573926Z","steps":["trace[180795868] 'process raft request' (duration: 205.25932ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:54:19.57409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.361893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/magnum-system/\" range_end:\"/registry/endpointslices/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-07T22:54:19.574172Z","caller":"traceutil/trace.go:171","msg":"trace[914158762] range","detail":"{range_begin:/registry/endpointslices/magnum-system/; range_end:/registry/endpointslices/magnum-system0; response_count:0; response_revision:25506; }","duration":"205.500936ms","start":"2026-10-07T22:54:19.368648Z","end":"2026-10-07T22:54:19.574149Z","steps":["trace[914158762] 'agreement among raft nodes before linearized reading' (duration: 205.305911ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:54:19.925194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.074633ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-10-07T22:54:19.925421Z","caller":"traceutil/trace.go:171","msg":"trace[991188198] linearizableReadLoop","detail":"{readStateIndex:26336; appliedIndex:26335; }","duration":"351.435751ms","start":"2026-10-07T22:54:19.573961Z","end":"2026-10-07T22:54:19.925397Z","steps":["trace[991188198] 'read index received' (duration: 124.293745ms)","trace[991188198] 'applied index is now lower than readState.Index' (duration: 227.140536ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T22:54:19.925539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.021305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-07T22:54:19.925563Z","caller":"traceutil/trace.go:171","msg":"trace[2141109578] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25506; }","duration":"410.108417ms","start":"2026-10-07T22:54:19.515446Z","end":"2026-10-07T22:54:19.925555Z","steps":["trace[2141109578] 'agreement among raft nodes before linearized reading' (duration: 410.052335ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:54:19.92562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:54:19.515419Z","time spent":"410.19299ms","remote":"127.0.0.1:55866","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-10-07T22:54:19.925915Z","caller":"traceutil/trace.go:171","msg":"trace[1235529055] transaction","detail":"{read_only:false; response_revision:25507; number_of_response:1; }","duration":"342.583035ms","start":"2026-10-07T22:54:19.583306Z","end":"2026-10-07T22:54:19.925889Z","steps":["trace[1235529055] 'process raft request' (duration: 341.990009ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:54:19.926086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:54:19.583273Z","time spent":"342.727779ms","remote":"127.0.0.1:56174","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-07T22:54:19.92848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.722017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/magnum-system/\" range_end:\"/registry/endpointslices/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-07T22:54:19.928455Z","caller":"traceutil/trace.go:171","msg":"trace[1238833018] transaction","detail":"{read_only:false; response_revision:25508; number_of_response:1; }","duration":"177.921461ms","start":"2026-10-07T22:54:19.750501Z","end":"2026-10-07T22:54:19.928423Z","steps":["trace[1238833018] 'process raft request' (duration: 175.372291ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:54:19.928566Z","caller":"traceutil/trace.go:171","msg":"trace[1838591858] range","detail":"{range_begin:/registry/endpointslices/magnum-system/; range_end:/registry/endpointslices/magnum-system0; response_count:0; response_revision:25508; }","duration":"347.82703ms","start":"2026-10-07T22:54:19.580694Z","end":"2026-10-07T22:54:19.928521Z","steps":["trace[1838591858] 'agreement among raft nodes before linearized reading' (duration: 347.713247ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:54:19.9286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:54:19.580672Z","time spent":"347.919663ms","remote":"127.0.0.1:56182","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":29,"request content":"key:\"/registry/endpointslices/magnum-system/\" range_end:\"/registry/endpointslices/magnum-system0\" "} {"level":"info","ts":"2026-10-07T22:54:21.08113Z","caller":"traceutil/trace.go:171","msg":"trace[755575410] transaction","detail":"{read_only:false; response_revision:25514; number_of_response:1; }","duration":"109.621729ms","start":"2026-10-07T22:54:20.971479Z","end":"2026-10-07T22:54:21.081101Z","steps":["trace[755575410] 'process raft request' (duration: 107.631394ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:54:21.083301Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":22096} {"level":"info","ts":"2026-10-07T22:54:21.216296Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":22096,"took":"129.270963ms","hash":2019549390,"current-db-size-bytes":57090048,"current-db-size":"57 MB","current-db-size-in-use-bytes":45105152,"current-db-size-in-use":"45 MB"} {"level":"info","ts":"2026-10-07T22:54:21.216366Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2019549390,"revision":22096,"compact-revision":19906} {"level":"info","ts":"2026-10-07T22:54:26.513799Z","caller":"traceutil/trace.go:171","msg":"trace[769868576] linearizableReadLoop","detail":"{readStateIndex:26391; appliedIndex:26390; }","duration":"177.707345ms","start":"2026-10-07T22:54:26.336057Z","end":"2026-10-07T22:54:26.513765Z","steps":["trace[769868576] 'read index received' (duration: 177.422427ms)","trace[769868576] 'applied index is now lower than readState.Index' (duration: 284.028µs)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:54:26.513913Z","caller":"traceutil/trace.go:171","msg":"trace[1019113960] transaction","detail":"{read_only:false; response_revision:25559; number_of_response:1; }","duration":"180.482973ms","start":"2026-10-07T22:54:26.333395Z","end":"2026-10-07T22:54:26.513878Z","steps":["trace[1019113960] 'process raft request' (duration: 180.155943ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:54:26.514016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.476894ms","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-07T22:54:26.514052Z","caller":"traceutil/trace.go:171","msg":"trace[1091756720] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:25559; }","duration":"175.627848ms","start":"2026-10-07T22:54:26.338413Z","end":"2026-10-07T22:54:26.514041Z","steps":["trace[1091756720] 'agreement among raft nodes before linearized reading' (duration: 175.486584ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:54:26.514119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.035065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"} {"level":"info","ts":"2026-10-07T22:54:26.514238Z","caller":"traceutil/trace.go:171","msg":"trace[908157754] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25559; }","duration":"178.222ms","start":"2026-10-07T22:54:26.335996Z","end":"2026-10-07T22:54:26.514218Z","steps":["trace[908157754] 'agreement among raft nodes before linearized reading' (duration: 177.896881ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:54:33.58681Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-000000000000674d.wal"} {"level":"warn","ts":"2026-10-07T22:54:36.079994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.057856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-07T22:54:36.080663Z","caller":"traceutil/trace.go:171","msg":"trace[1697434076] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:25679; }","duration":"230.785337ms","start":"2026-10-07T22:54:35.849849Z","end":"2026-10-07T22:54:36.080634Z","steps":["trace[1697434076] 'count revisions from in-memory index tree' (duration: 229.881992ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:54:36.080354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.285508ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" ","response":"range_response_count:1 size:898"} {"level":"info","ts":"2026-10-07T22:54:36.080852Z","caller":"traceutil/trace.go:171","msg":"trace[1319817445] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/local-path-provisioner; range_end:; response_count:1; response_revision:25679; }","duration":"153.778563ms","start":"2026-10-07T22:54:35.927043Z","end":"2026-10-07T22:54:36.080822Z","steps":["trace[1319817445] 'range keys from in-memory index tree' (duration: 153.075953ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:54:36.080337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.702928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-manila-server\" ","response":"range_response_count:1 size:9604"} {"level":"info","ts":"2026-10-07T22:54:36.081157Z","caller":"traceutil/trace.go:171","msg":"trace[991697548] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-manila-server; range_end:; response_count:1; response_revision:25679; }","duration":"317.580163ms","start":"2026-10-07T22:54:35.763559Z","end":"2026-10-07T22:54:36.081139Z","steps":["trace[991697548] 'range keys from in-memory index tree' (duration: 316.617816ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:54:36.081217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:54:35.763529Z","time spent":"317.660245ms","remote":"127.0.0.1:56358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":1,"response size":9627,"request content":"key:\"/registry/statefulsets/openstack/rabbitmq-manila-server\" "} {"level":"warn","ts":"2026-10-07T22:54:36.081752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.845994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:57 size:2225409"} {"level":"info","ts":"2026-10-07T22:54:36.081855Z","caller":"traceutil/trace.go:171","msg":"trace[1106886688] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:57; response_revision:25679; }","duration":"311.983978ms","start":"2026-10-07T22:54:35.769852Z","end":"2026-10-07T22:54:36.081836Z","steps":["trace[1106886688] 'range keys from in-memory index tree' (duration: 310.486847ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:54:36.081899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:54:35.769841Z","time spent":"312.045699ms","remote":"127.0.0.1:56016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":57,"response size":2225432,"request content":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" "} {"level":"info","ts":"2026-10-07T22:54:36.172923Z","caller":"traceutil/trace.go:171","msg":"trace[26461388] transaction","detail":"{read_only:false; response_revision:25680; number_of_response:1; }","duration":"188.455024ms","start":"2026-10-07T22:54:35.984433Z","end":"2026-10-07T22:54:36.172888Z","steps":["trace[26461388] 'process raft request' (duration: 188.266849ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:54:36.490358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.707602ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-07T22:54:36.49053Z","caller":"traceutil/trace.go:171","msg":"trace[463671338] transaction","detail":"{read_only:false; response_revision:25681; number_of_response:1; }","duration":"495.267349ms","start":"2026-10-07T22:54:35.995229Z","end":"2026-10-07T22:54:36.490496Z","steps":["trace[463671338] 'process raft request' (duration: 314.942731ms)","trace[463671338] 'compare' (duration: 179.31171ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T22:54:36.490681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:54:35.995194Z","time spent":"495.407352ms","remote":"127.0.0.1:56174","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-07T22:54:36.490849Z","caller":"traceutil/trace.go:171","msg":"trace[641634648] transaction","detail":"{read_only:false; response_revision:25682; number_of_response:1; }","duration":"300.983043ms","start":"2026-10-07T22:54:36.189847Z","end":"2026-10-07T22:54:36.49083Z","steps":["trace[641634648] 'process raft request' (duration: 300.640314ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:54:36.490983Z","caller":"traceutil/trace.go:171","msg":"trace[463989942] linearizableReadLoop","detail":"{readStateIndex:26515; appliedIndex:26513; }","duration":"407.922338ms","start":"2026-10-07T22:54:36.083034Z","end":"2026-10-07T22:54:36.490956Z","steps":["trace[463989942] 'read index received' (duration: 89.707157ms)","trace[463989942] 'applied index is now lower than readState.Index' (duration: 318.212481ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T22:54:36.491053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:54:36.189825Z","time spent":"301.076515ms","remote":"127.0.0.1:56174","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-07T22:54:36.491237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.193405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-53817342-e3be-4ebd-bc20-7a3b320dcbd4\" ","response":"range_response_count:1 size:3644"} {"level":"info","ts":"2026-10-07T22:54:36.491282Z","caller":"traceutil/trace.go:171","msg":"trace[266313429] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-53817342-e3be-4ebd-bc20-7a3b320dcbd4; range_end:; response_count:1; response_revision:25682; }","duration":"408.301138ms","start":"2026-10-07T22:54:36.08297Z","end":"2026-10-07T22:54:36.491272Z","steps":["trace[266313429] 'agreement among raft nodes before linearized reading' (duration: 408.124484ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:54:36.491315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:54:36.082927Z","time spent":"408.37947ms","remote":"127.0.0.1:56092","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3667,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-53817342-e3be-4ebd-bc20-7a3b320dcbd4\" "} {"level":"warn","ts":"2026-10-07T22:54:36.491399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.341236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/cert-manager/cert-manager\" ","response":"range_response_count:1 size:969"} {"level":"info","ts":"2026-10-07T22:54:36.49144Z","caller":"traceutil/trace.go:171","msg":"trace[1254447864] range","detail":"{range_begin:/registry/serviceaccounts/cert-manager/cert-manager; range_end:; response_count:1; response_revision:25682; }","duration":"256.400397ms","start":"2026-10-07T22:54:36.23503Z","end":"2026-10-07T22:54:36.49143Z","steps":["trace[1254447864] 'agreement among raft nodes before linearized reading' (duration: 256.309734ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:54:36.491314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.796526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0\" ","response":"range_response_count:1 size:1446"} {"level":"info","ts":"2026-10-07T22:54:36.491547Z","caller":"traceutil/trace.go:171","msg":"trace[430173269] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:25682; }","duration":"407.056044ms","start":"2026-10-07T22:54:36.084478Z","end":"2026-10-07T22:54:36.491534Z","steps":["trace[430173269] 'agreement among raft nodes before linearized reading' (duration: 406.734185ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:54:36.491587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:54:36.084458Z","time spent":"407.118445ms","remote":"127.0.0.1:56058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":1,"response size":1469,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0\" "} {"level":"warn","ts":"2026-10-07T22:54:36.491607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.208939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/projects/\" range_end:\"/registry/openstack.k-orc.cloud/projects0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-07T22:54:36.491636Z","caller":"traceutil/trace.go:171","msg":"trace[418759870] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/projects/; range_end:/registry/openstack.k-orc.cloud/projects0; response_count:0; response_revision:25682; }","duration":"266.280131ms","start":"2026-10-07T22:54:36.225346Z","end":"2026-10-07T22:54:36.491626Z","steps":["trace[418759870] 'agreement among raft nodes before linearized reading' (duration: 266.2321ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:54:36.491841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.095492ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1822"} {"level":"info","ts":"2026-10-07T22:54:36.491879Z","caller":"traceutil/trace.go:171","msg":"trace[1568121724] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:25682; }","duration":"373.173404ms","start":"2026-10-07T22:54:36.118695Z","end":"2026-10-07T22:54:36.491868Z","steps":["trace[1568121724] 'agreement among raft nodes before linearized reading' (duration: 373.074681ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:54:36.491912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:54:36.118666Z","time spent":"373.233056ms","remote":"127.0.0.1:56008","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":1845,"request content":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" "} {"level":"info","ts":"2026-10-07T22:54:36.951224Z","caller":"traceutil/trace.go:171","msg":"trace[1199741439] linearizableReadLoop","detail":"{readStateIndex:26519; appliedIndex:26518; }","duration":"235.873578ms","start":"2026-10-07T22:54:36.715315Z","end":"2026-10-07T22:54:36.951189Z","steps":["trace[1199741439] 'read index received' (duration: 153.544546ms)","trace[1199741439] 'applied index is now lower than readState.Index' (duration: 82.327502ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:54:36.951571Z","caller":"traceutil/trace.go:171","msg":"trace[736768815] transaction","detail":"{read_only:false; response_revision:25685; number_of_response:1; }","duration":"271.450354ms","start":"2026-10-07T22:54:36.680106Z","end":"2026-10-07T22:54:36.951556Z","steps":["trace[736768815] 'process raft request' (duration: 188.825694ms)","trace[736768815] 'compare' (duration: 81.927931ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T22:54:36.951763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.179366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"} {"level":"info","ts":"2026-10-07T22:54:36.951843Z","caller":"traceutil/trace.go:171","msg":"trace[1214159544] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25685; }","duration":"197.31284ms","start":"2026-10-07T22:54:36.754512Z","end":"2026-10-07T22:54:36.951824Z","steps":["trace[1214159544] 'agreement among raft nodes before linearized reading' (duration: 197.092814ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:54:36.951917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.576657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-10-07T22:54:36.952025Z","caller":"traceutil/trace.go:171","msg":"trace[179042812] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25685; }","duration":"236.728832ms","start":"2026-10-07T22:54:36.715271Z","end":"2026-10-07T22:54:36.952Z","steps":["trace[179042812] 'agreement among raft nodes before linearized reading' (duration: 236.409473ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:54:37.111334Z","caller":"traceutil/trace.go:171","msg":"trace[322635078] linearizableReadLoop","detail":"{readStateIndex:26520; appliedIndex:26519; }","duration":"154.116182ms","start":"2026-10-07T22:54:36.957193Z","end":"2026-10-07T22:54:37.111309Z","steps":["trace[322635078] 'read index received' (duration: 129.470069ms)","trace[322635078] 'applied index is now lower than readState.Index' (duration: 24.644803ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:54:37.111443Z","caller":"traceutil/trace.go:171","msg":"trace[1833729642] transaction","detail":"{read_only:false; response_revision:25686; number_of_response:1; }","duration":"155.397048ms","start":"2026-10-07T22:54:36.956032Z","end":"2026-10-07T22:54:37.111429Z","steps":["trace[1833729642] 'process raft request' (duration: 130.649302ms)","trace[1833729642] 'compare' (duration: 24.518659ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T22:54:37.11173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.511893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"} {"level":"info","ts":"2026-10-07T22:54:37.111825Z","caller":"traceutil/trace.go:171","msg":"trace[493997051] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25686; }","duration":"154.658787ms","start":"2026-10-07T22:54:36.957144Z","end":"2026-10-07T22:54:37.111803Z","steps":["trace[493997051] 'agreement among raft nodes before linearized reading' (duration: 154.41269ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:54:37.499156Z","caller":"traceutil/trace.go:171","msg":"trace[214286225] transaction","detail":"{read_only:false; response_revision:25687; number_of_response:1; }","duration":"528.829919ms","start":"2026-10-07T22:54:36.970302Z","end":"2026-10-07T22:54:37.499132Z","steps":["trace[214286225] 'process raft request' (duration: 510.069739ms)","trace[214286225] 'compare' (duration: 18.183604ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T22:54:37.499293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:54:36.970281Z","time spent":"528.941992ms","remote":"127.0.0.1:44288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1317,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-07T22:54:37.499396Z","caller":"traceutil/trace.go:171","msg":"trace[137086292] linearizableReadLoop","detail":"{readStateIndex:26522; appliedIndex:26520; }","duration":"387.971414ms","start":"2026-10-07T22:54:37.111397Z","end":"2026-10-07T22:54:37.499369Z","steps":["trace[137086292] 'read index received' (duration: 369.06982ms)","trace[137086292] 'applied index is now lower than readState.Index' (duration: 18.899424ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:54:37.499563Z","caller":"traceutil/trace.go:171","msg":"trace[1724716533] transaction","detail":"{read_only:false; response_revision:25688; number_of_response:1; }","duration":"415.550289ms","start":"2026-10-07T22:54:37.08399Z","end":"2026-10-07T22:54:37.49954Z","steps":["trace[1724716533] 'process raft request' (duration: 415.042095ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:54:37.499711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:54:37.083971Z","time spent":"415.660532ms","remote":"127.0.0.1:56174","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":627,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-07T22:54:37.500809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"519.976654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:57 size:2225409"} {"level":"info","ts":"2026-10-07T22:54:37.500896Z","caller":"traceutil/trace.go:171","msg":"trace[1645194992] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:57; response_revision:25688; }","duration":"520.072456ms","start":"2026-10-07T22:54:36.980804Z","end":"2026-10-07T22:54:37.500876Z","steps":["trace[1645194992] 'agreement among raft nodes before linearized reading' (duration: 518.810391ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:54:37.500955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:54:36.980783Z","time spent":"520.141128ms","remote":"127.0.0.1:56016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":57,"response size":2225432,"request content":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" "} {"level":"warn","ts":"2026-10-07T22:54:37.856397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.710128ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-07T22:54:37.85683Z","caller":"traceutil/trace.go:171","msg":"trace[1188021378] transaction","detail":"{read_only:false; response_revision:25689; number_of_response:1; }","duration":"700.952439ms","start":"2026-10-07T22:54:37.15584Z","end":"2026-10-07T22:54:37.856792Z","steps":["trace[1188021378] 'process raft request' (duration: 519.726916ms)","trace[1188021378] 'compare' (duration: 180.481252ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:54:37.856901Z","caller":"traceutil/trace.go:171","msg":"trace[637351028] transaction","detail":"{read_only:false; response_revision:25690; number_of_response:1; }","duration":"458.975281ms","start":"2026-10-07T22:54:37.397874Z","end":"2026-10-07T22:54:37.85685Z","steps":["trace[637351028] 'process raft request' (duration: 458.669783ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:54:37.857038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:54:37.155816Z","time spent":"701.110733ms","remote":"127.0.0.1:56174","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-07T22:54:37.857138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:54:37.397845Z","time spent":"459.184557ms","remote":"127.0.0.1:56174","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-07T22:54:37.857184Z","caller":"traceutil/trace.go:171","msg":"trace[294287109] transaction","detail":"{read_only:false; response_revision:25691; number_of_response:1; }","duration":"403.475273ms","start":"2026-10-07T22:54:37.453683Z","end":"2026-10-07T22:54:37.857158Z","steps":["trace[294287109] 'process raft request' (duration: 403.083392ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:54:37.857293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:54:37.453657Z","time spent":"403.573716ms","remote":"127.0.0.1:56174","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-07T22:54:37.857371Z","caller":"traceutil/trace.go:171","msg":"trace[1334563202] transaction","detail":"{read_only:false; response_revision:25692; number_of_response:1; }","duration":"402.747543ms","start":"2026-10-07T22:54:37.45461Z","end":"2026-10-07T22:54:37.857357Z","steps":["trace[1334563202] 'process raft request' (duration: 402.466886ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:54:37.85745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:54:37.454586Z","time spent":"402.826165ms","remote":"127.0.0.1:56174","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-07T22:54:37.857349Z","caller":"traceutil/trace.go:171","msg":"trace[552136293] linearizableReadLoop","detail":"{readStateIndex:26527; appliedIndex:26522; }","duration":"357.869228ms","start":"2026-10-07T22:54:37.499451Z","end":"2026-10-07T22:54:37.85732Z","steps":["trace[552136293] 'read index received' (duration: 176.128981ms)","trace[552136293] 'applied index is now lower than readState.Index' (duration: 181.739037ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:54:37.857388Z","caller":"traceutil/trace.go:171","msg":"trace[1596346577] transaction","detail":"{read_only:false; response_revision:25693; number_of_response:1; }","duration":"399.084591ms","start":"2026-10-07T22:54:37.458294Z","end":"2026-10-07T22:54:37.857379Z","steps":["trace[1596346577] 'process raft request' (duration: 398.927627ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:54:37.857775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:54:37.45828Z","time spent":"399.39789ms","remote":"127.0.0.1:56174","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-07T22:54:37.858473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"745.120043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:19234"} {"level":"info","ts":"2026-10-07T22:54:37.858557Z","caller":"traceutil/trace.go:171","msg":"trace[1006767416] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:25693; }","duration":"745.257647ms","start":"2026-10-07T22:54:37.113282Z","end":"2026-10-07T22:54:37.85854Z","steps":["trace[1006767416] 'agreement among raft nodes before linearized reading' (duration: 744.118456ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:54:37.858617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:54:37.113264Z","time spent":"745.345109ms","remote":"127.0.0.1:56082","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":19257,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-10-07T22:54:38.04661Z","caller":"traceutil/trace.go:171","msg":"trace[271112323] linearizableReadLoop","detail":"{readStateIndex:26528; appliedIndex:26527; }","duration":"189.02483ms","start":"2026-10-07T22:54:37.857534Z","end":"2026-10-07T22:54:38.046559Z","steps":["trace[271112323] 'read index received' (duration: 151.043537ms)","trace[271112323] 'applied index is now lower than readState.Index' (duration: 37.979953ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:54:38.046717Z","caller":"traceutil/trace.go:171","msg":"trace[692943162] transaction","detail":"{read_only:false; response_revision:25694; number_of_response:1; }","duration":"538.191857ms","start":"2026-10-07T22:54:37.50847Z","end":"2026-10-07T22:54:38.046662Z","steps":["trace[692943162] 'process raft request' (duration: 500.193823ms)","trace[692943162] 'compare' (duration: 37.656724ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T22:54:38.046761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.843502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-10-07T22:54:38.046823Z","caller":"traceutil/trace.go:171","msg":"trace[1017565457] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25694; }","duration":"373.924524ms","start":"2026-10-07T22:54:37.672881Z","end":"2026-10-07T22:54:38.046806Z","steps":["trace[1017565457] 'agreement among raft nodes before linearized reading' (duration: 373.682697ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:54:38.046805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.477971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-53817342-e3be-4ebd-bc20-7a3b320dcbd4\" ","response":"range_response_count:1 size:3644"} {"level":"warn","ts":"2026-10-07T22:54:38.046831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.278451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"warn","ts":"2026-10-07T22:54:38.046849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:54:37.508436Z","time spent":"538.344911ms","remote":"127.0.0.1:44246","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2229,"response count":0,"response size":41,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-07T22:54:38.046837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"500.294157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1822"} {"level":"warn","ts":"2026-10-07T22:54:38.046868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:54:37.672877Z","time spent":"373.983256ms","remote":"127.0.0.1:56174","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-10-07T22:54:38.046876Z","caller":"traceutil/trace.go:171","msg":"trace[1332318511] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-53817342-e3be-4ebd-bc20-7a3b320dcbd4; range_end:; response_count:1; response_revision:25694; }","duration":"395.590604ms","start":"2026-10-07T22:54:37.651271Z","end":"2026-10-07T22:54:38.046861Z","steps":["trace[1332318511] 'agreement among raft nodes before linearized reading' (duration: 395.313957ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:54:38.046889Z","caller":"traceutil/trace.go:171","msg":"trace[1492071050] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25694; }","duration":"384.352463ms","start":"2026-10-07T22:54:37.66252Z","end":"2026-10-07T22:54:38.046873Z","steps":["trace[1492071050] 'agreement among raft nodes before linearized reading' (duration: 384.135587ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:54:38.046857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.792254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:1 size:3309"} {"level":"info","ts":"2026-10-07T22:54:38.046906Z","caller":"traceutil/trace.go:171","msg":"trace[484069481] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:25694; }","duration":"500.426391ms","start":"2026-10-07T22:54:37.546461Z","end":"2026-10-07T22:54:38.046887Z","steps":["trace[484069481] 'agreement among raft nodes before linearized reading' (duration: 500.224695ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:54:38.046917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:54:37.651255Z","time spent":"395.652497ms","remote":"127.0.0.1:56092","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3667,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-53817342-e3be-4ebd-bc20-7a3b320dcbd4\" "} {"level":"warn","ts":"2026-10-07T22:54:38.046926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:54:37.662515Z","time spent":"384.403305ms","remote":"127.0.0.1:56174","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-10-07T22:54:38.046927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.938123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-07T22:54:38.046968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:54:37.54644Z","time spent":"500.519773ms","remote":"127.0.0.1:56008","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":1845,"request content":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" "} {"level":"info","ts":"2026-10-07T22:54:38.046996Z","caller":"traceutil/trace.go:171","msg":"trace[1548192247] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:25694; }","duration":"121.064876ms","start":"2026-10-07T22:54:37.925915Z","end":"2026-10-07T22:54:38.04698Z","steps":["trace[1548192247] 'agreement among raft nodes before linearized reading' (duration: 120.964213ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:54:38.046962Z","caller":"traceutil/trace.go:171","msg":"trace[842017078] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:1; response_revision:25694; }","duration":"424.921297ms","start":"2026-10-07T22:54:37.622004Z","end":"2026-10-07T22:54:38.046926Z","steps":["trace[842017078] 'agreement among raft nodes before linearized reading' (duration: 424.635179ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:54:38.047027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"541.700674ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"warn","ts":"2026-10-07T22:54:38.047045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:54:37.621983Z","time spent":"425.048951ms","remote":"127.0.0.1:54760","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":1,"response size":3332,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" "} {"level":"info","ts":"2026-10-07T22:54:38.047112Z","caller":"traceutil/trace.go:171","msg":"trace[234461148] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25694; }","duration":"541.783947ms","start":"2026-10-07T22:54:37.505287Z","end":"2026-10-07T22:54:38.047071Z","steps":["trace[234461148] 'agreement among raft nodes before linearized reading' (duration: 541.522ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:54:38.04719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:54:37.505274Z","time spent":"541.90301ms","remote":"127.0.0.1:56174","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-10-07T22:54:38.047283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.640497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-10-07T22:54:38.047318Z","caller":"traceutil/trace.go:171","msg":"trace[1237632536] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:25694; }","duration":"285.708609ms","start":"2026-10-07T22:54:37.761599Z","end":"2026-10-07T22:54:38.047308Z","steps":["trace[1237632536] 'agreement among raft nodes before linearized reading' (duration: 285.511003ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:54:38.478738Z","caller":"traceutil/trace.go:171","msg":"trace[1130847705] linearizableReadLoop","detail":"{readStateIndex:26533; appliedIndex:26532; }","duration":"313.85799ms","start":"2026-10-07T22:54:38.164854Z","end":"2026-10-07T22:54:38.478712Z","steps":["trace[1130847705] 'read index received' (duration: 292.871398ms)","trace[1130847705] 'applied index is now lower than readState.Index' (duration: 20.985112ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:54:38.479041Z","caller":"traceutil/trace.go:171","msg":"trace[249621352] transaction","detail":"{read_only:false; response_revision:25699; number_of_response:1; }","duration":"342.795002ms","start":"2026-10-07T22:54:38.136224Z","end":"2026-10-07T22:54:38.479019Z","steps":["trace[249621352] 'process raft request' (duration: 321.514313ms)","trace[249621352] 'compare' (duration: 20.382534ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T22:54:38.479157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:54:38.136204Z","time spent":"342.881394ms","remote":"127.0.0.1:55704","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7439,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-07T22:54:38.479444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.559299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/rabbitmq-manila.18dc613f27396e61\" ","response":"range_response_count:1 size:736"} {"level":"warn","ts":"2026-10-07T22:54:38.479464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.58009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-manila-server\" ","response":"range_response_count:1 size:9604"} {"level":"info","ts":"2026-10-07T22:54:38.479522Z","caller":"traceutil/trace.go:171","msg":"trace[1846422276] range","detail":"{range_begin:/registry/events/openstack/rabbitmq-manila.18dc613f27396e61; range_end:; response_count:1; response_revision:25699; }","duration":"314.695813ms","start":"2026-10-07T22:54:38.164807Z","end":"2026-10-07T22:54:38.479503Z","steps":["trace[1846422276] 'agreement among raft nodes before linearized reading' (duration: 314.461076ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:54:38.479536Z","caller":"traceutil/trace.go:171","msg":"trace[2037658528] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-manila-server; range_end:; response_count:1; response_revision:25699; }","duration":"314.709893ms","start":"2026-10-07T22:54:38.164807Z","end":"2026-10-07T22:54:38.479517Z","steps":["trace[2037658528] 'agreement among raft nodes before linearized reading' (duration: 314.463456ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:54:38.479566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:54:38.164786Z","time spent":"314.771255ms","remote":"127.0.0.1:55988","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":759,"request content":"key:\"/registry/events/openstack/rabbitmq-manila.18dc613f27396e61\" "} {"level":"warn","ts":"2026-10-07T22:54:38.479584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:54:38.164784Z","time spent":"314.791906ms","remote":"127.0.0.1:56358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":1,"response size":9627,"request content":"key:\"/registry/statefulsets/openstack/rabbitmq-manila-server\" "} {"level":"info","ts":"2026-10-07T22:54:38.527099Z","caller":"traceutil/trace.go:171","msg":"trace[1462746898] transaction","detail":"{read_only:false; response_revision:25700; number_of_response:1; }","duration":"348.301524ms","start":"2026-10-07T22:54:38.178773Z","end":"2026-10-07T22:54:38.527075Z","steps":["trace[1462746898] 'process raft request' (duration: 348.12609ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:54:38.527239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:54:38.178754Z","time spent":"348.411688ms","remote":"127.0.0.1:56174","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-07T22:54:38.527224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.623738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/coredns\" ","response":"range_response_count:1 size:180"} {"level":"info","ts":"2026-10-07T22:54:38.527334Z","caller":"traceutil/trace.go:171","msg":"trace[935194885] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/coredns; range_end:; response_count:1; response_revision:25700; }","duration":"241.777802ms","start":"2026-10-07T22:54:38.285534Z","end":"2026-10-07T22:54:38.527312Z","steps":["trace[935194885] 'agreement among raft nodes before linearized reading' (duration: 241.554436ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:54:38.767274Z","caller":"traceutil/trace.go:171","msg":"trace[2064742894] transaction","detail":"{read_only:false; response_revision:25701; number_of_response:1; }","duration":"285.669199ms","start":"2026-10-07T22:54:38.481573Z","end":"2026-10-07T22:54:38.767242Z","steps":["trace[2064742894] 'process raft request' (duration: 211.221185ms)","trace[2064742894] 'compare' (duration: 74.198937ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:54:38.767633Z","caller":"traceutil/trace.go:171","msg":"trace[1709090785] linearizableReadLoop","detail":"{readStateIndex:26537; appliedIndex:26534; }","duration":"240.558238ms","start":"2026-10-07T22:54:38.52705Z","end":"2026-10-07T22:54:38.767608Z","steps":["trace[1709090785] 'read index received' (duration: 165.663082ms)","trace[1709090785] 'applied index is now lower than readState.Index' (duration: 74.894046ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:54:38.767695Z","caller":"traceutil/trace.go:171","msg":"trace[499848684] transaction","detail":"{read_only:false; response_revision:25702; number_of_response:1; }","duration":"271.997059ms","start":"2026-10-07T22:54:38.495668Z","end":"2026-10-07T22:54:38.767665Z","steps":["trace[499848684] 'process raft request' (duration: 271.475125ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:54:38.767685Z","caller":"traceutil/trace.go:171","msg":"trace[221480346] transaction","detail":"{read_only:false; response_revision:25703; number_of_response:1; }","duration":"271.500376ms","start":"2026-10-07T22:54:38.496148Z","end":"2026-10-07T22:54:38.767649Z","steps":["trace[221480346] 'process raft request' (duration: 271.322071ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:54:38.767819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.23076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-07T22:54:38.76791Z","caller":"traceutil/trace.go:171","msg":"trace[1857705388] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25703; }","duration":"253.365724ms","start":"2026-10-07T22:54:38.514523Z","end":"2026-10-07T22:54:38.767888Z","steps":["trace[1857705388] 'agreement among raft nodes before linearized reading' (duration: 253.184479ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:54:38.767901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.940708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0\" ","response":"range_response_count:1 size:1446"} {"level":"warn","ts":"2026-10-07T22:54:38.767984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.997354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-67659f764b-62tll\" ","response":"range_response_count:1 size:4909"} {"level":"info","ts":"2026-10-07T22:54:38.767997Z","caller":"traceutil/trace.go:171","msg":"trace[1917063327] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:25703; }","duration":"285.072092ms","start":"2026-10-07T22:54:38.482904Z","end":"2026-10-07T22:54:38.767976Z","steps":["trace[1917063327] 'agreement among raft nodes before linearized reading' (duration: 284.815115ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:54:38.768045Z","caller":"traceutil/trace.go:171","msg":"trace[679694310] range","detail":"{range_begin:/registry/pods/kube-system/coredns-67659f764b-62tll; range_end:; response_count:1; response_revision:25703; }","duration":"239.124488ms","start":"2026-10-07T22:54:38.528894Z","end":"2026-10-07T22:54:38.768019Z","steps":["trace[679694310] 'agreement among raft nodes before linearized reading' (duration: 238.860781ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:54:38.768067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.69376ms","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-07T22:54:38.768189Z","caller":"traceutil/trace.go:171","msg":"trace[1695119401] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25703; }","duration":"127.880214ms","start":"2026-10-07T22:54:38.640287Z","end":"2026-10-07T22:54:38.768167Z","steps":["trace[1695119401] 'agreement among raft nodes before linearized reading' (duration: 127.486663ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:54:39.031781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.323891ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-07T22:54:39.031869Z","caller":"traceutil/trace.go:171","msg":"trace[1763729138] transaction","detail":"{read_only:false; response_revision:25705; number_of_response:1; }","duration":"189.75254ms","start":"2026-10-07T22:54:38.842098Z","end":"2026-10-07T22:54:39.031851Z","steps":["trace[1763729138] 'process raft request' (duration: 89.280774ms)","trace[1763729138] 'compare' (duration: 100.101165ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:54:39.300377Z","caller":"traceutil/trace.go:171","msg":"trace[880016963] linearizableReadLoop","detail":"{readStateIndex:26540; appliedIndex:26538; }","duration":"380.999781ms","start":"2026-10-07T22:54:38.919347Z","end":"2026-10-07T22:54:39.300347Z","steps":["trace[880016963] 'read index received' (duration: 11.949971ms)","trace[880016963] 'applied index is now lower than readState.Index' (duration: 369.04738ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:54:39.300428Z","caller":"traceutil/trace.go:171","msg":"trace[438295064] transaction","detail":"{read_only:false; response_revision:25706; number_of_response:1; }","duration":"448.159612ms","start":"2026-10-07T22:54:38.852203Z","end":"2026-10-07T22:54:39.300363Z","steps":["trace[438295064] 'process raft request' (duration: 434.483303ms)","trace[438295064] 'compare' (duration: 13.204056ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T22:54:39.300517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.152275ms","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-07T22:54:39.30059Z","caller":"traceutil/trace.go:171","msg":"trace[1146342080] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinesets/; range_end:/registry/cluster.x-k8s.io/machinesets0; response_count:0; response_revision:25706; }","duration":"381.277219ms","start":"2026-10-07T22:54:38.919292Z","end":"2026-10-07T22:54:39.300569Z","steps":["trace[1146342080] 'agreement among raft nodes before linearized reading' (duration: 381.150016ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:54:39.300583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:54:38.852183Z","time spent":"448.326747ms","remote":"127.0.0.1:55988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":923,"response count":0,"response size":41,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-07T22:54:39.300629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:54:38.919271Z","time spent":"381.34829ms","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":0,"response size":29,"request content":"key:\"/registry/cluster.x-k8s.io/machinesets/\" range_end:\"/registry/cluster.x-k8s.io/machinesets0\" count_only:true "} {"level":"warn","ts":"2026-10-07T22:54:39.300645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.488587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-53817342-e3be-4ebd-bc20-7a3b320dcbd4\" ","response":"range_response_count:1 size:3644"} {"level":"info","ts":"2026-10-07T22:54:39.300683Z","caller":"traceutil/trace.go:171","msg":"trace[1306267854] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-53817342-e3be-4ebd-bc20-7a3b320dcbd4; range_end:; response_count:1; response_revision:25706; }","duration":"248.540599ms","start":"2026-10-07T22:54:39.05213Z","end":"2026-10-07T22:54:39.30067Z","steps":["trace[1306267854] 'agreement among raft nodes before linearized reading' (duration: 248.367954ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:54:39.300674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.630647ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-10-07T22:54:39.300747Z","caller":"traceutil/trace.go:171","msg":"trace[1595551740] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25706; }","duration":"184.768862ms","start":"2026-10-07T22:54:39.11596Z","end":"2026-10-07T22:54:39.300729Z","steps":["trace[1595551740] 'agreement among raft nodes before linearized reading' (duration: 184.549095ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:54:39.728364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.482353ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-10-07T22:54:39.728866Z","caller":"traceutil/trace.go:171","msg":"trace[193564637] transaction","detail":"{read_only:false; response_revision:25708; number_of_response:1; }","duration":"152.312252ms","start":"2026-10-07T22:54:39.57652Z","end":"2026-10-07T22:54:39.728832Z","steps":["trace[193564637] 'process raft request' (duration: 151.928352ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:54:46.029783Z","caller":"traceutil/trace.go:171","msg":"trace[762004958] transaction","detail":"{read_only:false; response_revision:25780; number_of_response:1; }","duration":"139.402894ms","start":"2026-10-07T22:54:45.890356Z","end":"2026-10-07T22:54:46.029759Z","steps":["trace[762004958] 'process raft request' (duration: 139.265861ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:54:46.030043Z","caller":"traceutil/trace.go:171","msg":"trace[1217937258] transaction","detail":"{read_only:false; response_revision:25779; number_of_response:1; }","duration":"139.724074ms","start":"2026-10-07T22:54:45.890293Z","end":"2026-10-07T22:54:46.030017Z","steps":["trace[1217937258] 'process raft request' (duration: 139.109057ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:54:46.0301Z","caller":"traceutil/trace.go:171","msg":"trace[1645696891] transaction","detail":"{read_only:false; response_revision:25782; number_of_response:1; }","duration":"139.61997ms","start":"2026-10-07T22:54:45.890442Z","end":"2026-10-07T22:54:46.030062Z","steps":["trace[1645696891] 'process raft request' (duration: 139.26799ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:54:46.030071Z","caller":"traceutil/trace.go:171","msg":"trace[279474390] transaction","detail":"{read_only:false; response_revision:25781; number_of_response:1; }","duration":"139.659832ms","start":"2026-10-07T22:54:45.890356Z","end":"2026-10-07T22:54:46.030016Z","steps":["trace[279474390] 'process raft request' (duration: 139.313422ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:54:46.326199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.100504ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-07T22:54:46.326427Z","caller":"traceutil/trace.go:171","msg":"trace[1620338231] transaction","detail":"{read_only:false; response_revision:25784; number_of_response:1; }","duration":"212.568602ms","start":"2026-10-07T22:54:46.113842Z","end":"2026-10-07T22:54:46.32641Z","steps":["trace[1620338231] 'process raft request' (duration: 212.47053ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:54:46.326457Z","caller":"traceutil/trace.go:171","msg":"trace[1588244459] transaction","detail":"{read_only:false; response_revision:25783; number_of_response:1; }","duration":"214.251168ms","start":"2026-10-07T22:54:46.11216Z","end":"2026-10-07T22:54:46.326411Z","steps":["trace[1588244459] 'process raft request' (duration: 60.855336ms)","trace[1588244459] 'compare' (duration: 152.96704ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:54:46.326559Z","caller":"traceutil/trace.go:171","msg":"trace[754419190] transaction","detail":"{read_only:false; response_revision:25785; number_of_response:1; }","duration":"211.681058ms","start":"2026-10-07T22:54:46.114863Z","end":"2026-10-07T22:54:46.326544Z","steps":["trace[754419190] 'process raft request' (duration: 211.511203ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:55:01.067927Z","caller":"traceutil/trace.go:171","msg":"trace[1531489965] transaction","detail":"{read_only:false; response_revision:25910; number_of_response:1; }","duration":"126.96914ms","start":"2026-10-07T22:55:00.940916Z","end":"2026-10-07T22:55:01.067885Z","steps":["trace[1531489965] 'process raft request' (duration: 126.808145ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:55:02.276727Z","caller":"traceutil/trace.go:171","msg":"trace[1656471339] transaction","detail":"{read_only:false; response_revision:25914; number_of_response:1; }","duration":"186.975663ms","start":"2026-10-07T22:55:02.089729Z","end":"2026-10-07T22:55:02.276704Z","steps":["trace[1656471339] 'process raft request' (duration: 186.84226ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:55:02.422488Z","caller":"traceutil/trace.go:171","msg":"trace[640669355] transaction","detail":"{read_only:false; response_revision:25916; number_of_response:1; }","duration":"321.333548ms","start":"2026-10-07T22:55:02.101131Z","end":"2026-10-07T22:55:02.422464Z","steps":["trace[640669355] 'process raft request' (duration: 321.226025ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:55:02.423416Z","caller":"traceutil/trace.go:171","msg":"trace[1955036966] transaction","detail":"{read_only:false; response_revision:25915; number_of_response:1; }","duration":"329.417692ms","start":"2026-10-07T22:55:02.093982Z","end":"2026-10-07T22:55:02.4234Z","steps":["trace[1955036966] 'process raft request' (duration: 281.864823ms)","trace[1955036966] 'compare' (duration: 46.338525ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T22:55:02.423467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:55:02.093964Z","time spent":"329.478853ms","remote":"127.0.0.1:56174","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-07T22:55:02.423644Z","caller":"traceutil/trace.go:171","msg":"trace[933020756] transaction","detail":"{read_only:false; response_revision:25918; number_of_response:1; }","duration":"283.084967ms","start":"2026-10-07T22:55:02.140531Z","end":"2026-10-07T22:55:02.423616Z","steps":["trace[933020756] 'process raft request' (duration: 282.896182ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:55:02.423628Z","caller":"traceutil/trace.go:171","msg":"trace[1153166133] transaction","detail":"{read_only:false; response_revision:25917; number_of_response:1; }","duration":"322.308894ms","start":"2026-10-07T22:55:02.10122Z","end":"2026-10-07T22:55:02.423529Z","steps":["trace[1153166133] 'process raft request' (duration: 321.208604ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:55:02.423959Z","caller":"traceutil/trace.go:171","msg":"trace[1574779871] transaction","detail":"{read_only:false; response_revision:25919; number_of_response:1; }","duration":"173.777067ms","start":"2026-10-07T22:55:02.250174Z","end":"2026-10-07T22:55:02.423951Z","steps":["trace[1574779871] 'process raft request' (duration: 173.382796ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:55:02.423999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:55:02.101212Z","time spent":"322.614692ms","remote":"127.0.0.1:56174","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-07T22:55:02.424306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.573847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1936"} {"level":"info","ts":"2026-10-07T22:55:02.424338Z","caller":"traceutil/trace.go:171","msg":"trace[866967556] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:25919; }","duration":"175.618428ms","start":"2026-10-07T22:55:02.248709Z","end":"2026-10-07T22:55:02.424328Z","steps":["trace[866967556] 'agreement among raft nodes before linearized reading' (duration: 175.488615ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:55:02.423672Z","caller":"traceutil/trace.go:171","msg":"trace[835077759] linearizableReadLoop","detail":"{readStateIndex:26758; appliedIndex:26753; }","duration":"174.9418ms","start":"2026-10-07T22:55:02.248715Z","end":"2026-10-07T22:55:02.423657Z","steps":["trace[835077759] 'read index received' (duration: 27.864483ms)","trace[835077759] 'applied index is now lower than readState.Index' (duration: 147.075837ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T22:55:02.425404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.661774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/heat-ks-endpoints\" ","response":"range_response_count:1 size:21561"} {"level":"info","ts":"2026-10-07T22:55:02.425453Z","caller":"traceutil/trace.go:171","msg":"trace[807485975] range","detail":"{range_begin:/registry/jobs/openstack/heat-ks-endpoints; range_end:; response_count:1; response_revision:25919; }","duration":"155.743317ms","start":"2026-10-07T22:55:02.269696Z","end":"2026-10-07T22:55:02.425439Z","steps":["trace[807485975] 'agreement among raft nodes before linearized reading' (duration: 155.597073ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:55:02.426002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.245601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/heat-db-sync\" ","response":"range_response_count:1 size:5129"} {"level":"info","ts":"2026-10-07T22:55:02.426035Z","caller":"traceutil/trace.go:171","msg":"trace[1274184443] range","detail":"{range_begin:/registry/jobs/openstack/heat-db-sync; range_end:; response_count:1; response_revision:25919; }","duration":"156.287352ms","start":"2026-10-07T22:55:02.26974Z","end":"2026-10-07T22:55:02.426027Z","steps":["trace[1274184443] 'agreement among raft nodes before linearized reading' (duration: 156.21107ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:55:02.426112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.276132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/keystone-api\" ","response":"range_response_count:1 size:675"} {"level":"info","ts":"2026-10-07T22:55:02.426128Z","caller":"traceutil/trace.go:171","msg":"trace[1983569541] range","detail":"{range_begin:/registry/services/endpoints/openstack/keystone-api; range_end:; response_count:1; response_revision:25919; }","duration":"156.318373ms","start":"2026-10-07T22:55:02.269805Z","end":"2026-10-07T22:55:02.426124Z","steps":["trace[1983569541] 'agreement among raft nodes before linearized reading' (duration: 156.268692ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:55:02.426156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.291672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/heat-domain-ks-user\" ","response":"range_response_count:1 size:7564"} {"level":"info","ts":"2026-10-07T22:55:02.426233Z","caller":"traceutil/trace.go:171","msg":"trace[1101434990] range","detail":"{range_begin:/registry/jobs/openstack/heat-domain-ks-user; range_end:; response_count:1; response_revision:25919; }","duration":"156.380754ms","start":"2026-10-07T22:55:02.269833Z","end":"2026-10-07T22:55:02.426214Z","steps":["trace[1101434990] 'agreement among raft nodes before linearized reading' (duration: 156.109497ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:55:02.426369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.167789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/heat-ks-user\" ","response":"range_response_count:1 size:11169"} {"level":"info","ts":"2026-10-07T22:55:02.426396Z","caller":"traceutil/trace.go:171","msg":"trace[1073443334] range","detail":"{range_begin:/registry/jobs/openstack/heat-ks-user; range_end:; response_count:1; response_revision:25919; }","duration":"156.20589ms","start":"2026-10-07T22:55:02.270184Z","end":"2026-10-07T22:55:02.42639Z","steps":["trace[1073443334] 'agreement among raft nodes before linearized reading' (duration: 156.144139ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:55:02.426471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.58788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/rabbitmq-heat\" ","response":"range_response_count:1 size:895"} {"level":"info","ts":"2026-10-07T22:55:02.426533Z","caller":"traceutil/trace.go:171","msg":"trace[115098551] range","detail":"{range_begin:/registry/services/endpoints/openstack/rabbitmq-heat; range_end:; response_count:1; response_revision:25919; }","duration":"156.654893ms","start":"2026-10-07T22:55:02.269862Z","end":"2026-10-07T22:55:02.426517Z","steps":["trace[115098551] 'agreement among raft nodes before linearized reading' (duration: 156.501289ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:55:02.426571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.706214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/percona-xtradb-haproxy\" ","response":"range_response_count:1 size:1149"} {"level":"info","ts":"2026-10-07T22:55:02.426593Z","caller":"traceutil/trace.go:171","msg":"trace[434753373] range","detail":"{range_begin:/registry/services/endpoints/openstack/percona-xtradb-haproxy; range_end:; response_count:1; response_revision:25919; }","duration":"156.732665ms","start":"2026-10-07T22:55:02.269854Z","end":"2026-10-07T22:55:02.426586Z","steps":["trace[434753373] 'agreement among raft nodes before linearized reading' (duration: 156.684603ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:55:02.422688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:55:02.101114Z","time spent":"321.43567ms","remote":"127.0.0.1:56174","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-07T22:55:02.702184Z","caller":"traceutil/trace.go:171","msg":"trace[1246318610] transaction","detail":"{read_only:false; response_revision:25924; number_of_response:1; }","duration":"157.733942ms","start":"2026-10-07T22:55:02.544416Z","end":"2026-10-07T22:55:02.70215Z","steps":["trace[1246318610] 'process raft request' (duration: 157.519206ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:55:02.852427Z","caller":"traceutil/trace.go:171","msg":"trace[292509694] linearizableReadLoop","detail":"{readStateIndex:26765; appliedIndex:26764; }","duration":"144.130844ms","start":"2026-10-07T22:55:02.70828Z","end":"2026-10-07T22:55:02.852411Z","steps":["trace[292509694] 'read index received' (duration: 72.607543ms)","trace[292509694] 'applied index is now lower than readState.Index' (duration: 71.520331ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:55:02.852582Z","caller":"traceutil/trace.go:171","msg":"trace[329074967] transaction","detail":"{read_only:false; response_revision:25925; number_of_response:1; }","duration":"203.935992ms","start":"2026-10-07T22:55:02.648638Z","end":"2026-10-07T22:55:02.852574Z","steps":["trace[329074967] 'process raft request' (duration: 132.347689ms)","trace[329074967] 'compare' (duration: 71.341716ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T22:55:02.852754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.440823ms","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":"info","ts":"2026-10-07T22:55:02.852839Z","caller":"traceutil/trace.go:171","msg":"trace[1810498865] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:25925; }","duration":"144.588537ms","start":"2026-10-07T22:55:02.708231Z","end":"2026-10-07T22:55:02.85282Z","steps":["trace[1810498865] 'agreement among raft nodes before linearized reading' (duration: 144.431162ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:55:02.852875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.614167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/heat-engine-cleaner-29856895-6nz7k\" ","response":"range_response_count:1 size:6988"} {"level":"info","ts":"2026-10-07T22:55:02.852974Z","caller":"traceutil/trace.go:171","msg":"trace[848241807] range","detail":"{range_begin:/registry/pods/openstack/heat-engine-cleaner-29856895-6nz7k; range_end:; response_count:1; response_revision:25925; }","duration":"122.766312ms","start":"2026-10-07T22:55:02.730186Z","end":"2026-10-07T22:55:02.852953Z","steps":["trace[848241807] 'agreement among raft nodes before linearized reading' (duration: 122.514775ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:55:03.020002Z","caller":"traceutil/trace.go:171","msg":"trace[1607366511] transaction","detail":"{read_only:false; response_revision:25928; number_of_response:1; }","duration":"153.337631ms","start":"2026-10-07T22:55:02.866627Z","end":"2026-10-07T22:55:03.019965Z","steps":["trace[1607366511] 'process raft request' (duration: 153.220768ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:55:03.020029Z","caller":"traceutil/trace.go:171","msg":"trace[497086318] transaction","detail":"{read_only:false; response_revision:25927; number_of_response:1; }","duration":"154.302597ms","start":"2026-10-07T22:55:02.865702Z","end":"2026-10-07T22:55:03.020005Z","steps":["trace[497086318] 'process raft request' (duration: 130.442755ms)","trace[497086318] 'compare' (duration: 23.524283ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:55:04.634459Z","caller":"traceutil/trace.go:171","msg":"trace[710846114] transaction","detail":"{read_only:false; response_revision:25949; number_of_response:1; }","duration":"113.594608ms","start":"2026-10-07T22:55:04.520831Z","end":"2026-10-07T22:55:04.634426Z","steps":["trace[710846114] 'process raft request' (duration: 101.678388ms)","trace[710846114] 'compare' (duration: 11.784337ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:55:04.682Z","caller":"traceutil/trace.go:171","msg":"trace[1333481296] linearizableReadLoop","detail":"{readStateIndex:26791; appliedIndex:26789; }","duration":"153.143085ms","start":"2026-10-07T22:55:04.528811Z","end":"2026-10-07T22:55:04.681954Z","steps":["trace[1333481296] 'read index received' (duration: 93.714188ms)","trace[1333481296] 'applied index is now lower than readState.Index' (duration: 59.427537ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T22:55:04.682142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.303059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddresses/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddresses0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-07T22:55:04.682195Z","caller":"traceutil/trace.go:171","msg":"trace[465962548] range","detail":"{range_begin:/registry/ipam.cluster.x-k8s.io/ipaddresses/; range_end:/registry/ipam.cluster.x-k8s.io/ipaddresses0; response_count:0; response_revision:25950; }","duration":"153.406102ms","start":"2026-10-07T22:55:04.528774Z","end":"2026-10-07T22:55:04.68218Z","steps":["trace[465962548] 'agreement among raft nodes before linearized reading' (duration: 153.30442ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:55:04.682188Z","caller":"traceutil/trace.go:171","msg":"trace[2047900637] transaction","detail":"{read_only:false; response_revision:25950; number_of_response:1; }","duration":"161.232479ms","start":"2026-10-07T22:55:04.520903Z","end":"2026-10-07T22:55:04.682136Z","steps":["trace[2047900637] 'process raft request' (duration: 160.89537ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:55:07.229337Z","caller":"traceutil/trace.go:171","msg":"trace[744086371] transaction","detail":"{read_only:false; response_revision:25975; number_of_response:1; }","duration":"107.965093ms","start":"2026-10-07T22:55:07.121344Z","end":"2026-10-07T22:55:07.229309Z","steps":["trace[744086371] 'process raft request' (duration: 38.874398ms)","trace[744086371] 'compare' (duration: 68.968031ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T22:55:12.176864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.638221ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-07T22:55:12.177001Z","caller":"traceutil/trace.go:171","msg":"trace[1066083273] transaction","detail":"{read_only:false; response_revision:26011; number_of_response:1; }","duration":"151.113059ms","start":"2026-10-07T22:55:12.025864Z","end":"2026-10-07T22:55:12.176977Z","steps":["trace[1066083273] 'process raft request' (duration: 42.285792ms)","trace[1066083273] 'compare' (duration: 108.523548ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T22:55:16.780814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.960803ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-07T22:55:16.781011Z","caller":"traceutil/trace.go:171","msg":"trace[1466217837] transaction","detail":"{read_only:false; response_revision:26050; number_of_response:1; }","duration":"265.663834ms","start":"2026-10-07T22:55:16.51533Z","end":"2026-10-07T22:55:16.780993Z","steps":["trace[1466217837] 'process raft request' (duration: 265.605372ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:55:16.781147Z","caller":"traceutil/trace.go:171","msg":"trace[1296659464] transaction","detail":"{read_only:false; response_revision:26049; number_of_response:1; }","duration":"265.807108ms","start":"2026-10-07T22:55:16.515309Z","end":"2026-10-07T22:55:16.781116Z","steps":["trace[1296659464] 'process raft request' (duration: 148.439515ms)","trace[1296659464] 'compare' (duration: 116.802537ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:55:16.843601Z","caller":"traceutil/trace.go:171","msg":"trace[904045284] linearizableReadLoop","detail":"{readStateIndex:26894; appliedIndex:26891; }","duration":"327.156918ms","start":"2026-10-07T22:55:16.516409Z","end":"2026-10-07T22:55:16.843566Z","steps":["trace[904045284] 'read index received' (duration: 147.356494ms)","trace[904045284] 'applied index is now lower than readState.Index' (duration: 179.799104ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:55:16.843637Z","caller":"traceutil/trace.go:171","msg":"trace[708900405] transaction","detail":"{read_only:false; response_revision:26051; number_of_response:1; }","duration":"328.189597ms","start":"2026-10-07T22:55:16.51542Z","end":"2026-10-07T22:55:16.843609Z","steps":["trace[708900405] 'process raft request' (duration: 327.973671ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:55:16.843767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.348244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-07T22:55:16.843808Z","caller":"traceutil/trace.go:171","msg":"trace[1092802133] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26051; }","duration":"327.428905ms","start":"2026-10-07T22:55:16.516367Z","end":"2026-10-07T22:55:16.843796Z","steps":["trace[1092802133] 'agreement among raft nodes before linearized reading' (duration: 327.346963ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:55:16.843803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:55:16.515398Z","time spent":"328.30753ms","remote":"127.0.0.1:56174","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-07T22:55:16.843841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:55:16.516355Z","time spent":"327.479168ms","remote":"127.0.0.1:55878","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-07T22:55:16.844028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.287549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-10-07T22:55:16.84412Z","caller":"traceutil/trace.go:171","msg":"trace[708552163] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26051; }","duration":"109.388062ms","start":"2026-10-07T22:55:16.734711Z","end":"2026-10-07T22:55:16.844099Z","steps":["trace[708552163] 'agreement among raft nodes before linearized reading' (duration: 109.129575ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:55:16.844099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.906347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-10-07T22:55:16.844187Z","caller":"traceutil/trace.go:171","msg":"trace[364294963] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26051; }","duration":"136.046361ms","start":"2026-10-07T22:55:16.708124Z","end":"2026-10-07T22:55:16.84417Z","steps":["trace[364294963] 'agreement among raft nodes before linearized reading' (duration: 135.776103ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:55:16.844149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.787228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-10-07T22:55:16.844275Z","caller":"traceutil/trace.go:171","msg":"trace[1907047009] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26051; }","duration":"313.964953ms","start":"2026-10-07T22:55:16.530277Z","end":"2026-10-07T22:55:16.844242Z","steps":["trace[1907047009] 'agreement among raft nodes before linearized reading' (duration: 313.551561ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:55:16.844339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:55:16.530263Z","time spent":"314.066555ms","remote":"127.0.0.1:56174","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-10-07T22:55:17.294722Z","caller":"traceutil/trace.go:171","msg":"trace[1686731872] transaction","detail":"{read_only:false; response_revision:26057; number_of_response:1; }","duration":"178.757054ms","start":"2026-10-07T22:55:17.115933Z","end":"2026-10-07T22:55:17.29469Z","steps":["trace[1686731872] 'process raft request' (duration: 178.567959ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:55:17.48551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.280272ms","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-07T22:55:17.48567Z","caller":"traceutil/trace.go:171","msg":"trace[768641481] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26057; }","duration":"134.513979ms","start":"2026-10-07T22:55:17.351125Z","end":"2026-10-07T22:55:17.485639Z","steps":["trace[768641481] 'range keys from in-memory index tree' (duration: 133.905962ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:55:17.850288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.347209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-10-07T22:55:17.850537Z","caller":"traceutil/trace.go:171","msg":"trace[772855462] transaction","detail":"{read_only:false; response_revision:26060; number_of_response:1; }","duration":"124.291906ms","start":"2026-10-07T22:55:17.726212Z","end":"2026-10-07T22:55:17.850503Z","steps":["trace[772855462] 'process raft request' (duration: 106.020429ms)","trace[772855462] 'compare' (duration: 17.752182ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:55:17.850375Z","caller":"traceutil/trace.go:171","msg":"trace[1552099461] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26059; }","duration":"259.468893ms","start":"2026-10-07T22:55:17.590886Z","end":"2026-10-07T22:55:17.850355Z","steps":["trace[1552099461] 'range keys from in-memory index tree' (duration: 259.145203ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:55:33.483759Z","caller":"traceutil/trace.go:171","msg":"trace[1103786147] transaction","detail":"{read_only:false; response_revision:26174; number_of_response:1; }","duration":"126.735323ms","start":"2026-10-07T22:55:33.356994Z","end":"2026-10-07T22:55:33.48373Z","steps":["trace[1103786147] 'process raft request' (duration: 126.524987ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:55:33.652254Z","caller":"traceutil/trace.go:171","msg":"trace[7067520] transaction","detail":"{read_only:false; response_revision:26175; number_of_response:1; }","duration":"133.909702ms","start":"2026-10-07T22:55:33.518312Z","end":"2026-10-07T22:55:33.652222Z","steps":["trace[7067520] 'process raft request' (duration: 133.234213ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:55:33.860159Z","caller":"traceutil/trace.go:171","msg":"trace[14895116] transaction","detail":"{read_only:false; response_revision:26177; number_of_response:1; }","duration":"146.775659ms","start":"2026-10-07T22:55:33.713359Z","end":"2026-10-07T22:55:33.860135Z","steps":["trace[14895116] 'process raft request' (duration: 76.350417ms)","trace[14895116] 'compare' (duration: 69.960499ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:55:39.005786Z","caller":"traceutil/trace.go:171","msg":"trace[1087513989] transaction","detail":"{read_only:false; response_revision:26211; number_of_response:1; }","duration":"140.093073ms","start":"2026-10-07T22:55:38.865668Z","end":"2026-10-07T22:55:39.005761Z","steps":["trace[1087513989] 'process raft request' (duration: 139.898918ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:55:39.041577Z","caller":"traceutil/trace.go:171","msg":"trace[1136234939] transaction","detail":"{read_only:false; response_revision:26213; number_of_response:1; }","duration":"103.739815ms","start":"2026-10-07T22:55:38.93778Z","end":"2026-10-07T22:55:39.04152Z","steps":["trace[1136234939] 'process raft request' (duration: 103.619952ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:55:39.04158Z","caller":"traceutil/trace.go:171","msg":"trace[677606485] transaction","detail":"{read_only:false; response_revision:26212; number_of_response:1; }","duration":"164.665755ms","start":"2026-10-07T22:55:38.876873Z","end":"2026-10-07T22:55:39.041538Z","steps":["trace[677606485] 'process raft request' (duration: 164.434138ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:55:39.287059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.056448ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-07T22:55:39.287204Z","caller":"traceutil/trace.go:171","msg":"trace[433283200] transaction","detail":"{read_only:false; response_revision:26215; number_of_response:1; }","duration":"241.049032ms","start":"2026-10-07T22:55:39.046128Z","end":"2026-10-07T22:55:39.287177Z","steps":["trace[433283200] 'process raft request' (duration: 138.745006ms)","trace[433283200] 'compare' (duration: 101.875254ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:55:39.546549Z","caller":"traceutil/trace.go:171","msg":"trace[901539991] transaction","detail":"{read_only:false; response_revision:26216; number_of_response:1; }","duration":"499.207357ms","start":"2026-10-07T22:55:39.047311Z","end":"2026-10-07T22:55:39.546519Z","steps":["trace[901539991] 'process raft request' (duration: 406.559289ms)","trace[901539991] 'compare' (duration: 92.283408ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T22:55:39.546712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:55:39.047264Z","time spent":"499.356672ms","remote":"127.0.0.1:56174","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-07T22:55:39.546862Z","caller":"traceutil/trace.go:171","msg":"trace[1396081356] transaction","detail":"{read_only:false; response_revision:26218; number_of_response:1; }","duration":"483.42494ms","start":"2026-10-07T22:55:39.063381Z","end":"2026-10-07T22:55:39.546806Z","steps":["trace[1396081356] 'process raft request' (duration: 483.109492ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:55:39.546895Z","caller":"traceutil/trace.go:171","msg":"trace[1440609532] transaction","detail":"{read_only:false; response_revision:26217; number_of_response:1; }","duration":"499.524447ms","start":"2026-10-07T22:55:39.047339Z","end":"2026-10-07T22:55:39.546864Z","steps":["trace[1440609532] 'process raft request' (duration: 499.043134ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:55:39.547012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:55:39.063359Z","time spent":"483.568015ms","remote":"127.0.0.1:56174","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-07T22:55:39.547045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.705102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"} {"level":"warn","ts":"2026-10-07T22:55:39.547057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:55:39.047298Z","time spent":"499.658ms","remote":"127.0.0.1:56174","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-07T22:55:39.547086Z","caller":"traceutil/trace.go:171","msg":"trace[1137542661] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26219; }","duration":"201.805884ms","start":"2026-10-07T22:55:39.345268Z","end":"2026-10-07T22:55:39.547074Z","steps":["trace[1137542661] 'agreement among raft nodes before linearized reading' (duration: 201.642559ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:55:39.54686Z","caller":"traceutil/trace.go:171","msg":"trace[470527657] linearizableReadLoop","detail":"{readStateIndex:27065; appliedIndex:27062; }","duration":"201.470045ms","start":"2026-10-07T22:55:39.345347Z","end":"2026-10-07T22:55:39.546817Z","steps":["trace[470527657] 'read index received' (duration: 108.375114ms)","trace[470527657] 'applied index is now lower than readState.Index' (duration: 93.092341ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T22:55:39.998024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.088014ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-10-07T22:55:39.998151Z","caller":"traceutil/trace.go:171","msg":"trace[283808539] linearizableReadLoop","detail":"{readStateIndex:27067; appliedIndex:27066; }","duration":"451.007352ms","start":"2026-10-07T22:55:39.547122Z","end":"2026-10-07T22:55:39.99813Z","steps":["trace[283808539] 'read index received' (duration: 100.741453ms)","trace[283808539] 'applied index is now lower than readState.Index' (duration: 350.264019ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T22:55:39.998487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"448.017759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"} {"level":"warn","ts":"2026-10-07T22:55:39.998439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"483.77328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-07T22:55:39.99853Z","caller":"traceutil/trace.go:171","msg":"trace[1568626837] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26219; }","duration":"448.101681ms","start":"2026-10-07T22:55:39.550415Z","end":"2026-10-07T22:55:39.998516Z","steps":["trace[1568626837] 'agreement among raft nodes before linearized reading' (duration: 447.909776ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:55:39.998566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:55:39.550404Z","time spent":"448.154343ms","remote":"127.0.0.1:56092","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12235,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-10-07T22:55:39.998967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.807466ms","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-07T22:55:39.999033Z","caller":"traceutil/trace.go:171","msg":"trace[1091674090] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26219; }","duration":"266.910709ms","start":"2026-10-07T22:55:39.732098Z","end":"2026-10-07T22:55:39.999008Z","steps":["trace[1091674090] 'agreement among raft nodes before linearized reading' (duration: 266.527958ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:55:39.999174Z","caller":"traceutil/trace.go:171","msg":"trace[1575799777] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26219; }","duration":"483.966275ms","start":"2026-10-07T22:55:39.514573Z","end":"2026-10-07T22:55:39.998539Z","steps":["trace[1575799777] 'agreement among raft nodes before linearized reading' (duration: 483.716768ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:55:39.999261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.932967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/\" range_end:\"/registry/deployments/openstack0\" ","response":"range_response_count:32 size:277959"} {"level":"warn","ts":"2026-10-07T22:55:39.999316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:55:39.51455Z","time spent":"484.724107ms","remote":"127.0.0.1:55866","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-10-07T22:55:39.99935Z","caller":"traceutil/trace.go:171","msg":"trace[1454673488] range","detail":"{range_begin:/registry/deployments/openstack/; range_end:/registry/deployments/openstack0; response_count:32; response_revision:26219; }","duration":"268.05058ms","start":"2026-10-07T22:55:39.731274Z","end":"2026-10-07T22:55:39.999325Z","steps":["trace[1454673488] 'agreement among raft nodes before linearized reading' (duration: 267.460804ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:55:40.285221Z","caller":"traceutil/trace.go:171","msg":"trace[789569731] linearizableReadLoop","detail":"{readStateIndex:27069; appliedIndex:27067; }","duration":"244.269101ms","start":"2026-10-07T22:55:40.040926Z","end":"2026-10-07T22:55:40.285195Z","steps":["trace[789569731] 'read index received' (duration: 56.683301ms)","trace[789569731] 'applied index is now lower than readState.Index' (duration: 187.58427ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:55:40.285343Z","caller":"traceutil/trace.go:171","msg":"trace[1094201722] transaction","detail":"{read_only:false; response_revision:26221; number_of_response:1; }","duration":"275.482736ms","start":"2026-10-07T22:55:40.009793Z","end":"2026-10-07T22:55:40.285275Z","steps":["trace[1094201722] 'process raft request' (duration: 275.212059ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:55:40.285451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.015827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-07T22:55:40.285485Z","caller":"traceutil/trace.go:171","msg":"trace[47713650] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:26221; }","duration":"212.070539ms","start":"2026-10-07T22:55:40.073406Z","end":"2026-10-07T22:55:40.285476Z","steps":["trace[47713650] 'agreement among raft nodes before linearized reading' (duration: 211.949005ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:55:40.285581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.641481ms","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-07T22:55:40.285777Z","caller":"traceutil/trace.go:171","msg":"trace[1220689690] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26221; }","duration":"244.872627ms","start":"2026-10-07T22:55:40.04088Z","end":"2026-10-07T22:55:40.285752Z","steps":["trace[1220689690] 'agreement among raft nodes before linearized reading' (duration: 244.443695ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:55:40.285718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.954346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-07T22:55:40.285951Z","caller":"traceutil/trace.go:171","msg":"trace[2118539039] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0; response_count:0; response_revision:26221; }","duration":"146.241943ms","start":"2026-10-07T22:55:40.139697Z","end":"2026-10-07T22:55:40.285939Z","steps":["trace[2118539039] 'agreement among raft nodes before linearized reading' (duration: 145.994537ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:55:40.589815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.344883ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-07T22:55:40.590128Z","caller":"traceutil/trace.go:171","msg":"trace[162368029] transaction","detail":"{read_only:false; response_revision:26223; number_of_response:1; }","duration":"293.501126ms","start":"2026-10-07T22:55:40.296606Z","end":"2026-10-07T22:55:40.590108Z","steps":["trace[162368029] 'process raft request' (duration: 166.753363ms)","trace[162368029] 'compare' (duration: 126.202078ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:55:40.590231Z","caller":"traceutil/trace.go:171","msg":"trace[804684433] linearizableReadLoop","detail":"{readStateIndex:27071; appliedIndex:27070; }","duration":"230.007456ms","start":"2026-10-07T22:55:40.360198Z","end":"2026-10-07T22:55:40.590206Z","steps":["trace[804684433] 'read index received' (duration: 103.074817ms)","trace[804684433] 'applied index is now lower than readState.Index' (duration: 126.930579ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T22:55:40.590405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.780381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/magnum-system/\" range_end:\"/registry/endpointslices/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-07T22:55:40.590442Z","caller":"traceutil/trace.go:171","msg":"trace[1983724959] range","detail":"{range_begin:/registry/endpointslices/magnum-system/; range_end:/registry/endpointslices/magnum-system0; response_count:0; response_revision:26223; }","duration":"294.845493ms","start":"2026-10-07T22:55:40.295582Z","end":"2026-10-07T22:55:40.590428Z","steps":["trace[1983724959] 'agreement among raft nodes before linearized reading' (duration: 294.75975ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:55:40.59046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.17103ms","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-07T22:55:40.590499Z","caller":"traceutil/trace.go:171","msg":"trace[1722236100] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:26223; }","duration":"151.244672ms","start":"2026-10-07T22:55:40.439242Z","end":"2026-10-07T22:55:40.590487Z","steps":["trace[1722236100] 'agreement among raft nodes before linearized reading' (duration: 151.131969ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:55:40.590535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.276357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:19234"} {"level":"info","ts":"2026-10-07T22:55:40.590591Z","caller":"traceutil/trace.go:171","msg":"trace[128634312] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:26223; }","duration":"228.33523ms","start":"2026-10-07T22:55:40.362242Z","end":"2026-10-07T22:55:40.590577Z","steps":["trace[128634312] 'agreement among raft nodes before linearized reading' (duration: 228.135704ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:55:40.5906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.325377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates/\" range_end:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-07T22:55:40.590653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.00112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-10-07T22:55:40.590791Z","caller":"traceutil/trace.go:171","msg":"trace[1534783675] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:26223; }","duration":"167.273816ms","start":"2026-10-07T22:55:40.423499Z","end":"2026-10-07T22:55:40.590772Z","steps":["trace[1534783675] 'agreement among raft nodes before linearized reading' (duration: 166.896966ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:55:40.590701Z","caller":"traceutil/trace.go:171","msg":"trace[174338933] range","detail":"{range_begin:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates/; range_end:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates0; response_count:0; response_revision:26223; }","duration":"185.448201ms","start":"2026-10-07T22:55:40.405225Z","end":"2026-10-07T22:55:40.590673Z","steps":["trace[174338933] 'agreement among raft nodes before linearized reading' (duration: 185.175083ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:55:40.893426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.610688ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-07T22:55:40.893542Z","caller":"traceutil/trace.go:171","msg":"trace[426511932] linearizableReadLoop","detail":"{readStateIndex:27072; appliedIndex:27071; }","duration":"272.172354ms","start":"2026-10-07T22:55:40.621352Z","end":"2026-10-07T22:55:40.893524Z","steps":["trace[426511932] 'read index received' (duration: 118.285359ms)","trace[426511932] 'applied index is now lower than readState.Index' (duration: 153.885695ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:55:40.893696Z","caller":"traceutil/trace.go:171","msg":"trace[1498156621] transaction","detail":"{read_only:false; response_revision:26224; number_of_response:1; }","duration":"276.779642ms","start":"2026-10-07T22:55:40.616879Z","end":"2026-10-07T22:55:40.893658Z","steps":["trace[1498156621] 'process raft request' (duration: 122.842255ms)","trace[1498156621] 'compare' (duration: 153.020522ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T22:55:40.893855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.488074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5652"} {"level":"info","ts":"2026-10-07T22:55:40.893896Z","caller":"traceutil/trace.go:171","msg":"trace[1916413560] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:26224; }","duration":"272.601006ms","start":"2026-10-07T22:55:40.621282Z","end":"2026-10-07T22:55:40.893883Z","steps":["trace[1916413560] 'agreement among raft nodes before linearized reading' (duration: 272.36719ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:55:40.894169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.388898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/bindings/\" range_end:\"/registry/rabbitmq.com/bindings0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-07T22:55:40.894207Z","caller":"traceutil/trace.go:171","msg":"trace[861976505] range","detail":"{range_begin:/registry/rabbitmq.com/bindings/; range_end:/registry/rabbitmq.com/bindings0; response_count:0; response_revision:26224; }","duration":"260.47768ms","start":"2026-10-07T22:55:40.63372Z","end":"2026-10-07T22:55:40.894198Z","steps":["trace[861976505] 'agreement among raft nodes before linearized reading' (duration: 260.416288ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:55:40.894631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.343109ms","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-07T22:55:40.894731Z","caller":"traceutil/trace.go:171","msg":"trace[555275278] range","detail":"{range_begin:/registry/ceph.rook.io/cephbuckettopics/; range_end:/registry/ceph.rook.io/cephbuckettopics0; response_count:0; response_revision:26224; }","duration":"180.523344ms","start":"2026-10-07T22:55:40.714181Z","end":"2026-10-07T22:55:40.894705Z","steps":["trace[555275278] 'agreement among raft nodes before linearized reading' (duration: 179.968749ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:55:41.259462Z","caller":"traceutil/trace.go:171","msg":"trace[1605935434] transaction","detail":"{read_only:false; response_revision:26225; number_of_response:1; }","duration":"248.114337ms","start":"2026-10-07T22:55:41.011316Z","end":"2026-10-07T22:55:41.25943Z","steps":["trace[1605935434] 'process raft request' (duration: 158.217755ms)","trace[1605935434] 'compare' (duration: 89.630145ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:55:41.285015Z","caller":"traceutil/trace.go:171","msg":"trace[1182120846] transaction","detail":"{read_only:false; response_revision:26226; number_of_response:1; }","duration":"236.601559ms","start":"2026-10-07T22:55:41.048327Z","end":"2026-10-07T22:55:41.284928Z","steps":["trace[1182120846] 'process raft request' (duration: 229.630515ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:55:41.286056Z","caller":"traceutil/trace.go:171","msg":"trace[1888434942] linearizableReadLoop","detail":"{readStateIndex:27076; appliedIndex:27073; }","duration":"103.245612ms","start":"2026-10-07T22:55:41.182757Z","end":"2026-10-07T22:55:41.286003Z","steps":["trace[1888434942] 'read index received' (duration: 95.091435ms)","trace[1888434942] 'applied index is now lower than readState.Index' (duration: 8.152387ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:55:41.28598Z","caller":"traceutil/trace.go:171","msg":"trace[2001054899] transaction","detail":"{read_only:false; response_revision:26227; number_of_response:1; }","duration":"236.687171ms","start":"2026-10-07T22:55:41.049217Z","end":"2026-10-07T22:55:41.285904Z","steps":["trace[2001054899] 'process raft request' (duration: 235.662703ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:55:41.286243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.473029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/openstack/default\" ","response":"range_response_count:1 size:176"} {"level":"info","ts":"2026-10-07T22:55:41.286301Z","caller":"traceutil/trace.go:171","msg":"trace[316380020] range","detail":"{range_begin:/registry/serviceaccounts/openstack/default; range_end:; response_count:1; response_revision:26228; }","duration":"103.590592ms","start":"2026-10-07T22:55:41.182689Z","end":"2026-10-07T22:55:41.286279Z","steps":["trace[316380020] 'agreement among raft nodes before linearized reading' (duration: 103.394686ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:55:41.286521Z","caller":"traceutil/trace.go:171","msg":"trace[1696579552] transaction","detail":"{read_only:false; response_revision:26228; number_of_response:1; }","duration":"237.213436ms","start":"2026-10-07T22:55:41.04929Z","end":"2026-10-07T22:55:41.286503Z","steps":["trace[1696579552] 'process raft request' (duration: 236.157756ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:55:41.717799Z","caller":"traceutil/trace.go:171","msg":"trace[472664325] transaction","detail":"{read_only:false; response_revision:26231; number_of_response:1; }","duration":"165.391995ms","start":"2026-10-07T22:55:41.552368Z","end":"2026-10-07T22:55:41.71776Z","steps":["trace[472664325] 'process raft request' (duration: 165.026054ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:55:41.71797Z","caller":"traceutil/trace.go:171","msg":"trace[1626515322] linearizableReadLoop","detail":"{readStateIndex:27080; appliedIndex:27078; }","duration":"146.785929ms","start":"2026-10-07T22:55:41.571131Z","end":"2026-10-07T22:55:41.717916Z","steps":["trace[1626515322] 'read index received' (duration: 146.268945ms)","trace[1626515322] 'applied index is now lower than readState.Index' (duration: 513.704µs)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:55:41.718047Z","caller":"traceutil/trace.go:171","msg":"trace[943413694] transaction","detail":"{read_only:false; response_revision:26232; number_of_response:1; }","duration":"161.932108ms","start":"2026-10-07T22:55:41.556106Z","end":"2026-10-07T22:55:41.718038Z","steps":["trace[943413694] 'process raft request' (duration: 161.563248ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:55:41.718214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.177977ms","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-07T22:55:41.718237Z","caller":"traceutil/trace.go:171","msg":"trace[4718047] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26232; }","duration":"166.257449ms","start":"2026-10-07T22:55:41.551971Z","end":"2026-10-07T22:55:41.718228Z","steps":["trace[4718047] 'agreement among raft nodes before linearized reading' (duration: 166.137925ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:55:41.719523Z","caller":"traceutil/trace.go:171","msg":"trace[1434864399] transaction","detail":"{read_only:false; response_revision:26233; number_of_response:1; }","duration":"143.872418ms","start":"2026-10-07T22:55:41.575628Z","end":"2026-10-07T22:55:41.7195Z","steps":["trace[1434864399] 'process raft request' (duration: 143.745394ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:55:41.719914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.548161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephrbdmirrors/\" range_end:\"/registry/ceph.rook.io/cephrbdmirrors0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-07T22:55:41.720004Z","caller":"traceutil/trace.go:171","msg":"trace[50601811] range","detail":"{range_begin:/registry/ceph.rook.io/cephrbdmirrors/; range_end:/registry/ceph.rook.io/cephrbdmirrors0; response_count:0; response_revision:26233; }","duration":"142.696295ms","start":"2026-10-07T22:55:41.577284Z","end":"2026-10-07T22:55:41.719981Z","steps":["trace[50601811] 'agreement among raft nodes before linearized reading' (duration: 142.535781ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:56:05.574967Z","caller":"traceutil/trace.go:171","msg":"trace[2026631045] transaction","detail":"{read_only:false; response_revision:26558; number_of_response:1; }","duration":"207.105221ms","start":"2026-10-07T22:56:05.367829Z","end":"2026-10-07T22:56:05.574934Z","steps":["trace[2026631045] 'process raft request' (duration: 189.950866ms)","trace[2026631045] 'compare' (duration: 16.767275ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:56:05.74491Z","caller":"traceutil/trace.go:171","msg":"trace[963546599] transaction","detail":"{read_only:false; response_revision:26559; number_of_response:1; }","duration":"361.358596ms","start":"2026-10-07T22:56:05.383509Z","end":"2026-10-07T22:56:05.744867Z","steps":["trace[963546599] 'process raft request' (duration: 337.537256ms)","trace[963546599] 'compare' (duration: 23.560423ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T22:56:05.745159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:56:05.383477Z","time spent":"361.566332ms","remote":"127.0.0.1:56174","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-07T22:56:05.74582Z","caller":"traceutil/trace.go:171","msg":"trace[7338924] transaction","detail":"{read_only:false; response_revision:26560; number_of_response:1; }","duration":"361.82613ms","start":"2026-10-07T22:56:05.383949Z","end":"2026-10-07T22:56:05.745775Z","steps":["trace[7338924] 'process raft request' (duration: 360.862953ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:56:05.745982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:56:05.383927Z","time spent":"361.962233ms","remote":"127.0.0.1:56174","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-07T22:56:05.74612Z","caller":"traceutil/trace.go:171","msg":"trace[273695493] linearizableReadLoop","detail":"{readStateIndex:27416; appliedIndex:27412; }","duration":"277.480241ms","start":"2026-10-07T22:56:05.468603Z","end":"2026-10-07T22:56:05.746084Z","steps":["trace[273695493] 'read index received' (duration: 89.208102ms)","trace[273695493] 'applied index is now lower than readState.Index' (duration: 188.269949ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:56:05.746169Z","caller":"traceutil/trace.go:171","msg":"trace[716264169] transaction","detail":"{read_only:false; response_revision:26562; number_of_response:1; }","duration":"169.274562ms","start":"2026-10-07T22:56:05.576862Z","end":"2026-10-07T22:56:05.746137Z","steps":["trace[716264169] 'process raft request' (duration: 169.073636ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:56:05.746374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.358213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-07T22:56:05.746418Z","caller":"traceutil/trace.go:171","msg":"trace[722422839] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26562; }","duration":"231.484416ms","start":"2026-10-07T22:56:05.514921Z","end":"2026-10-07T22:56:05.746405Z","steps":["trace[722422839] 'agreement among raft nodes before linearized reading' (duration: 231.349792ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:56:05.746425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.8095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-10-07T22:56:05.746499Z","caller":"traceutil/trace.go:171","msg":"trace[672779438] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26562; }","duration":"277.927774ms","start":"2026-10-07T22:56:05.468549Z","end":"2026-10-07T22:56:05.746476Z","steps":["trace[672779438] 'agreement among raft nodes before linearized reading' (duration: 277.687677ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:56:05.746712Z","caller":"traceutil/trace.go:171","msg":"trace[2017806372] transaction","detail":"{read_only:false; response_revision:26561; number_of_response:1; }","duration":"335.964543ms","start":"2026-10-07T22:56:05.410066Z","end":"2026-10-07T22:56:05.746031Z","steps":["trace[2017806372] 'process raft request' (duration: 335.659774ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:56:05.747095Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:56:05.410049Z","time spent":"336.9609ms","remote":"127.0.0.1:56174","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-07T22:56:06.044256Z","caller":"traceutil/trace.go:171","msg":"trace[1178327519] transaction","detail":"{read_only:false; response_revision:26564; number_of_response:1; }","duration":"233.902564ms","start":"2026-10-07T22:56:05.810325Z","end":"2026-10-07T22:56:06.044227Z","steps":["trace[1178327519] 'process raft request' (duration: 225.508541ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:56:06.339769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.830458ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-07T22:56:06.340008Z","caller":"traceutil/trace.go:171","msg":"trace[267463149] linearizableReadLoop","detail":"{readStateIndex:27420; appliedIndex:27418; }","duration":"497.316315ms","start":"2026-10-07T22:56:05.842669Z","end":"2026-10-07T22:56:06.339985Z","steps":["trace[267463149] 'read index received' (duration: 193.114183ms)","trace[267463149] 'applied index is now lower than readState.Index' (duration: 304.199892ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:56:06.340109Z","caller":"traceutil/trace.go:171","msg":"trace[1741501388] transaction","detail":"{read_only:false; response_revision:26565; number_of_response:1; }","duration":"527.017429ms","start":"2026-10-07T22:56:05.813044Z","end":"2026-10-07T22:56:06.340062Z","steps":["trace[1741501388] 'process raft request' (duration: 400.7908ms)","trace[1741501388] 'compare' (duration: 125.698694ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T22:56:06.340304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:56:05.813021Z","time spent":"527.185603ms","remote":"127.0.0.1:56174","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-07T22:56:06.340381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"497.671926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"warn","ts":"2026-10-07T22:56:06.340404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.985414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-db-sync\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-07T22:56:06.340408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.339405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-endpoints\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-07T22:56:06.340438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.262444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-rabbit-init\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-07T22:56:06.340437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.218392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-07T22:56:06.340438Z","caller":"traceutil/trace.go:171","msg":"trace[82500206] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26565; }","duration":"497.817809ms","start":"2026-10-07T22:56:05.842608Z","end":"2026-10-07T22:56:06.340426Z","steps":["trace[82500206] 'agreement among raft nodes before linearized reading' (duration: 497.531021ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:56:06.340497Z","caller":"traceutil/trace.go:171","msg":"trace[1326949830] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-endpoints; range_end:; response_count:0; response_revision:26565; }","duration":"256.450809ms","start":"2026-10-07T22:56:06.084026Z","end":"2026-10-07T22:56:06.340477Z","steps":["trace[1326949830] 'agreement among raft nodes before linearized reading' (duration: 256.312655ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:56:06.34049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"487.634797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-10-07T22:56:06.340515Z","caller":"traceutil/trace.go:171","msg":"trace[1617257787] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-user; range_end:; response_count:0; response_revision:26565; }","duration":"256.318205ms","start":"2026-10-07T22:56:06.084175Z","end":"2026-10-07T22:56:06.340493Z","steps":["trace[1617257787] 'agreement among raft nodes before linearized reading' (duration: 256.180701ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:56:06.340569Z","caller":"traceutil/trace.go:171","msg":"trace[1925141901] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26565; }","duration":"487.72449ms","start":"2026-10-07T22:56:05.852825Z","end":"2026-10-07T22:56:06.34055Z","steps":["trace[1925141901] 'agreement among raft nodes before linearized reading' (duration: 487.497743ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:56:06.34053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.331577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-07T22:56:06.340618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:56:05.852744Z","time spent":"487.865353ms","remote":"127.0.0.1:56174","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-10-07T22:56:06.340575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:56:05.842582Z","time spent":"497.978684ms","remote":"127.0.0.1:56174","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-10-07T22:56:06.340653Z","caller":"traceutil/trace.go:171","msg":"trace[1680990888] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:26565; }","duration":"413.555784ms","start":"2026-10-07T22:56:05.927067Z","end":"2026-10-07T22:56:06.340622Z","steps":["trace[1680990888] 'agreement among raft nodes before linearized reading' (duration: 413.277636ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:56:06.340486Z","caller":"traceutil/trace.go:171","msg":"trace[1290917533] range","detail":"{range_begin:/registry/jobs/openstack/manila-db-sync; range_end:; response_count:0; response_revision:26565; }","duration":"257.124277ms","start":"2026-10-07T22:56:06.083342Z","end":"2026-10-07T22:56:06.340466Z","steps":["trace[1290917533] 'agreement among raft nodes before linearized reading' (duration: 256.990424ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:56:06.340718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:56:05.927034Z","time spent":"413.671677ms","remote":"127.0.0.1:59386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true "} {"level":"info","ts":"2026-10-07T22:56:06.340504Z","caller":"traceutil/trace.go:171","msg":"trace[1619481535] range","detail":"{range_begin:/registry/jobs/openstack/manila-rabbit-init; range_end:; response_count:0; response_revision:26565; }","duration":"256.352926ms","start":"2026-10-07T22:56:06.084131Z","end":"2026-10-07T22:56:06.340484Z","steps":["trace[1619481535] 'agreement among raft nodes before linearized reading' (duration: 256.197361ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:56:46.65194Z","caller":"traceutil/trace.go:171","msg":"trace[1904332950] transaction","detail":"{read_only:false; response_revision:26892; number_of_response:1; }","duration":"121.29255ms","start":"2026-10-07T22:56:46.530615Z","end":"2026-10-07T22:56:46.651908Z","steps":["trace[1904332950] 'process raft request' (duration: 120.95371ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:56:46.826226Z","caller":"traceutil/trace.go:171","msg":"trace[609587630] transaction","detail":"{read_only:false; response_revision:26894; number_of_response:1; }","duration":"169.72847ms","start":"2026-10-07T22:56:46.656464Z","end":"2026-10-07T22:56:46.826192Z","steps":["trace[609587630] 'process raft request' (duration: 150.287788ms)","trace[609587630] 'compare' (duration: 19.085242ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T22:56:46.82664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.180456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-10-07T22:56:46.826718Z","caller":"traceutil/trace.go:171","msg":"trace[331842452] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26894; }","duration":"164.267018ms","start":"2026-10-07T22:56:46.662429Z","end":"2026-10-07T22:56:46.826696Z","steps":["trace[331842452] 'agreement among raft nodes before linearized reading' (duration: 164.051752ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:56:46.826222Z","caller":"traceutil/trace.go:171","msg":"trace[411466128] linearizableReadLoop","detail":"{readStateIndex:27757; appliedIndex:27755; }","duration":"163.730264ms","start":"2026-10-07T22:56:46.662449Z","end":"2026-10-07T22:56:46.82618Z","steps":["trace[411466128] 'read index received' (duration: 33.118494ms)","trace[411466128] 'applied index is now lower than readState.Index' (duration: 130.60976ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T22:56:46.827781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.196655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-10-07T22:56:46.827853Z","caller":"traceutil/trace.go:171","msg":"trace[1521425371] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26894; }","duration":"146.314458ms","start":"2026-10-07T22:56:46.681521Z","end":"2026-10-07T22:56:46.827836Z","steps":["trace[1521425371] 'agreement among raft nodes before linearized reading' (duration: 146.079241ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:56:46.827785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.701019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-10-07T22:56:46.828053Z","caller":"traceutil/trace.go:171","msg":"trace[1308351338] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26894; }","duration":"161.011828ms","start":"2026-10-07T22:56:46.667027Z","end":"2026-10-07T22:56:46.828039Z","steps":["trace[1308351338] 'agreement among raft nodes before linearized reading' (duration: 160.549115ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:59:21.090849Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25513} {"level":"info","ts":"2026-10-07T22:59:21.273382Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25513,"took":"177.778512ms","hash":2901253785,"current-db-size-bytes":59150336,"current-db-size":"59 MB","current-db-size-in-use-bytes":35639296,"current-db-size-in-use":"36 MB"} {"level":"info","ts":"2026-10-07T22:59:21.273448Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2901253785,"revision":25513,"compact-revision":22096} {"level":"info","ts":"2026-10-07T23:00:29.75953Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"15a19459cc268924","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-07T23:00:29.765634Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-10-07T23:00:29.765757Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-10-07T23:04:21.099118Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28351} {"level":"info","ts":"2026-10-07T23:04:21.255458Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28351,"took":"151.810997ms","hash":3513751814,"current-db-size-bytes":59150336,"current-db-size":"59 MB","current-db-size-in-use-bytes":32518144,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-07T23:04:21.255531Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3513751814,"revision":28351,"compact-revision":25513} {"level":"info","ts":"2026-10-07T23:09:21.106322Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30774} {"level":"info","ts":"2026-10-07T23:09:21.260859Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30774,"took":"149.926348ms","hash":2873440129,"current-db-size-bytes":59150336,"current-db-size":"59 MB","current-db-size-in-use-bytes":30797824,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-07T23:09:21.260945Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2873440129,"revision":30774,"compact-revision":28351} {"level":"info","ts":"2026-10-07T23:14:21.113164Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33064} {"level":"info","ts":"2026-10-07T23:14:21.271651Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33064,"took":"154.116435ms","hash":797622767,"current-db-size-bytes":60190720,"current-db-size":"60 MB","current-db-size-in-use-bytes":30425088,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-10-07T23:14:21.271748Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":797622767,"revision":33064,"compact-revision":30774} {"level":"info","ts":"2026-10-07T23:19:21.119894Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35293} {"level":"info","ts":"2026-10-07T23:19:21.256517Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35293,"took":"131.446474ms","hash":2490902417,"current-db-size-bytes":60190720,"current-db-size":"60 MB","current-db-size-in-use-bytes":32096256,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-07T23:19:21.256608Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2490902417,"revision":35293,"compact-revision":33064} {"level":"info","ts":"2026-10-07T23:21:57.103076Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"15a19459cc268924","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-07T23:21:57.110076Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-10-07T23:21:57.110191Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-10-07T23:24:21.128125Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37582} {"level":"info","ts":"2026-10-07T23:24:21.28337Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37582,"took":"148.744696ms","hash":594817745,"current-db-size-bytes":60190720,"current-db-size":"60 MB","current-db-size-in-use-bytes":32284672,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-07T23:24:21.283457Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":594817745,"revision":37582,"compact-revision":35293} {"level":"info","ts":"2026-10-07T23:29:21.140307Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":39860} {"level":"info","ts":"2026-10-07T23:29:21.306341Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":39860,"took":"161.997455ms","hash":931087276,"current-db-size-bytes":60190720,"current-db-size":"60 MB","current-db-size-in-use-bytes":30863360,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-07T23:29:21.30641Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":931087276,"revision":39860,"compact-revision":37582}