{"level":"warn","ts":"2026-06-30T22:18:41.084546Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-30T22:18:41.084675Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.53: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.53:2380","--initial-cluster=instance=https://199.204.45.53:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.53:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.53:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-06-30T22:18:41.084775Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-30T22:18:41.084787Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.53:2380"]} {"level":"info","ts":"2026-06-30T22:18:41.084807Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-30T22:18:41.085532Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.53:2379"]} {"level":"info","ts":"2026-06-30T22:18:41.085626Z","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.53:2380"],"listen-peer-urls":["https://199.204.45.53:2380"],"advertise-client-urls":["https://199.204.45.53:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.53:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.53:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-06-30T22:18:41.090386Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.389863ms"} {"level":"info","ts":"2026-06-30T22:18:41.096375Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c47ca1a7b1fe506b","cluster-id":"95bd21e158fabf07"} {"level":"info","ts":"2026-06-30T22:18:41.096458Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b switched to configuration voters=()"} {"level":"info","ts":"2026-06-30T22:18:41.096482Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became follower at term 0"} {"level":"info","ts":"2026-06-30T22:18:41.096497Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c47ca1a7b1fe506b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-30T22:18:41.096514Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became follower at term 1"} {"level":"info","ts":"2026-06-30T22:18:41.096559Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b switched to configuration voters=(14158369070163841131)"} {"level":"warn","ts":"2026-06-30T22:18:41.103706Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-30T22:18:41.104956Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-30T22:18:41.106091Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-06-30T22:18:41.108822Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c47ca1a7b1fe506b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-30T22:18:41.10897Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-30T22:18:41.109049Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-30T22:18:41.108985Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c47ca1a7b1fe506b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-30T22:18:41.109067Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-30T22:18:41.110007Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b switched to configuration voters=(14158369070163841131)"} {"level":"info","ts":"2026-06-30T22:18:41.110181Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"95bd21e158fabf07","local-member-id":"c47ca1a7b1fe506b","added-peer-id":"c47ca1a7b1fe506b","added-peer-peer-urls":["https://199.204.45.53:2380"]} {"level":"info","ts":"2026-06-30T22:18:41.114001Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-30T22:18:41.114115Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.53:2380"} {"level":"info","ts":"2026-06-30T22:18:41.114207Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.53:2380"} {"level":"info","ts":"2026-06-30T22:18:41.114287Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c47ca1a7b1fe506b","initial-advertise-peer-urls":["https://199.204.45.53:2380"],"listen-peer-urls":["https://199.204.45.53:2380"],"advertise-client-urls":["https://199.204.45.53:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.53:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-30T22:18:41.114337Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-30T22:18:41.896901Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b is starting a new election at term 1"} {"level":"info","ts":"2026-06-30T22:18:41.89697Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became pre-candidate at term 1"} {"level":"info","ts":"2026-06-30T22:18:41.897015Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b received MsgPreVoteResp from c47ca1a7b1fe506b at term 1"} {"level":"info","ts":"2026-06-30T22:18:41.897033Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became candidate at term 2"} {"level":"info","ts":"2026-06-30T22:18:41.897044Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b received MsgVoteResp from c47ca1a7b1fe506b at term 2"} {"level":"info","ts":"2026-06-30T22:18:41.897059Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became leader at term 2"} {"level":"info","ts":"2026-06-30T22:18:41.897073Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c47ca1a7b1fe506b elected leader c47ca1a7b1fe506b at term 2"} {"level":"info","ts":"2026-06-30T22:18:41.90223Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c47ca1a7b1fe506b","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.53:2379]}","request-path":"/0/members/c47ca1a7b1fe506b/attributes","cluster-id":"95bd21e158fabf07","publish-timeout":"7s"} {"level":"info","ts":"2026-06-30T22:18:41.902309Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-30T22:18:41.902406Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-30T22:18:41.902458Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-30T22:18:41.904026Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"95bd21e158fabf07","local-member-id":"c47ca1a7b1fe506b","cluster-version":"3.5"} {"level":"info","ts":"2026-06-30T22:18:41.904152Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-30T22:18:41.904212Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-30T22:18:41.90436Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-30T22:18:41.904384Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-30T22:18:41.905964Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.53:2379"} {"level":"info","ts":"2026-06-30T22:18:41.90666Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-06-30T22:18:48.774705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.700836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-06-30T22:18:48.774814Z","caller":"traceutil/trace.go:171","msg":"trace[125835310] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:314; }","duration":"134.902312ms","start":"2026-06-30T22:18:48.639891Z","end":"2026-06-30T22:18:48.774793Z","steps":["trace[125835310] 'range keys from in-memory index tree' (duration: 134.558372ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:19:05.126844Z","caller":"traceutil/trace.go:171","msg":"trace[1071423336] linearizableReadLoop","detail":"{readStateIndex:444; appliedIndex:443; }","duration":"108.969537ms","start":"2026-06-30T22:19:05.017846Z","end":"2026-06-30T22:19:05.126816Z","steps":["trace[1071423336] 'read index received' (duration: 90.006449ms)","trace[1071423336] 'applied index is now lower than readState.Index' (duration: 18.960988ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T22:19:05.126924Z","caller":"traceutil/trace.go:171","msg":"trace[2029352889] transaction","detail":"{read_only:false; response_revision:428; number_of_response:1; }","duration":"109.831321ms","start":"2026-06-30T22:19:05.017052Z","end":"2026-06-30T22:19:05.126884Z","steps":["trace[2029352889] 'process raft request' (duration: 90.77019ms)","trace[2029352889] 'compare' (duration: 18.883936ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T22:19:05.126991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.123021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T22:19:05.127026Z","caller":"traceutil/trace.go:171","msg":"trace[644183195] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:428; }","duration":"109.207084ms","start":"2026-06-30T22:19:05.017808Z","end":"2026-06-30T22:19:05.127015Z","steps":["trace[644183195] 'agreement among raft nodes before linearized reading' (duration: 109.114251ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:19:19.020198Z","caller":"traceutil/trace.go:171","msg":"trace[1660919972] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"329.584562ms","start":"2026-06-30T22:19:18.690583Z","end":"2026-06-30T22:19:19.020168Z","steps":["trace[1660919972] 'process raft request' (duration: 329.362656ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:19:19.020345Z","caller":"traceutil/trace.go:171","msg":"trace[121511855] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"322.217367ms","start":"2026-06-30T22:19:18.698086Z","end":"2026-06-30T22:19:19.020304Z","steps":["trace[121511855] 'process raft request' (duration: 322.061523ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:19:19.021001Z","caller":"traceutil/trace.go:171","msg":"trace[578461971] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"327.508885ms","start":"2026-06-30T22:19:18.692778Z","end":"2026-06-30T22:19:19.020287Z","steps":["trace[578461971] 'process raft request' (duration: 327.318789ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:19:19.022081Z","caller":"traceutil/trace.go:171","msg":"trace[1041784474] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"319.878873ms","start":"2026-06-30T22:19:18.700488Z","end":"2026-06-30T22:19:19.020367Z","steps":["trace[1041784474] 'process raft request' (duration: 319.699368ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:19:19.020614Z","caller":"traceutil/trace.go:171","msg":"trace[140283678] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"319.636886ms","start":"2026-06-30T22:19:18.700867Z","end":"2026-06-30T22:19:19.020504Z","steps":["trace[140283678] 'process raft request' (duration: 319.41609ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:19:19.022153Z","caller":"traceutil/trace.go:171","msg":"trace[485257489] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"319.001098ms","start":"2026-06-30T22:19:18.702927Z","end":"2026-06-30T22:19:19.021928Z","steps":["trace[485257489] 'process raft request' (duration: 317.424715ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:19:19.021968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:19:18.690319Z","time spent":"330.025504ms","remote":"127.0.0.1:53284","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-30T22:19:19.022288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:19:18.700482Z","time spent":"321.739804ms","remote":"127.0.0.1:53284","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-30T22:19:19.022297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:19:18.700845Z","time spent":"321.385235ms","remote":"127.0.0.1:53284","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-30T22:19:19.022314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:19:18.702912Z","time spent":"319.327427ms","remote":"127.0.0.1:53284","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-30T22:19:19.022425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:19:18.692761Z","time spent":"328.470281ms","remote":"127.0.0.1:53284","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-30T22:19:19.022464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:19:18.698079Z","time spent":"322.352072ms","remote":"127.0.0.1:53284","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-30T22:19:19.022668Z","caller":"traceutil/trace.go:171","msg":"trace[2060537126] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"318.129634ms","start":"2026-06-30T22:19:18.704336Z","end":"2026-06-30T22:19:19.022465Z","steps":["trace[2060537126] 'process raft request' (duration: 317.492987ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:19:19.022786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:19:18.704315Z","time spent":"318.423832ms","remote":"127.0.0.1:53284","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-30T22:19:19.029102Z","caller":"traceutil/trace.go:171","msg":"trace[1933087968] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"316.346984ms","start":"2026-06-30T22:19:18.712728Z","end":"2026-06-30T22:19:19.029075Z","steps":["trace[1933087968] 'process raft request' (duration: 311.070697ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:19:19.029146Z","caller":"traceutil/trace.go:171","msg":"trace[625375979] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"293.358235ms","start":"2026-06-30T22:19:18.735719Z","end":"2026-06-30T22:19:19.029077Z","steps":["trace[625375979] 'process raft request' (duration: 293.206811ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:19:19.029239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:19:18.712709Z","time spent":"316.466438ms","remote":"127.0.0.1:53284","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-30T22:19:19.029239Z","caller":"traceutil/trace.go:171","msg":"trace[1796439469] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"285.59509ms","start":"2026-06-30T22:19:18.743624Z","end":"2026-06-30T22:19:19.029219Z","steps":["trace[1796439469] 'process raft request' (duration: 285.361103ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:19:19.029596Z","caller":"traceutil/trace.go:171","msg":"trace[371429732] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"270.8689ms","start":"2026-06-30T22:19:18.758708Z","end":"2026-06-30T22:19:19.029577Z","steps":["trace[371429732] 'process raft request' (duration: 270.756017ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:19:19.029621Z","caller":"traceutil/trace.go:171","msg":"trace[881227291] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"189.890869ms","start":"2026-06-30T22:19:18.839714Z","end":"2026-06-30T22:19:19.029605Z","steps":["trace[881227291] 'process raft request' (duration: 189.845277ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:19:19.02971Z","caller":"traceutil/trace.go:171","msg":"trace[1821218312] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"267.661261ms","start":"2026-06-30T22:19:18.762033Z","end":"2026-06-30T22:19:19.029694Z","steps":["trace[1821218312] 'process raft request' (duration: 267.467646ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:19:24.700488Z","caller":"traceutil/trace.go:171","msg":"trace[1895076475] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"142.241404ms","start":"2026-06-30T22:19:24.55822Z","end":"2026-06-30T22:19:24.700461Z","steps":["trace[1895076475] 'process raft request' (duration: 142.025238ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:19:25.114025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.692371ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-30T22:19:25.11416Z","caller":"traceutil/trace.go:171","msg":"trace[786188929] linearizableReadLoop","detail":"{readStateIndex:655; appliedIndex:654; }","duration":"259.691819ms","start":"2026-06-30T22:19:24.854451Z","end":"2026-06-30T22:19:25.114143Z","steps":["trace[786188929] 'read index received' (duration: 95.636078ms)","trace[786188929] 'applied index is now lower than readState.Index' (duration: 164.054331ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T22:19:25.114232Z","caller":"traceutil/trace.go:171","msg":"trace[1172332874] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"290.905477ms","start":"2026-06-30T22:19:24.82327Z","end":"2026-06-30T22:19:25.114175Z","steps":["trace[1172332874] 'process raft request' (duration: 126.785624ms)","trace[1172332874] 'compare' (duration: 163.366052ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T22:19:25.114488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.826574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.53\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-06-30T22:19:25.114533Z","caller":"traceutil/trace.go:171","msg":"trace[441911855] range","detail":"{range_begin:/registry/masterleases/199.204.45.53; range_end:; response_count:1; response_revision:631; }","duration":"260.112882ms","start":"2026-06-30T22:19:24.854407Z","end":"2026-06-30T22:19:25.11452Z","steps":["trace[441911855] 'agreement among raft nodes before linearized reading' (duration: 259.784503ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:19:25.615861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.058595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-30T22:19:25.615922Z","caller":"traceutil/trace.go:171","msg":"trace[2090611185] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:632; }","duration":"130.144988ms","start":"2026-06-30T22:19:25.485763Z","end":"2026-06-30T22:19:25.615908Z","steps":["trace[2090611185] 'range keys from in-memory index tree' (duration: 129.941282ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:19:25.616035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.216206ms","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-06-30T22:19:25.616173Z","caller":"traceutil/trace.go:171","msg":"trace[1064510366] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:632; }","duration":"141.392541ms","start":"2026-06-30T22:19:25.474765Z","end":"2026-06-30T22:19:25.616158Z","steps":["trace[1064510366] 'range keys from in-memory index tree' (duration: 140.923988ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:19:25.617622Z","caller":"traceutil/trace.go:171","msg":"trace[2062588115] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"113.979368ms","start":"2026-06-30T22:19:25.503626Z","end":"2026-06-30T22:19:25.617605Z","steps":["trace[2062588115] 'process raft request' (duration: 112.823536ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:20:55.023005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.956068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-30T22:20:55.023134Z","caller":"traceutil/trace.go:171","msg":"trace[38980543] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1859; }","duration":"361.170615ms","start":"2026-06-30T22:20:54.661936Z","end":"2026-06-30T22:20:55.023107Z","steps":["trace[38980543] 'range keys from in-memory index tree' (duration: 360.561157ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:20:55.023108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.531431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.53\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-06-30T22:20:55.023185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:20:54.661905Z","time spent":"361.268878ms","remote":"127.0.0.1:41428","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5436,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-06-30T22:20:55.023233Z","caller":"traceutil/trace.go:171","msg":"trace[1754673043] range","detail":"{range_begin:/registry/masterleases/199.204.45.53; range_end:; response_count:1; response_revision:1859; }","duration":"162.722376ms","start":"2026-06-30T22:20:54.860472Z","end":"2026-06-30T22:20:55.023194Z","steps":["trace[1754673043] 'range keys from in-memory index tree' (duration: 162.015546ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:20:55.228636Z","caller":"traceutil/trace.go:171","msg":"trace[177371272] linearizableReadLoop","detail":"{readStateIndex:1934; appliedIndex:1933; }","duration":"144.284075ms","start":"2026-06-30T22:20:55.08422Z","end":"2026-06-30T22:20:55.228505Z","steps":["trace[177371272] 'read index received' (duration: 66.917148ms)","trace[177371272] 'applied index is now lower than readState.Index' (duration: 77.365457ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T22:20:55.228655Z","caller":"traceutil/trace.go:171","msg":"trace[1758242337] transaction","detail":"{read_only:false; response_revision:1861; number_of_response:1; }","duration":"155.029893ms","start":"2026-06-30T22:20:55.073542Z","end":"2026-06-30T22:20:55.228572Z","steps":["trace[1758242337] 'process raft request' (duration: 77.684176ms)","trace[1758242337] 'compare' (duration: 76.870794ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T22:20:55.228869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.630084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:421"} {"level":"info","ts":"2026-06-30T22:20:55.228967Z","caller":"traceutil/trace.go:171","msg":"trace[795274427] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:1861; }","duration":"144.778838ms","start":"2026-06-30T22:20:55.084163Z","end":"2026-06-30T22:20:55.228941Z","steps":["trace[795274427] 'agreement among raft nodes before linearized reading' (duration: 144.511931ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:20:55.229219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.267104ms","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-06-30T22:20:55.229296Z","caller":"traceutil/trace.go:171","msg":"trace[2084174700] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1861; }","duration":"100.47609ms","start":"2026-06-30T22:20:55.128801Z","end":"2026-06-30T22:20:55.229277Z","steps":["trace[2084174700] 'agreement among raft nodes before linearized reading' (duration: 100.200312ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:20:55.908732Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794900282193368761,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-30T22:20:55.95345Z","caller":"traceutil/trace.go:171","msg":"trace[1832954198] transaction","detail":"{read_only:false; response_revision:1865; number_of_response:1; }","duration":"712.985561ms","start":"2026-06-30T22:20:55.240446Z","end":"2026-06-30T22:20:55.953432Z","steps":["trace[1832954198] 'process raft request' (duration: 712.95559ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:20:55.953621Z","caller":"traceutil/trace.go:171","msg":"trace[1796706962] transaction","detail":"{read_only:false; response_revision:1864; number_of_response:1; }","duration":"715.604253ms","start":"2026-06-30T22:20:55.237979Z","end":"2026-06-30T22:20:55.953583Z","steps":["trace[1796706962] 'process raft request' (duration: 715.388697ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:20:55.953685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:20:55.240426Z","time spent":"713.074483ms","remote":"127.0.0.1:53520","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T22:20:55.953783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:20:55.237966Z","time spent":"715.728006ms","remote":"127.0.0.1:53422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3731,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T22:20:55.953946Z","caller":"traceutil/trace.go:171","msg":"trace[454990327] transaction","detail":"{read_only:false; response_revision:1863; number_of_response:1; }","duration":"719.219573ms","start":"2026-06-30T22:20:55.234705Z","end":"2026-06-30T22:20:55.953924Z","steps":["trace[454990327] 'process raft request' (duration: 718.565035ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:20:55.954009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:20:55.234674Z","time spent":"719.306006ms","remote":"127.0.0.1:53520","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T22:20:56.079257Z","caller":"traceutil/trace.go:171","msg":"trace[253984451] transaction","detail":"{read_only:false; response_revision:1866; number_of_response:1; }","duration":"575.113712ms","start":"2026-06-30T22:20:55.504116Z","end":"2026-06-30T22:20:56.079229Z","steps":["trace[253984451] 'process raft request' (duration: 569.897868ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:20:56.07945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:20:55.504082Z","time spent":"575.271027ms","remote":"127.0.0.1:53520","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T22:20:56.079606Z","caller":"traceutil/trace.go:171","msg":"trace[571885591] transaction","detail":"{read_only:false; response_revision:1867; number_of_response:1; }","duration":"501.034016ms","start":"2026-06-30T22:20:55.578534Z","end":"2026-06-30T22:20:56.079568Z","steps":["trace[571885591] 'process raft request' (duration: 500.630955ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:20:56.079683Z","caller":"traceutil/trace.go:171","msg":"trace[1970442130] linearizableReadLoop","detail":"{readStateIndex:1940; appliedIndex:1938; }","duration":"670.958813ms","start":"2026-06-30T22:20:55.408674Z","end":"2026-06-30T22:20:56.079633Z","steps":["trace[1970442130] 'read index received' (duration: 544.932606ms)","trace[1970442130] 'applied index is now lower than readState.Index' (duration: 126.017856ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T22:20:56.079774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:20:55.578515Z","time spent":"501.16728ms","remote":"127.0.0.1:53520","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T22:20:56.079855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"671.173078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5508108f-a452-48d1-8340-82a69c921fde\" ","response":"range_response_count:1 size:3746"} {"level":"info","ts":"2026-06-30T22:20:56.079929Z","caller":"traceutil/trace.go:171","msg":"trace[1428289498] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-5508108f-a452-48d1-8340-82a69c921fde; range_end:; response_count:1; response_revision:1868; }","duration":"671.303452ms","start":"2026-06-30T22:20:55.408607Z","end":"2026-06-30T22:20:56.07991Z","steps":["trace[1428289498] 'agreement among raft nodes before linearized reading' (duration: 671.111227ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:20:56.07997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:20:55.408576Z","time spent":"671.385425ms","remote":"127.0.0.1:53422","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-5508108f-a452-48d1-8340-82a69c921fde\" "} {"level":"warn","ts":"2026-06-30T22:20:56.080127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.610108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-30T22:20:56.080186Z","caller":"traceutil/trace.go:171","msg":"trace[2096318011] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1868; }","duration":"503.782263ms","start":"2026-06-30T22:20:55.576388Z","end":"2026-06-30T22:20:56.08017Z","steps":["trace[2096318011] 'agreement among raft nodes before linearized reading' (duration: 503.485234ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:20:56.080337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:20:55.576364Z","time spent":"503.963008ms","remote":"127.0.0.1:41428","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5436,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-06-30T22:21:46.42416Z","caller":"traceutil/trace.go:171","msg":"trace[598842682] transaction","detail":"{read_only:false; response_revision:2187; number_of_response:1; }","duration":"154.398364ms","start":"2026-06-30T22:21:46.269738Z","end":"2026-06-30T22:21:46.424136Z","steps":["trace[598842682] 'process raft request' (duration: 154.346712ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:21:46.424208Z","caller":"traceutil/trace.go:171","msg":"trace[620262385] transaction","detail":"{read_only:false; response_revision:2186; number_of_response:1; }","duration":"155.824733ms","start":"2026-06-30T22:21:46.268358Z","end":"2026-06-30T22:21:46.424183Z","steps":["trace[620262385] 'process raft request' (duration: 155.594347ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:21:46.587753Z","caller":"traceutil/trace.go:171","msg":"trace[2128910735] linearizableReadLoop","detail":"{readStateIndex:2271; appliedIndex:2270; }","duration":"112.963835ms","start":"2026-06-30T22:21:46.474753Z","end":"2026-06-30T22:21:46.587716Z","steps":["trace[2128910735] 'read index received' (duration: 86.82338ms)","trace[2128910735] 'applied index is now lower than readState.Index' (duration: 26.139455ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T22:21:46.587812Z","caller":"traceutil/trace.go:171","msg":"trace[971243709] transaction","detail":"{read_only:false; response_revision:2188; number_of_response:1; }","duration":"296.903659ms","start":"2026-06-30T22:21:46.29087Z","end":"2026-06-30T22:21:46.587774Z","steps":["trace[971243709] 'process raft request' (duration: 270.763643ms)","trace[971243709] 'compare' (duration: 25.94586ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T22:21:46.588024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.246833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-06-30T22:21:46.588078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.700672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-30T22:21:46.588133Z","caller":"traceutil/trace.go:171","msg":"trace[508452938] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2188; }","duration":"113.399857ms","start":"2026-06-30T22:21:46.47471Z","end":"2026-06-30T22:21:46.58811Z","steps":["trace[508452938] 'agreement among raft nodes before linearized reading' (duration: 113.134119ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:21:46.588132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.990116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-30T22:21:46.588137Z","caller":"traceutil/trace.go:171","msg":"trace[155159388] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2188; }","duration":"110.810215ms","start":"2026-06-30T22:21:46.477306Z","end":"2026-06-30T22:21:46.588116Z","steps":["trace[155159388] 'agreement among raft nodes before linearized reading' (duration: 110.610109ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:21:46.588206Z","caller":"traceutil/trace.go:171","msg":"trace[989249948] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2188; }","duration":"104.105739ms","start":"2026-06-30T22:21:46.484083Z","end":"2026-06-30T22:21:46.588188Z","steps":["trace[989249948] 'agreement among raft nodes before linearized reading' (duration: 103.895463ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:21:46.588392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.437439ms","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-06-30T22:21:46.588474Z","caller":"traceutil/trace.go:171","msg":"trace[1459538750] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2188; }","duration":"108.545162ms","start":"2026-06-30T22:21:46.479909Z","end":"2026-06-30T22:21:46.588454Z","steps":["trace[1459538750] 'agreement among raft nodes before linearized reading' (duration: 108.118541ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:22:35.185998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.695822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"} {"level":"info","ts":"2026-06-30T22:22:35.186104Z","caller":"traceutil/trace.go:171","msg":"trace[1841904036] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2628; }","duration":"111.854476ms","start":"2026-06-30T22:22:35.07423Z","end":"2026-06-30T22:22:35.186084Z","steps":["trace[1841904036] 'range keys from in-memory index tree' (duration: 111.426055ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:22:35.186073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.13961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T22:22:35.186212Z","caller":"traceutil/trace.go:171","msg":"trace[587090257] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2628; }","duration":"168.351455ms","start":"2026-06-30T22:22:35.017834Z","end":"2026-06-30T22:22:35.186185Z","steps":["trace[587090257] 'range keys from in-memory index tree' (duration: 168.005855ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:23:08.955561Z","caller":"traceutil/trace.go:171","msg":"trace[380573601] transaction","detail":"{read_only:false; response_revision:2828; number_of_response:1; }","duration":"221.557513ms","start":"2026-06-30T22:23:08.73395Z","end":"2026-06-30T22:23:08.955508Z","steps":["trace[380573601] 'process raft request' (duration: 212.86186ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:27:12.526316Z","caller":"traceutil/trace.go:171","msg":"trace[749022020] transaction","detail":"{read_only:false; response_revision:5236; number_of_response:1; }","duration":"121.162753ms","start":"2026-06-30T22:27:12.405103Z","end":"2026-06-30T22:27:12.526266Z","steps":["trace[749022020] 'process raft request' (duration: 49.648442ms)","trace[749022020] 'compare' (duration: 71.305175ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T22:27:12.526333Z","caller":"traceutil/trace.go:171","msg":"trace[936262789] transaction","detail":"{read_only:false; response_revision:5237; number_of_response:1; }","duration":"119.758173ms","start":"2026-06-30T22:27:12.406536Z","end":"2026-06-30T22:27:12.526294Z","steps":["trace[936262789] 'process raft request' (duration: 119.65047ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:28:41.935368Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3012} {"level":"info","ts":"2026-06-30T22:28:42.017015Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3012,"took":"80.301174ms","hash":57743362,"current-db-size-bytes":59027456,"current-db-size":"59 MB","current-db-size-in-use-bytes":32104448,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-30T22:28:42.017114Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":57743362,"revision":3012,"compact-revision":-1} {"level":"info","ts":"2026-06-30T22:33:41.942591Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6119} {"level":"info","ts":"2026-06-30T22:33:42.037569Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6119,"took":"93.098964ms","hash":3694240140,"current-db-size-bytes":59027456,"current-db-size":"59 MB","current-db-size-in-use-bytes":23982080,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-06-30T22:33:42.03765Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3694240140,"revision":6119,"compact-revision":3012} {"level":"info","ts":"2026-06-30T22:33:43.433037Z","caller":"traceutil/trace.go:171","msg":"trace[1172020618] transaction","detail":"{read_only:false; response_revision:8322; number_of_response:1; }","duration":"235.638801ms","start":"2026-06-30T22:33:43.197375Z","end":"2026-06-30T22:33:43.433014Z","steps":["trace[1172020618] 'process raft request' (duration: 235.514257ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:33:43.433074Z","caller":"traceutil/trace.go:171","msg":"trace[418125082] linearizableReadLoop","detail":"{readStateIndex:8619; appliedIndex:8619; }","duration":"228.699827ms","start":"2026-06-30T22:33:43.204345Z","end":"2026-06-30T22:33:43.433045Z","steps":["trace[418125082] 'read index received' (duration: 228.689687ms)","trace[418125082] 'applied index is now lower than readState.Index' (duration: 8.23µs)"],"step_count":2} {"level":"warn","ts":"2026-06-30T22:33:43.433285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.917544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"} {"level":"info","ts":"2026-06-30T22:33:43.433322Z","caller":"traceutil/trace.go:171","msg":"trace[1859843484] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:8322; }","duration":"229.015597ms","start":"2026-06-30T22:33:43.204296Z","end":"2026-06-30T22:33:43.433311Z","steps":["trace[1859843484] 'agreement among raft nodes before linearized reading' (duration: 228.855872ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:33:43.463254Z","caller":"traceutil/trace.go:171","msg":"trace[1101176415] transaction","detail":"{read_only:false; response_revision:8323; number_of_response:1; }","duration":"218.609707ms","start":"2026-06-30T22:33:43.244623Z","end":"2026-06-30T22:33:43.463233Z","steps":["trace[1101176415] 'process raft request' (duration: 209.33802ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:33:43.463716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.079579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:130570"} {"level":"info","ts":"2026-06-30T22:33:43.463766Z","caller":"traceutil/trace.go:171","msg":"trace[1513366997] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:8323; }","duration":"251.162181ms","start":"2026-06-30T22:33:43.212591Z","end":"2026-06-30T22:33:43.463753Z","steps":["trace[1513366997] 'agreement among raft nodes before linearized reading' (duration: 250.984056ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:33:57.271572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.572408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-30T22:33:57.271697Z","caller":"traceutil/trace.go:171","msg":"trace[1824635207] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:8394; }","duration":"293.755383ms","start":"2026-06-30T22:33:56.977917Z","end":"2026-06-30T22:33:57.271673Z","steps":["trace[1824635207] 'count revisions from in-memory index tree' (duration: 293.460765ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:33:57.310978Z","caller":"traceutil/trace.go:171","msg":"trace[1872234488] transaction","detail":"{read_only:false; response_revision:8395; number_of_response:1; }","duration":"291.935623ms","start":"2026-06-30T22:33:57.019012Z","end":"2026-06-30T22:33:57.310948Z","steps":["trace[1872234488] 'process raft request' (duration: 291.736848ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:33:57.322474Z","caller":"traceutil/trace.go:171","msg":"trace[1585368185] transaction","detail":"{read_only:false; response_revision:8396; number_of_response:1; }","duration":"102.199007ms","start":"2026-06-30T22:33:57.220242Z","end":"2026-06-30T22:33:57.322441Z","steps":["trace[1585368185] 'process raft request' (duration: 101.878388ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:33:58.231901Z","caller":"traceutil/trace.go:171","msg":"trace[388264863] linearizableReadLoop","detail":"{readStateIndex:8699; appliedIndex:8698; }","duration":"118.460297ms","start":"2026-06-30T22:33:58.113412Z","end":"2026-06-30T22:33:58.231872Z","steps":["trace[388264863] 'read index received' (duration: 118.246371ms)","trace[388264863] 'applied index is now lower than readState.Index' (duration: 212.306µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T22:33:58.232013Z","caller":"traceutil/trace.go:171","msg":"trace[957721155] transaction","detail":"{read_only:false; response_revision:8399; number_of_response:1; }","duration":"147.134734ms","start":"2026-06-30T22:33:58.084844Z","end":"2026-06-30T22:33:58.231978Z","steps":["trace[957721155] 'process raft request' (duration: 146.796785ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:33:58.232176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.761836ms","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-06-30T22:33:58.232235Z","caller":"traceutil/trace.go:171","msg":"trace[1163553407] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8399; }","duration":"118.89135ms","start":"2026-06-30T22:33:58.11332Z","end":"2026-06-30T22:33:58.232211Z","steps":["trace[1163553407] 'agreement among raft nodes before linearized reading' (duration: 118.717465ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:33:58.232725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.831965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-30T22:33:58.232842Z","caller":"traceutil/trace.go:171","msg":"trace[1201095197] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8399; }","duration":"107.012861ms","start":"2026-06-30T22:33:58.1258Z","end":"2026-06-30T22:33:58.232813Z","steps":["trace[1201095197] 'agreement among raft nodes before linearized reading' (duration: 106.63471ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:33:58.372903Z","caller":"traceutil/trace.go:171","msg":"trace[948450990] transaction","detail":"{read_only:false; response_revision:8400; number_of_response:1; }","duration":"135.726777ms","start":"2026-06-30T22:33:58.237143Z","end":"2026-06-30T22:33:58.37287Z","steps":["trace[948450990] 'process raft request' (duration: 38.003454ms)","trace[948450990] 'compare' (duration: 97.492337ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T22:33:58.424701Z","caller":"traceutil/trace.go:171","msg":"trace[1366628642] transaction","detail":"{read_only:false; response_revision:8401; number_of_response:1; }","duration":"187.483124ms","start":"2026-06-30T22:33:58.237193Z","end":"2026-06-30T22:33:58.424676Z","steps":["trace[1366628642] 'process raft request' (duration: 187.298489ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:33:58.424858Z","caller":"traceutil/trace.go:171","msg":"trace[1381876549] linearizableReadLoop","detail":"{readStateIndex:8701; appliedIndex:8699; }","duration":"186.945229ms","start":"2026-06-30T22:33:58.237864Z","end":"2026-06-30T22:33:58.424809Z","steps":["trace[1381876549] 'read index received' (duration: 37.206062ms)","trace[1381876549] 'applied index is now lower than readState.Index' (duration: 149.738037ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T22:33:58.425043Z","caller":"traceutil/trace.go:171","msg":"trace[1661719708] transaction","detail":"{read_only:false; response_revision:8402; number_of_response:1; }","duration":"186.97603ms","start":"2026-06-30T22:33:58.238054Z","end":"2026-06-30T22:33:58.42503Z","steps":["trace[1661719708] 'process raft request' (duration: 186.562029ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:33:58.425475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.575606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:25 size:224112"} {"level":"info","ts":"2026-06-30T22:33:58.425538Z","caller":"traceutil/trace.go:171","msg":"trace[1809327939] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:25; response_revision:8402; }","duration":"187.668709ms","start":"2026-06-30T22:33:58.237854Z","end":"2026-06-30T22:33:58.425523Z","steps":["trace[1809327939] 'agreement among raft nodes before linearized reading' (duration: 187.203886ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:33:58.606226Z","caller":"traceutil/trace.go:171","msg":"trace[1876333291] transaction","detail":"{read_only:false; response_revision:8403; number_of_response:1; }","duration":"121.108962ms","start":"2026-06-30T22:33:58.48507Z","end":"2026-06-30T22:33:58.606179Z","steps":["trace[1876333291] 'process raft request' (duration: 34.542219ms)","trace[1876333291] 'compare' (duration: 86.416749ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T22:33:59.667279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.901239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-30T22:33:59.667372Z","caller":"traceutil/trace.go:171","msg":"trace[2085576328] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8406; }","duration":"115.031283ms","start":"2026-06-30T22:33:59.552315Z","end":"2026-06-30T22:33:59.667346Z","steps":["trace[2085576328] 'range keys from in-memory index tree' (duration: 114.675074ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:34:22.548161Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000022ae.wal"} {"level":"warn","ts":"2026-06-30T22:34:30.73955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.618531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-06-30T22:34:30.739655Z","caller":"traceutil/trace.go:171","msg":"trace[1194342667] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8626; }","duration":"203.753555ms","start":"2026-06-30T22:34:30.535879Z","end":"2026-06-30T22:34:30.739632Z","steps":["trace[1194342667] 'range keys from in-memory index tree' (duration: 203.474237ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:34:30.739689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.233039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-7kwj9\" ","response":"range_response_count:1 size:6527"} {"level":"info","ts":"2026-06-30T22:34:30.739785Z","caller":"traceutil/trace.go:171","msg":"trace[687736571] range","detail":"{range_begin:/registry/pods/openstack/keepalived-7kwj9; range_end:; response_count:1; response_revision:8626; }","duration":"128.425274ms","start":"2026-06-30T22:34:30.611338Z","end":"2026-06-30T22:34:30.739763Z","steps":["trace[687736571] 'range keys from in-memory index tree' (duration: 128.037694ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:34:30.739535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.188338ms","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-06-30T22:34:30.739948Z","caller":"traceutil/trace.go:171","msg":"trace[1069050929] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8626; }","duration":"141.646461ms","start":"2026-06-30T22:34:30.598282Z","end":"2026-06-30T22:34:30.739928Z","steps":["trace[1069050929] 'range keys from in-memory index tree' (duration: 141.064865ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:34:30.740309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.531582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-30T22:34:30.740427Z","caller":"traceutil/trace.go:171","msg":"trace[716365323] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8626; }","duration":"157.711697ms","start":"2026-06-30T22:34:30.582701Z","end":"2026-06-30T22:34:30.740413Z","steps":["trace[716365323] 'range keys from in-memory index tree' (duration: 156.532445ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:34:30.896779Z","caller":"traceutil/trace.go:171","msg":"trace[1895638834] transaction","detail":"{read_only:false; response_revision:8628; number_of_response:1; }","duration":"153.51989ms","start":"2026-06-30T22:34:30.743233Z","end":"2026-06-30T22:34:30.896753Z","steps":["trace[1895638834] 'process raft request' (duration: 153.321885ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:34:30.897158Z","caller":"traceutil/trace.go:171","msg":"trace[1847194404] transaction","detail":"{read_only:false; response_revision:8629; number_of_response:1; }","duration":"153.569472ms","start":"2026-06-30T22:34:30.743558Z","end":"2026-06-30T22:34:30.897127Z","steps":["trace[1847194404] 'process raft request' (duration: 153.15393ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:34:30.897173Z","caller":"traceutil/trace.go:171","msg":"trace[1418161094] linearizableReadLoop","detail":"{readStateIndex:8940; appliedIndex:8936; }","duration":"153.039827ms","start":"2026-06-30T22:34:30.744099Z","end":"2026-06-30T22:34:30.897139Z","steps":["trace[1418161094] 'read index received' (duration: 83.361023ms)","trace[1418161094] 'applied index is now lower than readState.Index' (duration: 69.677424ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T22:34:30.897396Z","caller":"traceutil/trace.go:171","msg":"trace[1100385094] transaction","detail":"{read_only:false; response_revision:8630; number_of_response:1; }","duration":"153.692085ms","start":"2026-06-30T22:34:30.743671Z","end":"2026-06-30T22:34:30.897363Z","steps":["trace[1100385094] 'process raft request' (duration: 153.328825ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:34:30.897768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.640014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:26 size:228839"} {"level":"info","ts":"2026-06-30T22:34:30.897831Z","caller":"traceutil/trace.go:171","msg":"trace[70241830] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:26; response_revision:8630; }","duration":"153.751107ms","start":"2026-06-30T22:34:30.744065Z","end":"2026-06-30T22:34:30.897816Z","steps":["trace[70241830] 'agreement among raft nodes before linearized reading' (duration: 153.196071ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:34:39.887336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.170489ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T22:34:39.887434Z","caller":"traceutil/trace.go:171","msg":"trace[1441126051] linearizableReadLoop","detail":"{readStateIndex:9029; appliedIndex:9028; }","duration":"157.091049ms","start":"2026-06-30T22:34:39.730328Z","end":"2026-06-30T22:34:39.887419Z","steps":["trace[1441126051] 'read index received' (duration: 33.712025ms)","trace[1441126051] 'applied index is now lower than readState.Index' (duration: 123.377754ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T22:34:39.887661Z","caller":"traceutil/trace.go:171","msg":"trace[1332345153] transaction","detail":"{read_only:false; response_revision:8716; number_of_response:1; }","duration":"157.738647ms","start":"2026-06-30T22:34:39.729903Z","end":"2026-06-30T22:34:39.887642Z","steps":["trace[1332345153] 'process raft request' (duration: 34.182099ms)","trace[1332345153] 'compare' (duration: 122.782617ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T22:34:39.887848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.509521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-v9nzx\" ","response":"range_response_count:1 size:4644"} {"level":"info","ts":"2026-06-30T22:34:39.887905Z","caller":"traceutil/trace.go:171","msg":"trace[532152610] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-v9nzx; range_end:; response_count:1; response_revision:8716; }","duration":"157.592643ms","start":"2026-06-30T22:34:39.730298Z","end":"2026-06-30T22:34:39.887891Z","steps":["trace[532152610] 'agreement among raft nodes before linearized reading' (duration: 157.495871ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:34:40.033805Z","caller":"traceutil/trace.go:171","msg":"trace[482056193] transaction","detail":"{read_only:false; response_revision:8717; number_of_response:1; }","duration":"142.129655ms","start":"2026-06-30T22:34:39.89165Z","end":"2026-06-30T22:34:40.033779Z","steps":["trace[482056193] 'process raft request' (duration: 127.625112ms)","trace[482056193] 'compare' (duration: 14.298247ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T22:34:40.052503Z","caller":"traceutil/trace.go:171","msg":"trace[2080748818] transaction","detail":"{read_only:false; response_revision:8718; number_of_response:1; }","duration":"157.089539ms","start":"2026-06-30T22:34:39.895388Z","end":"2026-06-30T22:34:40.052478Z","steps":["trace[2080748818] 'process raft request' (duration: 156.948586ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:35:40.405685Z","caller":"traceutil/trace.go:171","msg":"trace[1319695142] linearizableReadLoop","detail":"{readStateIndex:9700; appliedIndex:9699; }","duration":"111.276199ms","start":"2026-06-30T22:35:40.294389Z","end":"2026-06-30T22:35:40.405665Z","steps":["trace[1319695142] 'read index received' (duration: 111.212167ms)","trace[1319695142] 'applied index is now lower than readState.Index' (duration: 63.262µs)"],"step_count":2} {"level":"warn","ts":"2026-06-30T22:35:40.405844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.445513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-30T22:35:40.405873Z","caller":"traceutil/trace.go:171","msg":"trace[373559309] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:9370; }","duration":"111.509355ms","start":"2026-06-30T22:35:40.294356Z","end":"2026-06-30T22:35:40.405865Z","steps":["trace[373559309] 'agreement among raft nodes before linearized reading' (duration: 111.398472ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:35:40.40592Z","caller":"traceutil/trace.go:171","msg":"trace[305084641] transaction","detail":"{read_only:false; response_revision:9370; number_of_response:1; }","duration":"132.134077ms","start":"2026-06-30T22:35:40.273622Z","end":"2026-06-30T22:35:40.405756Z","steps":["trace[305084641] 'process raft request' (duration: 131.913161ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:35:52.93161Z","caller":"traceutil/trace.go:171","msg":"trace[192351237] transaction","detail":"{read_only:false; response_revision:9449; number_of_response:1; }","duration":"105.59236ms","start":"2026-06-30T22:35:52.825988Z","end":"2026-06-30T22:35:52.93158Z","steps":["trace[192351237] 'process raft request' (duration: 105.377104ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:36:22.247185Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"c47ca1a7b1fe506b","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-30T22:36:22.252647Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-06-30T22:36:22.252769Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-06-30T22:38:41.949182Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8314} {"level":"info","ts":"2026-06-30T22:38:42.031397Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8314,"took":"80.606506ms","hash":1137619666,"current-db-size-bytes":59027456,"current-db-size":"59 MB","current-db-size-in-use-bytes":25198592,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-06-30T22:38:42.03147Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1137619666,"revision":8314,"compact-revision":6119} {"level":"info","ts":"2026-06-30T22:39:31.761599Z","caller":"traceutil/trace.go:171","msg":"trace[856628522] transaction","detail":"{read_only:false; response_revision:10789; number_of_response:1; }","duration":"182.034749ms","start":"2026-06-30T22:39:31.579535Z","end":"2026-06-30T22:39:31.761569Z","steps":["trace[856628522] 'process raft request' (duration: 181.860374ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:39:32.397293Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794900282193391340,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-30T22:39:32.898403Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794900282193391340,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-30T22:39:33.398634Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794900282193391340,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-30T22:39:33.898888Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794900282193391340,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-30T22:39:34.01974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000107951s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-06-30T22:39:34.019855Z","caller":"traceutil/trace.go:171","msg":"trace[752948504] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000286836s","start":"2026-06-30T22:39:32.019548Z","end":"2026-06-30T22:39:34.019835Z","steps":["trace[752948504] 'agreement among raft nodes before linearized reading' (duration: 2.000135262s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:39:34.019907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:39:32.019529Z","time spent":"2.000366768s","remote":"127.0.0.1:53232","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-30T22:39:34.399974Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794900282193391340,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-30T22:39:34.900659Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794900282193391340,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-30T22:39:34.901614Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.347044875s","expected-duration":"1s"} {"level":"warn","ts":"2026-06-30T22:39:34.905783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:39:34.019976Z","time spent":"885.798392ms","remote":"127.0.0.1:37306","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-06-30T22:39:34.906067Z","caller":"traceutil/trace.go:171","msg":"trace[1676832565] transaction","detail":"{read_only:false; response_revision:10790; number_of_response:1; }","duration":"3.045372506s","start":"2026-06-30T22:39:31.86066Z","end":"2026-06-30T22:39:34.906032Z","steps":["trace[1676832565] 'process raft request' (duration: 3.041248521s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:39:34.906202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:39:31.860623Z","time spent":"3.045500739s","remote":"127.0.0.1:53520","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":543,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T22:39:34.907942Z","caller":"traceutil/trace.go:171","msg":"trace[1376925711] linearizableReadLoop","detail":"{readStateIndex:11180; appliedIndex:11173; }","duration":"3.011249289s","start":"2026-06-30T22:39:31.896669Z","end":"2026-06-30T22:39:34.907918Z","steps":["trace[1376925711] 'read index received' (duration: 3.005239692s)","trace[1376925711] 'applied index is now lower than readState.Index' (duration: 6.008737ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T22:39:34.907942Z","caller":"traceutil/trace.go:171","msg":"trace[282949628] transaction","detail":"{read_only:false; response_revision:10791; number_of_response:1; }","duration":"2.905072414s","start":"2026-06-30T22:39:32.002813Z","end":"2026-06-30T22:39:34.907885Z","steps":["trace[282949628] 'process raft request' (duration: 2.904825018s)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:39:34.908037Z","caller":"traceutil/trace.go:171","msg":"trace[1509206315] transaction","detail":"{read_only:false; response_revision:10792; number_of_response:1; }","duration":"2.326589227s","start":"2026-06-30T22:39:32.581437Z","end":"2026-06-30T22:39:34.908027Z","steps":["trace[1509206315] 'process raft request' (duration: 2.326346771s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:39:34.908129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:39:32.581412Z","time spent":"2.326651439s","remote":"127.0.0.1:53520","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T22:39:34.90817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:39:32.00278Z","time spent":"2.90527023s","remote":"127.0.0.1:53520","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T22:39:34.908302Z","caller":"traceutil/trace.go:171","msg":"trace[1449770869] transaction","detail":"{read_only:false; response_revision:10793; number_of_response:1; }","duration":"2.326799224s","start":"2026-06-30T22:39:32.581488Z","end":"2026-06-30T22:39:34.908287Z","steps":["trace[1449770869] 'process raft request' (duration: 2.32632832s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:39:34.908349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:39:32.581468Z","time spent":"2.326855365s","remote":"127.0.0.1:53520","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T22:39:34.908458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.011784135s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-30T22:39:34.90851Z","caller":"traceutil/trace.go:171","msg":"trace[955033242] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:10796; }","duration":"3.011881827s","start":"2026-06-30T22:39:31.896616Z","end":"2026-06-30T22:39:34.908498Z","steps":["trace[955033242] 'agreement among raft nodes before linearized reading' (duration: 3.011753954s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:39:34.908538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:39:31.896594Z","time spent":"3.011938518s","remote":"127.0.0.1:53594","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":112,"response size":31,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true "} {"level":"info","ts":"2026-06-30T22:39:34.908659Z","caller":"traceutil/trace.go:171","msg":"trace[811714262] transaction","detail":"{read_only:false; response_revision:10794; number_of_response:1; }","duration":"1.726616006s","start":"2026-06-30T22:39:33.182036Z","end":"2026-06-30T22:39:34.908652Z","steps":["trace[811714262] 'process raft request' (duration: 1.725802943s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:39:34.908711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:39:33.18201Z","time spent":"1.726662167s","remote":"127.0.0.1:53520","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T22:39:34.908812Z","caller":"traceutil/trace.go:171","msg":"trace[96865646] transaction","detail":"{read_only:false; response_revision:10795; number_of_response:1; }","duration":"213.136782ms","start":"2026-06-30T22:39:34.695669Z","end":"2026-06-30T22:39:34.908806Z","steps":["trace[96865646] 'process raft request' (duration: 212.196926ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:39:34.90848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.852576398s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-30T22:39:34.909013Z","caller":"traceutil/trace.go:171","msg":"trace[1992303556] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:10796; }","duration":"2.853143794s","start":"2026-06-30T22:39:32.055863Z","end":"2026-06-30T22:39:34.909007Z","steps":["trace[1992303556] 'agreement among raft nodes before linearized reading' (duration: 2.852540047s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:39:34.909035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:39:32.055844Z","time spent":"2.853184215s","remote":"127.0.0.1:53520","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-30T22:39:34.909105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.143338396s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-06-30T22:39:34.909128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.454395693s","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-06-30T22:39:34.909138Z","caller":"traceutil/trace.go:171","msg":"trace[627765075] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:10796; }","duration":"1.143424608s","start":"2026-06-30T22:39:33.765704Z","end":"2026-06-30T22:39:34.909128Z","steps":["trace[627765075] 'agreement among raft nodes before linearized reading' (duration: 1.143299174s)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:39:34.909144Z","caller":"traceutil/trace.go:171","msg":"trace[1210441928] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:10796; }","duration":"2.454441004s","start":"2026-06-30T22:39:32.454696Z","end":"2026-06-30T22:39:34.909137Z","steps":["trace[1210441928] 'agreement among raft nodes before linearized reading' (duration: 2.454384043s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:39:34.909157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:39:32.454679Z","time spent":"2.454474385s","remote":"127.0.0.1:53520","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-30T22:39:34.909159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:39:33.765674Z","time spent":"1.14348028s","remote":"127.0.0.1:53520","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-30T22:39:34.909222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.193008833s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1986"} {"level":"info","ts":"2026-06-30T22:39:34.909234Z","caller":"traceutil/trace.go:171","msg":"trace[1666821999] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:10796; }","duration":"2.193054605s","start":"2026-06-30T22:39:32.716175Z","end":"2026-06-30T22:39:34.909229Z","steps":["trace[1666821999] 'agreement among raft nodes before linearized reading' (duration: 2.193010063s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:39:34.909248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:39:32.716156Z","time spent":"2.193088685s","remote":"127.0.0.1:53426","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":1,"response size":2010,"request content":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" "} {"level":"warn","ts":"2026-06-30T22:39:34.909343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.909231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"} {"level":"warn","ts":"2026-06-30T22:39:34.909353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.448337975s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-30T22:39:34.909361Z","caller":"traceutil/trace.go:171","msg":"trace[1358304269] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:10796; }","duration":"418.952581ms","start":"2026-06-30T22:39:34.490402Z","end":"2026-06-30T22:39:34.909355Z","steps":["trace[1358304269] 'agreement among raft nodes before linearized reading' (duration: 418.89761ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:39:34.909367Z","caller":"traceutil/trace.go:171","msg":"trace[1928396073] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:10796; }","duration":"2.448378695s","start":"2026-06-30T22:39:32.460984Z","end":"2026-06-30T22:39:34.909363Z","steps":["trace[1928396073] 'agreement among raft nodes before linearized reading' (duration: 2.448337184s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:39:34.909369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.466259792s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-06-30T22:39:34.90938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:39:32.460969Z","time spent":"2.448407237s","remote":"127.0.0.1:53520","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-30T22:39:34.909398Z","caller":"traceutil/trace.go:171","msg":"trace[1348534033] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:10796; }","duration":"2.466333634s","start":"2026-06-30T22:39:32.443056Z","end":"2026-06-30T22:39:34.90939Z","steps":["trace[1348534033] 'agreement among raft nodes before linearized reading' (duration: 2.466257632s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:39:34.909401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"888.543817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T22:39:34.909419Z","caller":"traceutil/trace.go:171","msg":"trace[1840822355] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:10796; }","duration":"888.595359ms","start":"2026-06-30T22:39:34.020817Z","end":"2026-06-30T22:39:34.909412Z","steps":["trace[1840822355] 'agreement among raft nodes before linearized reading' (duration: 888.569318ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:39:34.909435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:39:34.020801Z","time spent":"888.63066ms","remote":"127.0.0.1:53240","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-30T22:39:34.909537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"894.705009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-30T22:39:34.909556Z","caller":"traceutil/trace.go:171","msg":"trace[1141626786] range","detail":"{range_begin:/registry/cert-manager.io/certificates/; range_end:/registry/cert-manager.io/certificates0; response_count:0; response_revision:10796; }","duration":"894.751421ms","start":"2026-06-30T22:39:34.014795Z","end":"2026-06-30T22:39:34.909546Z","steps":["trace[1141626786] 'agreement among raft nodes before linearized reading' (duration: 894.712559ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:39:34.909565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"894.915695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-30T22:39:34.90957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:39:34.014773Z","time spent":"894.792301ms","remote":"127.0.0.1:52230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":15,"response size":31,"request content":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" count_only:true "} {"level":"info","ts":"2026-06-30T22:39:34.909584Z","caller":"traceutil/trace.go:171","msg":"trace[582230773] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:10796; }","duration":"894.957615ms","start":"2026-06-30T22:39:34.014621Z","end":"2026-06-30T22:39:34.909578Z","steps":["trace[582230773] 'agreement among raft nodes before linearized reading' (duration: 894.924765ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:39:34.909599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:39:34.014608Z","time spent":"894.987317ms","remote":"127.0.0.1:56672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-30T22:39:34.909419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:39:32.443032Z","time spent":"2.466381885s","remote":"127.0.0.1:53520","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-30T22:39:34.909376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:39:34.490388Z","time spent":"418.983393ms","remote":"127.0.0.1:53422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12236,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-06-30T22:41:29.991329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.918511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/cinder-backup-5fdfbb8557-9rsrx.18bdfd0c9c09d1b9\" ","response":"range_response_count:1 size:811"} {"level":"warn","ts":"2026-06-30T22:41:29.991379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.424351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T22:41:29.991433Z","caller":"traceutil/trace.go:171","msg":"trace[1846574152] range","detail":"{range_begin:/registry/events/openstack/cinder-backup-5fdfbb8557-9rsrx.18bdfd0c9c09d1b9; range_end:; response_count:1; response_revision:11866; }","duration":"140.087316ms","start":"2026-06-30T22:41:29.851326Z","end":"2026-06-30T22:41:29.991413Z","steps":["trace[1846574152] 'range keys from in-memory index tree' (duration: 139.738276ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:41:29.99146Z","caller":"traceutil/trace.go:171","msg":"trace[1781568662] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:11866; }","duration":"239.543255ms","start":"2026-06-30T22:41:29.751897Z","end":"2026-06-30T22:41:29.99144Z","steps":["trace[1781568662] 'count revisions from in-memory index tree' (duration: 239.37208ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:41:29.991459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.42102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-7kwj9\" ","response":"range_response_count:1 size:6527"} {"level":"info","ts":"2026-06-30T22:41:29.991507Z","caller":"traceutil/trace.go:171","msg":"trace[1032016994] range","detail":"{range_begin:/registry/pods/openstack/keepalived-7kwj9; range_end:; response_count:1; response_revision:11866; }","duration":"213.494612ms","start":"2026-06-30T22:41:29.777999Z","end":"2026-06-30T22:41:29.991493Z","steps":["trace[1032016994] 'range keys from in-memory index tree' (duration: 213.204154ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:43:41.956384Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10537} {"level":"info","ts":"2026-06-30T22:43:42.038681Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10537,"took":"79.810903ms","hash":537600965,"current-db-size-bytes":59027456,"current-db-size":"59 MB","current-db-size-in-use-bytes":26161152,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-06-30T22:43:42.038786Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":537600965,"revision":10537,"compact-revision":8314} {"level":"info","ts":"2026-06-30T22:48:34.219305Z","caller":"traceutil/trace.go:171","msg":"trace[198856659] transaction","detail":"{read_only:false; response_revision:14851; number_of_response:1; }","duration":"179.306665ms","start":"2026-06-30T22:48:34.039979Z","end":"2026-06-30T22:48:34.219286Z","steps":["trace[198856659] 'process raft request' (duration: 175.53906ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:48:34.21964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.740788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-30T22:48:34.219743Z","caller":"traceutil/trace.go:171","msg":"trace[2103874518] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:14852; }","duration":"183.898452ms","start":"2026-06-30T22:48:34.035824Z","end":"2026-06-30T22:48:34.219723Z","steps":["trace[2103874518] 'agreement among raft nodes before linearized reading' (duration: 183.622065ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:48:41.962756Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12747} {"level":"info","ts":"2026-06-30T22:48:42.039737Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12747,"took":"74.339192ms","hash":3519294939,"current-db-size-bytes":59027456,"current-db-size":"59 MB","current-db-size-in-use-bytes":28504064,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-06-30T22:48:42.039794Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3519294939,"revision":12747,"compact-revision":10537} {"level":"info","ts":"2026-06-30T22:50:00.524639Z","caller":"traceutil/trace.go:171","msg":"trace[1831035519] linearizableReadLoop","detail":"{readStateIndex:16211; appliedIndex:16210; }","duration":"118.452576ms","start":"2026-06-30T22:50:00.406158Z","end":"2026-06-30T22:50:00.524611Z","steps":["trace[1831035519] 'read index received' (duration: 69.278932ms)","trace[1831035519] 'applied index is now lower than readState.Index' (duration: 49.172144ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T22:50:00.52481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.634451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T22:50:00.524852Z","caller":"traceutil/trace.go:171","msg":"trace[48897716] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15664; }","duration":"118.747955ms","start":"2026-06-30T22:50:00.406091Z","end":"2026-06-30T22:50:00.524839Z","steps":["trace[48897716] 'agreement among raft nodes before linearized reading' (duration: 118.664562ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:50:00.524844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.464356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-user\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-30T22:50:00.524907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.151028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T22:50:00.524931Z","caller":"traceutil/trace.go:171","msg":"trace[779101748] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:15664; }","duration":"118.57976ms","start":"2026-06-30T22:50:00.406332Z","end":"2026-06-30T22:50:00.524912Z","steps":["trace[779101748] 'agreement among raft nodes before linearized reading' (duration: 118.442676ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:50:00.524983Z","caller":"traceutil/trace.go:171","msg":"trace[1388901856] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:15664; }","duration":"118.24907ms","start":"2026-06-30T22:50:00.406715Z","end":"2026-06-30T22:50:00.524964Z","steps":["trace[1388901856] 'agreement among raft nodes before linearized reading' (duration: 118.130447ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:50:00.525018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.810321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"} {"level":"info","ts":"2026-06-30T22:50:00.525092Z","caller":"traceutil/trace.go:171","msg":"trace[1228818229] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15664; }","duration":"116.920193ms","start":"2026-06-30T22:50:00.408156Z","end":"2026-06-30T22:50:00.525077Z","steps":["trace[1228818229] 'agreement among raft nodes before linearized reading' (duration: 116.684387ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:53:41.968895Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14921} {"level":"info","ts":"2026-06-30T22:53:42.059083Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14921,"took":"88.00293ms","hash":3757063394,"current-db-size-bytes":59027456,"current-db-size":"59 MB","current-db-size-in-use-bytes":30134272,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-30T22:53:42.059168Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3757063394,"revision":14921,"compact-revision":12747} {"level":"info","ts":"2026-06-30T22:58:41.975175Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17367} {"level":"info","ts":"2026-06-30T22:58:42.071267Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17367,"took":"92.72663ms","hash":2047180500,"current-db-size-bytes":59027456,"current-db-size":"59 MB","current-db-size-in-use-bytes":29487104,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-30T22:58:42.071317Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2047180500,"revision":17367,"compact-revision":14921} {"level":"info","ts":"2026-06-30T22:59:16.796489Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"c47ca1a7b1fe506b","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-30T22:59:16.802216Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-06-30T22:59:16.80235Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"warn","ts":"2026-06-30T23:03:23.546858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.510342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-j8jck\" ","response":"range_response_count:1 size:20641"} {"level":"info","ts":"2026-06-30T23:03:23.546934Z","caller":"traceutil/trace.go:171","msg":"trace[1403398970] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-j8jck; range_end:; response_count:1; response_revision:20637; }","duration":"368.631985ms","start":"2026-06-30T23:03:23.178284Z","end":"2026-06-30T23:03:23.546916Z","steps":["trace[1403398970] 'range keys from in-memory index tree' (duration: 368.360737ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:03:23.546967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T23:03:23.178258Z","time spent":"368.700597ms","remote":"127.0.0.1:53422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":20665,"request content":"key:\"/registry/pods/openstack/libvirt-libvirt-default-j8jck\" "} {"level":"warn","ts":"2026-06-30T23:03:23.547434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.747759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:703"} {"level":"info","ts":"2026-06-30T23:03:23.547464Z","caller":"traceutil/trace.go:171","msg":"trace[491999334] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:20637; }","duration":"302.805341ms","start":"2026-06-30T23:03:23.244651Z","end":"2026-06-30T23:03:23.547457Z","steps":["trace[491999334] 'range keys from in-memory index tree' (duration: 302.669897ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:03:23.547484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T23:03:23.244636Z","time spent":"302.842582ms","remote":"127.0.0.1:53412","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":727,"request content":"key:\"/registry/services/endpoints/openstack/neutron-server\" "} {"level":"warn","ts":"2026-06-30T23:03:23.547526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"659.184686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-30T23:03:23.547656Z","caller":"traceutil/trace.go:171","msg":"trace[1758686096] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:20637; }","duration":"659.461674ms","start":"2026-06-30T23:03:22.888174Z","end":"2026-06-30T23:03:23.547636Z","steps":["trace[1758686096] 'count revisions from in-memory index tree' (duration: 658.985861ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:03:23.547698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T23:03:22.888153Z","time spent":"659.533326ms","remote":"127.0.0.1:53346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":124,"response size":32,"request content":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true "} {"level":"warn","ts":"2026-06-30T23:03:23.547875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.522783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-tjp8d\" ","response":"range_response_count:1 size:22097"} {"level":"info","ts":"2026-06-30T23:03:23.547899Z","caller":"traceutil/trace.go:171","msg":"trace[32442114] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-tjp8d; range_end:; response_count:1; response_revision:20637; }","duration":"149.586115ms","start":"2026-06-30T23:03:23.398307Z","end":"2026-06-30T23:03:23.547893Z","steps":["trace[32442114] 'range keys from in-memory index tree' (duration: 149.428801ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:03:23.548061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"550.425013ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-tjp8d\" ","response":"range_response_count:1 size:22097"} {"level":"warn","ts":"2026-06-30T23:03:23.548114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"803.312561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-30T23:03:23.548147Z","caller":"traceutil/trace.go:171","msg":"trace[1440675963] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:20637; }","duration":"803.389603ms","start":"2026-06-30T23:03:22.744747Z","end":"2026-06-30T23:03:23.548137Z","steps":["trace[1440675963] 'range keys from in-memory index tree' (duration: 803.217117ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:03:23.548158Z","caller":"traceutil/trace.go:171","msg":"trace[294294081] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-tjp8d; range_end:; response_count:1; response_revision:20637; }","duration":"550.6565ms","start":"2026-06-30T23:03:22.99748Z","end":"2026-06-30T23:03:23.548136Z","steps":["trace[294294081] 'range keys from in-memory index tree' (duration: 550.205097ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:03:23.548174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T23:03:22.744712Z","time spent":"803.453994ms","remote":"127.0.0.1:53656","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":30,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"warn","ts":"2026-06-30T23:03:23.548236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T23:03:22.997422Z","time spent":"550.797403ms","remote":"127.0.0.1:53422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":22121,"request content":"key:\"/registry/pods/openstack/nova-compute-default-tjp8d\" "} {"level":"warn","ts":"2026-06-30T23:03:23.54851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"544.882309ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-7kwj9\" ","response":"range_response_count:1 size:6528"} {"level":"info","ts":"2026-06-30T23:03:23.548619Z","caller":"traceutil/trace.go:171","msg":"trace[1290712087] range","detail":"{range_begin:/registry/pods/openstack/keepalived-7kwj9; range_end:; response_count:1; response_revision:20637; }","duration":"545.029303ms","start":"2026-06-30T23:03:23.003564Z","end":"2026-06-30T23:03:23.548593Z","steps":["trace[1290712087] 'range keys from in-memory index tree' (duration: 544.724575ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:03:23.548684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T23:03:23.003543Z","time spent":"545.125466ms","remote":"127.0.0.1:53422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6552,"request content":"key:\"/registry/pods/openstack/keepalived-7kwj9\" "} {"level":"warn","ts":"2026-06-30T23:03:23.547723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"790.083323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/openstack/cinder-storage-init\" ","response":"range_response_count:1 size:541"} {"level":"info","ts":"2026-06-30T23:03:23.549157Z","caller":"traceutil/trace.go:171","msg":"trace[1219466332] range","detail":"{range_begin:/registry/serviceaccounts/openstack/cinder-storage-init; range_end:; response_count:1; response_revision:20637; }","duration":"791.494622ms","start":"2026-06-30T23:03:22.757576Z","end":"2026-06-30T23:03:23.54907Z","steps":["trace[1219466332] 'range keys from in-memory index tree' (duration: 789.201119ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:03:23.549266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T23:03:22.757555Z","time spent":"791.642547ms","remote":"127.0.0.1:53432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":1,"response size":565,"request content":"key:\"/registry/serviceaccounts/openstack/cinder-storage-init\" "} {"level":"warn","ts":"2026-06-30T23:03:23.550358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"824.540909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/libvirt-libvirt-default-j8jck.18bdfd750b3aaa85\\000\" range_end:\"/registry/events/openstack0\" limit:1000 revision:20637 ","response":"range_response_count:810 size:628164"} {"level":"info","ts":"2026-06-30T23:03:23.550422Z","caller":"traceutil/trace.go:171","msg":"trace[1773801566] range","detail":"{range_begin:/registry/events/openstack/libvirt-libvirt-default-j8jck.18bdfd750b3aaa85\u0000; range_end:/registry/events/openstack0; response_count:810; response_revision:20637; }","duration":"824.636711ms","start":"2026-06-30T23:03:22.72577Z","end":"2026-06-30T23:03:23.550407Z","steps":["trace[1773801566] 'range keys from in-memory index tree' (duration: 821.504425ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:03:23.550503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T23:03:22.725762Z","time spent":"824.699283ms","remote":"127.0.0.1:53324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":810,"response size":628188,"request content":"key:\"/registry/events/openstack/libvirt-libvirt-default-j8jck.18bdfd750b3aaa85\\000\" range_end:\"/registry/events/openstack0\" limit:1000 revision:20637 "} {"level":"info","ts":"2026-06-30T23:03:41.980874Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19142} {"level":"info","ts":"2026-06-30T23:03:42.069612Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19142,"took":"86.030944ms","hash":506067539,"current-db-size-bytes":59027456,"current-db-size":"59 MB","current-db-size-in-use-bytes":24883200,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-06-30T23:03:42.069709Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":506067539,"revision":19142,"compact-revision":17367}