{"level":"warn","ts":"2026-09-12T01:09:01.388624Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-12T01:09:01.388741Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.186: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.186:2380","--initial-cluster=instance=https://162.253.55.186:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.186:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.186: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-09-12T01:09:01.388836Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-12T01:09:01.388855Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.186:2380"]} {"level":"info","ts":"2026-09-12T01:09:01.388881Z","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-09-12T01:09:01.38974Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.186:2379"]} {"level":"info","ts":"2026-09-12T01:09:01.389849Z","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.186:2380"],"listen-peer-urls":["https://162.253.55.186:2380"],"advertise-client-urls":["https://162.253.55.186:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.186:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.186: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-09-12T01:09:01.394387Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.116745ms"} {"level":"info","ts":"2026-09-12T01:09:01.405717Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"612d5169b08bb96b","cluster-id":"20ec8eafba602517"} {"level":"info","ts":"2026-09-12T01:09:01.4058Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b switched to configuration voters=()"} {"level":"info","ts":"2026-09-12T01:09:01.405827Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b became follower at term 0"} {"level":"info","ts":"2026-09-12T01:09:01.405847Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 612d5169b08bb96b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-12T01:09:01.405861Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b became follower at term 1"} {"level":"info","ts":"2026-09-12T01:09:01.405909Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b switched to configuration voters=(7002342510006352235)"} {"level":"warn","ts":"2026-09-12T01:09:01.41257Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-12T01:09:01.41487Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-12T01:09:01.416579Z","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-09-12T01:09:01.418937Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"612d5169b08bb96b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-12T01:09:01.419073Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"612d5169b08bb96b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-12T01:09:01.41917Z","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-09-12T01:09:01.419351Z","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-09-12T01:09:01.419376Z","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-09-12T01:09:01.420359Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b switched to configuration voters=(7002342510006352235)"} {"level":"info","ts":"2026-09-12T01:09:01.421693Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"20ec8eafba602517","local-member-id":"612d5169b08bb96b","added-peer-id":"612d5169b08bb96b","added-peer-peer-urls":["https://162.253.55.186:2380"]} {"level":"info","ts":"2026-09-12T01:09:01.42468Z","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-09-12T01:09:01.424866Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.186:2380"} {"level":"info","ts":"2026-09-12T01:09:01.42498Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.186:2380"} {"level":"info","ts":"2026-09-12T01:09:01.425217Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"612d5169b08bb96b","initial-advertise-peer-urls":["https://162.253.55.186:2380"],"listen-peer-urls":["https://162.253.55.186:2380"],"advertise-client-urls":["https://162.253.55.186:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.186:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-12T01:09:01.425313Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-12T01:09:01.607165Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b is starting a new election at term 1"} {"level":"info","ts":"2026-09-12T01:09:01.607256Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b became pre-candidate at term 1"} {"level":"info","ts":"2026-09-12T01:09:01.607332Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b received MsgPreVoteResp from 612d5169b08bb96b at term 1"} {"level":"info","ts":"2026-09-12T01:09:01.607359Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b became candidate at term 2"} {"level":"info","ts":"2026-09-12T01:09:01.60737Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b received MsgVoteResp from 612d5169b08bb96b at term 2"} {"level":"info","ts":"2026-09-12T01:09:01.607388Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b became leader at term 2"} {"level":"info","ts":"2026-09-12T01:09:01.607404Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 612d5169b08bb96b elected leader 612d5169b08bb96b at term 2"} {"level":"info","ts":"2026-09-12T01:09:01.608528Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-12T01:09:01.611708Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"20ec8eafba602517","local-member-id":"612d5169b08bb96b","cluster-version":"3.5"} {"level":"info","ts":"2026-09-12T01:09:01.611797Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-12T01:09:01.611829Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-12T01:09:01.611849Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-12T01:09:01.611861Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-12T01:09:01.611888Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"612d5169b08bb96b","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.186:2379]}","request-path":"/0/members/612d5169b08bb96b/attributes","cluster-id":"20ec8eafba602517","publish-timeout":"7s"} {"level":"info","ts":"2026-09-12T01:09:01.612355Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-12T01:09:01.612419Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-12T01:09:01.615223Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-12T01:09:01.618486Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.186:2379"} {"level":"info","ts":"2026-09-12T01:10:00.306909Z","caller":"traceutil/trace.go:171","msg":"trace[83161807] transaction","detail":"{read_only:false; response_revision:674; number_of_response:1; }","duration":"101.252472ms","start":"2026-09-12T01:10:00.20563Z","end":"2026-09-12T01:10:00.306882Z","steps":["trace[83161807] 'process raft request' (duration: 100.611468ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:10:00.463219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.642616ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-12T01:10:00.463448Z","caller":"traceutil/trace.go:171","msg":"trace[915724230] transaction","detail":"{read_only:false; response_revision:675; number_of_response:1; }","duration":"151.034034ms","start":"2026-09-12T01:10:00.312356Z","end":"2026-09-12T01:10:00.46339Z","steps":["trace[915724230] 'process raft request' (duration: 45.484279ms)","trace[915724230] 'compare' (duration: 104.472333ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T01:10:00.463521Z","caller":"traceutil/trace.go:171","msg":"trace[2066579425] linearizableReadLoop","detail":"{readStateIndex:698; appliedIndex:697; }","duration":"101.905056ms","start":"2026-09-12T01:10:00.361588Z","end":"2026-09-12T01:10:00.463493Z","steps":["trace[2066579425] 'read index received' (duration: 49.981µs)","trace[2066579425] 'applied index is now lower than readState.Index' (duration: 101.852445ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T01:10:00.46373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.12851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-09-12T01:10:00.463773Z","caller":"traceutil/trace.go:171","msg":"trace[1024937336] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:676; }","duration":"102.237052ms","start":"2026-09-12T01:10:00.361524Z","end":"2026-09-12T01:10:00.463762Z","steps":["trace[1024937336] 'agreement among raft nodes before linearized reading' (duration: 102.038918ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:10:00.667915Z","caller":"traceutil/trace.go:171","msg":"trace[1462414707] linearizableReadLoop","detail":"{readStateIndex:700; appliedIndex:699; }","duration":"199.853016ms","start":"2026-09-12T01:10:00.468034Z","end":"2026-09-12T01:10:00.667887Z","steps":["trace[1462414707] 'read index received' (duration: 140.743443ms)","trace[1462414707] 'applied index is now lower than readState.Index' (duration: 59.108443ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T01:10:00.668069Z","caller":"traceutil/trace.go:171","msg":"trace[1853314489] transaction","detail":"{read_only:false; response_revision:677; number_of_response:1; }","duration":"200.381339ms","start":"2026-09-12T01:10:00.467647Z","end":"2026-09-12T01:10:00.668028Z","steps":["trace[1853314489] 'process raft request' (duration: 141.199694ms)","trace[1853314489] 'compare' (duration: 58.859979ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T01:10:00.668308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.197203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-09-12T01:10:00.668468Z","caller":"traceutil/trace.go:171","msg":"trace[887780452] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:677; }","duration":"200.45431ms","start":"2026-09-12T01:10:00.467964Z","end":"2026-09-12T01:10:00.668419Z","steps":["trace[887780452] 'agreement among raft nodes before linearized reading' (duration: 200.116852ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:10:01.12274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.262859ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-12T01:10:01.122859Z","caller":"traceutil/trace.go:171","msg":"trace[873241196] transaction","detail":"{read_only:false; response_revision:678; number_of_response:1; }","duration":"437.546729ms","start":"2026-09-12T01:10:00.685293Z","end":"2026-09-12T01:10:01.122839Z","steps":["trace[873241196] 'process raft request' (duration: 125.101987ms)","trace[873241196] 'compare' (duration: 312.092665ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T01:10:01.122916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T01:10:00.68527Z","time spent":"437.6222ms","remote":"127.0.0.1:51492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-12T01:10:01.130307Z","caller":"traceutil/trace.go:171","msg":"trace[2018323346] linearizableReadLoop","detail":"{readStateIndex:702; appliedIndex:701; }","duration":"250.60527ms","start":"2026-09-12T01:10:00.879672Z","end":"2026-09-12T01:10:01.130278Z","steps":["trace[2018323346] 'read index received' (duration: 250.342834ms)","trace[2018323346] 'applied index is now lower than readState.Index' (duration: 261.386µs)"],"step_count":2} {"level":"info","ts":"2026-09-12T01:10:01.130391Z","caller":"traceutil/trace.go:171","msg":"trace[1617481913] transaction","detail":"{read_only:false; response_revision:679; number_of_response:1; }","duration":"444.294786ms","start":"2026-09-12T01:10:00.686062Z","end":"2026-09-12T01:10:01.130356Z","steps":["trace[1617481913] 'process raft request' (duration: 443.974639ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:10:01.130524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T01:10:00.686032Z","time spent":"444.427388ms","remote":"127.0.0.1:51492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-12T01:10:01.130603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.909187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-09-12T01:10:01.130655Z","caller":"traceutil/trace.go:171","msg":"trace[1033122823] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:679; }","duration":"251.03393ms","start":"2026-09-12T01:10:00.879606Z","end":"2026-09-12T01:10:01.13064Z","steps":["trace[1033122823] 'agreement among raft nodes before linearized reading' (duration: 250.806865ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:10:01.149568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.953108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-12T01:10:01.149725Z","caller":"traceutil/trace.go:171","msg":"trace[1995825740] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:684; }","duration":"180.153332ms","start":"2026-09-12T01:10:00.969547Z","end":"2026-09-12T01:10:01.149701Z","steps":["trace[1995825740] 'agreement among raft nodes before linearized reading' (duration: 179.961018ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:10:01.149602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.504361ms","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-09-12T01:10:01.14996Z","caller":"traceutil/trace.go:171","msg":"trace[1049918718] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:684; }","duration":"245.895679ms","start":"2026-09-12T01:10:00.90405Z","end":"2026-09-12T01:10:01.149945Z","steps":["trace[1049918718] 'agreement among raft nodes before linearized reading' (duration: 245.366378ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:11:34.972838Z","caller":"traceutil/trace.go:171","msg":"trace[1600614325] transaction","detail":"{read_only:false; response_revision:1874; number_of_response:1; }","duration":"122.805975ms","start":"2026-09-12T01:11:34.85001Z","end":"2026-09-12T01:11:34.972816Z","steps":["trace[1600614325] 'process raft request' (duration: 122.647652ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:11:35.136564Z","caller":"traceutil/trace.go:171","msg":"trace[2124838436] linearizableReadLoop","detail":"{readStateIndex:1946; appliedIndex:1944; }","duration":"167.109794ms","start":"2026-09-12T01:11:34.969403Z","end":"2026-09-12T01:11:35.136513Z","steps":["trace[2124838436] 'read index received' (duration: 3.255282ms)","trace[2124838436] 'applied index is now lower than readState.Index' (duration: 163.853182ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T01:11:35.136603Z","caller":"traceutil/trace.go:171","msg":"trace[726462485] transaction","detail":"{read_only:false; response_revision:1875; number_of_response:1; }","duration":"276.72552ms","start":"2026-09-12T01:11:34.859844Z","end":"2026-09-12T01:11:35.136569Z","steps":["trace[726462485] 'process raft request' (duration: 253.1803ms)","trace[726462485] 'compare' (duration: 23.228143ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T01:11:35.136736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.286818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-12T01:11:35.136801Z","caller":"traceutil/trace.go:171","msg":"trace[140781713] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1875; }","duration":"167.435631ms","start":"2026-09-12T01:11:34.969347Z","end":"2026-09-12T01:11:35.136783Z","steps":["trace[140781713] 'agreement among raft nodes before linearized reading' (duration: 167.285868ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:11:35.136844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.894176ms","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-09-12T01:11:35.136875Z","caller":"traceutil/trace.go:171","msg":"trace[1859162829] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1875; }","duration":"164.953027ms","start":"2026-09-12T01:11:34.971913Z","end":"2026-09-12T01:11:35.136866Z","steps":["trace[1859162829] 'agreement among raft nodes before linearized reading' (duration: 164.819164ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:11:35.309534Z","caller":"traceutil/trace.go:171","msg":"trace[613960826] transaction","detail":"{read_only:false; response_revision:1878; number_of_response:1; }","duration":"111.624679ms","start":"2026-09-12T01:11:35.197869Z","end":"2026-09-12T01:11:35.309494Z","steps":["trace[613960826] 'process raft request' (duration: 52.697436ms)","trace[613960826] 'compare' (duration: 58.781019ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T01:12:24.53112Z","caller":"traceutil/trace.go:171","msg":"trace[1020950967] transaction","detail":"{read_only:false; response_revision:2196; number_of_response:1; }","duration":"110.129646ms","start":"2026-09-12T01:12:24.420968Z","end":"2026-09-12T01:12:24.531098Z","steps":["trace[1020950967] 'process raft request' (duration: 109.952361ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:12:25.246735Z","caller":"traceutil/trace.go:171","msg":"trace[977354846] transaction","detail":"{read_only:false; response_revision:2197; number_of_response:1; }","duration":"233.257777ms","start":"2026-09-12T01:12:25.013445Z","end":"2026-09-12T01:12:25.246703Z","steps":["trace[977354846] 'process raft request' (duration: 233.069573ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:12:25.601742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.519685ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-12T01:12:25.601935Z","caller":"traceutil/trace.go:171","msg":"trace[26195027] transaction","detail":"{read_only:false; response_revision:2198; number_of_response:1; }","duration":"357.772241ms","start":"2026-09-12T01:12:25.244136Z","end":"2026-09-12T01:12:25.601908Z","steps":["trace[26195027] 'process raft request' (duration: 189.97839ms)","trace[26195027] 'compare' (duration: 167.347471ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T01:12:25.602061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T01:12:25.244108Z","time spent":"357.900374ms","remote":"127.0.0.1:51570","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-12T01:12:25.602886Z","caller":"traceutil/trace.go:171","msg":"trace[621877115] linearizableReadLoop","detail":"{readStateIndex:2282; appliedIndex:2280; }","duration":"188.713352ms","start":"2026-09-12T01:12:25.414082Z","end":"2026-09-12T01:12:25.602795Z","steps":["trace[621877115] 'read index received' (duration: 20.055003ms)","trace[621877115] 'applied index is now lower than readState.Index' (duration: 168.656139ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T01:12:25.602914Z","caller":"traceutil/trace.go:171","msg":"trace[773867080] transaction","detail":"{read_only:false; response_revision:2199; number_of_response:1; }","duration":"248.000543ms","start":"2026-09-12T01:12:25.354889Z","end":"2026-09-12T01:12:25.60289Z","steps":["trace[773867080] 'process raft request' (duration: 247.728507ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:12:25.60325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.137332ms","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-09-12T01:12:25.603371Z","caller":"traceutil/trace.go:171","msg":"trace[1274786618] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2199; }","duration":"189.325936ms","start":"2026-09-12T01:12:25.414014Z","end":"2026-09-12T01:12:25.60334Z","steps":["trace[1274786618] 'agreement among raft nodes before linearized reading' (duration: 188.971438ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:13:02.806219Z","caller":"traceutil/trace.go:171","msg":"trace[795624475] transaction","detail":"{read_only:false; response_revision:2583; number_of_response:1; }","duration":"138.092486ms","start":"2026-09-12T01:13:02.668015Z","end":"2026-09-12T01:13:02.806108Z","steps":["trace[795624475] 'process raft request' (duration: 137.757909ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:18:23.485372Z","caller":"traceutil/trace.go:171","msg":"trace[10602445] transaction","detail":"{read_only:false; number_of_response:1; response_revision:5091; }","duration":"102.298706ms","start":"2026-09-12T01:18:23.383049Z","end":"2026-09-12T01:18:23.485348Z","steps":["trace[10602445] 'process raft request' (duration: 29.650687ms)","trace[10602445] 'compare' (duration: 72.518066ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T01:18:23.518036Z","caller":"traceutil/trace.go:171","msg":"trace[722309584] transaction","detail":"{read_only:false; response_revision:5092; number_of_response:1; }","duration":"123.018539ms","start":"2026-09-12T01:18:23.394994Z","end":"2026-09-12T01:18:23.518013Z","steps":["trace[722309584] 'process raft request' (duration: 122.743544ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:18:23.518262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.176659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:7 size:62980"} {"level":"info","ts":"2026-09-12T01:18:23.518345Z","caller":"traceutil/trace.go:171","msg":"trace[752813407] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:7; response_revision:5092; }","duration":"126.280931ms","start":"2026-09-12T01:18:23.392043Z","end":"2026-09-12T01:18:23.518324Z","steps":["trace[752813407] 'agreement among raft nodes before linearized reading' (duration: 125.956563ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:18:44.134796Z","caller":"traceutil/trace.go:171","msg":"trace[770008799] linearizableReadLoop","detail":"{readStateIndex:5728; appliedIndex:5727; }","duration":"322.429829ms","start":"2026-09-12T01:18:43.81234Z","end":"2026-09-12T01:18:44.134769Z","steps":["trace[770008799] 'read index received' (duration: 235.205097ms)","trace[770008799] 'applied index is now lower than readState.Index' (duration: 87.223822ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T01:18:44.134999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.646855ms","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-09-12T01:18:44.135035Z","caller":"traceutil/trace.go:171","msg":"trace[1445977807] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5522; }","duration":"322.739686ms","start":"2026-09-12T01:18:43.812285Z","end":"2026-09-12T01:18:44.135025Z","steps":["trace[1445977807] 'agreement among raft nodes before linearized reading' (duration: 322.589983ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:18:44.135067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T01:18:43.812268Z","time spent":"322.790357ms","remote":"127.0.0.1:51570","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-09-12T01:18:44.135108Z","caller":"traceutil/trace.go:171","msg":"trace[1546719555] transaction","detail":"{read_only:false; response_revision:5522; number_of_response:1; }","duration":"329.055882ms","start":"2026-09-12T01:18:43.806014Z","end":"2026-09-12T01:18:44.13507Z","steps":["trace[1546719555] 'process raft request' (duration: 241.589595ms)","trace[1546719555] 'compare' (duration: 87.028607ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T01:18:44.135311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T01:18:43.805947Z","time spent":"329.270586ms","remote":"127.0.0.1:51570","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-12T01:18:55.194197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.839948ms","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-09-12T01:18:55.194295Z","caller":"traceutil/trace.go:171","msg":"trace[2015090543] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:5740; }","duration":"164.991832ms","start":"2026-09-12T01:18:55.029285Z","end":"2026-09-12T01:18:55.194277Z","steps":["trace[2015090543] 'count revisions from in-memory index tree' (duration: 164.692695ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:18:55.194337Z","caller":"traceutil/trace.go:171","msg":"trace[1784080798] transaction","detail":"{read_only:false; response_revision:5741; number_of_response:1; }","duration":"103.520612ms","start":"2026-09-12T01:18:55.090784Z","end":"2026-09-12T01:18:55.194304Z","steps":["trace[1784080798] 'process raft request' (duration: 57.467433ms)","trace[1784080798] 'compare' (duration: 45.856905ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T01:18:55.34497Z","caller":"traceutil/trace.go:171","msg":"trace[2021147325] linearizableReadLoop","detail":"{readStateIndex:5953; appliedIndex:5951; }","duration":"218.836066ms","start":"2026-09-12T01:18:55.126097Z","end":"2026-09-12T01:18:55.344933Z","steps":["trace[2021147325] 'read index received' (duration: 22.149724ms)","trace[2021147325] 'applied index is now lower than readState.Index' (duration: 196.684022ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T01:18:55.344972Z","caller":"traceutil/trace.go:171","msg":"trace[352445594] transaction","detail":"{read_only:false; response_revision:5742; number_of_response:1; }","duration":"250.18554ms","start":"2026-09-12T01:18:55.094734Z","end":"2026-09-12T01:18:55.344919Z","steps":["trace[352445594] 'process raft request' (duration: 213.263467ms)","trace[352445594] 'compare' (duration: 36.617376ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T01:18:55.345207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.101042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-72b13d38-151b-41ce-a505-3472727c8566\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-09-12T01:18:55.345269Z","caller":"traceutil/trace.go:171","msg":"trace[855942208] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-72b13d38-151b-41ce-a505-3472727c8566; range_end:; response_count:1; response_revision:5742; }","duration":"219.216425ms","start":"2026-09-12T01:18:55.126033Z","end":"2026-09-12T01:18:55.345249Z","steps":["trace[855942208] 'agreement among raft nodes before linearized reading' (duration: 219.01558ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:19:02.164157Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2925} {"level":"info","ts":"2026-09-12T01:19:02.246897Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2925,"took":"81.373696ms","hash":1656922644,"current-db-size-bytes":57581568,"current-db-size":"58 MB","current-db-size-in-use-bytes":32190464,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-09-12T01:19:02.246946Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1656922644,"revision":2925,"compact-revision":-1} {"level":"info","ts":"2026-09-12T01:19:07.72935Z","caller":"traceutil/trace.go:171","msg":"trace[1643246786] transaction","detail":"{read_only:false; response_revision:5845; number_of_response:1; }","duration":"104.36595ms","start":"2026-09-12T01:19:07.62496Z","end":"2026-09-12T01:19:07.729326Z","steps":["trace[1643246786] 'process raft request' (duration: 104.231637ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:24:02.17059Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5804} {"level":"info","ts":"2026-09-12T01:24:02.261392Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5804,"took":"89.043911ms","hash":1092502391,"current-db-size-bytes":57581568,"current-db-size":"58 MB","current-db-size-in-use-bytes":25837568,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-09-12T01:24:02.261458Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1092502391,"revision":5804,"compact-revision":2925} {"level":"warn","ts":"2026-09-12T01:25:21.573184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.904565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-12T01:25:21.57327Z","caller":"traceutil/trace.go:171","msg":"trace[1648336321] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8620; }","duration":"285.040848ms","start":"2026-09-12T01:25:21.288212Z","end":"2026-09-12T01:25:21.573253Z","steps":["trace[1648336321] 'range keys from in-memory index tree' (duration: 284.754661ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:25:23.249361Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000022e9.wal"} {"level":"info","ts":"2026-09-12T01:25:33.023295Z","caller":"traceutil/trace.go:171","msg":"trace[8496481] transaction","detail":"{read_only:false; response_revision:8682; number_of_response:1; }","duration":"214.416271ms","start":"2026-09-12T01:25:32.808848Z","end":"2026-09-12T01:25:33.023265Z","steps":["trace[8496481] 'process raft request' (duration: 213.905191ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:26:04.037771Z","caller":"traceutil/trace.go:171","msg":"trace[614892821] transaction","detail":"{read_only:false; response_revision:8899; number_of_response:1; }","duration":"200.694936ms","start":"2026-09-12T01:26:03.837057Z","end":"2026-09-12T01:26:04.037751Z","steps":["trace[614892821] 'process raft request' (duration: 200.37145ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:26:04.223146Z","caller":"traceutil/trace.go:171","msg":"trace[2073521947] transaction","detail":"{read_only:false; response_revision:8901; number_of_response:1; }","duration":"119.984366ms","start":"2026-09-12T01:26:04.103133Z","end":"2026-09-12T01:26:04.223117Z","steps":["trace[2073521947] 'process raft request' (duration: 68.449419ms)","trace[2073521947] 'compare' (duration: 51.305771ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T01:26:06.680897Z","caller":"traceutil/trace.go:171","msg":"trace[10758271] linearizableReadLoop","detail":"{readStateIndex:9231; appliedIndex:9230; }","duration":"119.636068ms","start":"2026-09-12T01:26:06.561234Z","end":"2026-09-12T01:26:06.68087Z","steps":["trace[10758271] 'read index received' (duration: 119.314341ms)","trace[10758271] 'applied index is now lower than readState.Index' (duration: 320.767µs)"],"step_count":2} {"level":"info","ts":"2026-09-12T01:26:06.680926Z","caller":"traceutil/trace.go:171","msg":"trace[975496265] transaction","detail":"{read_only:false; response_revision:8914; number_of_response:1; }","duration":"126.190268ms","start":"2026-09-12T01:26:06.554716Z","end":"2026-09-12T01:26:06.680907Z","steps":["trace[975496265] 'process raft request' (duration: 125.897552ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:26:06.681139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.875433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-09-12T01:26:06.681253Z","caller":"traceutil/trace.go:171","msg":"trace[460075676] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8914; }","duration":"120.024336ms","start":"2026-09-12T01:26:06.561207Z","end":"2026-09-12T01:26:06.681231Z","steps":["trace[460075676] 'agreement among raft nodes before linearized reading' (duration: 119.76975ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:26:14.821353Z","caller":"traceutil/trace.go:171","msg":"trace[1952393605] linearizableReadLoop","detail":"{readStateIndex:9276; appliedIndex:9275; }","duration":"106.980866ms","start":"2026-09-12T01:26:14.714344Z","end":"2026-09-12T01:26:14.821325Z","steps":["trace[1952393605] 'read index received' (duration: 106.744141ms)","trace[1952393605] 'applied index is now lower than readState.Index' (duration: 235.555µs)"],"step_count":2} {"level":"info","ts":"2026-09-12T01:26:14.82143Z","caller":"traceutil/trace.go:171","msg":"trace[1714642547] transaction","detail":"{read_only:false; response_revision:8958; number_of_response:1; }","duration":"108.859806ms","start":"2026-09-12T01:26:14.712535Z","end":"2026-09-12T01:26:14.821394Z","steps":["trace[1714642547] 'process raft request' (duration: 108.632381ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:26:14.821606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.241901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-09-12T01:26:14.821664Z","caller":"traceutil/trace.go:171","msg":"trace[1567467652] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8958; }","duration":"107.344663ms","start":"2026-09-12T01:26:14.714303Z","end":"2026-09-12T01:26:14.821648Z","steps":["trace[1567467652] 'agreement among raft nodes before linearized reading' (duration: 107.128659ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:26:17.215989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.386634ms","expected-duration":"100ms","prefix":"","request":"header: txn: success: > failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-12T01:26:17.216076Z","caller":"traceutil/trace.go:171","msg":"trace[352929166] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8982; }","duration":"136.352796ms","start":"2026-09-12T01:26:17.079708Z","end":"2026-09-12T01:26:17.216061Z","steps":["trace[352929166] 'compare' (duration: 113.278692ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:26:17.264453Z","caller":"traceutil/trace.go:171","msg":"trace[1360606060] transaction","detail":"{read_only:false; response_revision:8983; number_of_response:1; }","duration":"184.723354ms","start":"2026-09-12T01:26:17.079703Z","end":"2026-09-12T01:26:17.264426Z","steps":["trace[1360606060] 'process raft request' (duration: 184.599091ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:27:21.191112Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"612d5169b08bb96b","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-09-12T01:27:21.214151Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-09-12T01:27:21.214319Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-09-12T01:27:31.36032Z","caller":"traceutil/trace.go:171","msg":"trace[954816839] transaction","detail":"{read_only:false; response_revision:9747; number_of_response:1; }","duration":"103.688871ms","start":"2026-09-12T01:27:31.256552Z","end":"2026-09-12T01:27:31.360241Z","steps":["trace[954816839] 'process raft request' (duration: 45.404332ms)","trace[954816839] 'compare' (duration: 58.098605ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T01:27:44.501376Z","caller":"traceutil/trace.go:171","msg":"trace[998410426] transaction","detail":"{read_only:false; response_revision:9820; number_of_response:1; }","duration":"101.755261ms","start":"2026-09-12T01:27:44.399579Z","end":"2026-09-12T01:27:44.501334Z","steps":["trace[998410426] 'process raft request' (duration: 69.170612ms)","trace[998410426] 'compare' (duration: 32.402875ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T01:27:44.853182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.838462ms","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-09-12T01:27:44.853284Z","caller":"traceutil/trace.go:171","msg":"trace[1013065654] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:9820; }","duration":"101.968574ms","start":"2026-09-12T01:27:44.751289Z","end":"2026-09-12T01:27:44.853258Z","steps":["trace[1013065654] 'range keys from in-memory index tree' (duration: 101.679948ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:27:44.853435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.01629ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-12T01:27:44.853635Z","caller":"traceutil/trace.go:171","msg":"trace[29823178] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:9820; }","duration":"119.234234ms","start":"2026-09-12T01:27:44.734374Z","end":"2026-09-12T01:27:44.853608Z","steps":["trace[29823178] 'range keys from in-memory index tree' (duration: 118.995689ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:27:44.853548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.025609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-09-12T01:27:44.853807Z","caller":"traceutil/trace.go:171","msg":"trace[1866288031] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:9820; }","duration":"104.311426ms","start":"2026-09-12T01:27:44.749468Z","end":"2026-09-12T01:27:44.853779Z","steps":["trace[1866288031] 'range keys from in-memory index tree' (duration: 103.801344ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:29:02.177563Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7972} {"level":"info","ts":"2026-09-12T01:29:02.252004Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7972,"took":"70.446559ms","hash":1332549819,"current-db-size-bytes":57581568,"current-db-size":"58 MB","current-db-size-in-use-bytes":28069888,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-12T01:29:02.252074Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1332549819,"revision":7972,"compact-revision":5804} {"level":"info","ts":"2026-09-12T01:33:07.042067Z","caller":"traceutil/trace.go:171","msg":"trace[315002489] transaction","detail":"{read_only:false; response_revision:12160; number_of_response:1; }","duration":"101.553694ms","start":"2026-09-12T01:33:06.940477Z","end":"2026-09-12T01:33:07.042031Z","steps":["trace[315002489] 'process raft request' (duration: 99.380488ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:33:25.213775Z","caller":"traceutil/trace.go:171","msg":"trace[569785481] transaction","detail":"{read_only:false; response_revision:12263; number_of_response:1; }","duration":"162.34257ms","start":"2026-09-12T01:33:25.051406Z","end":"2026-09-12T01:33:25.213748Z","steps":["trace[569785481] 'process raft request' (duration: 162.207508ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:33:25.219849Z","caller":"traceutil/trace.go:171","msg":"trace[2052797759] transaction","detail":"{read_only:false; response_revision:12264; number_of_response:1; }","duration":"116.840172ms","start":"2026-09-12T01:33:25.102984Z","end":"2026-09-12T01:33:25.219824Z","steps":["trace[2052797759] 'process raft request' (duration: 116.667298ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:34:02.188646Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10340} {"level":"info","ts":"2026-09-12T01:34:02.275688Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10340,"took":"85.356055ms","hash":3198456486,"current-db-size-bytes":57581568,"current-db-size":"58 MB","current-db-size-in-use-bytes":25767936,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-09-12T01:34:02.275762Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3198456486,"revision":10340,"compact-revision":7972} {"level":"info","ts":"2026-09-12T01:39:02.194694Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12514} {"level":"info","ts":"2026-09-12T01:39:02.27392Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12514,"took":"77.287251ms","hash":3359663939,"current-db-size-bytes":57581568,"current-db-size":"58 MB","current-db-size-in-use-bytes":27664384,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-12T01:39:02.274021Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3359663939,"revision":12514,"compact-revision":10340} {"level":"info","ts":"2026-09-12T01:40:14.92969Z","caller":"traceutil/trace.go:171","msg":"trace[1139186213] linearizableReadLoop","detail":"{readStateIndex:15499; appliedIndex:15498; }","duration":"133.984779ms","start":"2026-09-12T01:40:14.795674Z","end":"2026-09-12T01:40:14.929659Z","steps":["trace[1139186213] 'read index received' (duration: 133.796785ms)","trace[1139186213] 'applied index is now lower than readState.Index' (duration: 186.624µs)"],"step_count":2} {"level":"info","ts":"2026-09-12T01:40:14.929798Z","caller":"traceutil/trace.go:171","msg":"trace[123841349] transaction","detail":"{read_only:false; response_revision:14980; number_of_response:1; }","duration":"136.203687ms","start":"2026-09-12T01:40:14.793539Z","end":"2026-09-12T01:40:14.929743Z","steps":["trace[123841349] 'process raft request' (duration: 135.933951ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:40:14.930018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.1341ms","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-09-12T01:40:14.930062Z","caller":"traceutil/trace.go:171","msg":"trace[428678049] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:14980; }","duration":"132.256151ms","start":"2026-09-12T01:40:14.797794Z","end":"2026-09-12T01:40:14.93005Z","steps":["trace[428678049] 'agreement among raft nodes before linearized reading' (duration: 132.046037ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:40:14.930049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.347097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-09-12T01:40:14.930148Z","caller":"traceutil/trace.go:171","msg":"trace[1458558722] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:14980; }","duration":"134.49265ms","start":"2026-09-12T01:40:14.795631Z","end":"2026-09-12T01:40:14.930124Z","steps":["trace[1458558722] 'agreement among raft nodes before linearized reading' (duration: 134.179173ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:40:15.612024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.630691ms","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-09-12T01:40:15.612378Z","caller":"traceutil/trace.go:171","msg":"trace[1270807190] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:14985; }","duration":"194.03513ms","start":"2026-09-12T01:40:15.418317Z","end":"2026-09-12T01:40:15.612352Z","steps":["trace[1270807190] 'range keys from in-memory index tree' (duration: 193.449556ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:40:15.762995Z","caller":"traceutil/trace.go:171","msg":"trace[1732373050] transaction","detail":"{read_only:false; response_revision:14986; number_of_response:1; }","duration":"343.595933ms","start":"2026-09-12T01:40:15.419368Z","end":"2026-09-12T01:40:15.762964Z","steps":["trace[1732373050] 'process raft request' (duration: 343.393869ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:40:15.763193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T01:40:15.419335Z","time spent":"343.753686ms","remote":"127.0.0.1:51570","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-12T01:40:15.769053Z","caller":"traceutil/trace.go:171","msg":"trace[1943456307] transaction","detail":"{read_only:false; response_revision:14987; number_of_response:1; }","duration":"152.290842ms","start":"2026-09-12T01:40:15.616729Z","end":"2026-09-12T01:40:15.76902Z","steps":["trace[1943456307] 'process raft request' (duration: 152.096188ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:40:39.993867Z","caller":"traceutil/trace.go:171","msg":"trace[1296632382] linearizableReadLoop","detail":"{readStateIndex:15838; appliedIndex:15837; }","duration":"109.866561ms","start":"2026-09-12T01:40:39.883971Z","end":"2026-09-12T01:40:39.993837Z","steps":["trace[1296632382] 'read index received' (duration: 109.700527ms)","trace[1296632382] 'applied index is now lower than readState.Index' (duration: 164.514µs)"],"step_count":2} {"level":"info","ts":"2026-09-12T01:40:39.994052Z","caller":"traceutil/trace.go:171","msg":"trace[1311390004] transaction","detail":"{read_only:false; response_revision:15305; number_of_response:1; }","duration":"113.514139ms","start":"2026-09-12T01:40:39.880524Z","end":"2026-09-12T01:40:39.994039Z","steps":["trace[1311390004] 'process raft request' (duration: 113.128541ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:40:39.994331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.338451ms","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-09-12T01:40:39.994427Z","caller":"traceutil/trace.go:171","msg":"trace[422160009] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:15305; }","duration":"110.460983ms","start":"2026-09-12T01:40:39.883941Z","end":"2026-09-12T01:40:39.994402Z","steps":["trace[422160009] 'agreement among raft nodes before linearized reading' (duration: 110.138766ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:41:53.441432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.628503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-12T01:41:53.441523Z","caller":"traceutil/trace.go:171","msg":"trace[1236844017] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:16048; }","duration":"134.773546ms","start":"2026-09-12T01:41:53.306732Z","end":"2026-09-12T01:41:53.441505Z","steps":["trace[1236844017] 'count revisions from in-memory index tree' (duration: 134.542112ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:41:53.441579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.445197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheusagents/\" range_end:\"/registry/monitoring.coreos.com/prometheusagents0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-12T01:41:53.441661Z","caller":"traceutil/trace.go:171","msg":"trace[152655479] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheusagents/; range_end:/registry/monitoring.coreos.com/prometheusagents0; response_count:0; response_revision:16048; }","duration":"214.541039ms","start":"2026-09-12T01:41:53.227099Z","end":"2026-09-12T01:41:53.44164Z","steps":["trace[152655479] 'count revisions from in-memory index tree' (duration: 214.366146ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:41:53.441577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.707435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheusrules/\" range_end:\"/registry/monitoring.coreos.com/prometheusrules0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-12T01:41:53.44243Z","caller":"traceutil/trace.go:171","msg":"trace[1599932638] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheusrules/; range_end:/registry/monitoring.coreos.com/prometheusrules0; response_count:0; response_revision:16048; }","duration":"122.724867ms","start":"2026-09-12T01:41:53.319677Z","end":"2026-09-12T01:41:53.442402Z","steps":["trace[1599932638] 'count revisions from in-memory index tree' (duration: 121.545751ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:44:02.202411Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14510} {"level":"info","ts":"2026-09-12T01:44:02.290772Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14510,"took":"85.839954ms","hash":777588482,"current-db-size-bytes":57581568,"current-db-size":"58 MB","current-db-size-in-use-bytes":31186944,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-09-12T01:44:02.290875Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":777588482,"revision":14510,"compact-revision":12514} {"level":"info","ts":"2026-09-12T01:48:26.691571Z","caller":"traceutil/trace.go:171","msg":"trace[2090014635] linearizableReadLoop","detail":"{readStateIndex:19511; appliedIndex:19510; }","duration":"114.298792ms","start":"2026-09-12T01:48:26.577215Z","end":"2026-09-12T01:48:26.691514Z","steps":["trace[2090014635] 'read index received' (duration: 113.963085ms)","trace[2090014635] 'applied index is now lower than readState.Index' (duration: 334.467µs)"],"step_count":2} {"level":"info","ts":"2026-09-12T01:48:26.692055Z","caller":"traceutil/trace.go:171","msg":"trace[1594434971] transaction","detail":"{read_only:false; response_revision:18865; number_of_response:1; }","duration":"198.260255ms","start":"2026-09-12T01:48:26.493777Z","end":"2026-09-12T01:48:26.692038Z","steps":["trace[1594434971] 'process raft request' (duration: 197.503079ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:48:26.692593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.335905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-09-12T01:48:26.69267Z","caller":"traceutil/trace.go:171","msg":"trace[1428184248] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:18865; }","duration":"115.453887ms","start":"2026-09-12T01:48:26.577176Z","end":"2026-09-12T01:48:26.69263Z","steps":["trace[1428184248] 'agreement among raft nodes before linearized reading' (duration: 115.227272ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:48:26.697238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.904698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-12T01:48:26.698851Z","caller":"traceutil/trace.go:171","msg":"trace[1558388859] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:18867; }","duration":"111.550113ms","start":"2026-09-12T01:48:26.587274Z","end":"2026-09-12T01:48:26.698824Z","steps":["trace[1558388859] 'agreement among raft nodes before linearized reading' (duration: 109.836376ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:48:34.258514Z","caller":"traceutil/trace.go:171","msg":"trace[2146259758] linearizableReadLoop","detail":"{readStateIndex:19556; appliedIndex:19555; }","duration":"228.052692ms","start":"2026-09-12T01:48:34.030436Z","end":"2026-09-12T01:48:34.258488Z","steps":["trace[2146259758] 'read index received' (duration: 227.166493ms)","trace[2146259758] 'applied index is now lower than readState.Index' (duration: 884.918µs)"],"step_count":2} {"level":"warn","ts":"2026-09-12T01:48:34.258682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.224076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-12T01:48:34.258725Z","caller":"traceutil/trace.go:171","msg":"trace[1039120911] range","detail":"{range_begin:/registry/rabbitmq.com/federations/; range_end:/registry/rabbitmq.com/federations0; response_count:0; response_revision:18908; }","duration":"228.328117ms","start":"2026-09-12T01:48:34.030386Z","end":"2026-09-12T01:48:34.258714Z","steps":["trace[1039120911] 'agreement among raft nodes before linearized reading' (duration: 228.205495ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:48:34.25882Z","caller":"traceutil/trace.go:171","msg":"trace[26120724] transaction","detail":"{read_only:false; response_revision:18908; number_of_response:1; }","duration":"250.527882ms","start":"2026-09-12T01:48:34.008251Z","end":"2026-09-12T01:48:34.258779Z","steps":["trace[26120724] 'process raft request' (duration: 250.068182ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:48:34.592726Z","caller":"traceutil/trace.go:171","msg":"trace[9048017] linearizableReadLoop","detail":"{readStateIndex:19557; appliedIndex:19556; }","duration":"154.605014ms","start":"2026-09-12T01:48:34.438091Z","end":"2026-09-12T01:48:34.592696Z","steps":["trace[9048017] 'read index received' (duration: 154.4406ms)","trace[9048017] 'applied index is now lower than readState.Index' (duration: 163.074µs)"],"step_count":2} {"level":"info","ts":"2026-09-12T01:48:34.592779Z","caller":"traceutil/trace.go:171","msg":"trace[1415553252] transaction","detail":"{read_only:false; response_revision:18909; number_of_response:1; }","duration":"233.134872ms","start":"2026-09-12T01:48:34.359607Z","end":"2026-09-12T01:48:34.592742Z","steps":["trace[1415553252] 'process raft request' (duration: 232.919677ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:48:34.592931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.842388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-09-12T01:48:34.592972Z","caller":"traceutil/trace.go:171","msg":"trace[1038486091] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:18909; }","duration":"154.93995ms","start":"2026-09-12T01:48:34.438022Z","end":"2026-09-12T01:48:34.592962Z","steps":["trace[1038486091] 'agreement among raft nodes before linearized reading' (duration: 154.782197ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:48:34.897195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.35124ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-12T01:48:34.897306Z","caller":"traceutil/trace.go:171","msg":"trace[1239132955] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:18910; }","duration":"163.473863ms","start":"2026-09-12T01:48:34.733816Z","end":"2026-09-12T01:48:34.89729Z","steps":["trace[1239132955] 'range keys from in-memory index tree' (duration: 163.316528ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:48:34.897898Z","caller":"traceutil/trace.go:171","msg":"trace[501403253] linearizableReadLoop","detail":"{readStateIndex:19559; appliedIndex:19558; }","duration":"164.844042ms","start":"2026-09-12T01:48:34.733036Z","end":"2026-09-12T01:48:34.89788Z","steps":["trace[501403253] 'read index received' (duration: 164.463423ms)","trace[501403253] 'applied index is now lower than readState.Index' (duration: 379.949µs)"],"step_count":2} {"level":"info","ts":"2026-09-12T01:48:34.89805Z","caller":"traceutil/trace.go:171","msg":"trace[1908777139] transaction","detail":"{read_only:false; response_revision:18911; number_of_response:1; }","duration":"167.54637ms","start":"2026-09-12T01:48:34.730474Z","end":"2026-09-12T01:48:34.898021Z","steps":["trace[1908777139] 'process raft request' (duration: 167.140531ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:48:34.898265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.193539ms","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-09-12T01:48:34.898326Z","caller":"traceutil/trace.go:171","msg":"trace[1179714826] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:18911; }","duration":"165.322402ms","start":"2026-09-12T01:48:34.732995Z","end":"2026-09-12T01:48:34.898317Z","steps":["trace[1179714826] 'agreement among raft nodes before linearized reading' (duration: 164.954764ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:49:02.214393Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":16843} {"level":"info","ts":"2026-09-12T01:49:02.311047Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":16843,"took":"93.707541ms","hash":4111183818,"current-db-size-bytes":57581568,"current-db-size":"58 MB","current-db-size-in-use-bytes":32120832,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-09-12T01:49:02.311156Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4111183818,"revision":16843,"compact-revision":14510} {"level":"info","ts":"2026-09-12T01:49:13.537562Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"612d5169b08bb96b","local-member-applied-index":20013,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-09-12T01:49:13.544399Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20013} {"level":"info","ts":"2026-09-12T01:49:13.544495Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15013} {"level":"info","ts":"2026-09-12T01:54:02.221729Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19217} {"level":"info","ts":"2026-09-12T01:54:02.337269Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19217,"took":"112.61757ms","hash":2475272566,"current-db-size-bytes":57581568,"current-db-size":"58 MB","current-db-size-in-use-bytes":33615872,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-09-12T01:54:02.33735Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2475272566,"revision":19217,"compact-revision":16843} {"level":"info","ts":"2026-09-12T01:54:38.460696Z","caller":"traceutil/trace.go:171","msg":"trace[1241490890] transaction","detail":"{read_only:false; response_revision:21688; number_of_response:1; }","duration":"111.380954ms","start":"2026-09-12T01:54:38.349291Z","end":"2026-09-12T01:54:38.460672Z","steps":["trace[1241490890] 'process raft request' (duration: 111.253631ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:54:54.620923Z","caller":"traceutil/trace.go:171","msg":"trace[513874534] transaction","detail":"{read_only:false; response_revision:21772; number_of_response:1; }","duration":"103.371752ms","start":"2026-09-12T01:54:54.517514Z","end":"2026-09-12T01:54:54.620886Z","steps":["trace[513874534] 'process raft request' (duration: 102.957683ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:54:54.860267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.785934ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-12T01:54:54.860419Z","caller":"traceutil/trace.go:171","msg":"trace[231440063] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:21772; }","duration":"126.949547ms","start":"2026-09-12T01:54:54.733447Z","end":"2026-09-12T01:54:54.860396Z","steps":["trace[231440063] 'range keys from in-memory index tree' (duration: 126.767523ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:54:54.860992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.395937ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-12T01:54:54.86112Z","caller":"traceutil/trace.go:171","msg":"trace[334374096] transaction","detail":"{read_only:false; response_revision:21773; number_of_response:1; }","duration":"236.176044ms","start":"2026-09-12T01:54:54.624922Z","end":"2026-09-12T01:54:54.861098Z","steps":["trace[334374096] 'process raft request' (duration: 115.123563ms)","trace[334374096] 'compare' (duration: 120.07177ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T01:54:55.034633Z","caller":"traceutil/trace.go:171","msg":"trace[1681891189] transaction","detail":"{read_only:false; response_revision:21774; number_of_response:1; }","duration":"386.377219ms","start":"2026-09-12T01:54:54.648221Z","end":"2026-09-12T01:54:55.034599Z","steps":["trace[1681891189] 'process raft request' (duration: 375.972777ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:54:55.034838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T01:54:54.648192Z","time spent":"386.521022ms","remote":"127.0.0.1:51570","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-12T01:54:55.179028Z","caller":"traceutil/trace.go:171","msg":"trace[1344589266] transaction","detail":"{read_only:false; response_revision:21775; number_of_response:1; }","duration":"139.926195ms","start":"2026-09-12T01:54:55.039076Z","end":"2026-09-12T01:54:55.179002Z","steps":["trace[1344589266] 'process raft request' (duration: 127.941938ms)","trace[1344589266] 'compare' (duration: 11.866854ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T01:54:55.468033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.931187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-09-12T01:54:55.468115Z","caller":"traceutil/trace.go:171","msg":"trace[1592066729] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:21775; }","duration":"142.089231ms","start":"2026-09-12T01:54:55.326006Z","end":"2026-09-12T01:54:55.468095Z","steps":["trace[1592066729] 'range keys from in-memory index tree' (duration: 141.730463ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:58:59.073432Z","caller":"traceutil/trace.go:171","msg":"trace[1800100682] linearizableReadLoop","detail":"{readStateIndex:25121; appliedIndex:25119; }","duration":"104.129998ms","start":"2026-09-12T01:58:58.969286Z","end":"2026-09-12T01:58:59.073416Z","steps":["trace[1800100682] 'read index received' (duration: 42.599692ms)","trace[1800100682] 'applied index is now lower than readState.Index' (duration: 61.529556ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T01:58:59.07369Z","caller":"traceutil/trace.go:171","msg":"trace[648464416] transaction","detail":"{read_only:false; response_revision:24302; number_of_response:1; }","duration":"110.412094ms","start":"2026-09-12T01:58:58.963269Z","end":"2026-09-12T01:58:59.073681Z","steps":["trace[648464416] 'process raft request' (duration: 109.929713ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:58:59.074116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.812164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-12T01:58:59.074186Z","caller":"traceutil/trace.go:171","msg":"trace[856153891] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24303; }","duration":"104.903856ms","start":"2026-09-12T01:58:58.969251Z","end":"2026-09-12T01:58:59.074155Z","steps":["trace[856153891] 'agreement among raft nodes before linearized reading' (duration: 104.808814ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:58:59.074806Z","caller":"traceutil/trace.go:171","msg":"trace[1598019890] transaction","detail":"{read_only:false; response_revision:24303; number_of_response:1; }","duration":"105.326324ms","start":"2026-09-12T01:58:58.969471Z","end":"2026-09-12T01:58:59.074798Z","steps":["trace[1598019890] 'process raft request' (duration: 103.865553ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:58:59.379382Z","caller":"traceutil/trace.go:171","msg":"trace[1570164328] transaction","detail":"{read_only:false; response_revision:24304; number_of_response:1; }","duration":"237.770418ms","start":"2026-09-12T01:58:59.141589Z","end":"2026-09-12T01:58:59.379359Z","steps":["trace[1570164328] 'process raft request' (duration: 237.589535ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:58:59.380127Z","caller":"traceutil/trace.go:171","msg":"trace[1605755968] linearizableReadLoop","detail":"{readStateIndex:25124; appliedIndex:25122; }","duration":"205.666881ms","start":"2026-09-12T01:58:59.174438Z","end":"2026-09-12T01:58:59.380105Z","steps":["trace[1605755968] 'read index received' (duration: 204.856554ms)","trace[1605755968] 'applied index is now lower than readState.Index' (duration: 809.567µs)"],"step_count":2} {"level":"warn","ts":"2026-09-12T01:58:59.380384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.930147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/openstackclusters.infrastructure.cluster.x-k8s.io\" ","response":"range_response_count:1 size:87332"} {"level":"info","ts":"2026-09-12T01:58:59.380431Z","caller":"traceutil/trace.go:171","msg":"trace[1120134829] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/openstackclusters.infrastructure.cluster.x-k8s.io; range_end:; response_count:1; response_revision:24305; }","duration":"206.187233ms","start":"2026-09-12T01:58:59.174233Z","end":"2026-09-12T01:58:59.38042Z","steps":["trace[1120134829] 'agreement among raft nodes before linearized reading' (duration: 206.022879ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:58:59.380429Z","caller":"traceutil/trace.go:171","msg":"trace[956704674] transaction","detail":"{read_only:false; response_revision:24305; number_of_response:1; }","duration":"214.691175ms","start":"2026-09-12T01:58:59.165723Z","end":"2026-09-12T01:58:59.380414Z","steps":["trace[956704674] 'process raft request' (duration: 214.310077ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:59:02.231498Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21504} {"level":"info","ts":"2026-09-12T01:59:02.349714Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21504,"took":"114.716765ms","hash":3329709563,"current-db-size-bytes":57581568,"current-db-size":"58 MB","current-db-size-in-use-bytes":41656320,"current-db-size-in-use":"42 MB"} {"level":"info","ts":"2026-09-12T01:59:02.349786Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3329709563,"revision":21504,"compact-revision":19217} {"level":"info","ts":"2026-09-12T02:01:17.297592Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006808.wal"} {"level":"info","ts":"2026-09-12T02:02:30.782719Z","caller":"traceutil/trace.go:171","msg":"trace[566221793] linearizableReadLoop","detail":"{readStateIndex:27289; appliedIndex:27287; }","duration":"205.779752ms","start":"2026-09-12T02:02:30.576916Z","end":"2026-09-12T02:02:30.782696Z","steps":["trace[566221793] 'read index received' (duration: 3.347442ms)","trace[566221793] 'applied index is now lower than readState.Index' (duration: 202.43142ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T02:02:30.782853Z","caller":"traceutil/trace.go:171","msg":"trace[1718497203] transaction","detail":"{read_only:false; number_of_response:1; response_revision:26419; }","duration":"210.491153ms","start":"2026-09-12T02:02:30.57233Z","end":"2026-09-12T02:02:30.782821Z","steps":["trace[1718497203] 'process raft request' (duration: 121.54948ms)","trace[1718497203] 'compare' (duration: 88.661987ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T02:02:30.782885Z","caller":"traceutil/trace.go:171","msg":"trace[2007243774] transaction","detail":"{read_only:false; response_revision:26420; number_of_response:1; }","duration":"194.598273ms","start":"2026-09-12T02:02:30.588257Z","end":"2026-09-12T02:02:30.782855Z","steps":["trace[2007243774] 'process raft request' (duration: 194.378658ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:02:30.782971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.036198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:3959"} {"level":"info","ts":"2026-09-12T02:02:30.783008Z","caller":"traceutil/trace.go:171","msg":"trace[651110584] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:26420; }","duration":"206.097329ms","start":"2026-09-12T02:02:30.576898Z","end":"2026-09-12T02:02:30.782996Z","steps":["trace[651110584] 'agreement among raft nodes before linearized reading' (duration: 205.933755ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:02:30.783286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.22342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/magnum-api-certs-66lf8\" ","response":"range_response_count:1 size:2465"} {"level":"info","ts":"2026-09-12T02:02:30.783316Z","caller":"traceutil/trace.go:171","msg":"trace[98075573] range","detail":"{range_begin:/registry/secrets/openstack/magnum-api-certs-66lf8; range_end:; response_count:1; response_revision:26420; }","duration":"197.28097ms","start":"2026-09-12T02:02:30.586025Z","end":"2026-09-12T02:02:30.783306Z","steps":["trace[98075573] 'agreement among raft nodes before linearized reading' (duration: 197.159548ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:02:30.783448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.000654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/magnum-api-certs\" ","response":"range_response_count:1 size:4359"} {"level":"warn","ts":"2026-09-12T02:02:30.783472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.50008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:4727"} {"level":"info","ts":"2026-09-12T02:02:30.783499Z","caller":"traceutil/trace.go:171","msg":"trace[1233726371] range","detail":"{range_begin:/registry/secrets/openstack/magnum-api-certs; range_end:; response_count:1; response_revision:26420; }","duration":"196.080105ms","start":"2026-09-12T02:02:30.587402Z","end":"2026-09-12T02:02:30.783482Z","steps":["trace[1233726371] 'agreement among raft nodes before linearized reading' (duration: 195.940532ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:02:30.78355Z","caller":"traceutil/trace.go:171","msg":"trace[400996736] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:26420; }","duration":"193.614772ms","start":"2026-09-12T02:02:30.589916Z","end":"2026-09-12T02:02:30.783531Z","steps":["trace[400996736] 'agreement among raft nodes before linearized reading' (duration: 193.355047ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:02:42.722855Z","caller":"traceutil/trace.go:171","msg":"trace[1359601570] transaction","detail":"{read_only:false; response_revision:26582; number_of_response:1; }","duration":"297.127838ms","start":"2026-09-12T02:02:42.4257Z","end":"2026-09-12T02:02:42.722828Z","steps":["trace[1359601570] 'process raft request' (duration: 296.969814ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:02:43.081351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.170042ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-12T02:02:43.08158Z","caller":"traceutil/trace.go:171","msg":"trace[733373546] transaction","detail":"{read_only:false; response_revision:26584; number_of_response:1; }","duration":"145.036773ms","start":"2026-09-12T02:02:42.936526Z","end":"2026-09-12T02:02:43.081562Z","steps":["trace[733373546] 'process raft request' (duration: 144.945111ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:02:43.081593Z","caller":"traceutil/trace.go:171","msg":"trace[1939928110] transaction","detail":"{read_only:false; response_revision:26583; number_of_response:1; }","duration":"367.83133ms","start":"2026-09-12T02:02:42.713736Z","end":"2026-09-12T02:02:43.081568Z","steps":["trace[1939928110] 'process raft request' (duration: 231.355241ms)","trace[1939928110] 'compare' (duration: 136.019019ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T02:02:43.081713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:02:42.713709Z","time spent":"367.930132ms","remote":"127.0.0.1:51570","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":628,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-12T02:02:43.08185Z","caller":"traceutil/trace.go:171","msg":"trace[1383057894] transaction","detail":"{read_only:false; response_revision:26585; number_of_response:1; }","duration":"141.495847ms","start":"2026-09-12T02:02:42.940347Z","end":"2026-09-12T02:02:43.081843Z","steps":["trace[1383057894] 'process raft request' (duration: 141.17644ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:02:43.081814Z","caller":"traceutil/trace.go:171","msg":"trace[904305489] linearizableReadLoop","detail":"{readStateIndex:27462; appliedIndex:27459; }","duration":"111.327381ms","start":"2026-09-12T02:02:42.970438Z","end":"2026-09-12T02:02:43.081765Z","steps":["trace[904305489] 'read index received' (duration: 12.417355ms)","trace[904305489] 'applied index is now lower than readState.Index' (duration: 98.906496ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T02:02:43.081962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.500855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-12T02:02:43.082061Z","caller":"traceutil/trace.go:171","msg":"trace[1319566809] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26585; }","duration":"111.641058ms","start":"2026-09-12T02:02:42.970409Z","end":"2026-09-12T02:02:43.08205Z","steps":["trace[1319566809] 'agreement among raft nodes before linearized reading' (duration: 111.479895ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:02:43.326372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.324117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephnfses/\" range_end:\"/registry/ceph.rook.io/cephnfses0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-12T02:02:43.3265Z","caller":"traceutil/trace.go:171","msg":"trace[2121167006] range","detail":"{range_begin:/registry/ceph.rook.io/cephnfses/; range_end:/registry/ceph.rook.io/cephnfses0; response_count:0; response_revision:26585; }","duration":"122.46008ms","start":"2026-09-12T02:02:43.203996Z","end":"2026-09-12T02:02:43.326456Z","steps":["trace[2121167006] 'count revisions from in-memory index tree' (duration: 122.149374ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:02:48.050756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.338623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagerconfigs/\" range_end:\"/registry/monitoring.coreos.com/alertmanagerconfigs0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-12T02:02:48.050831Z","caller":"traceutil/trace.go:171","msg":"trace[1654406919] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagerconfigs/; range_end:/registry/monitoring.coreos.com/alertmanagerconfigs0; response_count:0; response_revision:26619; }","duration":"112.455766ms","start":"2026-09-12T02:02:47.938347Z","end":"2026-09-12T02:02:48.050803Z","steps":["trace[1654406919] 'count revisions from in-memory index tree' (duration: 112.15281ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:02:48.051135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.059735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-09-12T02:02:48.051165Z","caller":"traceutil/trace.go:171","msg":"trace[1001021783] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26619; }","duration":"110.138567ms","start":"2026-09-12T02:02:47.941019Z","end":"2026-09-12T02:02:48.051158Z","steps":["trace[1001021783] 'range keys from in-memory index tree' (duration: 109.667226ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:02:48.373571Z","caller":"traceutil/trace.go:171","msg":"trace[1615708750] linearizableReadLoop","detail":"{readStateIndex:27501; appliedIndex:27500; }","duration":"151.369369ms","start":"2026-09-12T02:02:48.222165Z","end":"2026-09-12T02:02:48.373535Z","steps":["trace[1615708750] 'read index received' (duration: 126.392185ms)","trace[1615708750] 'applied index is now lower than readState.Index' (duration: 24.976454ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T02:02:48.373645Z","caller":"traceutil/trace.go:171","msg":"trace[648804084] transaction","detail":"{read_only:false; response_revision:26623; number_of_response:1; }","duration":"165.524111ms","start":"2026-09-12T02:02:48.208111Z","end":"2026-09-12T02:02:48.373635Z","steps":["trace[648804084] 'process raft request' (duration: 140.23842ms)","trace[648804084] 'compare' (duration: 25.052156ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T02:02:48.373842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.665835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-09-12T02:02:48.373923Z","caller":"traceutil/trace.go:171","msg":"trace[310677398] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26623; }","duration":"151.785309ms","start":"2026-09-12T02:02:48.222118Z","end":"2026-09-12T02:02:48.373904Z","steps":["trace[310677398] 'agreement among raft nodes before linearized reading' (duration: 151.595254ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:02:48.536477Z","caller":"traceutil/trace.go:171","msg":"trace[1157221527] transaction","detail":"{read_only:false; response_revision:26625; number_of_response:1; }","duration":"158.128404ms","start":"2026-09-12T02:02:48.378323Z","end":"2026-09-12T02:02:48.536451Z","steps":["trace[1157221527] 'process raft request' (duration: 158.072732ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:02:48.536622Z","caller":"traceutil/trace.go:171","msg":"trace[2018298520] transaction","detail":"{read_only:false; response_revision:26624; number_of_response:1; }","duration":"292.293504ms","start":"2026-09-12T02:02:48.244289Z","end":"2026-09-12T02:02:48.536583Z","steps":["trace[2018298520] 'process raft request' (duration: 241.983828ms)","trace[2018298520] 'compare' (duration: 49.973298ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T02:02:48.536654Z","caller":"traceutil/trace.go:171","msg":"trace[1305415453] linearizableReadLoop","detail":"{readStateIndex:27502; appliedIndex:27501; }","duration":"163.020928ms","start":"2026-09-12T02:02:48.37361Z","end":"2026-09-12T02:02:48.536631Z","steps":["trace[1305415453] 'read index received' (duration: 112.691822ms)","trace[1305415453] 'applied index is now lower than readState.Index' (duration: 50.326686ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T02:02:48.536826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.691612ms","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-09-12T02:02:48.536874Z","caller":"traceutil/trace.go:171","msg":"trace[880867943] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26625; }","duration":"249.777394ms","start":"2026-09-12T02:02:48.287086Z","end":"2026-09-12T02:02:48.536863Z","steps":["trace[880867943] 'agreement among raft nodes before linearized reading' (duration: 249.611471ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:02:48.910418Z","caller":"traceutil/trace.go:171","msg":"trace[1054062663] transaction","detail":"{read_only:false; response_revision:26627; number_of_response:1; }","duration":"165.161884ms","start":"2026-09-12T02:02:48.745229Z","end":"2026-09-12T02:02:48.910391Z","steps":["trace[1054062663] 'process raft request' (duration: 164.948879ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:02:49.327037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.151963ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-12T02:02:49.327137Z","caller":"traceutil/trace.go:171","msg":"trace[2013502523] transaction","detail":"{read_only:false; response_revision:26629; number_of_response:1; }","duration":"212.481586ms","start":"2026-09-12T02:02:49.114636Z","end":"2026-09-12T02:02:49.327117Z","steps":["trace[2013502523] 'process raft request' (duration: 83.16906ms)","trace[2013502523] 'compare' (duration: 129.043431ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T02:02:49.709501Z","caller":"traceutil/trace.go:171","msg":"trace[513930259] transaction","detail":"{read_only:false; response_revision:26630; number_of_response:1; }","duration":"168.72524ms","start":"2026-09-12T02:02:49.540755Z","end":"2026-09-12T02:02:49.709481Z","steps":["trace[513930259] 'process raft request' (duration: 168.521636ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:02:49.921266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.229161ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-12T02:02:49.92144Z","caller":"traceutil/trace.go:171","msg":"trace[78650890] linearizableReadLoop","detail":"{readStateIndex:27510; appliedIndex:27508; }","duration":"158.87706ms","start":"2026-09-12T02:02:49.762545Z","end":"2026-09-12T02:02:49.921422Z","steps":["trace[78650890] 'read index received' (duration: 25.272281ms)","trace[78650890] 'applied index is now lower than readState.Index' (duration: 133.603629ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T02:02:49.921758Z","caller":"traceutil/trace.go:171","msg":"trace[1110156325] transaction","detail":"{read_only:false; response_revision:26631; number_of_response:1; }","duration":"337.01349ms","start":"2026-09-12T02:02:49.584707Z","end":"2026-09-12T02:02:49.921721Z","steps":["trace[1110156325] 'process raft request' (duration: 203.230587ms)","trace[1110156325] 'compare' (duration: 132.801462ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T02:02:49.921779Z","caller":"traceutil/trace.go:171","msg":"trace[1925713078] transaction","detail":"{read_only:false; response_revision:26632; number_of_response:1; }","duration":"238.284888ms","start":"2026-09-12T02:02:49.683453Z","end":"2026-09-12T02:02:49.921737Z","steps":["trace[1925713078] 'process raft request' (duration: 237.90293ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:02:49.92184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.262258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinepools/\" range_end:\"/registry/cluster.x-k8s.io/machinepools0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-09-12T02:02:49.921921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:02:49.584676Z","time spent":"337.160134ms","remote":"127.0.0.1:51570","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-12T02:02:49.922503Z","caller":"traceutil/trace.go:171","msg":"trace[907489508] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinepools/; range_end:/registry/cluster.x-k8s.io/machinepools0; response_count:0; response_revision:26632; }","duration":"159.419751ms","start":"2026-09-12T02:02:49.76249Z","end":"2026-09-12T02:02:49.921909Z","steps":["trace[907489508] 'agreement among raft nodes before linearized reading' (duration: 159.251698ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:02:50.475193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.586154ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-12T02:02:50.475359Z","caller":"traceutil/trace.go:171","msg":"trace[1791431504] linearizableReadLoop","detail":"{readStateIndex:27512; appliedIndex:27511; }","duration":"363.863466ms","start":"2026-09-12T02:02:50.111471Z","end":"2026-09-12T02:02:50.475335Z","steps":["trace[1791431504] 'read index received' (duration: 218.960895ms)","trace[1791431504] 'applied index is now lower than readState.Index' (duration: 144.900171ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T02:02:50.475453Z","caller":"traceutil/trace.go:171","msg":"trace[2123815596] transaction","detail":"{read_only:false; response_revision:26634; number_of_response:1; }","duration":"404.820772ms","start":"2026-09-12T02:02:50.070587Z","end":"2026-09-12T02:02:50.475408Z","steps":["trace[2123815596] 'process raft request' (duration: 259.913161ms)","trace[2123815596] 'compare' (duration: 144.467082ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T02:02:50.47552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.044419ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystemmirrors/\" range_end:\"/registry/ceph.rook.io/cephfilesystemmirrors0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-12T02:02:50.475571Z","caller":"traceutil/trace.go:171","msg":"trace[1096124576] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemmirrors/; range_end:/registry/ceph.rook.io/cephfilesystemmirrors0; response_count:0; response_revision:26634; }","duration":"364.137621ms","start":"2026-09-12T02:02:50.111416Z","end":"2026-09-12T02:02:50.475554Z","steps":["trace[1096124576] 'agreement among raft nodes before linearized reading' (duration: 364.024169ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:02:50.475626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:02:50.111395Z","time spent":"364.216032ms","remote":"127.0.0.1:52528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephfilesystemmirrors/\" range_end:\"/registry/ceph.rook.io/cephfilesystemmirrors0\" count_only:true "} {"level":"warn","ts":"2026-09-12T02:02:50.475639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:02:50.07056Z","time spent":"404.978606ms","remote":"127.0.0.1:51570","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-12T02:02:50.950831Z","caller":"traceutil/trace.go:171","msg":"trace[403643465] transaction","detail":"{read_only:false; response_revision:26635; number_of_response:1; }","duration":"570.808262ms","start":"2026-09-12T02:02:50.379993Z","end":"2026-09-12T02:02:50.950801Z","steps":["trace[403643465] 'process raft request' (duration: 481.323967ms)","trace[403643465] 'compare' (duration: 89.013725ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T02:02:50.950906Z","caller":"traceutil/trace.go:171","msg":"trace[1937412982] linearizableReadLoop","detail":"{readStateIndex:27513; appliedIndex:27512; }","duration":"475.480052ms","start":"2026-09-12T02:02:50.475398Z","end":"2026-09-12T02:02:50.950878Z","steps":["trace[1937412982] 'read index received' (duration: 385.944357ms)","trace[1937412982] 'applied index is now lower than readState.Index' (duration: 89.533315ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T02:02:50.950993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:02:50.379959Z","time spent":"570.938025ms","remote":"127.0.0.1:51570","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-12T02:02:50.951075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"552.141054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/routerinterfaces/\" range_end:\"/registry/openstack.k-orc.cloud/routerinterfaces0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-12T02:02:50.951118Z","caller":"traceutil/trace.go:171","msg":"trace[724388518] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/routerinterfaces/; range_end:/registry/openstack.k-orc.cloud/routerinterfaces0; response_count:0; response_revision:26637; }","duration":"552.261516ms","start":"2026-09-12T02:02:50.398845Z","end":"2026-09-12T02:02:50.951106Z","steps":["trace[724388518] 'agreement among raft nodes before linearized reading' (duration: 552.138584ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:02:50.95112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"641.395993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/vhosts/\" range_end:\"/registry/rabbitmq.com/vhosts0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-09-12T02:02:50.951151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:02:50.398822Z","time spent":"552.319357ms","remote":"127.0.0.1:60796","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/openstack.k-orc.cloud/routerinterfaces/\" range_end:\"/registry/openstack.k-orc.cloud/routerinterfaces0\" count_only:true "} {"level":"info","ts":"2026-09-12T02:02:50.951048Z","caller":"traceutil/trace.go:171","msg":"trace[1322587929] transaction","detail":"{read_only:false; response_revision:26636; number_of_response:1; }","duration":"409.297397ms","start":"2026-09-12T02:02:50.541719Z","end":"2026-09-12T02:02:50.951017Z","steps":["trace[1322587929] 'process raft request' (duration: 409.042002ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:02:50.951185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"826.674039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"warn","ts":"2026-09-12T02:02:50.951123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"592.864224ms","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-09-12T02:02:50.951235Z","caller":"traceutil/trace.go:171","msg":"trace[741136047] range","detail":"{range_begin:/registry/rabbitmq.com/vhosts/; range_end:/registry/rabbitmq.com/vhosts0; response_count:0; response_revision:26637; }","duration":"641.566588ms","start":"2026-09-12T02:02:50.309615Z","end":"2026-09-12T02:02:50.951181Z","steps":["trace[741136047] 'agreement among raft nodes before linearized reading' (duration: 641.426314ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:02:50.951246Z","caller":"traceutil/trace.go:171","msg":"trace[1794692093] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26637; }","duration":"826.7604ms","start":"2026-09-12T02:02:50.124476Z","end":"2026-09-12T02:02:50.951236Z","steps":["trace[1794692093] 'agreement among raft nodes before linearized reading' (duration: 826.607376ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:02:50.951263Z","caller":"traceutil/trace.go:171","msg":"trace[978387042] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:26637; }","duration":"593.015318ms","start":"2026-09-12T02:02:50.35823Z","end":"2026-09-12T02:02:50.951245Z","steps":["trace[978387042] 'agreement among raft nodes before linearized reading' (duration: 592.821903ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:02:50.951285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:02:50.124463Z","time spent":"826.814671ms","remote":"127.0.0.1:51570","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-09-12T02:02:50.951289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:02:50.309582Z","time spent":"641.695971ms","remote":"127.0.0.1:56518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/vhosts/\" range_end:\"/registry/rabbitmq.com/vhosts0\" count_only:true "} {"level":"warn","ts":"2026-09-12T02:02:50.951317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:02:50.358117Z","time spent":"593.177612ms","remote":"127.0.0.1:56570","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":30,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-09-12T02:02:50.95139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:02:50.541692Z","time spent":"409.575244ms","remote":"127.0.0.1:51570","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-12T02:02:51.136046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.148137ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-09-12T02:02:51.136281Z","caller":"traceutil/trace.go:171","msg":"trace[1810816880] linearizableReadLoop","detail":"{readStateIndex:27516; appliedIndex:27515; }","duration":"185.305566ms","start":"2026-09-12T02:02:50.950958Z","end":"2026-09-12T02:02:51.136263Z","steps":["trace[1810816880] 'read index received' (duration: 9.944153ms)","trace[1810816880] 'applied index is now lower than readState.Index' (duration: 175.360453ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T02:02:51.13642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"595.495752ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-09-12T02:02:51.136457Z","caller":"traceutil/trace.go:171","msg":"trace[1599022469] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26637; }","duration":"595.579873ms","start":"2026-09-12T02:02:50.540866Z","end":"2026-09-12T02:02:51.136445Z","steps":["trace[1599022469] 'agreement among raft nodes before linearized reading' (duration: 595.448861ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:02:51.136509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:02:50.540841Z","time spent":"595.659015ms","remote":"127.0.0.1:51570","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-09-12T02:02:51.136551Z","caller":"traceutil/trace.go:171","msg":"trace[120634283] transaction","detail":"{read_only:false; response_revision:26638; number_of_response:1; }","duration":"180.934762ms","start":"2026-09-12T02:02:50.955576Z","end":"2026-09-12T02:02:51.13651Z","steps":["trace[120634283] 'process raft request' (duration: 180.567644ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:02:51.279186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"737.97206ms","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-09-12T02:02:51.279294Z","caller":"traceutil/trace.go:171","msg":"trace[1263111898] 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:26638; }","duration":"738.134233ms","start":"2026-09-12T02:02:50.541137Z","end":"2026-09-12T02:02:51.279271Z","steps":["trace[1263111898] 'agreement among raft nodes before linearized reading' (duration: 595.354028ms)","trace[1263111898] 'range keys from in-memory index tree' (duration: 142.610892ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T02:02:51.279348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:02:50.541118Z","time spent":"738.214515ms","remote":"127.0.0.1:53098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":152,"response count":0,"response size":28,"request content":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" "} {"level":"warn","ts":"2026-09-12T02:02:51.279518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.816171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-09-12T02:02:51.279553Z","caller":"traceutil/trace.go:171","msg":"trace[1997275578] linearizableReadLoop","detail":"{readStateIndex:27518; appliedIndex:27517; }","duration":"104.969697ms","start":"2026-09-12T02:02:51.174552Z","end":"2026-09-12T02:02:51.279522Z","steps":["trace[1997275578] 'read index received' (duration: 91.815235ms)","trace[1997275578] 'applied index is now lower than readState.Index' (duration: 13.153102ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T02:02:51.279645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"634.372093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-09-12T02:02:51.279671Z","caller":"traceutil/trace.go:171","msg":"trace[2013094253] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:26638; }","duration":"634.477226ms","start":"2026-09-12T02:02:50.645185Z","end":"2026-09-12T02:02:51.279662Z","steps":["trace[2013094253] 'agreement among raft nodes before linearized reading' (duration: 491.247201ms)","trace[2013094253] 'count revisions from in-memory index tree' (duration: 143.188304ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T02:02:51.27971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:02:50.645159Z","time spent":"634.541637ms","remote":"127.0.0.1:51764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":20,"response size":30,"request content":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true "} {"level":"warn","ts":"2026-09-12T02:02:51.27976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"698.654449ms","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-09-12T02:02:51.279843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.770965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-12T02:02:51.279856Z","caller":"traceutil/trace.go:171","msg":"trace[666618327] transaction","detail":"{read_only:false; response_revision:26639; number_of_response:1; }","duration":"139.396613ms","start":"2026-09-12T02:02:51.14044Z","end":"2026-09-12T02:02:51.279837Z","steps":["trace[666618327] 'process raft request' (duration: 125.931925ms)","trace[666618327] 'compare' (duration: 12.694092ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T02:02:51.2799Z","caller":"traceutil/trace.go:171","msg":"trace[1702678443] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:26638; }","duration":"436.866667ms","start":"2026-09-12T02:02:50.843015Z","end":"2026-09-12T02:02:51.279882Z","steps":["trace[1702678443] 'agreement among raft nodes before linearized reading' (duration: 293.443759ms)","trace[1702678443] 'count revisions from in-memory index tree' (duration: 143.345407ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T02:02:51.279858Z","caller":"traceutil/trace.go:171","msg":"trace[1063385966] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26638; }","duration":"698.795862ms","start":"2026-09-12T02:02:50.581038Z","end":"2026-09-12T02:02:51.279834Z","steps":["trace[1063385966] 'agreement among raft nodes before linearized reading' (duration: 555.435645ms)","trace[1063385966] 'range keys from in-memory index tree' (duration: 143.088712ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T02:02:51.279945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:02:50.842995Z","time spent":"436.936068ms","remote":"127.0.0.1:51516","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":28,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"warn","ts":"2026-09-12T02:02:51.279958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:02:50.581017Z","time spent":"698.924635ms","remote":"127.0.0.1:51570","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-09-12T02:02:51.279591Z","caller":"traceutil/trace.go:171","msg":"trace[1487388272] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:26638; }","duration":"432.937624ms","start":"2026-09-12T02:02:50.846631Z","end":"2026-09-12T02:02:51.279568Z","steps":["trace[1487388272] 'agreement among raft nodes before linearized reading' (duration: 289.818992ms)","trace[1487388272] 'count revisions from in-memory index tree' (duration: 143.01623ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T02:02:51.280055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:02:50.846609Z","time spent":"433.432594ms","remote":"127.0.0.1:51804","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":6,"response size":30,"request content":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-09-12T02:02:51.280189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.61637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secrettemplates/\" range_end:\"/registry/secretgen.carvel.dev/secrettemplates0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-09-12T02:02:51.280304Z","caller":"traceutil/trace.go:171","msg":"trace[407170093] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secrettemplates/; range_end:/registry/secretgen.carvel.dev/secrettemplates0; response_count:0; response_revision:26639; }","duration":"105.782564ms","start":"2026-09-12T02:02:51.174497Z","end":"2026-09-12T02:02:51.28028Z","steps":["trace[407170093] 'agreement among raft nodes before linearized reading' (duration: 105.541989ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:02:51.484868Z","caller":"traceutil/trace.go:171","msg":"trace[102785016] linearizableReadLoop","detail":"{readStateIndex:27519; appliedIndex:27518; }","duration":"205.19573ms","start":"2026-09-12T02:02:51.279614Z","end":"2026-09-12T02:02:51.48481Z","steps":["trace[102785016] 'read index received' (duration: 144.406289ms)","trace[102785016] 'applied index is now lower than readState.Index' (duration: 60.787371ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T02:02:51.485032Z","caller":"traceutil/trace.go:171","msg":"trace[1605968586] transaction","detail":"{read_only:false; response_revision:26640; number_of_response:1; }","duration":"294.217465ms","start":"2026-09-12T02:02:51.190799Z","end":"2026-09-12T02:02:51.485016Z","steps":["trace[1605968586] 'process raft request' (duration: 233.22821ms)","trace[1605968586] 'compare' (duration: 60.308451ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T02:02:51.485256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.580284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-12T02:02:51.485347Z","caller":"traceutil/trace.go:171","msg":"trace[1237335823] range","detail":"{range_begin:/registry/rabbitmq.com/users/; range_end:/registry/rabbitmq.com/users0; response_count:0; response_revision:26640; }","duration":"237.753038ms","start":"2026-09-12T02:02:51.247571Z","end":"2026-09-12T02:02:51.485324Z","steps":["trace[1237335823] 'agreement among raft nodes before linearized reading' (duration: 237.573344ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:02:51.979889Z","caller":"traceutil/trace.go:171","msg":"trace[815953060] transaction","detail":"{read_only:false; response_revision:26643; number_of_response:1; }","duration":"263.496908ms","start":"2026-09-12T02:02:51.716364Z","end":"2026-09-12T02:02:51.979861Z","steps":["trace[815953060] 'process raft request' (duration: 263.436237ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:02:51.979949Z","caller":"traceutil/trace.go:171","msg":"trace[2081650609] transaction","detail":"{read_only:false; response_revision:26642; number_of_response:1; }","duration":"647.190827ms","start":"2026-09-12T02:02:51.332693Z","end":"2026-09-12T02:02:51.979884Z","steps":["trace[2081650609] 'process raft request' (duration: 646.738848ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:02:51.979976Z","caller":"traceutil/trace.go:171","msg":"trace[164179802] linearizableReadLoop","detail":"{readStateIndex:27521; appliedIndex:27519; }","duration":"494.984861ms","start":"2026-09-12T02:02:51.484959Z","end":"2026-09-12T02:02:51.979944Z","steps":["trace[164179802] 'read index received' (duration: 429.162802ms)","trace[164179802] 'applied index is now lower than readState.Index' (duration: 65.818779ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T02:02:51.980076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:02:51.332658Z","time spent":"647.33313ms","remote":"127.0.0.1:51570","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-12T02:02:51.980112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"689.055683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-09-12T02:02:51.980162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"693.148001ms","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-09-12T02:02:51.980229Z","caller":"traceutil/trace.go:171","msg":"trace[1661540292] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26643; }","duration":"689.177466ms","start":"2026-09-12T02:02:51.291005Z","end":"2026-09-12T02:02:51.980183Z","steps":["trace[1661540292] 'agreement among raft nodes before linearized reading' (duration: 689.011562ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:02:51.980289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:02:51.290997Z","time spent":"689.283408ms","remote":"127.0.0.1:51320","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-09-12T02:02:51.980289Z","caller":"traceutil/trace.go:171","msg":"trace[1576353310] range","detail":"{range_begin:/registry/services/specs/magnum-system/; range_end:/registry/services/specs/magnum-system0; response_count:0; response_revision:26643; }","duration":"693.310664ms","start":"2026-09-12T02:02:51.286953Z","end":"2026-09-12T02:02:51.980264Z","steps":["trace[1576353310] 'agreement among raft nodes before linearized reading' (duration: 693.11873ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:02:51.980347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:02:51.286943Z","time spent":"693.389296ms","remote":"127.0.0.1:51500","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" "} {"level":"info","ts":"2026-09-12T02:02:51.98064Z","caller":"traceutil/trace.go:171","msg":"trace[718823930] transaction","detail":"{read_only:false; response_revision:26641; number_of_response:1; }","duration":"695.876859ms","start":"2026-09-12T02:02:51.284727Z","end":"2026-09-12T02:02:51.980604Z","steps":["trace[718823930] 'process raft request' (duration: 629.380846ms)","trace[718823930] 'compare' (duration: 65.054101ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T02:02:51.980778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:02:51.284702Z","time spent":"695.999931ms","remote":"127.0.0.1:51570","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-12T02:02:52.227359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.844531ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-12T02:02:52.227473Z","caller":"traceutil/trace.go:171","msg":"trace[1617853770] linearizableReadLoop","detail":"{readStateIndex:27523; appliedIndex:27522; }","duration":"247.330302ms","start":"2026-09-12T02:02:51.980124Z","end":"2026-09-12T02:02:52.227455Z","steps":["trace[1617853770] 'read index received' (duration: 101.141815ms)","trace[1617853770] 'applied index is now lower than readState.Index' (duration: 146.186747ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T02:02:52.227622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.645523ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-12T02:02:52.227727Z","caller":"traceutil/trace.go:171","msg":"trace[1146585750] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26644; }","duration":"257.809576ms","start":"2026-09-12T02:02:51.969894Z","end":"2026-09-12T02:02:52.227704Z","steps":["trace[1146585750] 'agreement among raft nodes before linearized reading' (duration: 257.634233ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:02:52.227765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.116553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-09-12T02:02:52.227772Z","caller":"traceutil/trace.go:171","msg":"trace[1317464748] transaction","detail":"{read_only:false; response_revision:26644; number_of_response:1; }","duration":"300.275874ms","start":"2026-09-12T02:02:51.927469Z","end":"2026-09-12T02:02:52.227745Z","steps":["trace[1317464748] 'process raft request' (duration: 153.941694ms)","trace[1317464748] 'compare' (duration: 145.601805ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T02:02:52.227807Z","caller":"traceutil/trace.go:171","msg":"trace[937906551] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26644; }","duration":"302.202235ms","start":"2026-09-12T02:02:51.925594Z","end":"2026-09-12T02:02:52.227797Z","steps":["trace[937906551] 'agreement among raft nodes before linearized reading' (duration: 302.110033ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:02:52.227673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.260747ms","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-09-12T02:02:52.227838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:02:51.925567Z","time spent":"302.264827ms","remote":"127.0.0.1:51570","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-09-12T02:02:52.227806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.287134ms","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-09-12T02:02:52.227912Z","caller":"traceutil/trace.go:171","msg":"trace[1087011279] range","detail":"{range_begin:/registry/endpointslices/magnum-system/; range_end:/registry/endpointslices/magnum-system0; response_count:0; response_revision:26644; }","duration":"242.443247ms","start":"2026-09-12T02:02:51.985443Z","end":"2026-09-12T02:02:52.227886Z","steps":["trace[1087011279] 'agreement among raft nodes before linearized reading' (duration: 242.255823ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:02:52.227927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:02:51.927439Z","time spent":"300.389827ms","remote":"127.0.0.1:51570","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-12T02:02:52.227915Z","caller":"traceutil/trace.go:171","msg":"trace[337976642] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26644; }","duration":"281.533023ms","start":"2026-09-12T02:02:51.946342Z","end":"2026-09-12T02:02:52.227875Z","steps":["trace[337976642] 'agreement among raft nodes before linearized reading' (duration: 281.200676ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:02:52.685317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.859389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-09-12T02:02:52.685331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.957829ms","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-09-12T02:02:52.685403Z","caller":"traceutil/trace.go:171","msg":"trace[1166164420] range","detail":"{range_begin:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates/; range_end:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates0; response_count:0; response_revision:26646; }","duration":"216.028483ms","start":"2026-09-12T02:02:52.469354Z","end":"2026-09-12T02:02:52.685382Z","steps":["trace[1166164420] 'count revisions from in-memory index tree' (duration: 215.747476ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:02:52.685438Z","caller":"traceutil/trace.go:171","msg":"trace[707420149] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:26646; }","duration":"315.091262ms","start":"2026-09-12T02:02:52.370321Z","end":"2026-09-12T02:02:52.685412Z","steps":["trace[707420149] 'range keys from in-memory index tree' (duration: 314.834897ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:02:52.685486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:02:52.37024Z","time spent":"315.235405ms","remote":"127.0.0.1:51746","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":28,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"warn","ts":"2026-09-12T02:02:52.686188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.403512ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-12T02:02:52.686272Z","caller":"traceutil/trace.go:171","msg":"trace[1343232055] linearizableReadLoop","detail":"{readStateIndex:27526; appliedIndex:27525; }","duration":"192.792955ms","start":"2026-09-12T02:02:52.493467Z","end":"2026-09-12T02:02:52.68626Z","steps":["trace[1343232055] 'read index received' (duration: 54.292891ms)","trace[1343232055] 'applied index is now lower than readState.Index' (duration: 138.498784ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T02:02:52.686447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.97981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-09-12T02:02:52.686472Z","caller":"traceutil/trace.go:171","msg":"trace[1228545710] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:26647; }","duration":"193.069431ms","start":"2026-09-12T02:02:52.493394Z","end":"2026-09-12T02:02:52.686464Z","steps":["trace[1228545710] 'agreement among raft nodes before linearized reading' (duration: 192.898698ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:02:52.686566Z","caller":"traceutil/trace.go:171","msg":"trace[2114435307] transaction","detail":"{read_only:false; response_revision:26647; number_of_response:1; }","duration":"205.167049ms","start":"2026-09-12T02:02:52.481337Z","end":"2026-09-12T02:02:52.686504Z","steps":["trace[2114435307] 'process raft request' (duration: 66.348629ms)","trace[2114435307] 'compare' (duration: 137.569194ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T02:02:52.990104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.208602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-12T02:02:52.990231Z","caller":"traceutil/trace.go:171","msg":"trace[843905504] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:26647; }","duration":"185.367236ms","start":"2026-09-12T02:02:52.804815Z","end":"2026-09-12T02:02:52.990182Z","steps":["trace[843905504] 'count revisions from in-memory index tree' (duration: 185.117381ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:03:03.281417Z","caller":"traceutil/trace.go:171","msg":"trace[263239033] transaction","detail":"{read_only:false; response_revision:26727; number_of_response:1; }","duration":"115.259116ms","start":"2026-09-12T02:03:03.166114Z","end":"2026-09-12T02:03:03.281373Z","steps":["trace[263239033] 'process raft request' (duration: 114.990811ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:03:06.899606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"536.293295ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-12T02:03:06.899727Z","caller":"traceutil/trace.go:171","msg":"trace[1162229636] transaction","detail":"{read_only:false; response_revision:26751; number_of_response:1; }","duration":"544.898519ms","start":"2026-09-12T02:03:06.354798Z","end":"2026-09-12T02:03:06.899697Z","steps":["trace[1162229636] 'compare' (duration: 535.716512ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:03:06.89981Z","caller":"traceutil/trace.go:171","msg":"trace[646807738] transaction","detail":"{read_only:false; response_revision:26752; number_of_response:1; }","duration":"331.175367ms","start":"2026-09-12T02:03:06.568618Z","end":"2026-09-12T02:03:06.899793Z","steps":["trace[646807738] 'process raft request' (duration: 331.088295ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:03:06.899811Z","caller":"traceutil/trace.go:171","msg":"trace[2075058510] linearizableReadLoop","detail":"{readStateIndex:27634; appliedIndex:27633; }","duration":"393.163763ms","start":"2026-09-12T02:03:06.506585Z","end":"2026-09-12T02:03:06.899749Z","steps":["trace[2075058510] 'read index received' (duration: 29.571µs)","trace[2075058510] 'applied index is now lower than readState.Index' (duration: 393.126692ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T02:03:06.899884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:03:06.568595Z","time spent":"331.254918ms","remote":"127.0.0.1:51570","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-12T02:03:06.899887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:03:06.354777Z","time spent":"545.017632ms","remote":"127.0.0.1:51570","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-12T02:03:06.899996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.408608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1866"} {"level":"info","ts":"2026-09-12T02:03:06.900053Z","caller":"traceutil/trace.go:171","msg":"trace[910853729] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:26752; }","duration":"393.49892ms","start":"2026-09-12T02:03:06.506536Z","end":"2026-09-12T02:03:06.900035Z","steps":["trace[910853729] 'agreement among raft nodes before linearized reading' (duration: 393.324276ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:03:06.90009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:03:06.506518Z","time spent":"393.564291ms","remote":"127.0.0.1:51470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1888,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "} {"level":"info","ts":"2026-09-12T02:03:06.998199Z","caller":"traceutil/trace.go:171","msg":"trace[286784270] transaction","detail":"{read_only:false; response_revision:26753; number_of_response:1; }","duration":"250.632793ms","start":"2026-09-12T02:03:06.74754Z","end":"2026-09-12T02:03:06.998172Z","steps":["trace[286784270] 'process raft request' (duration: 250.327356ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:03:06.998248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.691642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/objectbucket.io/objectbuckets/\" range_end:\"/registry/objectbucket.io/objectbuckets0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-12T02:03:06.998339Z","caller":"traceutil/trace.go:171","msg":"trace[1590504700] range","detail":"{range_begin:/registry/objectbucket.io/objectbuckets/; range_end:/registry/objectbucket.io/objectbuckets0; response_count:0; response_revision:26753; }","duration":"234.865566ms","start":"2026-09-12T02:03:06.76345Z","end":"2026-09-12T02:03:06.998316Z","steps":["trace[1590504700] 'agreement among raft nodes before linearized reading' (duration: 234.666021ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:03:07.222227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.494611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-12T02:03:07.222434Z","caller":"traceutil/trace.go:171","msg":"trace[2112739626] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26753; }","duration":"222.768277ms","start":"2026-09-12T02:03:06.999639Z","end":"2026-09-12T02:03:07.222408Z","steps":["trace[2112739626] 'range keys from in-memory index tree' (duration: 222.399039ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:03:07.22258Z","caller":"traceutil/trace.go:171","msg":"trace[706544835] transaction","detail":"{read_only:false; response_revision:26754; number_of_response:1; }","duration":"163.753184ms","start":"2026-09-12T02:03:07.058799Z","end":"2026-09-12T02:03:07.222553Z","steps":["trace[706544835] 'process raft request' (duration: 152.398371ms)","trace[706544835] 'compare' (duration: 10.987566ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T02:03:07.222301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.690836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/openstack/\" range_end:\"/registry/resourcequotas/openstack0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-12T02:03:07.222798Z","caller":"traceutil/trace.go:171","msg":"trace[1865623526] range","detail":"{range_begin:/registry/resourcequotas/openstack/; range_end:/registry/resourcequotas/openstack0; response_count:0; response_revision:26753; }","duration":"216.213906ms","start":"2026-09-12T02:03:07.00655Z","end":"2026-09-12T02:03:07.222763Z","steps":["trace[1865623526] 'range keys from in-memory index tree' (duration: 215.615593ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:03:07.259895Z","caller":"traceutil/trace.go:171","msg":"trace[1852327787] transaction","detail":"{read_only:false; response_revision:26756; number_of_response:1; }","duration":"193.06686ms","start":"2026-09-12T02:03:07.066802Z","end":"2026-09-12T02:03:07.259869Z","steps":["trace[1852327787] 'process raft request' (duration: 192.981129ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:03:07.259972Z","caller":"traceutil/trace.go:171","msg":"trace[1803196689] transaction","detail":"{read_only:false; response_revision:26755; number_of_response:1; }","duration":"200.840116ms","start":"2026-09-12T02:03:07.059103Z","end":"2026-09-12T02:03:07.259943Z","steps":["trace[1803196689] 'process raft request' (duration: 200.404117ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:03:07.807124Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13360949273435471838,"retry-timeout":"500ms"} {"level":"info","ts":"2026-09-12T02:03:08.025916Z","caller":"traceutil/trace.go:171","msg":"trace[89695946] transaction","detail":"{read_only:false; response_revision:26757; number_of_response:1; }","duration":"801.09847ms","start":"2026-09-12T02:03:07.224792Z","end":"2026-09-12T02:03:08.02589Z","steps":["trace[89695946] 'process raft request' (duration: 800.959668ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:03:08.026106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:03:07.224766Z","time spent":"801.271024ms","remote":"127.0.0.1:56402","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1633,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-12T02:03:08.049629Z","caller":"traceutil/trace.go:171","msg":"trace[667124188] linearizableReadLoop","detail":"{readStateIndex:27641; appliedIndex:27640; }","duration":"743.254862ms","start":"2026-09-12T02:03:07.306343Z","end":"2026-09-12T02:03:08.049598Z","steps":["trace[667124188] 'read index received' (duration: 719.832552ms)","trace[667124188] 'applied index is now lower than readState.Index' (duration: 23.42108ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T02:03:08.049713Z","caller":"traceutil/trace.go:171","msg":"trace[2007832846] transaction","detail":"{read_only:false; response_revision:26758; number_of_response:1; }","duration":"512.432974ms","start":"2026-09-12T02:03:07.537245Z","end":"2026-09-12T02:03:08.049678Z","steps":["trace[2007832846] 'process raft request' (duration: 512.173139ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:03:08.04979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"743.416506ms","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-09-12T02:03:08.049835Z","caller":"traceutil/trace.go:171","msg":"trace[1782970276] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:26758; }","duration":"743.520968ms","start":"2026-09-12T02:03:07.3063Z","end":"2026-09-12T02:03:08.049821Z","steps":["trace[1782970276] 'agreement among raft nodes before linearized reading' (duration: 743.416616ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:03:08.049873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:03:07.306283Z","time spent":"743.579149ms","remote":"127.0.0.1:56546","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":30,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-09-12T02:03:08.049998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:03:07.537194Z","time spent":"512.667469ms","remote":"127.0.0.1:51570","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-12T02:03:08.674686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.435486ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-12T02:03:08.67478Z","caller":"traceutil/trace.go:171","msg":"trace[395666601] linearizableReadLoop","detail":"{readStateIndex:27642; appliedIndex:27641; }","duration":"625.075304ms","start":"2026-09-12T02:03:08.049689Z","end":"2026-09-12T02:03:08.674764Z","steps":["trace[395666601] 'read index received' (duration: 283.577227ms)","trace[395666601] 'applied index is now lower than readState.Index' (duration: 341.497017ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T02:03:08.674824Z","caller":"traceutil/trace.go:171","msg":"trace[528321985] transaction","detail":"{read_only:false; response_revision:26759; number_of_response:1; }","duration":"631.638725ms","start":"2026-09-12T02:03:08.04314Z","end":"2026-09-12T02:03:08.674778Z","steps":["trace[528321985] 'process raft request' (duration: 290.030775ms)","trace[528321985] 'compare' (duration: 341.069728ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T02:03:08.674907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.365908904s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"warn","ts":"2026-09-12T02:03:08.674907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"962.032443ms","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":"warn","ts":"2026-09-12T02:03:08.674915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"705.927144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-09-12T02:03:08.674947Z","caller":"traceutil/trace.go:171","msg":"trace[841917423] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26759; }","duration":"1.365989916s","start":"2026-09-12T02:03:07.308947Z","end":"2026-09-12T02:03:08.674936Z","steps":["trace[841917423] 'agreement among raft nodes before linearized reading' (duration: 1.365881264s)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:03:08.674973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:03:08.043121Z","time spent":"631.770887ms","remote":"127.0.0.1:51570","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-12T02:03:08.674958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.267582641s","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-09-12T02:03:08.674984Z","caller":"traceutil/trace.go:171","msg":"trace[1821832792] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26759; }","duration":"706.035296ms","start":"2026-09-12T02:03:07.968934Z","end":"2026-09-12T02:03:08.674969Z","steps":["trace[1821832792] 'agreement among raft nodes before linearized reading' (duration: 705.841262ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:03:08.675038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:03:07.968917Z","time spent":"706.111958ms","remote":"127.0.0.1:51492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12238,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-09-12T02:03:08.675038Z","caller":"traceutil/trace.go:171","msg":"trace[1318013921] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26759; }","duration":"1.267712344s","start":"2026-09-12T02:03:07.407307Z","end":"2026-09-12T02:03:08.67502Z","steps":["trace[1318013921] 'agreement among raft nodes before linearized reading' (duration: 1.267499239s)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:03:08.675056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"755.78472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-09-12T02:03:08.675028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"703.103313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-12T02:03:08.675088Z","caller":"traceutil/trace.go:171","msg":"trace[1201983627] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:26759; }","duration":"755.856451ms","start":"2026-09-12T02:03:07.919223Z","end":"2026-09-12T02:03:08.67508Z","steps":["trace[1201983627] 'agreement among raft nodes before linearized reading' (duration: 755.785699ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:03:08.675092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:03:07.407282Z","time spent":"1.267800515s","remote":"127.0.0.1:51570","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-09-12T02:03:08.675086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"639.36169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:1 size:1651"} {"level":"info","ts":"2026-09-12T02:03:08.675116Z","caller":"traceutil/trace.go:171","msg":"trace[1301290845] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26759; }","duration":"703.202865ms","start":"2026-09-12T02:03:07.971891Z","end":"2026-09-12T02:03:08.675094Z","steps":["trace[1301290845] 'agreement among raft nodes before linearized reading' (duration: 703.045942ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:03:08.675138Z","caller":"traceutil/trace.go:171","msg":"trace[1095970986] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:1; response_revision:26759; }","duration":"639.445841ms","start":"2026-09-12T02:03:08.035681Z","end":"2026-09-12T02:03:08.675127Z","steps":["trace[1095970986] 'agreement among raft nodes before linearized reading' (duration: 639.339939ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:03:08.67514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:03:07.919184Z","time spent":"755.945853ms","remote":"127.0.0.1:51720","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":30,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"warn","ts":"2026-09-12T02:03:08.675168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:03:08.035664Z","time spent":"639.495173ms","remote":"127.0.0.1:56402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":1,"response size":1673,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" "} {"level":"warn","ts":"2026-09-12T02:03:08.675166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:03:07.971859Z","time spent":"703.298168ms","remote":"127.0.0.1:51320","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-09-12T02:03:08.674986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:03:07.308913Z","time spent":"1.366064408s","remote":"127.0.0.1:51570","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-09-12T02:03:08.674983Z","caller":"traceutil/trace.go:171","msg":"trace[2140233891] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:26759; }","duration":"962.174686ms","start":"2026-09-12T02:03:07.712788Z","end":"2026-09-12T02:03:08.674963Z","steps":["trace[2140233891] 'agreement among raft nodes before linearized reading' (duration: 961.991983ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:03:08.675399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:03:07.712767Z","time spent":"962.610055ms","remote":"127.0.0.1:51622","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":22,"response size":30,"request content":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true "} {"level":"warn","ts":"2026-09-12T02:03:08.675469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"644.166612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:1 size:1651"} {"level":"info","ts":"2026-09-12T02:03:08.675571Z","caller":"traceutil/trace.go:171","msg":"trace[980434271] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:1; response_revision:26759; }","duration":"644.396598ms","start":"2026-09-12T02:03:08.031154Z","end":"2026-09-12T02:03:08.675551Z","steps":["trace[980434271] 'agreement among raft nodes before linearized reading' (duration: 643.687902ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:03:08.675646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:03:08.031137Z","time spent":"644.494709ms","remote":"127.0.0.1:56402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":1,"response size":1673,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" "} {"level":"warn","ts":"2026-09-12T02:03:09.189765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.669069ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-12T02:03:09.19011Z","caller":"traceutil/trace.go:171","msg":"trace[490498322] transaction","detail":"{read_only:false; response_revision:26760; number_of_response:1; }","duration":"1.131080331s","start":"2026-09-12T02:03:08.059006Z","end":"2026-09-12T02:03:09.190086Z","steps":["trace[490498322] 'process raft request' (duration: 804.029753ms)","trace[490498322] 'compare' (duration: 326.353893ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T02:03:09.190179Z","caller":"traceutil/trace.go:171","msg":"trace[221893531] transaction","detail":"{read_only:false; response_revision:26765; number_of_response:1; }","duration":"507.299664ms","start":"2026-09-12T02:03:08.682863Z","end":"2026-09-12T02:03:09.190162Z","steps":["trace[221893531] 'process raft request' (duration: 507.237832ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:03:09.190285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:03:08.682843Z","time spent":"507.399076ms","remote":"127.0.0.1:56402","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1946,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-12T02:03:09.190423Z","caller":"traceutil/trace.go:171","msg":"trace[1917536265] transaction","detail":"{read_only:false; response_revision:26763; number_of_response:1; }","duration":"509.384768ms","start":"2026-09-12T02:03:08.681007Z","end":"2026-09-12T02:03:09.190392Z","steps":["trace[1917536265] 'process raft request' (duration: 508.99657ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:03:09.190489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:03:08.68099Z","time spent":"509.457621ms","remote":"127.0.0.1:51570","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-12T02:03:09.19054Z","caller":"traceutil/trace.go:171","msg":"trace[622528028] transaction","detail":"{read_only:false; response_revision:26764; number_of_response:1; }","duration":"509.230044ms","start":"2026-09-12T02:03:08.681296Z","end":"2026-09-12T02:03:09.190526Z","steps":["trace[622528028] 'process raft request' (duration: 508.760204ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:03:09.190613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:03:08.681287Z","time spent":"509.285545ms","remote":"127.0.0.1:51570","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-12T02:03:09.19065Z","caller":"traceutil/trace.go:171","msg":"trace[2085492237] transaction","detail":"{read_only:false; response_revision:26761; number_of_response:1; }","duration":"908.017908ms","start":"2026-09-12T02:03:08.282622Z","end":"2026-09-12T02:03:09.190639Z","steps":["trace[2085492237] 'process raft request' (duration: 907.237181ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:03:09.190701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:03:08.282597Z","time spent":"908.076288ms","remote":"127.0.0.1:51570","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-12T02:03:09.190768Z","caller":"traceutil/trace.go:171","msg":"trace[454856766] transaction","detail":"{read_only:false; response_revision:26762; number_of_response:1; }","duration":"905.060454ms","start":"2026-09-12T02:03:08.2857Z","end":"2026-09-12T02:03:09.190761Z","steps":["trace[454856766] 'process raft request' (duration: 904.224457ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:03:09.190806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:03:08.285676Z","time spent":"905.108236ms","remote":"127.0.0.1:51570","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":628,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-12T02:03:09.190189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:03:08.058985Z","time spent":"1.131162092s","remote":"127.0.0.1:51570","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-12T02:03:09.190932Z","caller":"traceutil/trace.go:171","msg":"trace[1790750607] linearizableReadLoop","detail":"{readStateIndex:27645; appliedIndex:27642; }","duration":"516.117774ms","start":"2026-09-12T02:03:08.674803Z","end":"2026-09-12T02:03:09.190921Z","steps":["trace[1790750607] 'read index received' (duration: 188.194656ms)","trace[1790750607] 'applied index is now lower than readState.Index' (duration: 327.922068ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T02:03:09.191021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"757.467247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:1854"} {"level":"info","ts":"2026-09-12T02:03:09.191048Z","caller":"traceutil/trace.go:171","msg":"trace[1464039179] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26765; }","duration":"757.537679ms","start":"2026-09-12T02:03:08.433503Z","end":"2026-09-12T02:03:09.19104Z","steps":["trace[1464039179] 'agreement among raft nodes before linearized reading' (duration: 757.477228ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:03:09.191071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:03:08.433472Z","time spent":"757.5933ms","remote":"127.0.0.1:51470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":1,"response size":1876,"request content":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-09-12T02:03:09.191504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"825.214807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/\" range_end:\"/registry/deployments/openstack0\" ","response":"range_response_count:32 size:274763"} {"level":"info","ts":"2026-09-12T02:03:09.191533Z","caller":"traceutil/trace.go:171","msg":"trace[691407300] range","detail":"{range_begin:/registry/deployments/openstack/; range_end:/registry/deployments/openstack0; response_count:32; response_revision:26765; }","duration":"825.243927ms","start":"2026-09-12T02:03:08.366279Z","end":"2026-09-12T02:03:09.191523Z","steps":["trace[691407300] 'agreement among raft nodes before linearized reading' (duration: 824.91306ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:03:09.19156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:03:08.366246Z","time spent":"825.305919ms","remote":"127.0.0.1:51746","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":32,"response size":274785,"request content":"key:\"/registry/deployments/openstack/\" range_end:\"/registry/deployments/openstack0\" "} {"level":"warn","ts":"2026-09-12T02:03:09.191729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.118543602s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-09-12T02:03:09.191773Z","caller":"traceutil/trace.go:171","msg":"trace[721564939] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26765; }","duration":"1.118608543s","start":"2026-09-12T02:03:08.07315Z","end":"2026-09-12T02:03:09.191758Z","steps":["trace[721564939] 'agreement among raft nodes before linearized reading' (duration: 1.118485401s)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:03:09.191808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:03:08.07314Z","time spent":"1.118659554s","remote":"127.0.0.1:51570","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-09-12T02:03:09.192595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"844.872077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-09-12T02:03:09.192638Z","caller":"traceutil/trace.go:171","msg":"trace[1368757740] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26765; }","duration":"844.948028ms","start":"2026-09-12T02:03:08.347677Z","end":"2026-09-12T02:03:09.192625Z","steps":["trace[1368757740] 'agreement among raft nodes before linearized reading' (duration: 844.277003ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:03:09.192877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:03:08.347657Z","time spent":"845.204654ms","remote":"127.0.0.1:51570","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-09-12T02:03:09.544861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.038052ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-12T02:03:09.544968Z","caller":"traceutil/trace.go:171","msg":"trace[1889665326] transaction","detail":"{read_only:false; response_revision:26766; number_of_response:1; }","duration":"541.458005ms","start":"2026-09-12T02:03:09.00349Z","end":"2026-09-12T02:03:09.544948Z","steps":["trace[1889665326] 'process raft request' (duration: 397.244419ms)","trace[1889665326] 'compare' (duration: 143.888109ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T02:03:09.545057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:03:09.003465Z","time spent":"541.536266ms","remote":"127.0.0.1:51570","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-12T02:03:09.573685Z","caller":"traceutil/trace.go:171","msg":"trace[1833921627] transaction","detail":"{read_only:false; response_revision:26767; number_of_response:1; }","duration":"532.216167ms","start":"2026-09-12T02:03:09.041431Z","end":"2026-09-12T02:03:09.573647Z","steps":["trace[1833921627] 'process raft request' (duration: 531.92119ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:03:09.573749Z","caller":"traceutil/trace.go:171","msg":"trace[1197638964] transaction","detail":"{read_only:false; response_revision:26768; number_of_response:1; }","duration":"376.224949ms","start":"2026-09-12T02:03:09.197442Z","end":"2026-09-12T02:03:09.573666Z","steps":["trace[1197638964] 'process raft request' (duration: 376.061786ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:03:09.573769Z","caller":"traceutil/trace.go:171","msg":"trace[572761260] transaction","detail":"{read_only:false; response_revision:26772; number_of_response:1; }","duration":"309.445501ms","start":"2026-09-12T02:03:09.2643Z","end":"2026-09-12T02:03:09.573746Z","steps":["trace[572761260] 'process raft request' (duration: 309.380529ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:03:09.573779Z","caller":"traceutil/trace.go:171","msg":"trace[1291098685] transaction","detail":"{read_only:false; response_revision:26769; number_of_response:1; }","duration":"376.200908ms","start":"2026-09-12T02:03:09.197532Z","end":"2026-09-12T02:03:09.573732Z","steps":["trace[1291098685] 'process raft request' (duration: 376.016175ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:03:09.573862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:03:09.041406Z","time spent":"532.35975ms","remote":"127.0.0.1:51570","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-12T02:03:09.573895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:03:09.197417Z","time spent":"376.395063ms","remote":"127.0.0.1:51570","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-12T02:03:09.573913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:03:09.197506Z","time spent":"376.351572ms","remote":"127.0.0.1:51570","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-12T02:03:09.573918Z","caller":"traceutil/trace.go:171","msg":"trace[1677467267] linearizableReadLoop","detail":"{readStateIndex:27650; appliedIndex:27648; }","duration":"382.942223ms","start":"2026-09-12T02:03:09.19095Z","end":"2026-09-12T02:03:09.573893Z","steps":["trace[1677467267] 'read index received' (duration: 209.757607ms)","trace[1677467267] 'applied index is now lower than readState.Index' (duration: 173.183356ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T02:03:09.573966Z","caller":"traceutil/trace.go:171","msg":"trace[236842086] transaction","detail":"{read_only:false; response_revision:26771; number_of_response:1; }","duration":"346.484892ms","start":"2026-09-12T02:03:09.227474Z","end":"2026-09-12T02:03:09.573959Z","steps":["trace[236842086] 'process raft request' (duration: 346.175106ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:03:09.574039Z","caller":"traceutil/trace.go:171","msg":"trace[641937332] transaction","detail":"{read_only:false; response_revision:26773; number_of_response:1; }","duration":"307.913838ms","start":"2026-09-12T02:03:09.266056Z","end":"2026-09-12T02:03:09.57397Z","steps":["trace[641937332] 'process raft request' (duration: 307.659493ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:03:09.573936Z","caller":"traceutil/trace.go:171","msg":"trace[1725764083] transaction","detail":"{read_only:false; response_revision:26770; number_of_response:1; }","duration":"370.910575ms","start":"2026-09-12T02:03:09.203015Z","end":"2026-09-12T02:03:09.573925Z","steps":["trace[1725764083] 'process raft request' (duration: 370.570128ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:03:09.574091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:03:09.227461Z","time spent":"346.601034ms","remote":"127.0.0.1:51570","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-12T02:03:09.574124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:03:09.202995Z","time spent":"371.097439ms","remote":"127.0.0.1:56402","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2793,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-12T02:03:09.574146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:03:09.266037Z","time spent":"308.051181ms","remote":"127.0.0.1:51570","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":496,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-12T02:03:09.574178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"669.868992ms","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-09-12T02:03:09.574246Z","caller":"traceutil/trace.go:171","msg":"trace[850004745] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26773; }","duration":"669.992835ms","start":"2026-09-12T02:03:08.90424Z","end":"2026-09-12T02:03:09.574233Z","steps":["trace[850004745] 'agreement among raft nodes before linearized reading' (duration: 669.802831ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:03:09.574278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"893.866645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"warn","ts":"2026-09-12T02:03:09.574131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"896.987282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-09-12T02:03:09.573896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:03:09.264284Z","time spent":"309.544432ms","remote":"127.0.0.1:51570","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-12T02:03:09.574329Z","caller":"traceutil/trace.go:171","msg":"trace[1746217346] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26773; }","duration":"897.207686ms","start":"2026-09-12T02:03:08.677113Z","end":"2026-09-12T02:03:09.57432Z","steps":["trace[1746217346] 'agreement among raft nodes before linearized reading' (duration: 896.93825ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:03:09.574358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:03:08.677094Z","time spent":"897.256117ms","remote":"127.0.0.1:51318","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-09-12T02:03:09.574376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.960927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-e24cc578-bd37-442f-936b-dd86001e941d\" ","response":"range_response_count:1 size:1304"} {"level":"warn","ts":"2026-09-12T02:03:09.574282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:03:08.904216Z","time spent":"670.057796ms","remote":"127.0.0.1:51570","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-09-12T02:03:09.574437Z","caller":"traceutil/trace.go:171","msg":"trace[1721844581] range","detail":"{range_begin:/registry/persistentvolumes/pvc-e24cc578-bd37-442f-936b-dd86001e941d; range_end:; response_count:1; response_revision:26773; }","duration":"378.059589ms","start":"2026-09-12T02:03:09.196359Z","end":"2026-09-12T02:03:09.574419Z","steps":["trace[1721844581] 'agreement among raft nodes before linearized reading' (duration: 377.947467ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:03:09.574326Z","caller":"traceutil/trace.go:171","msg":"trace[515280492] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26773; }","duration":"893.930657ms","start":"2026-09-12T02:03:08.680383Z","end":"2026-09-12T02:03:09.574314Z","steps":["trace[515280492] 'agreement among raft nodes before linearized reading' (duration: 893.771003ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:03:09.574485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:03:09.196341Z","time spent":"378.13302ms","remote":"127.0.0.1:51456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":1326,"request content":"key:\"/registry/persistentvolumes/pvc-e24cc578-bd37-442f-936b-dd86001e941d\" "} {"level":"warn","ts":"2026-09-12T02:03:09.574498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:03:08.680365Z","time spent":"894.12125ms","remote":"127.0.0.1:51492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12238,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-09-12T02:03:09.992832Z","caller":"traceutil/trace.go:171","msg":"trace[266257632] transaction","detail":"{read_only:false; response_revision:26774; number_of_response:1; }","duration":"409.709655ms","start":"2026-09-12T02:03:09.583097Z","end":"2026-09-12T02:03:09.992806Z","steps":["trace[266257632] 'process raft request' (duration: 409.503411ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:03:09.99298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:03:09.58308Z","time spent":"409.821668ms","remote":"127.0.0.1:51570","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-12T02:03:10.023658Z","caller":"traceutil/trace.go:171","msg":"trace[788423610] linearizableReadLoop","detail":"{readStateIndex:27658; appliedIndex:27656; }","duration":"436.450538ms","start":"2026-09-12T02:03:09.587185Z","end":"2026-09-12T02:03:10.023636Z","steps":["trace[788423610] 'read index received' (duration: 405.414534ms)","trace[788423610] 'applied index is now lower than readState.Index' (duration: 31.034884ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T02:03:10.023979Z","caller":"traceutil/trace.go:171","msg":"trace[1357623668] transaction","detail":"{read_only:false; response_revision:26775; number_of_response:1; }","duration":"439.123475ms","start":"2026-09-12T02:03:09.584814Z","end":"2026-09-12T02:03:10.023937Z","steps":["trace[1357623668] 'process raft request' (duration: 438.728077ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:03:10.024133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:03:09.58479Z","time spent":"439.269179ms","remote":"127.0.0.1:51500","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1240,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-12T02:03:10.024127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.284448ms","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-09-12T02:03:10.024343Z","caller":"traceutil/trace.go:171","msg":"trace[2118497929] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:26775; }","duration":"374.545384ms","start":"2026-09-12T02:03:09.649781Z","end":"2026-09-12T02:03:10.024327Z","steps":["trace[2118497929] 'agreement among raft nodes before linearized reading' (duration: 374.237707ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:03:10.024536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.339807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-12T02:03:10.024587Z","caller":"traceutil/trace.go:171","msg":"trace[1285717272] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26775; }","duration":"437.418309ms","start":"2026-09-12T02:03:09.587156Z","end":"2026-09-12T02:03:10.024574Z","steps":["trace[1285717272] 'agreement among raft nodes before linearized reading' (duration: 437.324117ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:03:10.024613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:03:09.587143Z","time spent":"437.463749ms","remote":"127.0.0.1:51320","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-09-12T02:03:10.025077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:03:09.649765Z","time spent":"374.604645ms","remote":"127.0.0.1:51746","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":28,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"info","ts":"2026-09-12T02:03:11.656202Z","caller":"traceutil/trace.go:171","msg":"trace[79821997] transaction","detail":"{read_only:false; response_revision:26841; number_of_response:1; }","duration":"104.923096ms","start":"2026-09-12T02:03:11.551241Z","end":"2026-09-12T02:03:11.656165Z","steps":["trace[79821997] 'process raft request' (duration: 104.680449ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:03:17.942592Z","caller":"traceutil/trace.go:171","msg":"trace[1869963507] transaction","detail":"{read_only:false; response_revision:26914; number_of_response:1; }","duration":"170.405837ms","start":"2026-09-12T02:03:17.77216Z","end":"2026-09-12T02:03:17.942566Z","steps":["trace[1869963507] 'process raft request' (duration: 170.247503ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:03:18.184297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.571906ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-12T02:03:18.18449Z","caller":"traceutil/trace.go:171","msg":"trace[1787752124] linearizableReadLoop","detail":"{readStateIndex:27803; appliedIndex:27800; }","duration":"376.827983ms","start":"2026-09-12T02:03:17.807649Z","end":"2026-09-12T02:03:18.184477Z","steps":["trace[1787752124] 'read index received' (duration: 135.167563ms)","trace[1787752124] 'applied index is now lower than readState.Index' (duration: 241.65954ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T02:03:18.184545Z","caller":"traceutil/trace.go:171","msg":"trace[728997594] transaction","detail":"{read_only:false; response_revision:26915; number_of_response:1; }","duration":"385.164491ms","start":"2026-09-12T02:03:17.799372Z","end":"2026-09-12T02:03:18.184537Z","steps":["trace[728997594] 'process raft request' (duration: 252.286879ms)","trace[728997594] 'compare' (duration: 132.336541ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T02:03:18.184583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:03:17.799324Z","time spent":"385.238453ms","remote":"127.0.0.1:51570","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-12T02:03:18.1846Z","caller":"traceutil/trace.go:171","msg":"trace[168575045] transaction","detail":"{read_only:false; response_revision:26916; number_of_response:1; }","duration":"385.138291ms","start":"2026-09-12T02:03:17.799431Z","end":"2026-09-12T02:03:18.18457Z","steps":["trace[168575045] 'process raft request' (duration: 384.935677ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:03:18.184726Z","caller":"traceutil/trace.go:171","msg":"trace[1026004983] transaction","detail":"{read_only:false; response_revision:26917; number_of_response:1; }","duration":"384.67021ms","start":"2026-09-12T02:03:17.800049Z","end":"2026-09-12T02:03:18.184719Z","steps":["trace[1026004983] 'process raft request' (duration: 384.388844ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:03:18.184763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:03:17.800028Z","time spent":"384.717651ms","remote":"127.0.0.1:51570","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-12T02:03:18.184897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:03:17.799296Z","time spent":"385.371846ms","remote":"127.0.0.1:51570","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-12T02:03:18.185841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.172511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-09-12T02:03:18.185924Z","caller":"traceutil/trace.go:171","msg":"trace[977212030] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26917; }","duration":"378.303724ms","start":"2026-09-12T02:03:17.807601Z","end":"2026-09-12T02:03:18.185905Z","steps":["trace[977212030] 'agreement among raft nodes before linearized reading' (duration: 377.205081ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:03:18.185965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:03:17.807588Z","time spent":"378.367045ms","remote":"127.0.0.1:51570","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-09-12T02:03:18.202238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.917621ms","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-09-12T02:03:18.202293Z","caller":"traceutil/trace.go:171","msg":"trace[2132383451] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26918; }","duration":"389.034944ms","start":"2026-09-12T02:03:17.813243Z","end":"2026-09-12T02:03:18.202278Z","steps":["trace[2132383451] 'agreement among raft nodes before linearized reading' (duration: 388.86426ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:03:18.202322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:03:17.8132Z","time spent":"389.114706ms","remote":"127.0.0.1:51570","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-09-12T02:03:18.202432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.135899ms","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-09-12T02:03:18.202522Z","caller":"traceutil/trace.go:171","msg":"trace[1399974700] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26918; }","duration":"176.303402ms","start":"2026-09-12T02:03:18.026196Z","end":"2026-09-12T02:03:18.202499Z","steps":["trace[1399974700] 'agreement among raft nodes before linearized reading' (duration: 175.992366ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:03:18.531169Z","caller":"traceutil/trace.go:171","msg":"trace[663919310] transaction","detail":"{read_only:false; response_revision:26919; number_of_response:1; }","duration":"338.449381ms","start":"2026-09-12T02:03:18.19269Z","end":"2026-09-12T02:03:18.531139Z","steps":["trace[663919310] 'process raft request' (duration: 338.292408ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:03:18.531375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:03:18.192671Z","time spent":"338.615535ms","remote":"127.0.0.1:51570","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-12T02:03:18.533178Z","caller":"traceutil/trace.go:171","msg":"trace[999047762] transaction","detail":"{read_only:false; response_revision:26920; number_of_response:1; }","duration":"326.797462ms","start":"2026-09-12T02:03:18.206362Z","end":"2026-09-12T02:03:18.533159Z","steps":["trace[999047762] 'process raft request' (duration: 326.652919ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:03:18.53326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:03:18.206351Z","time spent":"326.875073ms","remote":"127.0.0.1:51570","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-12T02:03:18.53331Z","caller":"traceutil/trace.go:171","msg":"trace[1654808665] transaction","detail":"{read_only:false; response_revision:26921; number_of_response:1; }","duration":"325.138816ms","start":"2026-09-12T02:03:18.208145Z","end":"2026-09-12T02:03:18.533284Z","steps":["trace[1654808665] 'process raft request' (duration: 324.959463ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:03:18.533419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:03:18.208126Z","time spent":"325.234668ms","remote":"127.0.0.1:51570","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-12T02:03:18.533537Z","caller":"traceutil/trace.go:171","msg":"trace[661232097] linearizableReadLoop","detail":"{readStateIndex:27807; appliedIndex:27804; }","duration":"109.001802ms","start":"2026-09-12T02:03:18.424486Z","end":"2026-09-12T02:03:18.533487Z","steps":["trace[661232097] 'read index received' (duration: 106.468728ms)","trace[661232097] 'applied index is now lower than readState.Index' (duration: 2.531614ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T02:03:18.533676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.195146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0\" ","response":"range_response_count:1 size:1860"} {"level":"info","ts":"2026-09-12T02:03:18.533729Z","caller":"traceutil/trace.go:171","msg":"trace[1541377397] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:26921; }","duration":"109.303399ms","start":"2026-09-12T02:03:18.424415Z","end":"2026-09-12T02:03:18.533718Z","steps":["trace[1541377397] 'agreement among raft nodes before linearized reading' (duration: 109.165616ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:03:24.69707Z","caller":"traceutil/trace.go:171","msg":"trace[686575574] transaction","detail":"{read_only:false; response_revision:26966; number_of_response:1; }","duration":"138.042194ms","start":"2026-09-12T02:03:24.559006Z","end":"2026-09-12T02:03:24.697048Z","steps":["trace[686575574] 'process raft request' (duration: 137.894971ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:03:24.834687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.279576ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-12T02:03:24.834818Z","caller":"traceutil/trace.go:171","msg":"trace[1478885307] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:26966; }","duration":"101.44531ms","start":"2026-09-12T02:03:24.733354Z","end":"2026-09-12T02:03:24.834799Z","steps":["trace[1478885307] 'range keys from in-memory index tree' (duration: 101.258866ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:03:24.834913Z","caller":"traceutil/trace.go:171","msg":"trace[736937783] linearizableReadLoop","detail":"{readStateIndex:27856; appliedIndex:27853; }","duration":"124.068214ms","start":"2026-09-12T02:03:24.710827Z","end":"2026-09-12T02:03:24.834895Z","steps":["trace[736937783] 'read index received' (duration: 52.865251ms)","trace[736937783] 'applied index is now lower than readState.Index' (duration: 71.202193ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T02:03:24.834994Z","caller":"traceutil/trace.go:171","msg":"trace[169696451] transaction","detail":"{read_only:false; response_revision:26968; number_of_response:1; }","duration":"273.589194ms","start":"2026-09-12T02:03:24.561397Z","end":"2026-09-12T02:03:24.834987Z","steps":["trace[169696451] 'process raft request' (duration: 273.39849ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:03:24.835019Z","caller":"traceutil/trace.go:171","msg":"trace[1129714406] transaction","detail":"{read_only:false; response_revision:26967; number_of_response:1; }","duration":"275.365281ms","start":"2026-09-12T02:03:24.559628Z","end":"2026-09-12T02:03:24.834993Z","steps":["trace[1129714406] 'process raft request' (duration: 204.003333ms)","trace[1129714406] 'compare' (duration: 70.823906ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T02:03:24.835263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.425361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-12T02:03:24.835315Z","caller":"traceutil/trace.go:171","msg":"trace[1947944159] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:26969; }","duration":"124.517813ms","start":"2026-09-12T02:03:24.710783Z","end":"2026-09-12T02:03:24.8353Z","steps":["trace[1947944159] 'agreement among raft nodes before linearized reading' (duration: 124.38603ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:03:24.835079Z","caller":"traceutil/trace.go:171","msg":"trace[34208271] transaction","detail":"{read_only:false; response_revision:26969; number_of_response:1; }","duration":"242.257342ms","start":"2026-09-12T02:03:24.592805Z","end":"2026-09-12T02:03:24.835062Z","steps":["trace[34208271] 'process raft request' (duration: 242.058988ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:03:24.911308Z","caller":"traceutil/trace.go:171","msg":"trace[762642741] transaction","detail":"{read_only:false; response_revision:26970; number_of_response:1; }","duration":"183.013385ms","start":"2026-09-12T02:03:24.728269Z","end":"2026-09-12T02:03:24.911282Z","steps":["trace[762642741] 'process raft request' (duration: 182.830741ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:03:24.911581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.795733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephcosidrivers/\" range_end:\"/registry/ceph.rook.io/cephcosidrivers0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-12T02:03:24.911622Z","caller":"traceutil/trace.go:171","msg":"trace[1832445122] range","detail":"{range_begin:/registry/ceph.rook.io/cephcosidrivers/; range_end:/registry/ceph.rook.io/cephcosidrivers0; response_count:0; response_revision:26970; }","duration":"112.869874ms","start":"2026-09-12T02:03:24.798739Z","end":"2026-09-12T02:03:24.911609Z","steps":["trace[1832445122] 'agreement among raft nodes before linearized reading' (duration: 112.795723ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:03:28.965835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.146647ms","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-09-12T02:03:28.96595Z","caller":"traceutil/trace.go:171","msg":"trace[30590511] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:1; response_revision:27002; }","duration":"174.316571ms","start":"2026-09-12T02:03:28.791607Z","end":"2026-09-12T02:03:28.965923Z","steps":["trace[30590511] 'range keys from in-memory index tree' (duration: 173.949891ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:03:28.966498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.595199ms","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-09-12T02:03:28.96657Z","caller":"traceutil/trace.go:171","msg":"trace[2072746870] range","detail":"{range_begin:/registry/rabbitmq.com/bindings/; range_end:/registry/rabbitmq.com/bindings0; response_count:0; response_revision:27002; }","duration":"133.725622ms","start":"2026-09-12T02:03:28.832826Z","end":"2026-09-12T02:03:28.966551Z","steps":["trace[2072746870] 'count revisions from in-memory index tree' (duration: 133.505987ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:03:28.966822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.234523ms","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-09-12T02:03:28.966855Z","caller":"traceutil/trace.go:171","msg":"trace[1501728966] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:27002; }","duration":"121.293835ms","start":"2026-09-12T02:03:28.845552Z","end":"2026-09-12T02:03:28.966846Z","steps":["trace[1501728966] 'range keys from in-memory index tree' (duration: 121.07597ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:03:28.966968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.697828ms","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-09-12T02:03:28.967029Z","caller":"traceutil/trace.go:171","msg":"trace[1420379426] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:27002; }","duration":"117.772589ms","start":"2026-09-12T02:03:28.849238Z","end":"2026-09-12T02:03:28.967011Z","steps":["trace[1420379426] 'range keys from in-memory index tree' (duration: 117.590846ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:03:30.862546Z","caller":"traceutil/trace.go:171","msg":"trace[1744474178] transaction","detail":"{read_only:false; response_revision:27016; number_of_response:1; }","duration":"120.334285ms","start":"2026-09-12T02:03:30.742184Z","end":"2026-09-12T02:03:30.862518Z","steps":["trace[1744474178] 'process raft request' (duration: 120.178892ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:03:44.349905Z","caller":"traceutil/trace.go:171","msg":"trace[2044694070] transaction","detail":"{read_only:false; response_revision:27123; number_of_response:1; }","duration":"109.909332ms","start":"2026-09-12T02:03:44.239967Z","end":"2026-09-12T02:03:44.349877Z","steps":["trace[2044694070] 'process raft request' (duration: 84.686992ms)","trace[2044694070] 'compare' (duration: 24.878372ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T02:03:44.502817Z","caller":"traceutil/trace.go:171","msg":"trace[2119419948] transaction","detail":"{read_only:false; response_revision:27127; number_of_response:1; }","duration":"195.040954ms","start":"2026-09-12T02:03:44.307747Z","end":"2026-09-12T02:03:44.502788Z","steps":["trace[2119419948] 'process raft request' (duration: 194.797439ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:03:44.502845Z","caller":"traceutil/trace.go:171","msg":"trace[1371997266] transaction","detail":"{read_only:false; response_revision:27125; number_of_response:1; }","duration":"207.260154ms","start":"2026-09-12T02:03:44.295563Z","end":"2026-09-12T02:03:44.502823Z","steps":["trace[1371997266] 'process raft request' (duration: 206.877216ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:03:44.502989Z","caller":"traceutil/trace.go:171","msg":"trace[301798391] transaction","detail":"{read_only:false; response_revision:27124; number_of_response:1; }","duration":"207.661563ms","start":"2026-09-12T02:03:44.295317Z","end":"2026-09-12T02:03:44.502979Z","steps":["trace[301798391] 'process raft request' (duration: 206.945018ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:03:44.503053Z","caller":"traceutil/trace.go:171","msg":"trace[1801874232] transaction","detail":"{read_only:false; response_revision:27126; number_of_response:1; }","duration":"199.407546ms","start":"2026-09-12T02:03:44.303606Z","end":"2026-09-12T02:03:44.503013Z","steps":["trace[1801874232] 'process raft request' (duration: 198.890686ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:03:45.192052Z","caller":"traceutil/trace.go:171","msg":"trace[572375481] linearizableReadLoop","detail":"{readStateIndex:28020; appliedIndex:28019; }","duration":"127.210103ms","start":"2026-09-12T02:03:45.064821Z","end":"2026-09-12T02:03:45.192031Z","steps":["trace[572375481] 'read index received' (duration: 126.994058ms)","trace[572375481] 'applied index is now lower than readState.Index' (duration: 215.225µs)"],"step_count":2} {"level":"info","ts":"2026-09-12T02:03:45.192116Z","caller":"traceutil/trace.go:171","msg":"trace[1043394019] transaction","detail":"{read_only:false; response_revision:27129; number_of_response:1; }","duration":"139.909054ms","start":"2026-09-12T02:03:45.052179Z","end":"2026-09-12T02:03:45.192088Z","steps":["trace[1043394019] 'process raft request' (duration: 139.696589ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:03:45.192414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.57207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-09-12T02:03:45.192462Z","caller":"traceutil/trace.go:171","msg":"trace[1554584419] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:27129; }","duration":"127.663891ms","start":"2026-09-12T02:03:45.064785Z","end":"2026-09-12T02:03:45.192449Z","steps":["trace[1554584419] 'agreement among raft nodes before linearized reading' (duration: 127.364465ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:03:45.192441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.146029ms","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-09-12T02:03:45.192549Z","caller":"traceutil/trace.go:171","msg":"trace[65320997] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:27129; }","duration":"126.322353ms","start":"2026-09-12T02:03:45.066198Z","end":"2026-09-12T02:03:45.19252Z","steps":["trace[65320997] 'agreement among raft nodes before linearized reading' (duration: 126.042207ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:03:55.611665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.139151ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-12T02:03:55.611829Z","caller":"traceutil/trace.go:171","msg":"trace[1646324514] linearizableReadLoop","detail":"{readStateIndex:28098; appliedIndex:28096; }","duration":"237.154523ms","start":"2026-09-12T02:03:55.374663Z","end":"2026-09-12T02:03:55.611818Z","steps":["trace[1646324514] 'read index received' (duration: 86.802717ms)","trace[1646324514] 'applied index is now lower than readState.Index' (duration: 150.351036ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T02:03:55.611884Z","caller":"traceutil/trace.go:171","msg":"trace[230619997] transaction","detail":"{read_only:false; response_revision:27205; number_of_response:1; }","duration":"242.389706ms","start":"2026-09-12T02:03:55.369489Z","end":"2026-09-12T02:03:55.611878Z","steps":["trace[230619997] 'process raft request' (duration: 242.252473ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:03:55.611865Z","caller":"traceutil/trace.go:171","msg":"trace[1701411947] transaction","detail":"{read_only:false; response_revision:27204; number_of_response:1; }","duration":"242.434667ms","start":"2026-09-12T02:03:55.369397Z","end":"2026-09-12T02:03:55.611832Z","steps":["trace[1701411947] 'process raft request' (duration: 92.05497ms)","trace[1701411947] 'compare' (duration: 149.891566ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T02:03:55.611977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.309896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-12T02:03:55.611993Z","caller":"traceutil/trace.go:171","msg":"trace[22397710] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:27205; }","duration":"237.349558ms","start":"2026-09-12T02:03:55.374637Z","end":"2026-09-12T02:03:55.611986Z","steps":["trace[22397710] 'agreement among raft nodes before linearized reading' (duration: 237.313457ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:03:55.612146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.007558ms","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-09-12T02:03:55.612185Z","caller":"traceutil/trace.go:171","msg":"trace[1079576863] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:27205; }","duration":"178.09748ms","start":"2026-09-12T02:03:55.434077Z","end":"2026-09-12T02:03:55.612175Z","steps":["trace[1079576863] 'agreement among raft nodes before linearized reading' (duration: 177.936766ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:03:55.612185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.595953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:357"} {"level":"warn","ts":"2026-09-12T02:03:55.61226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.275086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-09-12T02:03:55.612375Z","caller":"traceutil/trace.go:171","msg":"trace[1824318441] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:27205; }","duration":"223.812577ms","start":"2026-09-12T02:03:55.388533Z","end":"2026-09-12T02:03:55.612345Z","steps":["trace[1824318441] 'agreement among raft nodes before linearized reading' (duration: 223.46475ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:03:55.612386Z","caller":"traceutil/trace.go:171","msg":"trace[690098271] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:27205; }","duration":"179.475721ms","start":"2026-09-12T02:03:55.432882Z","end":"2026-09-12T02:03:55.612357Z","steps":["trace[690098271] 'agreement among raft nodes before linearized reading' (duration: 179.137033ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:03:55.830534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.784483ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-12T02:03:55.830729Z","caller":"traceutil/trace.go:171","msg":"trace[972114624] linearizableReadLoop","detail":"{readStateIndex:28100; appliedIndex:28098; }","duration":"130.304097ms","start":"2026-09-12T02:03:55.700396Z","end":"2026-09-12T02:03:55.830701Z","steps":["trace[972114624] 'read index received' (duration: 17.27216ms)","trace[972114624] 'applied index is now lower than readState.Index' (duration: 113.031097ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T02:03:55.830794Z","caller":"traceutil/trace.go:171","msg":"trace[1604037850] transaction","detail":"{read_only:false; response_revision:27206; number_of_response:1; }","duration":"215.50319ms","start":"2026-09-12T02:03:55.615277Z","end":"2026-09-12T02:03:55.83078Z","steps":["trace[1604037850] 'process raft request' (duration: 102.38042ms)","trace[1604037850] 'compare' (duration: 112.518817ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T02:03:55.830938Z","caller":"traceutil/trace.go:171","msg":"trace[2138598075] transaction","detail":"{read_only:false; response_revision:27207; number_of_response:1; }","duration":"214.245355ms","start":"2026-09-12T02:03:55.616668Z","end":"2026-09-12T02:03:55.830913Z","steps":["trace[2138598075] 'process raft request' (duration: 213.967078ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:03:55.83114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.683846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-09-12T02:03:55.831207Z","caller":"traceutil/trace.go:171","msg":"trace[1500106081] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:27207; }","duration":"130.84975ms","start":"2026-09-12T02:03:55.700339Z","end":"2026-09-12T02:03:55.831189Z","steps":["trace[1500106081] 'agreement among raft nodes before linearized reading' (duration: 130.574254ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:03:56.13696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.628662ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-12T02:03:56.137113Z","caller":"traceutil/trace.go:171","msg":"trace[1652526566] linearizableReadLoop","detail":"{readStateIndex:28104; appliedIndex:28102; }","duration":"154.026876ms","start":"2026-09-12T02:03:55.983072Z","end":"2026-09-12T02:03:56.137099Z","steps":["trace[1652526566] 'read index received' (duration: 63.701µs)","trace[1652526566] 'applied index is now lower than readState.Index' (duration: 153.962345ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T02:03:56.137186Z","caller":"traceutil/trace.go:171","msg":"trace[710538580] transaction","detail":"{read_only:false; response_revision:27209; number_of_response:1; }","duration":"251.798147ms","start":"2026-09-12T02:03:55.88538Z","end":"2026-09-12T02:03:56.137178Z","steps":["trace[710538580] 'process raft request' (duration: 57.884859ms)","trace[710538580] 'compare' (duration: 193.473239ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T02:03:56.13739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.612513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-12T02:03:56.137417Z","caller":"traceutil/trace.go:171","msg":"trace[1370352663] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:27210; }","duration":"150.685644ms","start":"2026-09-12T02:03:55.986722Z","end":"2026-09-12T02:03:56.137408Z","steps":["trace[1370352663] 'agreement among raft nodes before linearized reading' (duration: 150.623133ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:03:56.137468Z","caller":"traceutil/trace.go:171","msg":"trace[1673047071] transaction","detail":"{read_only:false; response_revision:27210; number_of_response:1; }","duration":"214.48545ms","start":"2026-09-12T02:03:55.922948Z","end":"2026-09-12T02:03:56.137433Z","steps":["trace[1673047071] 'process raft request' (duration: 214.098372ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:03:56.137578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.459135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/certificates/\" range_end:\"/registry/secretgen.k14s.io/certificates0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-12T02:03:56.137688Z","caller":"traceutil/trace.go:171","msg":"trace[2129121889] range","detail":"{range_begin:/registry/secretgen.k14s.io/certificates/; range_end:/registry/secretgen.k14s.io/certificates0; response_count:0; response_revision:27210; }","duration":"154.654278ms","start":"2026-09-12T02:03:55.983006Z","end":"2026-09-12T02:03:56.137661Z","steps":["trace[2129121889] 'agreement among raft nodes before linearized reading' (duration: 154.325392ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:03:56.370836Z","caller":"traceutil/trace.go:171","msg":"trace[1777410108] linearizableReadLoop","detail":"{readStateIndex:28105; appliedIndex:28104; }","duration":"148.63214ms","start":"2026-09-12T02:03:56.222179Z","end":"2026-09-12T02:03:56.370811Z","steps":["trace[1777410108] 'read index received' (duration: 64.955239ms)","trace[1777410108] 'applied index is now lower than readState.Index' (duration: 83.675791ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T02:03:56.370966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.775484ms","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-09-12T02:03:56.370951Z","caller":"traceutil/trace.go:171","msg":"trace[994794809] transaction","detail":"{read_only:false; response_revision:27211; number_of_response:1; }","duration":"157.922979ms","start":"2026-09-12T02:03:56.212985Z","end":"2026-09-12T02:03:56.370908Z","steps":["trace[994794809] 'process raft request' (duration: 74.282709ms)","trace[994794809] 'compare' (duration: 81.76178ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T02:03:56.370996Z","caller":"traceutil/trace.go:171","msg":"trace[1122593301] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:27211; }","duration":"148.881166ms","start":"2026-09-12T02:03:56.222105Z","end":"2026-09-12T02:03:56.370986Z","steps":["trace[1122593301] 'agreement among raft nodes before linearized reading' (duration: 148.796864ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:03:56.693583Z","caller":"traceutil/trace.go:171","msg":"trace[1975058774] transaction","detail":"{read_only:false; response_revision:27212; number_of_response:1; }","duration":"144.92991ms","start":"2026-09-12T02:03:56.548629Z","end":"2026-09-12T02:03:56.693559Z","steps":["trace[1975058774] 'process raft request' (duration: 144.771487ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:03:56.695003Z","caller":"traceutil/trace.go:171","msg":"trace[1651846960] transaction","detail":"{read_only:false; response_revision:27214; number_of_response:1; }","duration":"145.561314ms","start":"2026-09-12T02:03:56.549419Z","end":"2026-09-12T02:03:56.69498Z","steps":["trace[1651846960] 'process raft request' (duration: 145.488102ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:03:56.695088Z","caller":"traceutil/trace.go:171","msg":"trace[182698149] transaction","detail":"{read_only:false; response_revision:27213; number_of_response:1; }","duration":"145.84666ms","start":"2026-09-12T02:03:56.549204Z","end":"2026-09-12T02:03:56.69505Z","steps":["trace[182698149] 'process raft request' (duration: 145.549024ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:03:56.695189Z","caller":"traceutil/trace.go:171","msg":"trace[22089096] transaction","detail":"{read_only:false; response_revision:27215; number_of_response:1; }","duration":"145.388741ms","start":"2026-09-12T02:03:56.54979Z","end":"2026-09-12T02:03:56.695179Z","steps":["trace[22089096] 'process raft request' (duration: 145.153486ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:04:02.238411Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":24343} {"level":"info","ts":"2026-09-12T02:04:02.410338Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":24343,"took":"167.80199ms","hash":498001280,"current-db-size-bytes":57581568,"current-db-size":"58 MB","current-db-size-in-use-bytes":36507648,"current-db-size-in-use":"36 MB"} {"level":"info","ts":"2026-09-12T02:04:02.410402Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":498001280,"revision":24343,"compact-revision":21504} {"level":"info","ts":"2026-09-12T02:04:06.25267Z","caller":"traceutil/trace.go:171","msg":"trace[618737124] transaction","detail":"{read_only:false; response_revision:27284; number_of_response:1; }","duration":"103.478364ms","start":"2026-09-12T02:04:06.149169Z","end":"2026-09-12T02:04:06.252648Z","steps":["trace[618737124] 'process raft request' (duration: 103.30859ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:04:06.66784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.845937ms","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-09-12T02:04:06.667933Z","caller":"traceutil/trace.go:171","msg":"trace[1592817805] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:27285; }","duration":"114.98603ms","start":"2026-09-12T02:04:06.552925Z","end":"2026-09-12T02:04:06.667911Z","steps":["trace[1592817805] 'range keys from in-memory index tree' (duration: 114.765505ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:04:07.006842Z","caller":"traceutil/trace.go:171","msg":"trace[2082263940] transaction","detail":"{read_only:false; response_revision:27287; number_of_response:1; }","duration":"184.17041ms","start":"2026-09-12T02:04:06.82264Z","end":"2026-09-12T02:04:07.006811Z","steps":["trace[2082263940] 'process raft request' (duration: 103.088765ms)","trace[2082263940] 'compare' (duration: 80.957063ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T02:04:07.357872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.656031ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-12T02:04:07.358186Z","caller":"traceutil/trace.go:171","msg":"trace[277131610] linearizableReadLoop","detail":"{readStateIndex:28186; appliedIndex:28184; }","duration":"246.379281ms","start":"2026-09-12T02:04:07.111784Z","end":"2026-09-12T02:04:07.358164Z","steps":["trace[277131610] 'read index received' (duration: 4.219001ms)","trace[277131610] 'applied index is now lower than readState.Index' (duration: 242.15618ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T02:04:07.358323Z","caller":"traceutil/trace.go:171","msg":"trace[1409113592] transaction","detail":"{read_only:false; response_revision:27289; number_of_response:1; }","duration":"534.007894ms","start":"2026-09-12T02:04:06.824297Z","end":"2026-09-12T02:04:07.358305Z","steps":["trace[1409113592] 'process raft request' (duration: 533.744639ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:04:07.358409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:04:06.82428Z","time spent":"534.076066ms","remote":"127.0.0.1:51570","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-12T02:04:07.358499Z","caller":"traceutil/trace.go:171","msg":"trace[1191619713] transaction","detail":"{read_only:false; response_revision:27288; number_of_response:1; }","duration":"535.13101ms","start":"2026-09-12T02:04:06.823335Z","end":"2026-09-12T02:04:07.358466Z","steps":["trace[1191619713] 'process raft request' (duration: 292.760935ms)","trace[1191619713] 'compare' (duration: 241.468426ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T02:04:07.358622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:04:06.823322Z","time spent":"535.231643ms","remote":"127.0.0.1:51570","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-12T02:04:07.358653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.848582ms","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-09-12T02:04:07.358781Z","caller":"traceutil/trace.go:171","msg":"trace[604381773] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:27289; }","duration":"247.024606ms","start":"2026-09-12T02:04:07.111733Z","end":"2026-09-12T02:04:07.358757Z","steps":["trace[604381773] 'agreement among raft nodes before linearized reading' (duration: 246.742549ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:04:07.373407Z","caller":"traceutil/trace.go:171","msg":"trace[2082318269] transaction","detail":"{read_only:false; response_revision:27290; number_of_response:1; }","duration":"105.573299ms","start":"2026-09-12T02:04:07.267795Z","end":"2026-09-12T02:04:07.373368Z","steps":["trace[2082318269] 'process raft request' (duration: 105.329604ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:04:07.524942Z","caller":"traceutil/trace.go:171","msg":"trace[1768998400] linearizableReadLoop","detail":"{readStateIndex:28190; appliedIndex:28187; }","duration":"135.037499ms","start":"2026-09-12T02:04:07.389882Z","end":"2026-09-12T02:04:07.52492Z","steps":["trace[1768998400] 'read index received' (duration: 111.010264ms)","trace[1768998400] 'applied index is now lower than readState.Index' (duration: 24.026145ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T02:04:07.525075Z","caller":"traceutil/trace.go:171","msg":"trace[585986840] transaction","detail":"{read_only:false; response_revision:27293; number_of_response:1; }","duration":"146.661568ms","start":"2026-09-12T02:04:07.378388Z","end":"2026-09-12T02:04:07.52505Z","steps":["trace[585986840] 'process raft request' (duration: 146.495584ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:04:07.525063Z","caller":"traceutil/trace.go:171","msg":"trace[1242361867] transaction","detail":"{read_only:false; response_revision:27291; number_of_response:1; }","duration":"160.551554ms","start":"2026-09-12T02:04:07.364445Z","end":"2026-09-12T02:04:07.524996Z","steps":["trace[1242361867] 'process raft request' (duration: 136.436248ms)","trace[1242361867] 'compare' (duration: 23.638606ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T02:04:07.525155Z","caller":"traceutil/trace.go:171","msg":"trace[136603602] transaction","detail":"{read_only:false; response_revision:27292; number_of_response:1; }","duration":"147.114668ms","start":"2026-09-12T02:04:07.378006Z","end":"2026-09-12T02:04:07.525121Z","steps":["trace[136603602] 'process raft request' (duration: 146.793511ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:04:07.525093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.188182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/groups/\" range_end:\"/registry/openstack.k-orc.cloud/groups0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-12T02:04:07.525323Z","caller":"traceutil/trace.go:171","msg":"trace[471163866] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/groups/; range_end:/registry/openstack.k-orc.cloud/groups0; response_count:0; response_revision:27293; }","duration":"135.459618ms","start":"2026-09-12T02:04:07.389846Z","end":"2026-09-12T02:04:07.525305Z","steps":["trace[471163866] 'agreement among raft nodes before linearized reading' (duration: 135.194992ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:04:07.87898Z","caller":"traceutil/trace.go:171","msg":"trace[617535024] transaction","detail":"{read_only:false; response_revision:27294; number_of_response:1; }","duration":"221.602901ms","start":"2026-09-12T02:04:07.657341Z","end":"2026-09-12T02:04:07.878943Z","steps":["trace[617535024] 'process raft request' (duration: 221.403167ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:04:07.894369Z","caller":"traceutil/trace.go:171","msg":"trace[491541127] transaction","detail":"{read_only:false; response_revision:27295; number_of_response:1; }","duration":"235.986859ms","start":"2026-09-12T02:04:07.658358Z","end":"2026-09-12T02:04:07.894344Z","steps":["trace[491541127] 'process raft request' (duration: 235.840736ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:04:08.059489Z","caller":"traceutil/trace.go:171","msg":"trace[1908261621] transaction","detail":"{read_only:false; response_revision:27297; number_of_response:1; }","duration":"147.753662ms","start":"2026-09-12T02:04:07.911708Z","end":"2026-09-12T02:04:08.059462Z","steps":["trace[1908261621] 'process raft request' (duration: 141.735893ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:04:08.059684Z","caller":"traceutil/trace.go:171","msg":"trace[431517964] transaction","detail":"{read_only:false; response_revision:27298; number_of_response:1; }","duration":"134.721602ms","start":"2026-09-12T02:04:07.924935Z","end":"2026-09-12T02:04:08.059657Z","steps":["trace[431517964] 'process raft request' (duration: 134.435166ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:04:30.208527Z","caller":"traceutil/trace.go:171","msg":"trace[651590991] transaction","detail":"{read_only:false; response_revision:27616; number_of_response:1; }","duration":"154.070533ms","start":"2026-09-12T02:04:30.054428Z","end":"2026-09-12T02:04:30.208498Z","steps":["trace[651590991] 'process raft request' (duration: 89.666818ms)","trace[651590991] 'compare' (duration: 63.744111ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T02:04:30.722907Z","caller":"traceutil/trace.go:171","msg":"trace[1310972510] transaction","detail":"{read_only:false; response_revision:27618; number_of_response:1; }","duration":"150.066496ms","start":"2026-09-12T02:04:30.572816Z","end":"2026-09-12T02:04:30.722883Z","steps":["trace[1310972510] 'process raft request' (duration: 149.902303ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:04:31.058173Z","caller":"traceutil/trace.go:171","msg":"trace[1436900125] transaction","detail":"{read_only:false; response_revision:27619; number_of_response:1; }","duration":"195.209247ms","start":"2026-09-12T02:04:30.862943Z","end":"2026-09-12T02:04:31.058152Z","steps":["trace[1436900125] 'process raft request' (duration: 194.771077ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:04:31.058173Z","caller":"traceutil/trace.go:171","msg":"trace[1774537588] linearizableReadLoop","detail":"{readStateIndex:28522; appliedIndex:28521; }","duration":"138.047699ms","start":"2026-09-12T02:04:30.920093Z","end":"2026-09-12T02:04:31.058141Z","steps":["trace[1774537588] 'read index received' (duration: 137.560377ms)","trace[1774537588] 'applied index is now lower than readState.Index' (duration: 485.652µs)"],"step_count":2} {"level":"warn","ts":"2026-09-12T02:04:31.058384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.260333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-12T02:04:31.058443Z","caller":"traceutil/trace.go:171","msg":"trace[699627313] range","detail":"{range_begin:/registry/ipam.cluster.x-k8s.io/ipaddressclaims/; range_end:/registry/ipam.cluster.x-k8s.io/ipaddressclaims0; response_count:0; response_revision:27619; }","duration":"138.381336ms","start":"2026-09-12T02:04:30.920044Z","end":"2026-09-12T02:04:31.058425Z","steps":["trace[699627313] 'agreement among raft nodes before linearized reading' (duration: 138.252763ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:04:31.207191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.136415ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-09-12T02:04:31.207332Z","caller":"traceutil/trace.go:171","msg":"trace[1640805939] linearizableReadLoop","detail":"{readStateIndex:28523; appliedIndex:28522; }","duration":"149.041464ms","start":"2026-09-12T02:04:31.058271Z","end":"2026-09-12T02:04:31.207313Z","steps":["trace[1640805939] 'read index received' (duration: 7.668374ms)","trace[1640805939] 'applied index is now lower than readState.Index' (duration: 141.37141ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T02:04:31.207461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.493306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-09-12T02:04:31.207513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.337146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/neutron-dhcp-agent-default-phnd7.18d46fb4f0fc96ce\" ","response":"range_response_count:1 size:1395"} {"level":"info","ts":"2026-09-12T02:04:31.207561Z","caller":"traceutil/trace.go:171","msg":"trace[450136043] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:27619; }","duration":"237.602908ms","start":"2026-09-12T02:04:30.969937Z","end":"2026-09-12T02:04:31.20754Z","steps":["trace[450136043] 'agreement among raft nodes before linearized reading' (duration: 237.444745ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:04:31.207572Z","caller":"traceutil/trace.go:171","msg":"trace[1074803155] range","detail":"{range_begin:/registry/events/openstack/neutron-dhcp-agent-default-phnd7.18d46fb4f0fc96ce; range_end:; response_count:1; response_revision:27619; }","duration":"279.442578ms","start":"2026-09-12T02:04:30.928107Z","end":"2026-09-12T02:04:31.20755Z","steps":["trace[1074803155] 'agreement among raft nodes before linearized reading' (duration: 279.256524ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:04:31.308945Z","caller":"traceutil/trace.go:171","msg":"trace[851026335] linearizableReadLoop","detail":"{readStateIndex:28524; appliedIndex:28523; }","duration":"100.547611ms","start":"2026-09-12T02:04:31.20837Z","end":"2026-09-12T02:04:31.308918Z","steps":["trace[851026335] 'read index received' (duration: 100.385308ms)","trace[851026335] 'applied index is now lower than readState.Index' (duration: 161.383µs)"],"step_count":2} {"level":"info","ts":"2026-09-12T02:04:31.308997Z","caller":"traceutil/trace.go:171","msg":"trace[676389420] transaction","detail":"{read_only:false; response_revision:27620; number_of_response:1; }","duration":"211.714683ms","start":"2026-09-12T02:04:31.097258Z","end":"2026-09-12T02:04:31.308973Z","steps":["trace[676389420] 'process raft request' (duration: 211.516288ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:04:31.309063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.680025ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-12T02:04:31.309094Z","caller":"traceutil/trace.go:171","msg":"trace[417574348] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:27620; }","duration":"100.743496ms","start":"2026-09-12T02:04:31.20834Z","end":"2026-09-12T02:04:31.309084Z","steps":["trace[417574348] 'agreement among raft nodes before linearized reading' (duration: 100.673764ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:04:31.519646Z","caller":"traceutil/trace.go:171","msg":"trace[357344798] transaction","detail":"{read_only:false; response_revision:27621; number_of_response:1; }","duration":"309.408352ms","start":"2026-09-12T02:04:31.210197Z","end":"2026-09-12T02:04:31.519605Z","steps":["trace[357344798] 'process raft request' (duration: 292.866156ms)","trace[357344798] 'compare' (duration: 16.097236ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T02:04:31.519776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.241554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-endpoints\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-12T02:04:31.519871Z","caller":"traceutil/trace.go:171","msg":"trace[1552327973] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-endpoints; range_end:; response_count:0; response_revision:27621; }","duration":"179.424828ms","start":"2026-09-12T02:04:31.340428Z","end":"2026-09-12T02:04:31.519852Z","steps":["trace[1552327973] 'agreement among raft nodes before linearized reading' (duration: 179.275995ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:04:31.519823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:04:31.210172Z","time spent":"309.552954ms","remote":"127.0.0.1:51372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1377,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-12T02:04:31.519373Z","caller":"traceutil/trace.go:171","msg":"trace[1741459894] linearizableReadLoop","detail":"{readStateIndex:28525; appliedIndex:28524; }","duration":"178.826645ms","start":"2026-09-12T02:04:31.340515Z","end":"2026-09-12T02:04:31.519341Z","steps":["trace[1741459894] 'read index received' (duration: 162.499074ms)","trace[1741459894] 'applied index is now lower than readState.Index' (duration: 16.325561ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T02:04:31.520409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.815077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-09-12T02:04:31.520462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.082687ms","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":"warn","ts":"2026-09-12T02:04:31.520491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.907865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-12T02:04:31.52049Z","caller":"traceutil/trace.go:171","msg":"trace[342787426] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-user; range_end:; response_count:0; response_revision:27624; }","duration":"179.928499ms","start":"2026-09-12T02:04:31.340544Z","end":"2026-09-12T02:04:31.520473Z","steps":["trace[342787426] 'agreement among raft nodes before linearized reading' (duration: 179.779996ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:04:31.520531Z","caller":"traceutil/trace.go:171","msg":"trace[766538993] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:27624; }","duration":"164.941666ms","start":"2026-09-12T02:04:31.355574Z","end":"2026-09-12T02:04:31.520516Z","steps":["trace[766538993] 'agreement among raft nodes before linearized reading' (duration: 164.895735ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:04:31.520576Z","caller":"traceutil/trace.go:171","msg":"trace[1301081302] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:27624; }","duration":"137.284582ms","start":"2026-09-12T02:04:31.383269Z","end":"2026-09-12T02:04:31.520553Z","steps":["trace[1301081302] 'agreement among raft nodes before linearized reading' (duration: 137.059457ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T02:04:31.520643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.950199ms","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-09-12T02:04:31.520446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.632303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-db-sync\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-12T02:04:31.5207Z","caller":"traceutil/trace.go:171","msg":"trace[2113094430] range","detail":"{range_begin:/registry/jobs/openstack/manila-rabbit-init; range_end:; response_count:0; response_revision:27624; }","duration":"180.054811ms","start":"2026-09-12T02:04:31.340629Z","end":"2026-09-12T02:04:31.520684Z","steps":["trace[2113094430] 'agreement among raft nodes before linearized reading' (duration: 179.947899ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:04:31.520711Z","caller":"traceutil/trace.go:171","msg":"trace[1826138741] range","detail":"{range_begin:/registry/jobs/openstack/manila-db-sync; range_end:; response_count:0; response_revision:27624; }","duration":"179.913589ms","start":"2026-09-12T02:04:31.340787Z","end":"2026-09-12T02:04:31.5207Z","steps":["trace[1826138741] 'agreement among raft nodes before linearized reading' (duration: 179.634503ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T02:07:04.542852Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"612d5169b08bb96b","local-member-applied-index":30014,"local-member-snapshot-index":20013,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-09-12T02:07:04.550128Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30014} {"level":"info","ts":"2026-09-12T02:07:04.55024Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25014} {"level":"info","ts":"2026-09-12T02:09:02.250558Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":27254} {"level":"info","ts":"2026-09-12T02:09:02.388366Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":27254,"took":"134.053502ms","hash":3635576417,"current-db-size-bytes":57581568,"current-db-size":"58 MB","current-db-size-in-use-bytes":37539840,"current-db-size-in-use":"38 MB"} {"level":"info","ts":"2026-09-12T02:09:02.388439Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3635576417,"revision":27254,"compact-revision":24343} {"level":"info","ts":"2026-09-12T02:14:02.258007Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30168} {"level":"info","ts":"2026-09-12T02:14:02.410962Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30168,"took":"149.745216ms","hash":2349322700,"current-db-size-bytes":57581568,"current-db-size":"58 MB","current-db-size-in-use-bytes":30826496,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-09-12T02:14:02.411033Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2349322700,"revision":30168,"compact-revision":27254} {"level":"info","ts":"2026-09-12T02:19:02.269183Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32428} {"level":"info","ts":"2026-09-12T02:19:02.427323Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32428,"took":"153.861145ms","hash":1175431694,"current-db-size-bytes":58626048,"current-db-size":"59 MB","current-db-size-in-use-bytes":30285824,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-09-12T02:19:02.427412Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1175431694,"revision":32428,"compact-revision":30168} {"level":"info","ts":"2026-09-12T02:24:02.28046Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":34651} {"level":"info","ts":"2026-09-12T02:24:02.428939Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":34651,"took":"144.475285ms","hash":2928705970,"current-db-size-bytes":58626048,"current-db-size":"59 MB","current-db-size-in-use-bytes":30609408,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-09-12T02:24:02.429014Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2928705970,"revision":34651,"compact-revision":32428} {"level":"info","ts":"2026-09-12T02:28:04.678952Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"612d5169b08bb96b","local-member-applied-index":40015,"local-member-snapshot-index":30014,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-09-12T02:28:04.684846Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40015} {"level":"info","ts":"2026-09-12T02:28:04.684972Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35015} {"level":"info","ts":"2026-09-12T02:29:02.287722Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":36921} {"level":"info","ts":"2026-09-12T02:29:02.42296Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":36921,"took":"131.144099ms","hash":3775803714,"current-db-size-bytes":58626048,"current-db-size":"59 MB","current-db-size-in-use-bytes":31358976,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-09-12T02:29:02.423036Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3775803714,"revision":36921,"compact-revision":34651}