{"level":"warn","ts":"2026-04-18T22:16:47.29043Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-18T22:16:47.290566Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.242:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.242:2380","--initial-cluster=instance=https://199.204.45.242:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.242:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.242: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-04-18T22:16:47.290651Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-18T22:16:47.290683Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.242:2380"]} {"level":"info","ts":"2026-04-18T22:16:47.290716Z","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-04-18T22:16:47.291387Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.242:2379"]} {"level":"info","ts":"2026-04-18T22:16:47.291511Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.242:2380"],"listen-peer-urls":["https://199.204.45.242:2380"],"advertise-client-urls":["https://199.204.45.242:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.242:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.242: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-04-18T22:16:47.294851Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.111441ms"} {"level":"info","ts":"2026-04-18T22:16:47.304676Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b844c110b9783e73","cluster-id":"49dc9693ccd466a9"} {"level":"info","ts":"2026-04-18T22:16:47.304833Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 switched to configuration voters=()"} {"level":"info","ts":"2026-04-18T22:16:47.304886Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became follower at term 0"} {"level":"info","ts":"2026-04-18T22:16:47.304916Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b844c110b9783e73 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-18T22:16:47.304949Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became follower at term 1"} {"level":"info","ts":"2026-04-18T22:16:47.305006Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 switched to configuration voters=(13277949878970367603)"} {"level":"warn","ts":"2026-04-18T22:16:47.310372Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-18T22:16:47.311998Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-18T22:16:47.314474Z","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-04-18T22:16:47.31707Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b844c110b9783e73","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-18T22:16:47.317353Z","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-04-18T22:16:47.317426Z","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-04-18T22:16:47.31744Z","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-04-18T22:16:47.317538Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b844c110b9783e73","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-18T22:16:47.317935Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 switched to configuration voters=(13277949878970367603)"} {"level":"info","ts":"2026-04-18T22:16:47.318024Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"49dc9693ccd466a9","local-member-id":"b844c110b9783e73","added-peer-id":"b844c110b9783e73","added-peer-peer-urls":["https://199.204.45.242:2380"]} {"level":"info","ts":"2026-04-18T22:16:47.322572Z","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-04-18T22:16:47.322722Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.242:2380"} {"level":"info","ts":"2026-04-18T22:16:47.322902Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.242:2380"} {"level":"info","ts":"2026-04-18T22:16:47.32295Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b844c110b9783e73","initial-advertise-peer-urls":["https://199.204.45.242:2380"],"listen-peer-urls":["https://199.204.45.242:2380"],"advertise-client-urls":["https://199.204.45.242:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.242:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-18T22:16:47.322993Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-18T22:16:48.005448Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 is starting a new election at term 1"} {"level":"info","ts":"2026-04-18T22:16:48.005507Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-18T22:16:48.005549Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 received MsgPreVoteResp from b844c110b9783e73 at term 1"} {"level":"info","ts":"2026-04-18T22:16:48.005568Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became candidate at term 2"} {"level":"info","ts":"2026-04-18T22:16:48.005585Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 received MsgVoteResp from b844c110b9783e73 at term 2"} {"level":"info","ts":"2026-04-18T22:16:48.0056Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became leader at term 2"} {"level":"info","ts":"2026-04-18T22:16:48.005617Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b844c110b9783e73 elected leader b844c110b9783e73 at term 2"} {"level":"info","ts":"2026-04-18T22:16:48.006698Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b844c110b9783e73","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.242:2379]}","request-path":"/0/members/b844c110b9783e73/attributes","cluster-id":"49dc9693ccd466a9","publish-timeout":"7s"} {"level":"info","ts":"2026-04-18T22:16:48.006752Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-18T22:16:48.006862Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-18T22:16:48.006794Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-18T22:16:48.007061Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-18T22:16:48.007148Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-18T22:16:48.007435Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"49dc9693ccd466a9","local-member-id":"b844c110b9783e73","cluster-version":"3.5"} {"level":"info","ts":"2026-04-18T22:16:48.007509Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-18T22:16:48.007527Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-18T22:16:48.009592Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-18T22:16:48.011434Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.242:2379"} {"level":"info","ts":"2026-04-18T22:17:01.269996Z","caller":"traceutil/trace.go:171","msg":"trace[875145142] linearizableReadLoop","detail":"{readStateIndex:375; appliedIndex:374; }","duration":"146.906976ms","start":"2026-04-18T22:17:01.123054Z","end":"2026-04-18T22:17:01.269961Z","steps":["trace[875145142] 'read index received' (duration: 146.560916ms)","trace[875145142] 'applied index is now lower than readState.Index' (duration: 344.27µs)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:17:01.270074Z","caller":"traceutil/trace.go:171","msg":"trace[813076721] transaction","detail":"{read_only:false; response_revision:363; number_of_response:1; }","duration":"363.101657ms","start":"2026-04-18T22:17:00.906931Z","end":"2026-04-18T22:17:01.270033Z","steps":["trace[813076721] 'process raft request' (duration: 362.794768ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:01.270193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.114393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.242\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-18T22:17:01.270303Z","caller":"traceutil/trace.go:171","msg":"trace[1569733181] range","detail":"{range_begin:/registry/masterleases/199.204.45.242; range_end:; response_count:1; response_revision:363; }","duration":"147.288418ms","start":"2026-04-18T22:17:01.122999Z","end":"2026-04-18T22:17:01.270288Z","steps":["trace[1569733181] 'agreement among raft nodes before linearized reading' (duration: 147.108382ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:01.270742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:00.906901Z","time spent":"363.253612ms","remote":"127.0.0.1:33718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5149,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:17:25.701599Z","caller":"traceutil/trace.go:171","msg":"trace[1835168532] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"322.503419ms","start":"2026-04-18T22:17:25.379058Z","end":"2026-04-18T22:17:25.701562Z","steps":["trace[1835168532] 'process raft request' (duration: 320.824979ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:25.701806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:25.379027Z","time spent":"322.674704ms","remote":"127.0.0.1:33630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036281,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:17:25.866466Z","caller":"traceutil/trace.go:171","msg":"trace[1137666056] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"103.398372ms","start":"2026-04-18T22:17:25.763029Z","end":"2026-04-18T22:17:25.866427Z","steps":["trace[1137666056] 'process raft request' (duration: 102.99966ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:26.253193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.951349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-8hphn\" ","response":"range_response_count:1 size:16965"} {"level":"warn","ts":"2026-04-18T22:17:26.253217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.738917ms","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-04-18T22:17:26.253293Z","caller":"traceutil/trace.go:171","msg":"trace[44314080] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:584; }","duration":"277.863911ms","start":"2026-04-18T22:17:25.975411Z","end":"2026-04-18T22:17:26.253275Z","steps":["trace[44314080] 'range keys from in-memory index tree' (duration: 277.568662ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:17:26.253285Z","caller":"traceutil/trace.go:171","msg":"trace[1690054012] range","detail":"{range_begin:/registry/pods/kube-system/cilium-8hphn; range_end:; response_count:1; response_revision:584; }","duration":"307.094074ms","start":"2026-04-18T22:17:25.94617Z","end":"2026-04-18T22:17:26.253264Z","steps":["trace[1690054012] 'range keys from in-memory index tree' (duration: 306.758584ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:26.253361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:25.946147Z","time spent":"307.206517ms","remote":"127.0.0.1:33718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-8hphn\" "} {"level":"info","ts":"2026-04-18T22:17:26.823664Z","caller":"traceutil/trace.go:171","msg":"trace[1591984881] linearizableReadLoop","detail":"{readStateIndex:610; appliedIndex:609; }","duration":"352.972748ms","start":"2026-04-18T22:17:26.470662Z","end":"2026-04-18T22:17:26.823634Z","steps":["trace[1591984881] 'read index received' (duration: 352.730521ms)","trace[1591984881] 'applied index is now lower than readState.Index' (duration: 240.837µs)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:17:26.823714Z","caller":"traceutil/trace.go:171","msg":"trace[2066795554] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"364.58717ms","start":"2026-04-18T22:17:26.459103Z","end":"2026-04-18T22:17:26.823691Z","steps":["trace[2066795554] 'process raft request' (duration: 364.327303ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:26.823862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:26.459074Z","time spent":"364.710674ms","remote":"127.0.0.1:33766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-18T22:17:26.82399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.311387ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-18T22:17:26.824052Z","caller":"traceutil/trace.go:171","msg":"trace[1357721405] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:588; }","duration":"353.423111ms","start":"2026-04-18T22:17:26.470613Z","end":"2026-04-18T22:17:26.824036Z","steps":["trace[1357721405] 'agreement among raft nodes before linearized reading' (duration: 353.187274ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:26.824093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:26.47059Z","time spent":"353.491953ms","remote":"127.0.0.1:33796","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-18T22:17:26.824369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.9805ms","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-04-18T22:17:26.824464Z","caller":"traceutil/trace.go:171","msg":"trace[1611544640] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:588; }","duration":"306.459744ms","start":"2026-04-18T22:17:26.51798Z","end":"2026-04-18T22:17:26.82444Z","steps":["trace[1611544640] 'agreement among raft nodes before linearized reading' (duration: 305.863967ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:26.8245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:26.517955Z","time spent":"306.535397ms","remote":"127.0.0.1:33796","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-18T22:17:27.269015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.475911ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T22:17:27.269124Z","caller":"traceutil/trace.go:171","msg":"trace[897267199] linearizableReadLoop","detail":"{readStateIndex:612; appliedIndex:611; }","duration":"437.609706ms","start":"2026-04-18T22:17:26.831497Z","end":"2026-04-18T22:17:27.269107Z","steps":["trace[897267199] 'read index received' (duration: 46.286316ms)","trace[897267199] 'applied index is now lower than readState.Index' (duration: 391.32235ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:17:27.26917Z","caller":"traceutil/trace.go:171","msg":"trace[1184306325] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"440.278485ms","start":"2026-04-18T22:17:26.828859Z","end":"2026-04-18T22:17:27.269137Z","steps":["trace[1184306325] 'process raft request' (duration: 329.458914ms)","trace[1184306325] 'compare' (duration: 110.341426ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:17:27.269243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.453975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:17:27.269306Z","caller":"traceutil/trace.go:171","msg":"trace[1830368893] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:590; }","duration":"429.532758ms","start":"2026-04-18T22:17:26.839752Z","end":"2026-04-18T22:17:27.269284Z","steps":["trace[1830368893] 'agreement among raft nodes before linearized reading' (duration: 429.452655ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:27.269315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.165188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T22:17:27.269432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.645931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:17:27.269471Z","caller":"traceutil/trace.go:171","msg":"trace[349699073] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:590; }","duration":"346.683822ms","start":"2026-04-18T22:17:26.922777Z","end":"2026-04-18T22:17:27.269461Z","steps":["trace[349699073] 'agreement among raft nodes before linearized reading' (duration: 346.62382ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:27.269505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:26.922747Z","time spent":"346.749814ms","remote":"127.0.0.1:44514","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 "} {"level":"warn","ts":"2026-04-18T22:17:27.269506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:26.82881Z","time spent":"440.429659ms","remote":"127.0.0.1:33796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:17:27.26953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.121852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T22:17:27.269541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.979066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"warn","ts":"2026-04-18T22:17:27.269643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.239015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:17:27.269633Z","caller":"traceutil/trace.go:171","msg":"trace[1642974006] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:590; }","duration":"438.167453ms","start":"2026-04-18T22:17:26.831454Z","end":"2026-04-18T22:17:27.269621Z","steps":["trace[1642974006] 'agreement among raft nodes before linearized reading' (duration: 437.696219ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:27.269685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.496708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:17:27.269686Z","caller":"traceutil/trace.go:171","msg":"trace[240933300] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:590; }","duration":"374.318097ms","start":"2026-04-18T22:17:26.895358Z","end":"2026-04-18T22:17:27.269676Z","steps":["trace[240933300] 'agreement among raft nodes before linearized reading' (duration: 374.260596ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:17:27.269728Z","caller":"traceutil/trace.go:171","msg":"trace[1851638951] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:590; }","duration":"219.5681ms","start":"2026-04-18T22:17:27.050146Z","end":"2026-04-18T22:17:27.269714Z","steps":["trace[1851638951] 'agreement among raft nodes before linearized reading' (duration: 219.509159ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:27.269736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.613602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:17:27.269432Z","caller":"traceutil/trace.go:171","msg":"trace[1561173362] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:590; }","duration":"219.335254ms","start":"2026-04-18T22:17:27.050075Z","end":"2026-04-18T22:17:27.26941Z","steps":["trace[1561173362] 'agreement among raft nodes before linearized reading' (duration: 219.148168ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:27.269728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.391763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:17:27.269814Z","caller":"traceutil/trace.go:171","msg":"trace[1635522424] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:590; }","duration":"404.678184ms","start":"2026-04-18T22:17:26.865087Z","end":"2026-04-18T22:17:27.269765Z","steps":["trace[1635522424] 'agreement among raft nodes before linearized reading' (duration: 404.627212ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:27.269828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.997941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:17:27.269862Z","caller":"traceutil/trace.go:171","msg":"trace[1743800434] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:590; }","duration":"430.089664ms","start":"2026-04-18T22:17:26.839762Z","end":"2026-04-18T22:17:27.269852Z","steps":["trace[1743800434] 'agreement among raft nodes before linearized reading' (duration: 430.000831ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:17:27.269866Z","caller":"traceutil/trace.go:171","msg":"trace[1087024201] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:590; }","duration":"347.580049ms","start":"2026-04-18T22:17:26.922257Z","end":"2026-04-18T22:17:27.269837Z","steps":["trace[1087024201] 'agreement among raft nodes before linearized reading' (duration: 347.323092ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:27.269902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:26.839751Z","time spent":"430.142006ms","remote":"127.0.0.1:44494","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-18T22:17:27.269937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:26.922242Z","time spent":"347.671481ms","remote":"127.0.0.1:44514","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-04-18T22:17:27.269666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.925101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:17:27.269589Z","caller":"traceutil/trace.go:171","msg":"trace[84640484] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:590; }","duration":"374.218764ms","start":"2026-04-18T22:17:26.895353Z","end":"2026-04-18T22:17:27.269572Z","steps":["trace[84640484] 'agreement among raft nodes before linearized reading' (duration: 374.116861ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:17:27.269979Z","caller":"traceutil/trace.go:171","msg":"trace[1236026328] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:590; }","duration":"405.339823ms","start":"2026-04-18T22:17:26.86463Z","end":"2026-04-18T22:17:27.26997Z","steps":["trace[1236026328] 'agreement among raft nodes before linearized reading' (duration: 404.90932ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:27.270015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:26.864608Z","time spent":"405.399375ms","remote":"127.0.0.1:44500","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-18T22:17:27.269774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.164788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T22:17:27.269695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:26.83144Z","time spent":"438.244545ms","remote":"127.0.0.1:33734","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":216,"request content":"key:\"/registry/serviceaccounts/kube-system/job-controller\" "} {"level":"info","ts":"2026-04-18T22:17:27.270097Z","caller":"traceutil/trace.go:171","msg":"trace[534686725] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:590; }","duration":"405.515289ms","start":"2026-04-18T22:17:26.86455Z","end":"2026-04-18T22:17:27.270066Z","steps":["trace[534686725] 'agreement among raft nodes before linearized reading' (duration: 405.189449ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:27.269862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:26.865073Z","time spent":"404.774616ms","remote":"127.0.0.1:44494","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-18T22:17:27.270163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:26.864521Z","time spent":"405.621751ms","remote":"127.0.0.1:44500","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-18T22:17:27.269986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:26.895334Z","time spent":"374.645697ms","remote":"127.0.0.1:44506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-18T22:17:27.269373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:26.839735Z","time spent":"429.62146ms","remote":"127.0.0.1:44494","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-18T22:17:27.269736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:26.895345Z","time spent":"374.3816ms","remote":"127.0.0.1:44506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-04-18T22:17:27.269944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.575979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:17:27.270357Z","caller":"traceutil/trace.go:171","msg":"trace[608682734] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:590; }","duration":"348.022252ms","start":"2026-04-18T22:17:26.92232Z","end":"2026-04-18T22:17:27.270342Z","steps":["trace[608682734] 'agreement among raft nodes before linearized reading' (duration: 347.595009ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:27.270406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:26.922291Z","time spent":"348.102754ms","remote":"127.0.0.1:44514","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-18T22:18:15.321083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.481937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-18T22:18:15.321272Z","caller":"traceutil/trace.go:171","msg":"trace[822974578] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1155; }","duration":"219.722584ms","start":"2026-04-18T22:18:15.101529Z","end":"2026-04-18T22:18:15.321251Z","steps":["trace[822974578] 'range keys from in-memory index tree' (duration: 219.231719ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:19:01.59457Z","caller":"traceutil/trace.go:171","msg":"trace[786191595] transaction","detail":"{read_only:false; response_revision:1816; number_of_response:1; }","duration":"175.101676ms","start":"2026-04-18T22:19:01.41944Z","end":"2026-04-18T22:19:01.594542Z","steps":["trace[786191595] 'process raft request' (duration: 174.928892ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:19:02.108455Z","caller":"traceutil/trace.go:171","msg":"trace[561967647] linearizableReadLoop","detail":"{readStateIndex:1889; appliedIndex:1888; }","duration":"390.22276ms","start":"2026-04-18T22:19:01.718202Z","end":"2026-04-18T22:19:02.108424Z","steps":["trace[561967647] 'read index received' (duration: 389.906951ms)","trace[561967647] 'applied index is now lower than readState.Index' (duration: 314.419µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:19:02.109031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.12316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-18T22:19:02.109096Z","caller":"traceutil/trace.go:171","msg":"trace[593263024] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1818; }","duration":"354.496531ms","start":"2026-04-18T22:19:01.754583Z","end":"2026-04-18T22:19:02.109079Z","steps":["trace[593263024] 'agreement among raft nodes before linearized reading' (duration: 354.344237ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:19:02.109124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.998861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"warn","ts":"2026-04-18T22:19:02.109148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:19:01.754562Z","time spent":"354.572503ms","remote":"127.0.0.1:33796","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-18T22:19:02.109192Z","caller":"traceutil/trace.go:171","msg":"trace[331913005] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1818; }","duration":"120.131535ms","start":"2026-04-18T22:19:01.989042Z","end":"2026-04-18T22:19:02.109174Z","steps":["trace[331913005] 'agreement among raft nodes before linearized reading' (duration: 119.95566ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:19:02.108558Z","caller":"traceutil/trace.go:171","msg":"trace[1358103655] transaction","detail":"{read_only:false; response_revision:1818; number_of_response:1; }","duration":"476.728453ms","start":"2026-04-18T22:19:01.631808Z","end":"2026-04-18T22:19:02.108536Z","steps":["trace[1358103655] 'process raft request' (duration: 476.401544ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:19:02.109358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:19:01.631781Z","time spent":"477.503615ms","remote":"127.0.0.1:33796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:19:02.108741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.512828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b6392b60-bae8-48f0-9cec-409e82bf8677\" ","response":"range_response_count:1 size:3747"} {"level":"info","ts":"2026-04-18T22:19:02.109479Z","caller":"traceutil/trace.go:171","msg":"trace[1804369534] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-b6392b60-bae8-48f0-9cec-409e82bf8677; range_end:; response_count:1; response_revision:1818; }","duration":"391.290559ms","start":"2026-04-18T22:19:01.718166Z","end":"2026-04-18T22:19:02.109457Z","steps":["trace[1804369534] 'agreement among raft nodes before linearized reading' (duration: 390.401365ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:19:02.10954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:19:01.718148Z","time spent":"391.372562ms","remote":"127.0.0.1:33718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3770,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b6392b60-bae8-48f0-9cec-409e82bf8677\" "} {"level":"warn","ts":"2026-04-18T22:19:02.589564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.94753ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T22:19:02.589711Z","caller":"traceutil/trace.go:171","msg":"trace[110519384] transaction","detail":"{read_only:false; response_revision:1819; number_of_response:1; }","duration":"475.85764ms","start":"2026-04-18T22:19:02.113822Z","end":"2026-04-18T22:19:02.589679Z","steps":["trace[110519384] 'process raft request' (duration: 140.681144ms)","trace[110519384] 'compare' (duration: 334.775615ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:19:02.58977Z","caller":"traceutil/trace.go:171","msg":"trace[1156886874] linearizableReadLoop","detail":"{readStateIndex:1890; appliedIndex:1889; }","duration":"430.063523ms","start":"2026-04-18T22:19:02.159681Z","end":"2026-04-18T22:19:02.589745Z","steps":["trace[1156886874] 'read index received' (duration: 94.696611ms)","trace[1156886874] 'applied index is now lower than readState.Index' (duration: 335.365272ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:19:02.58982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:19:02.1138Z","time spent":"475.974733ms","remote":"127.0.0.1:33796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:19:02.589833Z","caller":"traceutil/trace.go:171","msg":"trace[29704469] transaction","detail":"{read_only:false; response_revision:1821; number_of_response:1; }","duration":"170.259462ms","start":"2026-04-18T22:19:02.419559Z","end":"2026-04-18T22:19:02.589819Z","steps":["trace[29704469] 'process raft request' (duration: 170.20413ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:19:02.589935Z","caller":"traceutil/trace.go:171","msg":"trace[795618304] transaction","detail":"{read_only:false; response_revision:1820; number_of_response:1; }","duration":"187.51276ms","start":"2026-04-18T22:19:02.402412Z","end":"2026-04-18T22:19:02.589925Z","steps":["trace[795618304] 'process raft request' (duration: 187.260533ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:19:02.589939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.244438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-04-18T22:19:02.589992Z","caller":"traceutil/trace.go:171","msg":"trace[251778362] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1821; }","duration":"430.345ms","start":"2026-04-18T22:19:02.159639Z","end":"2026-04-18T22:19:02.589984Z","steps":["trace[251778362] 'agreement among raft nodes before linearized reading' (duration: 430.217237ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:19:02.590011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:19:02.159619Z","time spent":"430.387861ms","remote":"127.0.0.1:33796","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":577,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-04-18T22:19:02.590034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.516399ms","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-04-18T22:19:02.590065Z","caller":"traceutil/trace.go:171","msg":"trace[97563304] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1821; }","duration":"200.600691ms","start":"2026-04-18T22:19:02.389454Z","end":"2026-04-18T22:19:02.590055Z","steps":["trace[97563304] 'agreement among raft nodes before linearized reading' (duration: 200.480398ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:19:02.869689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.166878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:19:02.86976Z","caller":"traceutil/trace.go:171","msg":"trace[977957393] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1823; }","duration":"115.285181ms","start":"2026-04-18T22:19:02.754458Z","end":"2026-04-18T22:19:02.869743Z","steps":["trace[977957393] 'range keys from in-memory index tree' (duration: 115.038544ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:19:16.356501Z","caller":"traceutil/trace.go:171","msg":"trace[1194476419] linearizableReadLoop","detail":"{readStateIndex:2010; appliedIndex:2009; }","duration":"131.921841ms","start":"2026-04-18T22:19:16.224557Z","end":"2026-04-18T22:19:16.356478Z","steps":["trace[1194476419] 'read index received' (duration: 131.757867ms)","trace[1194476419] 'applied index is now lower than readState.Index' (duration: 162.824µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:19:16.356708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.113606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-04-18T22:19:16.356753Z","caller":"traceutil/trace.go:171","msg":"trace[18567486] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1936; }","duration":"132.205039ms","start":"2026-04-18T22:19:16.224537Z","end":"2026-04-18T22:19:16.356742Z","steps":["trace[18567486] 'agreement among raft nodes before linearized reading' (duration: 132.025414ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:19:16.356767Z","caller":"traceutil/trace.go:171","msg":"trace[344338459] transaction","detail":"{read_only:false; response_revision:1936; number_of_response:1; }","duration":"141.392993ms","start":"2026-04-18T22:19:16.215347Z","end":"2026-04-18T22:19:16.356739Z","steps":["trace[344338459] 'process raft request' (duration: 141.003012ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:19:46.927152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.026449ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-18T22:19:46.927484Z","caller":"traceutil/trace.go:171","msg":"trace[2099400583] linearizableReadLoop","detail":"{readStateIndex:2195; appliedIndex:2194; }","duration":"356.590673ms","start":"2026-04-18T22:19:46.570847Z","end":"2026-04-18T22:19:46.927438Z","steps":["trace[2099400583] 'read index received' (duration: 200.312998ms)","trace[2099400583] 'applied index is now lower than readState.Index' (duration: 156.271045ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:19:46.927652Z","caller":"traceutil/trace.go:171","msg":"trace[1136083587] transaction","detail":"{read_only:false; response_revision:2115; number_of_response:1; }","duration":"177.13288ms","start":"2026-04-18T22:19:46.750508Z","end":"2026-04-18T22:19:46.927641Z","steps":["trace[1136083587] 'process raft request' (duration: 176.78148ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:19:46.927731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.872952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-04-18T22:19:46.927802Z","caller":"traceutil/trace.go:171","msg":"trace[2075901959] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2115; }","duration":"356.980415ms","start":"2026-04-18T22:19:46.570795Z","end":"2026-04-18T22:19:46.927775Z","steps":["trace[2075901959] 'agreement among raft nodes before linearized reading' (duration: 356.771139ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:19:46.927838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:19:46.570774Z","time spent":"357.055496ms","remote":"127.0.0.1:34952","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5467,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-04-18T22:19:46.927889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.613215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:19:46.927967Z","caller":"traceutil/trace.go:171","msg":"trace[1691829087] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2116; }","duration":"172.734768ms","start":"2026-04-18T22:19:46.755207Z","end":"2026-04-18T22:19:46.927942Z","steps":["trace[1691829087] 'agreement among raft nodes before linearized reading' (duration: 172.625385ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:19:46.928013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.01596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"warn","ts":"2026-04-18T22:19:46.928101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.304738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-18T22:19:46.928103Z","caller":"traceutil/trace.go:171","msg":"trace[988585910] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2116; }","duration":"102.110373ms","start":"2026-04-18T22:19:46.825971Z","end":"2026-04-18T22:19:46.928082Z","steps":["trace[988585910] 'agreement among raft nodes before linearized reading' (duration: 101.917428ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:19:46.928087Z","caller":"traceutil/trace.go:171","msg":"trace[1627613006] transaction","detail":"{read_only:false; response_revision:2116; number_of_response:1; }","duration":"151.929375ms","start":"2026-04-18T22:19:46.776091Z","end":"2026-04-18T22:19:46.928021Z","steps":["trace[1627613006] 'process raft request' (duration: 151.36181ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:19:46.928252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.978102ms","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-04-18T22:19:46.92818Z","caller":"traceutil/trace.go:171","msg":"trace[1034620868] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2116; }","duration":"102.412101ms","start":"2026-04-18T22:19:46.825752Z","end":"2026-04-18T22:19:46.928164Z","steps":["trace[1034620868] 'agreement among raft nodes before linearized reading' (duration: 102.236336ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:19:46.928306Z","caller":"traceutil/trace.go:171","msg":"trace[1422936837] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2116; }","duration":"109.079125ms","start":"2026-04-18T22:19:46.819215Z","end":"2026-04-18T22:19:46.928294Z","steps":["trace[1422936837] 'agreement among raft nodes before linearized reading' (duration: 108.89581ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:19:52.875091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.800416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:19:52.875169Z","caller":"traceutil/trace.go:171","msg":"trace[96117685] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2146; }","duration":"121.93944ms","start":"2026-04-18T22:19:52.753212Z","end":"2026-04-18T22:19:52.875151Z","steps":["trace[96117685] 'range keys from in-memory index tree' (duration: 121.695403ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:19:53.162307Z","caller":"traceutil/trace.go:171","msg":"trace[562943076] linearizableReadLoop","detail":"{readStateIndex:2230; appliedIndex:2229; }","duration":"191.380853ms","start":"2026-04-18T22:19:52.970899Z","end":"2026-04-18T22:19:53.162279Z","steps":["trace[562943076] 'read index received' (duration: 123.777761ms)","trace[562943076] 'applied index is now lower than readState.Index' (duration: 67.601752ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:19:53.16234Z","caller":"traceutil/trace.go:171","msg":"trace[1515940829] transaction","detail":"{read_only:false; response_revision:2148; number_of_response:1; }","duration":"216.034161ms","start":"2026-04-18T22:19:52.946268Z","end":"2026-04-18T22:19:53.162302Z","steps":["trace[1515940829] 'process raft request' (duration: 148.500211ms)","trace[1515940829] 'compare' (duration: 67.264223ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:19:53.162684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.760233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-04-18T22:19:53.162825Z","caller":"traceutil/trace.go:171","msg":"trace[1381121752] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2148; }","duration":"191.948688ms","start":"2026-04-18T22:19:52.97084Z","end":"2026-04-18T22:19:53.162789Z","steps":["trace[1381121752] 'agreement among raft nodes before linearized reading' (duration: 191.581758ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:19:53.162931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.149712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-18T22:19:53.162961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.97241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-18T22:19:53.163Z","caller":"traceutil/trace.go:171","msg":"trace[824106801] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2148; }","duration":"156.279595ms","start":"2026-04-18T22:19:53.006706Z","end":"2026-04-18T22:19:53.162986Z","steps":["trace[824106801] 'agreement among raft nodes before linearized reading' (duration: 156.08384ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:19:53.163017Z","caller":"traceutil/trace.go:171","msg":"trace[648426709] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2148; }","duration":"106.067663ms","start":"2026-04-18T22:19:53.056934Z","end":"2026-04-18T22:19:53.163002Z","steps":["trace[648426709] 'agreement among raft nodes before linearized reading' (duration: 105.894988ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:19:53.163125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.446012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-04-18T22:19:53.163189Z","caller":"traceutil/trace.go:171","msg":"trace[26055837] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2148; }","duration":"102.557525ms","start":"2026-04-18T22:19:53.060616Z","end":"2026-04-18T22:19:53.163173Z","steps":["trace[26055837] 'agreement among raft nodes before linearized reading' (duration: 102.201095ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:20:41.140951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.196796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/schemareplications/\" range_end:\"/registry/rabbitmq.com/schemareplications0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:20:41.141116Z","caller":"traceutil/trace.go:171","msg":"trace[267509180] range","detail":"{range_begin:/registry/rabbitmq.com/schemareplications/; range_end:/registry/rabbitmq.com/schemareplications0; response_count:0; response_revision:2579; }","duration":"127.392221ms","start":"2026-04-18T22:20:41.013669Z","end":"2026-04-18T22:20:41.141061Z","steps":["trace[267509180] 'count revisions from in-memory index tree' (duration: 127.022862ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:23:50.077786Z","caller":"traceutil/trace.go:171","msg":"trace[507501602] transaction","detail":"{read_only:false; response_revision:3801; number_of_response:1; }","duration":"126.08291ms","start":"2026-04-18T22:23:49.951683Z","end":"2026-04-18T22:23:50.077766Z","steps":["trace[507501602] 'process raft request' (duration: 125.937616ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:25:08.517496Z","caller":"traceutil/trace.go:171","msg":"trace[176789693] transaction","detail":"{read_only:false; response_revision:4765; number_of_response:1; }","duration":"158.577969ms","start":"2026-04-18T22:25:08.358895Z","end":"2026-04-18T22:25:08.517473Z","steps":["trace[176789693] 'process raft request' (duration: 158.391554ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:25:10.725841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.247523ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T22:25:10.726197Z","caller":"traceutil/trace.go:171","msg":"trace[41654960] transaction","detail":"{read_only:false; response_revision:4829; number_of_response:1; }","duration":"203.622643ms","start":"2026-04-18T22:25:10.52254Z","end":"2026-04-18T22:25:10.726162Z","steps":["trace[41654960] 'process raft request' (duration: 98.964289ms)","trace[41654960] 'compare' (duration: 104.1398ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:25:10.726308Z","caller":"traceutil/trace.go:171","msg":"trace[2134573128] linearizableReadLoop","detail":"{readStateIndex:5013; appliedIndex:5012; }","duration":"197.852027ms","start":"2026-04-18T22:25:10.52843Z","end":"2026-04-18T22:25:10.726282Z","steps":["trace[2134573128] 'read index received' (duration: 93.089729ms)","trace[2134573128] 'applied index is now lower than readState.Index' (duration: 104.757367ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:25:10.726357Z","caller":"traceutil/trace.go:171","msg":"trace[1555899921] transaction","detail":"{read_only:false; response_revision:4830; number_of_response:1; }","duration":"197.908158ms","start":"2026-04-18T22:25:10.528436Z","end":"2026-04-18T22:25:10.726344Z","steps":["trace[1555899921] 'process raft request' (duration: 197.510857ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:25:10.726536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.083153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-04-18T22:25:10.726565Z","caller":"traceutil/trace.go:171","msg":"trace[777616903] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4830; }","duration":"198.169526ms","start":"2026-04-18T22:25:10.528387Z","end":"2026-04-18T22:25:10.726556Z","steps":["trace[777616903] 'agreement among raft nodes before linearized reading' (duration: 198.015762ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:25:10.793643Z","caller":"traceutil/trace.go:171","msg":"trace[1406449063] transaction","detail":"{read_only:false; response_revision:4831; number_of_response:1; }","duration":"118.981594ms","start":"2026-04-18T22:25:10.67463Z","end":"2026-04-18T22:25:10.793612Z","steps":["trace[1406449063] 'process raft request' (duration: 118.724997ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:25:10.793974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.688404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-skv7v\" ","response":"range_response_count:1 size:6522"} {"level":"info","ts":"2026-04-18T22:25:10.794077Z","caller":"traceutil/trace.go:171","msg":"trace[932549877] range","detail":"{range_begin:/registry/pods/openstack/keepalived-skv7v; range_end:; response_count:1; response_revision:4831; }","duration":"161.839469ms","start":"2026-04-18T22:25:10.632215Z","end":"2026-04-18T22:25:10.794054Z","steps":["trace[932549877] 'agreement among raft nodes before linearized reading' (duration: 161.544181ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:25:15.059972Z","caller":"traceutil/trace.go:171","msg":"trace[1706398818] transaction","detail":"{read_only:false; response_revision:4991; number_of_response:1; }","duration":"241.792511ms","start":"2026-04-18T22:25:14.818142Z","end":"2026-04-18T22:25:15.059934Z","steps":["trace[1706398818] 'process raft request' (duration: 174.193094ms)","trace[1706398818] 'compare' (duration: 67.281689ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:25:15.060059Z","caller":"traceutil/trace.go:171","msg":"trace[1699244961] transaction","detail":"{read_only:false; response_revision:4992; number_of_response:1; }","duration":"241.122223ms","start":"2026-04-18T22:25:14.818913Z","end":"2026-04-18T22:25:15.060036Z","steps":["trace[1699244961] 'process raft request' (duration: 240.903527ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:25:15.060027Z","caller":"traceutil/trace.go:171","msg":"trace[1469613917] linearizableReadLoop","detail":"{readStateIndex:5180; appliedIndex:5178; }","duration":"239.983262ms","start":"2026-04-18T22:25:14.820023Z","end":"2026-04-18T22:25:15.060006Z","steps":["trace[1469613917] 'read index received' (duration: 172.314274ms)","trace[1469613917] 'applied index is now lower than readState.Index' (duration: 67.667938ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:25:15.060346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.711898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-18T22:25:15.060366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.318001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:7 size:62873"} {"level":"info","ts":"2026-04-18T22:25:15.060419Z","caller":"traceutil/trace.go:171","msg":"trace[1490192152] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4993; }","duration":"107.842681ms","start":"2026-04-18T22:25:14.952561Z","end":"2026-04-18T22:25:15.060404Z","steps":["trace[1490192152] 'agreement among raft nodes before linearized reading' (duration: 107.682667ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:25:15.060435Z","caller":"traceutil/trace.go:171","msg":"trace[1197667073] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:7; response_revision:4993; }","duration":"240.424074ms","start":"2026-04-18T22:25:14.819995Z","end":"2026-04-18T22:25:15.060419Z","steps":["trace[1197667073] 'agreement among raft nodes before linearized reading' (duration: 240.073395ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:25:15.060478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.733907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"warn","ts":"2026-04-18T22:25:15.060364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.410278ms","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-04-18T22:25:15.060607Z","caller":"traceutil/trace.go:171","msg":"trace[23033504] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4993; }","duration":"217.689436ms","start":"2026-04-18T22:25:14.842887Z","end":"2026-04-18T22:25:15.060576Z","steps":["trace[23033504] 'agreement among raft nodes before linearized reading' (duration: 217.336116ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:25:15.060532Z","caller":"traceutil/trace.go:171","msg":"trace[1993400390] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4993; }","duration":"196.814059ms","start":"2026-04-18T22:25:14.863699Z","end":"2026-04-18T22:25:15.060513Z","steps":["trace[1993400390] 'agreement among raft nodes before linearized reading' (duration: 196.716366ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:25:15.227731Z","caller":"traceutil/trace.go:171","msg":"trace[1161120106] linearizableReadLoop","detail":"{readStateIndex:5184; appliedIndex:5181; }","duration":"118.884801ms","start":"2026-04-18T22:25:15.108825Z","end":"2026-04-18T22:25:15.22771Z","steps":["trace[1161120106] 'read index received' (duration: 75.938824ms)","trace[1161120106] 'applied index is now lower than readState.Index' (duration: 42.944887ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:25:15.227872Z","caller":"traceutil/trace.go:171","msg":"trace[279713814] transaction","detail":"{read_only:false; response_revision:4994; number_of_response:1; }","duration":"163.936865ms","start":"2026-04-18T22:25:15.063922Z","end":"2026-04-18T22:25:15.227859Z","steps":["trace[279713814] 'process raft request' (duration: 120.758842ms)","trace[279713814] 'compare' (duration: 42.664759ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:25:15.228054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.204999ms","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-04-18T22:25:15.228132Z","caller":"traceutil/trace.go:171","msg":"trace[257784550] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4996; }","duration":"119.324033ms","start":"2026-04-18T22:25:15.108791Z","end":"2026-04-18T22:25:15.228115Z","steps":["trace[257784550] 'agreement among raft nodes before linearized reading' (duration: 119.095457ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:25:15.228265Z","caller":"traceutil/trace.go:171","msg":"trace[1690396160] transaction","detail":"{read_only:false; response_revision:4995; number_of_response:1; }","duration":"164.290455ms","start":"2026-04-18T22:25:15.063963Z","end":"2026-04-18T22:25:15.228253Z","steps":["trace[1690396160] 'process raft request' (duration: 163.595926ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:25:15.228357Z","caller":"traceutil/trace.go:171","msg":"trace[1119634643] transaction","detail":"{read_only:false; response_revision:4996; number_of_response:1; }","duration":"150.413018ms","start":"2026-04-18T22:25:15.077932Z","end":"2026-04-18T22:25:15.228345Z","steps":["trace[1119634643] 'process raft request' (duration: 149.73601ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:25:24.835705Z","caller":"traceutil/trace.go:171","msg":"trace[157984186] transaction","detail":"{read_only:false; response_revision:5201; number_of_response:1; }","duration":"125.952943ms","start":"2026-04-18T22:25:24.709727Z","end":"2026-04-18T22:25:24.83568Z","steps":["trace[157984186] 'process raft request' (duration: 125.522061ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:25:24.879565Z","caller":"traceutil/trace.go:171","msg":"trace[322578232] transaction","detail":"{read_only:false; response_revision:5202; number_of_response:1; }","duration":"108.16674ms","start":"2026-04-18T22:25:24.771359Z","end":"2026-04-18T22:25:24.879526Z","steps":["trace[322578232] 'process raft request' (duration: 103.141853ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:25:24.879584Z","caller":"traceutil/trace.go:171","msg":"trace[644756728] transaction","detail":"{read_only:false; response_revision:5203; number_of_response:1; }","duration":"106.657908ms","start":"2026-04-18T22:25:24.772854Z","end":"2026-04-18T22:25:24.879512Z","steps":["trace[644756728] 'process raft request' (duration: 106.554806ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:25:24.879757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.341317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-18T22:25:24.879838Z","caller":"traceutil/trace.go:171","msg":"trace[894005711] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:5203; }","duration":"125.501151ms","start":"2026-04-18T22:25:24.75432Z","end":"2026-04-18T22:25:24.879821Z","steps":["trace[894005711] 'agreement among raft nodes before linearized reading' (duration: 125.289655ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:25:33.295245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.628359ms","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-04-18T22:25:33.295398Z","caller":"traceutil/trace.go:171","msg":"trace[594514950] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:5364; }","duration":"116.793063ms","start":"2026-04-18T22:25:33.178581Z","end":"2026-04-18T22:25:33.295374Z","steps":["trace[594514950] 'range keys from in-memory index tree' (duration: 116.610749ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:25:33.295596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.365532ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T22:25:33.295958Z","caller":"traceutil/trace.go:171","msg":"trace[1429509871] linearizableReadLoop","detail":"{readStateIndex:5565; appliedIndex:5564; }","duration":"192.273596ms","start":"2026-04-18T22:25:33.103662Z","end":"2026-04-18T22:25:33.295935Z","steps":["trace[1429509871] 'read index received' (duration: 50.652µs)","trace[1429509871] 'applied index is now lower than readState.Index' (duration: 192.220884ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:25:33.295981Z","caller":"traceutil/trace.go:171","msg":"trace[1325436205] transaction","detail":"{read_only:false; response_revision:5365; number_of_response:1; }","duration":"329.607598ms","start":"2026-04-18T22:25:32.966333Z","end":"2026-04-18T22:25:33.295941Z","steps":["trace[1325436205] 'process raft request' (duration: 74.795193ms)","trace[1325436205] 'compare' (duration: 254.029933ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:25:33.296219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:25:32.966308Z","time spent":"329.812603ms","remote":"127.0.0.1:33796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:25:33.296265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.572854ms","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-04-18T22:25:33.296343Z","caller":"traceutil/trace.go:171","msg":"trace[798927709] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5365; }","duration":"192.706817ms","start":"2026-04-18T22:25:33.103617Z","end":"2026-04-18T22:25:33.296324Z","steps":["trace[798927709] 'agreement among raft nodes before linearized reading' (duration: 192.43789ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:25:33.309247Z","caller":"traceutil/trace.go:171","msg":"trace[1390008616] transaction","detail":"{read_only:false; response_revision:5366; number_of_response:1; }","duration":"108.15901ms","start":"2026-04-18T22:25:33.201059Z","end":"2026-04-18T22:25:33.309218Z","steps":["trace[1390008616] 'process raft request' (duration: 107.897112ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:25:33.440373Z","caller":"traceutil/trace.go:171","msg":"trace[88047433] linearizableReadLoop","detail":"{readStateIndex:5567; appliedIndex:5566; }","duration":"126.548009ms","start":"2026-04-18T22:25:33.313792Z","end":"2026-04-18T22:25:33.44034Z","steps":["trace[88047433] 'read index received' (duration: 122.279683ms)","trace[88047433] 'applied index is now lower than readState.Index' (duration: 4.267156ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:25:33.440509Z","caller":"traceutil/trace.go:171","msg":"trace[338603217] transaction","detail":"{read_only:false; response_revision:5367; number_of_response:1; }","duration":"126.771326ms","start":"2026-04-18T22:25:33.313702Z","end":"2026-04-18T22:25:33.440473Z","steps":["trace[338603217] 'process raft request' (duration: 122.390987ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:25:33.440737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.921199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:9 size:80100"} {"level":"info","ts":"2026-04-18T22:25:33.440824Z","caller":"traceutil/trace.go:171","msg":"trace[2042282277] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:9; response_revision:5367; }","duration":"127.025893ms","start":"2026-04-18T22:25:33.313774Z","end":"2026-04-18T22:25:33.4408Z","steps":["trace[2042282277] 'agreement among raft nodes before linearized reading' (duration: 126.721245ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:25:33.442652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.425034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-04-18T22:25:33.442707Z","caller":"traceutil/trace.go:171","msg":"trace[1514628029] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5368; }","duration":"116.493146ms","start":"2026-04-18T22:25:33.326199Z","end":"2026-04-18T22:25:33.442692Z","steps":["trace[1514628029] 'agreement among raft nodes before linearized reading' (duration: 116.299011ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:25:33.442727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.409806ms","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-04-18T22:25:33.442779Z","caller":"traceutil/trace.go:171","msg":"trace[1713493845] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5368; }","duration":"101.515169ms","start":"2026-04-18T22:25:33.341251Z","end":"2026-04-18T22:25:33.442766Z","steps":["trace[1713493845] 'agreement among raft nodes before linearized reading' (duration: 101.319904ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:25:33.442647Z","caller":"traceutil/trace.go:171","msg":"trace[1011442914] transaction","detail":"{read_only:false; response_revision:5368; number_of_response:1; }","duration":"128.148673ms","start":"2026-04-18T22:25:33.314482Z","end":"2026-04-18T22:25:33.442631Z","steps":["trace[1011442914] 'process raft request' (duration: 127.915126ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:25:33.443517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.167054ms","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-04-18T22:25:33.443601Z","caller":"traceutil/trace.go:171","msg":"trace[16635006] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5368; }","duration":"111.017057ms","start":"2026-04-18T22:25:33.332563Z","end":"2026-04-18T22:25:33.44358Z","steps":["trace[16635006] 'agreement among raft nodes before linearized reading' (duration: 110.046241ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:26:48.033292Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2969} {"level":"info","ts":"2026-04-18T22:26:48.110536Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2969,"took":"74.936428ms","hash":2706577704,"current-db-size-bytes":57327616,"current-db-size":"57 MB","current-db-size-in-use-bytes":33599488,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-04-18T22:26:48.110609Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2706577704,"revision":2969,"compact-revision":-1} {"level":"warn","ts":"2026-04-18T22:31:33.840162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.829049ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T22:31:33.840345Z","caller":"traceutil/trace.go:171","msg":"trace[2124479993] transaction","detail":"{read_only:false; response_revision:8173; number_of_response:1; }","duration":"378.063026ms","start":"2026-04-18T22:31:33.462257Z","end":"2026-04-18T22:31:33.84032Z","steps":["trace[2124479993] 'process raft request' (duration: 238.929528ms)","trace[2124479993] 'compare' (duration: 138.46025ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:31:33.840423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:31:33.462237Z","time spent":"378.150149ms","remote":"127.0.0.1:33796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:31:33.841556Z","caller":"traceutil/trace.go:171","msg":"trace[2088764236] transaction","detail":"{read_only:false; response_revision:8174; number_of_response:1; }","duration":"379.245479ms","start":"2026-04-18T22:31:33.462294Z","end":"2026-04-18T22:31:33.841539Z","steps":["trace[2088764236] 'process raft request' (duration: 379.102445ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:31:33.841647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:31:33.462279Z","time spent":"379.325311ms","remote":"127.0.0.1:33796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:31:33.841943Z","caller":"traceutil/trace.go:171","msg":"trace[1398654722] transaction","detail":"{read_only:false; response_revision:8175; number_of_response:1; }","duration":"379.469725ms","start":"2026-04-18T22:31:33.462412Z","end":"2026-04-18T22:31:33.841882Z","steps":["trace[1398654722] 'process raft request' (duration: 379.087414ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:31:33.841967Z","caller":"traceutil/trace.go:171","msg":"trace[412845959] linearizableReadLoop","detail":"{readStateIndex:8463; appliedIndex:8459; }","duration":"376.799662ms","start":"2026-04-18T22:31:33.46513Z","end":"2026-04-18T22:31:33.84193Z","steps":["trace[412845959] 'read index received' (duration: 236.127392ms)","trace[412845959] 'applied index is now lower than readState.Index' (duration: 140.67103ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:31:33.841986Z","caller":"traceutil/trace.go:171","msg":"trace[2016931004] transaction","detail":"{read_only:false; response_revision:8176; number_of_response:1; }","duration":"379.553297ms","start":"2026-04-18T22:31:33.462408Z","end":"2026-04-18T22:31:33.841961Z","steps":["trace[2016931004] 'process raft request' (duration: 379.377962ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:31:33.842107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:31:33.462405Z","time spent":"379.613269ms","remote":"127.0.0.1:33796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:31:33.842176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.971938ms","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-04-18T22:31:33.842222Z","caller":"traceutil/trace.go:171","msg":"trace[1762745364] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:8176; }","duration":"103.056071ms","start":"2026-04-18T22:31:33.739154Z","end":"2026-04-18T22:31:33.84221Z","steps":["trace[1762745364] 'agreement among raft nodes before linearized reading' (duration: 102.986569ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:31:33.842093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.967446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T22:31:33.842366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:31:33.462385Z","time spent":"379.757953ms","remote":"127.0.0.1:33796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:31:33.842388Z","caller":"traceutil/trace.go:171","msg":"trace[91733184] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8176; }","duration":"377.243974ms","start":"2026-04-18T22:31:33.4651Z","end":"2026-04-18T22:31:33.842344Z","steps":["trace[91733184] 'agreement among raft nodes before linearized reading' (duration: 376.954427ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:31:33.842488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:31:33.465093Z","time spent":"377.372378ms","remote":"127.0.0.1:33526","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-04-18T22:31:33.842267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.340236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-skv7v\" ","response":"range_response_count:1 size:6522"} {"level":"info","ts":"2026-04-18T22:31:33.842693Z","caller":"traceutil/trace.go:171","msg":"trace[1546464194] range","detail":"{range_begin:/registry/pods/openstack/keepalived-skv7v; range_end:; response_count:1; response_revision:8176; }","duration":"195.802019ms","start":"2026-04-18T22:31:33.64685Z","end":"2026-04-18T22:31:33.842652Z","steps":["trace[1546464194] 'agreement among raft nodes before linearized reading' (duration: 195.267364ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:31:44.8618Z","caller":"traceutil/trace.go:171","msg":"trace[1401712436] linearizableReadLoop","detail":"{readStateIndex:8525; appliedIndex:8523; }","duration":"106.645988ms","start":"2026-04-18T22:31:44.755123Z","end":"2026-04-18T22:31:44.861769Z","steps":["trace[1401712436] 'read index received' (duration: 31.891763ms)","trace[1401712436] 'applied index is now lower than readState.Index' (duration: 74.753125ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:31:44.861907Z","caller":"traceutil/trace.go:171","msg":"trace[946253067] transaction","detail":"{read_only:false; response_revision:8235; number_of_response:1; }","duration":"161.539341ms","start":"2026-04-18T22:31:44.700326Z","end":"2026-04-18T22:31:44.861866Z","steps":["trace[946253067] 'process raft request' (duration: 134.84082ms)","trace[946253067] 'compare' (duration: 26.493745ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:31:44.861936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.799422ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:31:44.862096Z","caller":"traceutil/trace.go:171","msg":"trace[1908021783] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8235; }","duration":"107.001098ms","start":"2026-04-18T22:31:44.75508Z","end":"2026-04-18T22:31:44.862081Z","steps":["trace[1908021783] 'agreement among raft nodes before linearized reading' (duration: 106.807673ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:31:47.168615Z","caller":"traceutil/trace.go:171","msg":"trace[1200773843] linearizableReadLoop","detail":"{readStateIndex:8535; appliedIndex:8534; }","duration":"103.685387ms","start":"2026-04-18T22:31:47.064906Z","end":"2026-04-18T22:31:47.168591Z","steps":["trace[1200773843] 'read index received' (duration: 54.375218ms)","trace[1200773843] 'applied index is now lower than readState.Index' (duration: 49.309309ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:31:47.168753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.830591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-18T22:31:47.168784Z","caller":"traceutil/trace.go:171","msg":"trace[2126861887] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:8244; }","duration":"103.916324ms","start":"2026-04-18T22:31:47.06486Z","end":"2026-04-18T22:31:47.168776Z","steps":["trace[2126861887] 'agreement among raft nodes before linearized reading' (duration: 103.816261ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:31:47.168988Z","caller":"traceutil/trace.go:171","msg":"trace[97109568] transaction","detail":"{read_only:false; response_revision:8244; number_of_response:1; }","duration":"300.253827ms","start":"2026-04-18T22:31:46.868687Z","end":"2026-04-18T22:31:47.168941Z","steps":["trace[97109568] 'process raft request' (duration: 250.698051ms)","trace[97109568] 'compare' (duration: 48.97158ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:31:47.169181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:31:46.868661Z","time spent":"300.422642ms","remote":"127.0.0.1:33796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:31:48.111317Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6054} {"level":"info","ts":"2026-04-18T22:31:48.620276Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6054,"took":"506.718468ms","hash":1886251982,"current-db-size-bytes":57327616,"current-db-size":"57 MB","current-db-size-in-use-bytes":23248896,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-04-18T22:31:48.620346Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1886251982,"revision":6054,"compact-revision":2969} {"level":"info","ts":"2026-04-18T22:32:15.954417Z","caller":"traceutil/trace.go:171","msg":"trace[1237176985] transaction","detail":"{read_only:false; response_revision:8452; number_of_response:1; }","duration":"174.65422ms","start":"2026-04-18T22:32:15.779738Z","end":"2026-04-18T22:32:15.954392Z","steps":["trace[1237176985] 'process raft request' (duration: 174.503096ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:32:28.345322Z","caller":"traceutil/trace.go:171","msg":"trace[1644155843] linearizableReadLoop","detail":"{readStateIndex:8863; appliedIndex:8862; }","duration":"212.604209ms","start":"2026-04-18T22:32:28.132678Z","end":"2026-04-18T22:32:28.345282Z","steps":["trace[1644155843] 'read index received' (duration: 140.550697ms)","trace[1644155843] 'applied index is now lower than readState.Index' (duration: 72.052122ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:32:28.345391Z","caller":"traceutil/trace.go:171","msg":"trace[630148285] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8558; }","duration":"213.508073ms","start":"2026-04-18T22:32:28.131826Z","end":"2026-04-18T22:32:28.345334Z","steps":["trace[630148285] 'process raft request' (duration: 141.38537ms)","trace[630148285] 'compare' (duration: 71.884977ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:32:28.345654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.954258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-5sggb\" ","response":"range_response_count:1 size:4648"} {"level":"info","ts":"2026-04-18T22:32:28.345755Z","caller":"traceutil/trace.go:171","msg":"trace[776871727] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-5sggb; range_end:; response_count:1; response_revision:8558; }","duration":"213.126173ms","start":"2026-04-18T22:32:28.132604Z","end":"2026-04-18T22:32:28.34573Z","steps":["trace[776871727] 'agreement among raft nodes before linearized reading' (duration: 212.775104ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:32:28.371593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.050595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"warn","ts":"2026-04-18T22:32:28.371629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.063996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-18T22:32:28.371632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.338889ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-skv7v\" ","response":"range_response_count:1 size:6522"} {"level":"warn","ts":"2026-04-18T22:32:28.371643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.600149ms","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-04-18T22:32:28.371683Z","caller":"traceutil/trace.go:171","msg":"trace[1601422589] transaction","detail":"{read_only:false; response_revision:8559; number_of_response:1; }","duration":"147.27401ms","start":"2026-04-18T22:32:28.224388Z","end":"2026-04-18T22:32:28.371662Z","steps":["trace[1601422589] 'process raft request' (duration: 146.772416ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:32:28.371692Z","caller":"traceutil/trace.go:171","msg":"trace[406044093] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8559; }","duration":"200.182668ms","start":"2026-04-18T22:32:28.171493Z","end":"2026-04-18T22:32:28.371676Z","steps":["trace[406044093] 'agreement among raft nodes before linearized reading' (duration: 200.017934ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:32:28.371726Z","caller":"traceutil/trace.go:171","msg":"trace[256474165] range","detail":"{range_begin:/registry/pods/openstack/keepalived-skv7v; range_end:; response_count:1; response_revision:8559; }","duration":"133.464943ms","start":"2026-04-18T22:32:28.238234Z","end":"2026-04-18T22:32:28.371699Z","steps":["trace[256474165] 'agreement among raft nodes before linearized reading' (duration: 133.306219ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:32:28.371729Z","caller":"traceutil/trace.go:171","msg":"trace[761801822] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8559; }","duration":"227.698751ms","start":"2026-04-18T22:32:28.144011Z","end":"2026-04-18T22:32:28.371709Z","steps":["trace[761801822] 'agreement among raft nodes before linearized reading' (duration: 227.451884ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:32:28.371947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.415502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-5sggb\" ","response":"range_response_count:1 size:4648"} {"level":"info","ts":"2026-04-18T22:32:28.371985Z","caller":"traceutil/trace.go:171","msg":"trace[689612459] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-5sggb; range_end:; response_count:1; response_revision:8559; }","duration":"148.490003ms","start":"2026-04-18T22:32:28.223485Z","end":"2026-04-18T22:32:28.371975Z","steps":["trace[689612459] 'agreement among raft nodes before linearized reading' (duration: 148.387131ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:32:28.371583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.655233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-18T22:32:28.372192Z","caller":"traceutil/trace.go:171","msg":"trace[736609741] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8559; }","duration":"223.330092ms","start":"2026-04-18T22:32:28.148848Z","end":"2026-04-18T22:32:28.372178Z","steps":["trace[736609741] 'agreement among raft nodes before linearized reading' (duration: 222.571431ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:32:28.371678Z","caller":"traceutil/trace.go:171","msg":"trace[1687812285] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8559; }","duration":"177.195969ms","start":"2026-04-18T22:32:28.194461Z","end":"2026-04-18T22:32:28.371657Z","steps":["trace[1687812285] 'agreement among raft nodes before linearized reading' (duration: 176.929572ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:32:29.119381Z","caller":"traceutil/trace.go:171","msg":"trace[1939427416] transaction","detail":"{read_only:false; response_revision:8568; number_of_response:1; }","duration":"110.260247ms","start":"2026-04-18T22:32:29.009084Z","end":"2026-04-18T22:32:29.119344Z","steps":["trace[1939427416] 'process raft request' (duration: 109.941038ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:32:29.272302Z","caller":"traceutil/trace.go:171","msg":"trace[1430014798] transaction","detail":"{read_only:false; response_revision:8569; number_of_response:1; }","duration":"201.813183ms","start":"2026-04-18T22:32:29.07046Z","end":"2026-04-18T22:32:29.272274Z","steps":["trace[1430014798] 'process raft request' (duration: 201.497235ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:32:29.320262Z","caller":"traceutil/trace.go:171","msg":"trace[1854515351] transaction","detail":"{read_only:false; response_revision:8570; number_of_response:1; }","duration":"186.544615ms","start":"2026-04-18T22:32:29.133679Z","end":"2026-04-18T22:32:29.320223Z","steps":["trace[1854515351] 'process raft request' (duration: 186.322169ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:32:30.940096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.540412ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T22:32:30.94038Z","caller":"traceutil/trace.go:171","msg":"trace[1582999559] transaction","detail":"{read_only:false; response_revision:8577; number_of_response:1; }","duration":"514.642633ms","start":"2026-04-18T22:32:30.425707Z","end":"2026-04-18T22:32:30.94035Z","steps":["trace[1582999559] 'process raft request' (duration: 514.53157ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:32:30.940501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:32:30.4257Z","time spent":"514.750326ms","remote":"127.0.0.1:33796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:32:30.94062Z","caller":"traceutil/trace.go:171","msg":"trace[777087526] transaction","detail":"{read_only:false; response_revision:8576; number_of_response:1; }","duration":"514.967713ms","start":"2026-04-18T22:32:30.425615Z","end":"2026-04-18T22:32:30.940583Z","steps":["trace[777087526] 'process raft request' (duration: 170.844545ms)","trace[777087526] 'compare' (duration: 343.398678ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:32:30.940665Z","caller":"traceutil/trace.go:171","msg":"trace[1942802114] transaction","detail":"{read_only:false; response_revision:8578; number_of_response:1; }","duration":"514.254012ms","start":"2026-04-18T22:32:30.426386Z","end":"2026-04-18T22:32:30.94064Z","steps":["trace[1942802114] 'process raft request' (duration: 513.908123ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:32:30.940798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:32:30.426363Z","time spent":"514.358826ms","remote":"127.0.0.1:33796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:32:30.940802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:32:30.425597Z","time spent":"515.115356ms","remote":"127.0.0.1:33796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:32:30.940805Z","caller":"traceutil/trace.go:171","msg":"trace[773768942] linearizableReadLoop","detail":"{readStateIndex:8883; appliedIndex:8879; }","duration":"512.970288ms","start":"2026-04-18T22:32:30.427791Z","end":"2026-04-18T22:32:30.940761Z","steps":["trace[773768942] 'read index received' (duration: 38.147384ms)","trace[773768942] 'applied index is now lower than readState.Index' (duration: 474.817494ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:32:30.940937Z","caller":"traceutil/trace.go:171","msg":"trace[2125983730] transaction","detail":"{read_only:false; response_revision:8579; number_of_response:1; }","duration":"149.719927ms","start":"2026-04-18T22:32:30.79116Z","end":"2026-04-18T22:32:30.94088Z","steps":["trace[2125983730] 'process raft request' (duration: 149.529032ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:32:30.94111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.205548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T22:32:30.941216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.11011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-18T22:32:30.941215Z","caller":"traceutil/trace.go:171","msg":"trace[925881532] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8579; }","duration":"185.365292ms","start":"2026-04-18T22:32:30.75582Z","end":"2026-04-18T22:32:30.941185Z","steps":["trace[925881532] 'agreement among raft nodes before linearized reading' (duration: 185.203768ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:32:30.941277Z","caller":"traceutil/trace.go:171","msg":"trace[1046315185] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8579; }","duration":"244.231394ms","start":"2026-04-18T22:32:30.697026Z","end":"2026-04-18T22:32:30.941258Z","steps":["trace[1046315185] 'agreement among raft nodes before linearized reading' (duration: 243.961597ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:32:30.941389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"513.565934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:26 size:228469"} {"level":"info","ts":"2026-04-18T22:32:30.941505Z","caller":"traceutil/trace.go:171","msg":"trace[1652925322] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:26; response_revision:8579; }","duration":"513.701517ms","start":"2026-04-18T22:32:30.427772Z","end":"2026-04-18T22:32:30.941474Z","steps":["trace[1652925322] 'agreement among raft nodes before linearized reading' (duration: 513.098691ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:32:30.941566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:32:30.427764Z","time spent":"513.78664ms","remote":"127.0.0.1:33718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":26,"response size":228492,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "} {"level":"info","ts":"2026-04-18T22:33:17.563171Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002459.wal"} {"level":"info","ts":"2026-04-18T22:34:35.56918Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"b844c110b9783e73","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-18T22:34:35.576261Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-18T22:34:35.576348Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-18T22:36:48.118316Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8251} {"level":"info","ts":"2026-04-18T22:36:48.202235Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8251,"took":"80.502126ms","hash":999587425,"current-db-size-bytes":57327616,"current-db-size":"57 MB","current-db-size-in-use-bytes":24879104,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-04-18T22:36:48.202312Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":999587425,"revision":8251,"compact-revision":6054} {"level":"info","ts":"2026-04-18T22:40:13.109276Z","caller":"traceutil/trace.go:171","msg":"trace[2108941548] transaction","detail":"{read_only:false; response_revision:11710; number_of_response:1; }","duration":"278.747587ms","start":"2026-04-18T22:40:12.830493Z","end":"2026-04-18T22:40:13.109241Z","steps":["trace[2108941548] 'process raft request' (duration: 278.514001ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:40:18.723608Z","caller":"traceutil/trace.go:171","msg":"trace[1590796185] transaction","detail":"{read_only:false; response_revision:11737; number_of_response:1; }","duration":"155.973192ms","start":"2026-04-18T22:40:18.567598Z","end":"2026-04-18T22:40:18.723571Z","steps":["trace[1590796185] 'process raft request' (duration: 155.55085ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:41:48.124019Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10647} {"level":"info","ts":"2026-04-18T22:41:48.203491Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10647,"took":"76.724952ms","hash":3563347254,"current-db-size-bytes":57327616,"current-db-size":"57 MB","current-db-size-in-use-bytes":20520960,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-04-18T22:41:48.203575Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3563347254,"revision":10647,"compact-revision":8251}