{"level":"warn","ts":"2026-07-25T08:41:18.644517Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-25T08:41:18.644615Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.57: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.57:2380","--initial-cluster=instance=https://199.204.45.57:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.57:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.57: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-07-25T08:41:18.64468Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-25T08:41:18.644692Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.57:2380"]} {"level":"info","ts":"2026-07-25T08:41:18.644709Z","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-07-25T08:41:18.64531Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.57:2379"]} {"level":"info","ts":"2026-07-25T08:41:18.645399Z","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":8,"max-cpu-available":8,"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.57:2380"],"listen-peer-urls":["https://199.204.45.57:2380"],"advertise-client-urls":["https://199.204.45.57:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.57:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.57: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-07-25T08:41:18.649145Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.542118ms"} {"level":"info","ts":"2026-07-25T08:41:18.655733Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b6478f0ac5aeb8e1","cluster-id":"6c58cff80d4a5b62"} {"level":"info","ts":"2026-07-25T08:41:18.655801Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 switched to configuration voters=()"} {"level":"info","ts":"2026-07-25T08:41:18.655824Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became follower at term 0"} {"level":"info","ts":"2026-07-25T08:41:18.655839Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b6478f0ac5aeb8e1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-25T08:41:18.655855Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became follower at term 1"} {"level":"info","ts":"2026-07-25T08:41:18.655891Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 switched to configuration voters=(13134624114678348001)"} {"level":"warn","ts":"2026-07-25T08:41:18.661745Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-25T08:41:18.663812Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-25T08:41:18.664788Z","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-07-25T08:41:18.666706Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b6478f0ac5aeb8e1","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-25T08:41:18.666993Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b6478f0ac5aeb8e1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-25T08:41:18.667133Z","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-07-25T08:41:18.667197Z","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-07-25T08:41:18.667206Z","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-07-25T08:41:18.669713Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 switched to configuration voters=(13134624114678348001)"} {"level":"info","ts":"2026-07-25T08:41:18.672272Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6c58cff80d4a5b62","local-member-id":"b6478f0ac5aeb8e1","added-peer-id":"b6478f0ac5aeb8e1","added-peer-peer-urls":["https://199.204.45.57:2380"]} {"level":"info","ts":"2026-07-25T08:41:18.676225Z","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-07-25T08:41:18.676307Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.57:2380"} {"level":"info","ts":"2026-07-25T08:41:18.676369Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.57:2380"} {"level":"info","ts":"2026-07-25T08:41:18.676435Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b6478f0ac5aeb8e1","initial-advertise-peer-urls":["https://199.204.45.57:2380"],"listen-peer-urls":["https://199.204.45.57:2380"],"advertise-client-urls":["https://199.204.45.57:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.57:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-25T08:41:18.676464Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-25T08:41:19.056515Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 is starting a new election at term 1"} {"level":"info","ts":"2026-07-25T08:41:19.056578Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-25T08:41:19.056625Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 received MsgPreVoteResp from b6478f0ac5aeb8e1 at term 1"} {"level":"info","ts":"2026-07-25T08:41:19.05665Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became candidate at term 2"} {"level":"info","ts":"2026-07-25T08:41:19.056667Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 received MsgVoteResp from b6478f0ac5aeb8e1 at term 2"} {"level":"info","ts":"2026-07-25T08:41:19.056688Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became leader at term 2"} {"level":"info","ts":"2026-07-25T08:41:19.056706Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b6478f0ac5aeb8e1 elected leader b6478f0ac5aeb8e1 at term 2"} {"level":"info","ts":"2026-07-25T08:41:19.057454Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-25T08:41:19.058302Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-25T08:41:19.058297Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b6478f0ac5aeb8e1","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.57:2379]}","request-path":"/0/members/b6478f0ac5aeb8e1/attributes","cluster-id":"6c58cff80d4a5b62","publish-timeout":"7s"} {"level":"info","ts":"2026-07-25T08:41:19.058495Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-25T08:41:19.058745Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-25T08:41:19.058771Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-25T08:41:19.06065Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6c58cff80d4a5b62","local-member-id":"b6478f0ac5aeb8e1","cluster-version":"3.5"} {"level":"info","ts":"2026-07-25T08:41:19.060719Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-25T08:41:19.060859Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-25T08:41:19.06562Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-25T08:41:19.073673Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.57:2379"} {"level":"info","ts":"2026-07-25T08:41:56.40447Z","caller":"traceutil/trace.go:171","msg":"trace[1578581518] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"127.261424ms","start":"2026-07-25T08:41:56.277184Z","end":"2026-07-25T08:41:56.404445Z","steps":["trace[1578581518] 'process raft request' (duration: 119.604656ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:41:56.405096Z","caller":"traceutil/trace.go:171","msg":"trace[562624955] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"126.15978ms","start":"2026-07-25T08:41:56.278921Z","end":"2026-07-25T08:41:56.40508Z","steps":["trace[562624955] 'process raft request' (duration: 125.843828ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:41:56.405391Z","caller":"traceutil/trace.go:171","msg":"trace[1681779177] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"116.908001ms","start":"2026-07-25T08:41:56.288457Z","end":"2026-07-25T08:41:56.405365Z","steps":["trace[1681779177] 'process raft request' (duration: 116.731634ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:41:56.405437Z","caller":"traceutil/trace.go:171","msg":"trace[295970058] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"121.166427ms","start":"2026-07-25T08:41:56.28424Z","end":"2026-07-25T08:41:56.405406Z","steps":["trace[295970058] 'process raft request' (duration: 120.642457ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:41:59.604657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.934772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-25T08:41:59.60475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.90783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-07-25T08:41:59.604825Z","caller":"traceutil/trace.go:171","msg":"trace[1953169110] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:575; }","duration":"225.14545ms","start":"2026-07-25T08:41:59.37965Z","end":"2026-07-25T08:41:59.604795Z","steps":["trace[1953169110] 'range keys from in-memory index tree' (duration: 224.777696ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:41:59.604847Z","caller":"traceutil/trace.go:171","msg":"trace[2021616031] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:575; }","duration":"221.024855ms","start":"2026-07-25T08:41:59.383788Z","end":"2026-07-25T08:41:59.604813Z","steps":["trace[2021616031] 'range keys from in-memory index tree' (duration: 220.723893ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:41:59.793192Z","caller":"traceutil/trace.go:171","msg":"trace[219484862] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"183.817425ms","start":"2026-07-25T08:41:59.609347Z","end":"2026-07-25T08:41:59.793165Z","steps":["trace[219484862] 'process raft request' (duration: 183.638608ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:42:01.50077Z","caller":"traceutil/trace.go:171","msg":"trace[271520319] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"102.758901ms","start":"2026-07-25T08:42:01.397983Z","end":"2026-07-25T08:42:01.500742Z","steps":["trace[271520319] 'process raft request' (duration: 101.832856ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:42:02.221541Z","caller":"traceutil/trace.go:171","msg":"trace[1806133013] linearizableReadLoop","detail":"{readStateIndex:613; appliedIndex:612; }","duration":"240.625775ms","start":"2026-07-25T08:42:01.980892Z","end":"2026-07-25T08:42:02.221518Z","steps":["trace[1806133013] 'read index received' (duration: 22.892613ms)","trace[1806133013] 'applied index is now lower than readState.Index' (duration: 217.729732ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T08:42:02.221638Z","caller":"traceutil/trace.go:171","msg":"trace[1300315634] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"245.639642ms","start":"2026-07-25T08:42:01.97599Z","end":"2026-07-25T08:42:02.221629Z","steps":["trace[1300315634] 'process raft request' (duration: 245.057581ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:42:02.221743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.831512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T08:42:02.221918Z","caller":"traceutil/trace.go:171","msg":"trace[1017143706] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:592; }","duration":"241.04637ms","start":"2026-07-25T08:42:01.980857Z","end":"2026-07-25T08:42:02.221904Z","steps":["trace[1017143706] 'agreement among raft nodes before linearized reading' (duration: 240.785601ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:42:02.722384Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322104649794864176,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-25T08:42:02.791858Z","caller":"traceutil/trace.go:171","msg":"trace[1112970173] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"767.969818ms","start":"2026-07-25T08:42:02.023868Z","end":"2026-07-25T08:42:02.791838Z","steps":["trace[1112970173] 'process raft request' (duration: 767.891725ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:42:02.791902Z","caller":"traceutil/trace.go:171","msg":"trace[641626616] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"787.339004ms","start":"2026-07-25T08:42:02.004528Z","end":"2026-07-25T08:42:02.791867Z","steps":["trace[641626616] 'process raft request' (duration: 787.089155ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:42:02.792463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:42:02.023825Z","time spent":"768.097012ms","remote":"127.0.0.1:59630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T08:42:02.792563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:42:02.004515Z","time spent":"787.47448ms","remote":"127.0.0.1:59404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T08:42:02.800937Z","caller":"traceutil/trace.go:171","msg":"trace[1780026979] linearizableReadLoop","detail":"{readStateIndex:616; appliedIndex:613; }","duration":"579.319582ms","start":"2026-07-25T08:42:02.221601Z","end":"2026-07-25T08:42:02.800921Z","steps":["trace[1780026979] 'read index received' (duration: 570.021678ms)","trace[1780026979] 'applied index is now lower than readState.Index' (duration: 9.296734ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T08:42:02.800998Z","caller":"traceutil/trace.go:171","msg":"trace[59917498] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"528.140509ms","start":"2026-07-25T08:42:02.272823Z","end":"2026-07-25T08:42:02.800963Z","steps":["trace[59917498] 'process raft request' (duration: 528.002974ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:42:02.801106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"727.963858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-g9r2q\" ","response":"range_response_count:1 size:16961"} {"level":"warn","ts":"2026-07-25T08:42:02.801128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:42:02.272798Z","time spent":"528.271614ms","remote":"127.0.0.1:59740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T08:42:02.801169Z","caller":"traceutil/trace.go:171","msg":"trace[247981825] range","detail":"{range_begin:/registry/pods/kube-system/cilium-g9r2q; range_end:; response_count:1; response_revision:595; }","duration":"728.031421ms","start":"2026-07-25T08:42:02.073103Z","end":"2026-07-25T08:42:02.801134Z","steps":["trace[247981825] 'agreement among raft nodes before linearized reading' (duration: 727.871125ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:42:02.801196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:42:02.073086Z","time spent":"728.104874ms","remote":"127.0.0.1:59562","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16984,"request content":"key:\"/registry/pods/kube-system/cilium-g9r2q\" "} {"level":"warn","ts":"2026-07-25T08:42:03.319944Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322104649794864182,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-25T08:42:03.820629Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322104649794864182,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-25T08:42:03.969648Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.152151378s","expected-duration":"1s"} {"level":"info","ts":"2026-07-25T08:42:04.069486Z","caller":"traceutil/trace.go:171","msg":"trace[1488928631] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"1.252086786s","start":"2026-07-25T08:42:02.817361Z","end":"2026-07-25T08:42:04.069447Z","steps":["trace[1488928631] 'process raft request' (duration: 1.152540163s)","trace[1488928631] 'compare' (duration: 98.533376ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T08:42:04.069642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:42:02.817337Z","time spent":"1.252235252s","remote":"127.0.0.1:59562","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T08:42:04.06975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.25030958s","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-07-25T08:42:04.069775Z","caller":"traceutil/trace.go:171","msg":"trace[2097734839] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:597; }","duration":"1.250369753s","start":"2026-07-25T08:42:02.819399Z","end":"2026-07-25T08:42:04.069769Z","steps":["trace[2097734839] 'agreement among raft nodes before linearized reading' (duration: 1.250271629s)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:42:04.069613Z","caller":"traceutil/trace.go:171","msg":"trace[754903707] linearizableReadLoop","detail":"{readStateIndex:618; appliedIndex:616; }","duration":"1.250156565s","start":"2026-07-25T08:42:02.819427Z","end":"2026-07-25T08:42:04.069584Z","steps":["trace[754903707] 'read index received' (duration: 1.150507918s)","trace[754903707] 'applied index is now lower than readState.Index' (duration: 99.647787ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T08:42:04.069814Z","caller":"traceutil/trace.go:171","msg":"trace[2067418389] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"881.02724ms","start":"2026-07-25T08:42:03.188782Z","end":"2026-07-25T08:42:04.069809Z","steps":["trace[2067418389] 'process raft request' (duration: 880.152278ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:42:04.069793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:42:02.819386Z","time spent":"1.250402573s","remote":"127.0.0.1:59630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-25T08:42:04.069865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:42:03.188756Z","time spent":"881.070402ms","remote":"127.0.0.1:59460","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036297,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T08:42:04.070075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.247418974s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-07-25T08:42:04.070112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.086626568s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T08:42:04.070129Z","caller":"traceutil/trace.go:171","msg":"trace[406755841] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:597; }","duration":"1.08666118s","start":"2026-07-25T08:42:02.983463Z","end":"2026-07-25T08:42:04.070124Z","steps":["trace[406755841] 'agreement among raft nodes before linearized reading' (duration: 1.086634939s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:42:04.070141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:42:02.983453Z","time spent":"1.08668495s","remote":"127.0.0.1:59354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-25T08:42:04.070109Z","caller":"traceutil/trace.go:171","msg":"trace[658719283] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:597; }","duration":"1.247463675s","start":"2026-07-25T08:42:02.822636Z","end":"2026-07-25T08:42:04.070099Z","steps":["trace[658719283] 'agreement among raft nodes before linearized reading' (duration: 1.24732259s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:42:04.070179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.088160255s","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-07-25T08:42:04.070213Z","caller":"traceutil/trace.go:171","msg":"trace[1584861157] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:597; }","duration":"1.088225188s","start":"2026-07-25T08:42:02.981979Z","end":"2026-07-25T08:42:04.070204Z","steps":["trace[1584861157] 'agreement among raft nodes before linearized reading' (duration: 1.088146575s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:42:04.070212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:42:02.82263Z","time spent":"1.247550868s","remote":"127.0.0.1:59630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-25T08:42:04.070239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:42:02.981962Z","time spent":"1.08827221s","remote":"127.0.0.1:59630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-25T08:42:04.070522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.905722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-07-25T08:42:04.070607Z","caller":"traceutil/trace.go:171","msg":"trace[368939938] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:597; }","duration":"267.102339ms","start":"2026-07-25T08:42:03.803482Z","end":"2026-07-25T08:42:04.070585Z","steps":["trace[368939938] 'agreement among raft nodes before linearized reading' (duration: 266.670544ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:42:04.645263Z","caller":"traceutil/trace.go:171","msg":"trace[862567009] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"135.432869ms","start":"2026-07-25T08:42:04.509803Z","end":"2026-07-25T08:42:04.645236Z","steps":["trace[862567009] 'process raft request' (duration: 134.262066ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:42:06.626981Z","caller":"traceutil/trace.go:171","msg":"trace[791175372] linearizableReadLoop","detail":"{readStateIndex:675; appliedIndex:674; }","duration":"179.846023ms","start":"2026-07-25T08:42:06.447112Z","end":"2026-07-25T08:42:06.626958Z","steps":["trace[791175372] 'read index received' (duration: 179.734709ms)","trace[791175372] 'applied index is now lower than readState.Index' (duration: 110.554µs)"],"step_count":2} {"level":"warn","ts":"2026-07-25T08:42:06.627167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.030919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T08:42:06.627039Z","caller":"traceutil/trace.go:171","msg":"trace[1252877010] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"335.745518ms","start":"2026-07-25T08:42:06.291249Z","end":"2026-07-25T08:42:06.626994Z","steps":["trace[1252877010] 'process raft request' (duration: 335.571732ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:42:06.627205Z","caller":"traceutil/trace.go:171","msg":"trace[1141136536] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:0; response_revision:654; }","duration":"180.134953ms","start":"2026-07-25T08:42:06.447056Z","end":"2026-07-25T08:42:06.627191Z","steps":["trace[1141136536] 'agreement among raft nodes before linearized reading' (duration: 180.000518ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:42:06.627327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:42:06.291239Z","time spent":"336.008207ms","remote":"127.0.0.1:59430","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":700,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T08:42:07.276461Z","caller":"traceutil/trace.go:171","msg":"trace[807772204] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"157.157447ms","start":"2026-07-25T08:42:07.119268Z","end":"2026-07-25T08:42:07.276426Z","steps":["trace[807772204] 'process raft request' (duration: 156.985391ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:42:12.271591Z","caller":"traceutil/trace.go:171","msg":"trace[1709986026] transaction","detail":"{read_only:false; response_revision:711; number_of_response:1; }","duration":"125.540678ms","start":"2026-07-25T08:42:12.14601Z","end":"2026-07-25T08:42:12.27155Z","steps":["trace[1709986026] 'process raft request' (duration: 117.902077ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:42:12.271644Z","caller":"traceutil/trace.go:171","msg":"trace[1802768681] transaction","detail":"{read_only:false; response_revision:713; number_of_response:1; }","duration":"124.510393ms","start":"2026-07-25T08:42:12.147118Z","end":"2026-07-25T08:42:12.271628Z","steps":["trace[1802768681] 'process raft request' (duration: 124.412559ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:42:12.271661Z","caller":"traceutil/trace.go:171","msg":"trace[1610557290] transaction","detail":"{read_only:false; response_revision:712; number_of_response:1; }","duration":"124.521632ms","start":"2026-07-25T08:42:12.147118Z","end":"2026-07-25T08:42:12.27164Z","steps":["trace[1610557290] 'process raft request' (duration: 124.353756ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:42:13.197183Z","caller":"traceutil/trace.go:171","msg":"trace[1372571211] transaction","detail":"{read_only:false; response_revision:721; number_of_response:1; }","duration":"164.066926ms","start":"2026-07-25T08:42:13.033087Z","end":"2026-07-25T08:42:13.197154Z","steps":["trace[1372571211] 'process raft request' (duration: 142.049358ms)","trace[1372571211] 'compare' (duration: 21.848792ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T08:42:13.203258Z","caller":"traceutil/trace.go:171","msg":"trace[229547175] transaction","detail":"{read_only:false; response_revision:722; number_of_response:1; }","duration":"128.339961ms","start":"2026-07-25T08:42:13.074904Z","end":"2026-07-25T08:42:13.203244Z","steps":["trace[229547175] 'process raft request' (duration: 128.01457ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:42:17.887613Z","caller":"traceutil/trace.go:171","msg":"trace[389214995] transaction","detail":"{read_only:false; response_revision:756; number_of_response:1; }","duration":"178.007517ms","start":"2026-07-25T08:42:17.709585Z","end":"2026-07-25T08:42:17.887593Z","steps":["trace[389214995] 'process raft request' (duration: 177.889113ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:42:18.351808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.798423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-07-25T08:42:18.352153Z","caller":"traceutil/trace.go:171","msg":"trace[803600494] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:756; }","duration":"183.188556ms","start":"2026-07-25T08:42:18.168945Z","end":"2026-07-25T08:42:18.352133Z","steps":["trace[803600494] 'range keys from in-memory index tree' (duration: 182.616727ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:42:18.35185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.78399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T08:42:18.352414Z","caller":"traceutil/trace.go:171","msg":"trace[1156276493] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:756; }","duration":"367.42044ms","start":"2026-07-25T08:42:17.984972Z","end":"2026-07-25T08:42:18.352392Z","steps":["trace[1156276493] 'range keys from in-memory index tree' (duration: 366.702497ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:42:18.352466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:42:17.984955Z","time spent":"367.497012ms","remote":"127.0.0.1:59354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-25T08:42:18.356392Z","caller":"traceutil/trace.go:171","msg":"trace[1659172023] transaction","detail":"{read_only:false; response_revision:757; number_of_response:1; }","duration":"177.990905ms","start":"2026-07-25T08:42:18.178383Z","end":"2026-07-25T08:42:18.356374Z","steps":["trace[1659172023] 'process raft request' (duration: 177.83066ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:42:19.378215Z","caller":"traceutil/trace.go:171","msg":"trace[674869306] transaction","detail":"{read_only:false; response_revision:762; number_of_response:1; }","duration":"199.882357ms","start":"2026-07-25T08:42:19.178307Z","end":"2026-07-25T08:42:19.37819Z","steps":["trace[674869306] 'process raft request' (duration: 199.740352ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:43:08.424292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.91954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T08:43:08.424386Z","caller":"traceutil/trace.go:171","msg":"trace[146396576] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1022; }","duration":"141.082657ms","start":"2026-07-25T08:43:08.283285Z","end":"2026-07-25T08:43:08.424368Z","steps":["trace[146396576] 'count revisions from in-memory index tree' (duration: 140.820703ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:43:08.793018Z","caller":"traceutil/trace.go:171","msg":"trace[1267860064] transaction","detail":"{read_only:false; response_revision:1024; number_of_response:1; }","duration":"112.668806ms","start":"2026-07-25T08:43:08.680329Z","end":"2026-07-25T08:43:08.792998Z","steps":["trace[1267860064] 'process raft request' (duration: 112.547946ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:43:08.823732Z","caller":"traceutil/trace.go:171","msg":"trace[345515851] linearizableReadLoop","detail":"{readStateIndex:1064; appliedIndex:1061; }","duration":"140.712464ms","start":"2026-07-25T08:43:08.682996Z","end":"2026-07-25T08:43:08.823708Z","steps":["trace[345515851] 'read index received' (duration: 109.872989ms)","trace[345515851] 'applied index is now lower than readState.Index' (duration: 30.838495ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T08:43:08.823772Z","caller":"traceutil/trace.go:171","msg":"trace[1724578010] transaction","detail":"{read_only:false; response_revision:1025; number_of_response:1; }","duration":"143.339153ms","start":"2026-07-25T08:43:08.680404Z","end":"2026-07-25T08:43:08.823744Z","steps":["trace[1724578010] 'process raft request' (duration: 143.19906ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:43:08.823815Z","caller":"traceutil/trace.go:171","msg":"trace[1902823534] transaction","detail":"{read_only:false; response_revision:1026; number_of_response:1; }","duration":"142.016873ms","start":"2026-07-25T08:43:08.681771Z","end":"2026-07-25T08:43:08.823788Z","steps":["trace[1902823534] 'process raft request' (duration: 141.904234ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:43:08.823899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.884393ms","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-07-25T08:43:08.823944Z","caller":"traceutil/trace.go:171","msg":"trace[29480551] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1026; }","duration":"140.964186ms","start":"2026-07-25T08:43:08.68297Z","end":"2026-07-25T08:43:08.823934Z","steps":["trace[29480551] 'agreement among raft nodes before linearized reading' (duration: 140.80831ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:43:10.695218Z","caller":"traceutil/trace.go:171","msg":"trace[193738786] transaction","detail":"{read_only:false; response_revision:1029; number_of_response:1; }","duration":"115.570451ms","start":"2026-07-25T08:43:10.579625Z","end":"2026-07-25T08:43:10.695195Z","steps":["trace[193738786] 'process raft request' (duration: 115.435448ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:43:10.902456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.570089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-07-25T08:43:10.90252Z","caller":"traceutil/trace.go:171","msg":"trace[297119420] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1029; }","duration":"105.678567ms","start":"2026-07-25T08:43:10.796829Z","end":"2026-07-25T08:43:10.902508Z","steps":["trace[297119420] 'range keys from in-memory index tree' (duration: 105.432776ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:43:11.103772Z","caller":"traceutil/trace.go:171","msg":"trace[1386376370] transaction","detail":"{read_only:false; response_revision:1032; number_of_response:1; }","duration":"197.704351ms","start":"2026-07-25T08:43:10.90604Z","end":"2026-07-25T08:43:11.103745Z","steps":["trace[1386376370] 'process raft request' (duration: 197.627769ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:43:11.103981Z","caller":"traceutil/trace.go:171","msg":"trace[1412185513] transaction","detail":"{read_only:false; response_revision:1031; number_of_response:1; }","duration":"197.970746ms","start":"2026-07-25T08:43:10.905999Z","end":"2026-07-25T08:43:11.10397Z","steps":["trace[1412185513] 'process raft request' (duration: 109.456648ms)","trace[1412185513] 'compare' (duration: 87.983409ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T08:43:11.104106Z","caller":"traceutil/trace.go:171","msg":"trace[1437200742] transaction","detail":"{read_only:false; response_revision:1033; number_of_response:1; }","duration":"197.857046ms","start":"2026-07-25T08:43:10.906228Z","end":"2026-07-25T08:43:11.104085Z","steps":["trace[1437200742] 'process raft request' (duration: 197.481934ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:43:11.104112Z","caller":"traceutil/trace.go:171","msg":"trace[869347106] linearizableReadLoop","detail":"{readStateIndex:1071; appliedIndex:1068; }","duration":"120.032117ms","start":"2026-07-25T08:43:10.984044Z","end":"2026-07-25T08:43:11.104076Z","steps":["trace[869347106] 'read index received' (duration: 31.338249ms)","trace[869347106] 'applied index is now lower than readState.Index' (duration: 88.690517ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T08:43:11.104289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.22889ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T08:43:11.104377Z","caller":"traceutil/trace.go:171","msg":"trace[1855885495] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1033; }","duration":"120.342979ms","start":"2026-07-25T08:43:10.984015Z","end":"2026-07-25T08:43:11.104358Z","steps":["trace[1855885495] 'agreement among raft nodes before linearized reading' (duration: 120.193494ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:43:13.477667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.173519ms","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-07-25T08:43:13.477771Z","caller":"traceutil/trace.go:171","msg":"trace[1074890425] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1037; }","duration":"369.307061ms","start":"2026-07-25T08:43:13.108439Z","end":"2026-07-25T08:43:13.477746Z","steps":["trace[1074890425] 'range keys from in-memory index tree' (duration: 368.963725ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:43:13.477828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:43:13.108411Z","time spent":"369.402204ms","remote":"127.0.0.1:59630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-25T08:43:13.478184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.127796ms","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-07-25T08:43:13.47824Z","caller":"traceutil/trace.go:171","msg":"trace[1394925715] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1037; }","duration":"370.222388ms","start":"2026-07-25T08:43:13.108005Z","end":"2026-07-25T08:43:13.478227Z","steps":["trace[1394925715] 'range keys from in-memory index tree' (duration: 369.962523ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:43:13.478282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:43:13.107986Z","time spent":"370.285349ms","remote":"127.0.0.1:59630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-25T08:43:13.478447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.171068ms","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-07-25T08:43:13.478501Z","caller":"traceutil/trace.go:171","msg":"trace[2141560624] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1037; }","duration":"370.278609ms","start":"2026-07-25T08:43:13.10821Z","end":"2026-07-25T08:43:13.478488Z","steps":["trace[2141560624] 'range keys from in-memory index tree' (duration: 370.019004ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:43:13.478534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:43:13.108192Z","time spent":"370.335691ms","remote":"127.0.0.1:59630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-25T08:43:17.375472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.393436535s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T08:43:17.375565Z","caller":"traceutil/trace.go:171","msg":"trace[1286530104] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1044; }","duration":"1.393578167s","start":"2026-07-25T08:43:15.981968Z","end":"2026-07-25T08:43:17.375546Z","steps":["trace[1286530104] 'range keys from in-memory index tree' (duration: 1.393354223s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:43:17.375603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:43:15.981946Z","time spent":"1.393649089s","remote":"127.0.0.1:59354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-25T08:43:17.375736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.545335201s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T08:43:17.376976Z","caller":"traceutil/trace.go:171","msg":"trace[2045911775] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:1044; }","duration":"1.546573323s","start":"2026-07-25T08:43:15.830381Z","end":"2026-07-25T08:43:17.376954Z","steps":["trace[2045911775] 'count revisions from in-memory index tree' (duration: 1.545238749s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:43:17.377054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:43:15.830312Z","time spent":"1.546713656s","remote":"127.0.0.1:59620","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":28,"request content":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true "} {"level":"warn","ts":"2026-07-25T08:43:17.375735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.882081081s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-25T08:43:17.377187Z","caller":"traceutil/trace.go:171","msg":"trace[1273398506] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1044; }","duration":"1.883567718s","start":"2026-07-25T08:43:15.493605Z","end":"2026-07-25T08:43:17.377172Z","steps":["trace[1273398506] 'range keys from in-memory index tree' (duration: 1.881953679s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:43:17.377235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:43:15.493591Z","time spent":"1.883630189s","remote":"127.0.0.1:59630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-25T08:43:17.37581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.881760626s","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-07-25T08:43:17.377329Z","caller":"traceutil/trace.go:171","msg":"trace[725783557] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1044; }","duration":"1.883275303s","start":"2026-07-25T08:43:15.494035Z","end":"2026-07-25T08:43:17.37731Z","steps":["trace[725783557] 'range keys from in-memory index tree' (duration: 1.881699724s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:43:17.375851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.877410896s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-07-25T08:43:17.377397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:43:15.49403Z","time spent":"1.883345194s","remote":"127.0.0.1:59630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-25T08:43:17.377431Z","caller":"traceutil/trace.go:171","msg":"trace[919283464] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1044; }","duration":"1.878996255s","start":"2026-07-25T08:43:15.498415Z","end":"2026-07-25T08:43:17.377411Z","steps":["trace[919283464] 'range keys from in-memory index tree' (duration: 1.877363326s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:43:17.377476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:43:15.4984Z","time spent":"1.879064507s","remote":"127.0.0.1:59630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-25T08:43:17.375931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.443770238s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T08:43:17.377556Z","caller":"traceutil/trace.go:171","msg":"trace[1304682315] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:1044; }","duration":"1.445397027s","start":"2026-07-25T08:43:15.93215Z","end":"2026-07-25T08:43:17.377547Z","steps":["trace[1304682315] 'count revisions from in-memory index tree' (duration: 1.443636666s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:43:17.377579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:43:15.932082Z","time spent":"1.44548858s","remote":"127.0.0.1:49740","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"warn","ts":"2026-07-25T08:43:17.376176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.158241357s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-07-25T08:43:17.377635Z","caller":"traceutil/trace.go:171","msg":"trace[414639549] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1044; }","duration":"1.159726264s","start":"2026-07-25T08:43:16.217901Z","end":"2026-07-25T08:43:17.377627Z","steps":["trace[414639549] 'range keys from in-memory index tree' (duration: 1.158144385s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:43:17.377659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:43:16.217882Z","time spent":"1.159770024s","remote":"127.0.0.1:59630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-25T08:43:17.376286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.242263331s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-25T08:43:17.376575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.152724ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-25T08:43:17.377717Z","caller":"traceutil/trace.go:171","msg":"trace[1492127596] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1044; }","duration":"1.243684437s","start":"2026-07-25T08:43:16.134015Z","end":"2026-07-25T08:43:17.3777Z","steps":["trace[1492127596] 'range keys from in-memory index tree' (duration: 1.242257091s)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:43:17.377999Z","caller":"traceutil/trace.go:171","msg":"trace[1456108962] transaction","detail":"{read_only:false; response_revision:1045; number_of_response:1; }","duration":"763.575085ms","start":"2026-07-25T08:43:16.614409Z","end":"2026-07-25T08:43:17.377984Z","steps":["trace[1456108962] 'process raft request' (duration: 438.830912ms)","trace[1456108962] 'compare' (duration: 322.700716ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T08:43:17.378129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:43:16.614388Z","time spent":"763.648687ms","remote":"127.0.0.1:59630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T08:43:17.378373Z","caller":"traceutil/trace.go:171","msg":"trace[2037807038] transaction","detail":"{read_only:false; response_revision:1046; number_of_response:1; }","duration":"660.716939ms","start":"2026-07-25T08:43:16.717644Z","end":"2026-07-25T08:43:17.378361Z","steps":["trace[2037807038] 'process raft request' (duration: 660.22371ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:43:17.378443Z","caller":"traceutil/trace.go:171","msg":"trace[1578718243] linearizableReadLoop","detail":"{readStateIndex:1085; appliedIndex:1083; }","duration":"249.260593ms","start":"2026-07-25T08:43:17.12917Z","end":"2026-07-25T08:43:17.378431Z","steps":["trace[1578718243] 'read index received' (duration: 247.758076ms)","trace[1578718243] 'applied index is now lower than readState.Index' (duration: 1.501597ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T08:43:17.378452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:43:16.71762Z","time spent":"660.785711ms","remote":"127.0.0.1:59630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T08:43:17.38052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.351861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-07-25T08:43:17.380562Z","caller":"traceutil/trace.go:171","msg":"trace[577395696] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1046; }","duration":"251.423103ms","start":"2026-07-25T08:43:17.129128Z","end":"2026-07-25T08:43:17.380551Z","steps":["trace[577395696] 'agreement among raft nodes before linearized reading' (duration: 249.358785ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:43:41.827976Z","caller":"traceutil/trace.go:171","msg":"trace[1555005477] linearizableReadLoop","detail":"{readStateIndex:1168; appliedIndex:1167; }","duration":"309.1796ms","start":"2026-07-25T08:43:41.518772Z","end":"2026-07-25T08:43:41.827951Z","steps":["trace[1555005477] 'read index received' (duration: 308.938666ms)","trace[1555005477] 'applied index is now lower than readState.Index' (duration: 240.074µs)"],"step_count":2} {"level":"info","ts":"2026-07-25T08:43:41.828116Z","caller":"traceutil/trace.go:171","msg":"trace[1630405462] transaction","detail":"{read_only:false; response_revision:1124; number_of_response:1; }","duration":"343.994652ms","start":"2026-07-25T08:43:41.484094Z","end":"2026-07-25T08:43:41.828089Z","steps":["trace[1630405462] 'process raft request' (duration: 343.721367ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:43:41.828177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.383564ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-25T08:43:41.82825Z","caller":"traceutil/trace.go:171","msg":"trace[1622986640] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1124; }","duration":"309.517146ms","start":"2026-07-25T08:43:41.518719Z","end":"2026-07-25T08:43:41.828236Z","steps":["trace[1622986640] 'agreement among raft nodes before linearized reading' (duration: 309.382594ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:43:41.828261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:43:41.484067Z","time spent":"344.101734ms","remote":"127.0.0.1:59630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T08:43:41.828295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:43:41.518699Z","time spent":"309.582357ms","remote":"127.0.0.1:59798","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":30,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"warn","ts":"2026-07-25T08:43:41.828344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.912266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-07-25T08:43:41.828368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.466111ms","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-07-25T08:43:41.828408Z","caller":"traceutil/trace.go:171","msg":"trace[718446647] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1124; }","duration":"228.008177ms","start":"2026-07-25T08:43:41.600381Z","end":"2026-07-25T08:43:41.828389Z","steps":["trace[718446647] 'agreement among raft nodes before linearized reading' (duration: 227.830024ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:43:41.828401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.81996ms","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-07-25T08:43:41.828445Z","caller":"traceutil/trace.go:171","msg":"trace[1889157487] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1124; }","duration":"236.554963ms","start":"2026-07-25T08:43:41.591869Z","end":"2026-07-25T08:43:41.828424Z","steps":["trace[1889157487] 'agreement among raft nodes before linearized reading' (duration: 236.320459ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:43:41.828477Z","caller":"traceutil/trace.go:171","msg":"trace[154269460] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1124; }","duration":"251.924441ms","start":"2026-07-25T08:43:41.576534Z","end":"2026-07-25T08:43:41.828458Z","steps":["trace[154269460] 'agreement among raft nodes before linearized reading' (duration: 251.731458ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:43:41.828634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.998143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-07-25T08:43:41.828709Z","caller":"traceutil/trace.go:171","msg":"trace[1378096233] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1124; }","duration":"263.131305ms","start":"2026-07-25T08:43:41.565563Z","end":"2026-07-25T08:43:41.828694Z","steps":["trace[1378096233] 'agreement among raft nodes before linearized reading' (duration: 262.953261ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:43:41.828773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.103433ms","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-07-25T08:43:41.828818Z","caller":"traceutil/trace.go:171","msg":"trace[1910837323] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1124; }","duration":"269.188245ms","start":"2026-07-25T08:43:41.559618Z","end":"2026-07-25T08:43:41.828806Z","steps":["trace[1910837323] 'agreement among raft nodes before linearized reading' (duration: 268.532733ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:43:42.762899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.542125ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-25T08:43:42.763009Z","caller":"traceutil/trace.go:171","msg":"trace[890986823] transaction","detail":"{read_only:false; response_revision:1125; number_of_response:1; }","duration":"929.326543ms","start":"2026-07-25T08:43:41.833663Z","end":"2026-07-25T08:43:42.76299Z","steps":["trace[890986823] 'process raft request' (duration: 478.592914ms)","trace[890986823] 'compare' (duration: 450.339892ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T08:43:42.763068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:43:41.833643Z","time spent":"929.397825ms","remote":"127.0.0.1:59630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T08:43:42.807389Z","caller":"traceutil/trace.go:171","msg":"trace[452746774] transaction","detail":"{read_only:false; response_revision:1127; number_of_response:1; }","duration":"973.118598ms","start":"2026-07-25T08:43:41.834248Z","end":"2026-07-25T08:43:42.807366Z","steps":["trace[452746774] 'process raft request' (duration: 973.052427ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:43:42.807402Z","caller":"traceutil/trace.go:171","msg":"trace[2009472586] transaction","detail":"{read_only:false; response_revision:1126; number_of_response:1; }","duration":"973.214159ms","start":"2026-07-25T08:43:41.834151Z","end":"2026-07-25T08:43:42.807365Z","steps":["trace[2009472586] 'process raft request' (duration: 973.058316ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:43:42.807525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:43:41.834239Z","time spent":"973.201349ms","remote":"127.0.0.1:59630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T08:43:42.807588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:43:41.834122Z","time spent":"973.347412ms","remote":"127.0.0.1:59630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T08:43:42.807644Z","caller":"traceutil/trace.go:171","msg":"trace[1748594146] transaction","detail":"{read_only:false; response_revision:1128; number_of_response:1; }","duration":"971.973366ms","start":"2026-07-25T08:43:41.835639Z","end":"2026-07-25T08:43:42.807612Z","steps":["trace[1748594146] 'process raft request' (duration: 971.696491ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:43:42.807789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:43:41.835625Z","time spent":"972.090939ms","remote":"127.0.0.1:59630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T08:43:42.807974Z","caller":"traceutil/trace.go:171","msg":"trace[1189765334] linearizableReadLoop","detail":"{readStateIndex:1173; appliedIndex:1168; }","duration":"925.728288ms","start":"2026-07-25T08:43:41.88222Z","end":"2026-07-25T08:43:42.807949Z","steps":["trace[1189765334] 'read index received' (duration: 430.125445ms)","trace[1189765334] 'applied index is now lower than readState.Index' (duration: 495.601573ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T08:43:42.807986Z","caller":"traceutil/trace.go:171","msg":"trace[1080380510] transaction","detail":"{read_only:false; response_revision:1129; number_of_response:1; }","duration":"972.220572ms","start":"2026-07-25T08:43:41.835739Z","end":"2026-07-25T08:43:42.80796Z","steps":["trace[1080380510] 'process raft request' (duration: 971.742763ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:43:42.808126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:43:41.835729Z","time spent":"972.324043ms","remote":"127.0.0.1:59630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T08:43:42.808297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"508.0848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-25T08:43:42.808363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"926.007102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-25T08:43:42.808436Z","caller":"traceutil/trace.go:171","msg":"trace[1428688261] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1129; }","duration":"508.245502ms","start":"2026-07-25T08:43:42.300171Z","end":"2026-07-25T08:43:42.808416Z","steps":["trace[1428688261] 'agreement among raft nodes before linearized reading' (duration: 508.042088ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:43:42.808415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"779.570666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T08:43:42.808438Z","caller":"traceutil/trace.go:171","msg":"trace[991578147] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:1129; }","duration":"926.246687ms","start":"2026-07-25T08:43:41.882176Z","end":"2026-07-25T08:43:42.808423Z","steps":["trace[991578147] 'agreement among raft nodes before linearized reading' (duration: 925.995963ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:43:42.808524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:43:42.30016Z","time spent":"508.349015ms","remote":"127.0.0.1:49818","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"info","ts":"2026-07-25T08:43:42.808493Z","caller":"traceutil/trace.go:171","msg":"trace[15684511] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1129; }","duration":"779.668627ms","start":"2026-07-25T08:43:42.028811Z","end":"2026-07-25T08:43:42.80848Z","steps":["trace[15684511] 'agreement among raft nodes before linearized reading' (duration: 779.567895ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:43:42.808681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:43:42.028799Z","time spent":"779.831361ms","remote":"127.0.0.1:59354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-25T08:43:42.808854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"839.339511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.57\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-07-25T08:43:42.808943Z","caller":"traceutil/trace.go:171","msg":"trace[1766767907] range","detail":"{range_begin:/registry/masterleases/199.204.45.57; range_end:; response_count:1; response_revision:1129; }","duration":"839.461662ms","start":"2026-07-25T08:43:41.969467Z","end":"2026-07-25T08:43:42.808929Z","steps":["trace[1766767907] 'agreement among raft nodes before linearized reading' (duration: 838.997584ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:43:42.809016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:43:41.969447Z","time spent":"839.557735ms","remote":"127.0.0.1:59404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.57\" "} {"level":"warn","ts":"2026-07-25T08:43:42.808686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:43:41.882163Z","time spent":"926.39407ms","remote":"127.0.0.1:60922","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":3,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true "} {"level":"warn","ts":"2026-07-25T08:43:44.968199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.29045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-07-25T08:43:44.968243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.588895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-07-25T08:43:44.968356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.679277ms","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-07-25T08:43:44.968351Z","caller":"traceutil/trace.go:171","msg":"trace[1682918320] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1132; }","duration":"154.528544ms","start":"2026-07-25T08:43:44.813788Z","end":"2026-07-25T08:43:44.968316Z","steps":["trace[1682918320] 'range keys from in-memory index tree' (duration: 153.939204ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:43:44.968399Z","caller":"traceutil/trace.go:171","msg":"trace[1558521954] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1132; }","duration":"154.741058ms","start":"2026-07-25T08:43:44.813642Z","end":"2026-07-25T08:43:44.968383Z","steps":["trace[1558521954] 'range keys from in-memory index tree' (duration: 154.561774ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:43:44.968252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.602236ms","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-07-25T08:43:44.968354Z","caller":"traceutil/trace.go:171","msg":"trace[1296459284] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1132; }","duration":"154.764179ms","start":"2026-07-25T08:43:44.813566Z","end":"2026-07-25T08:43:44.96833Z","steps":["trace[1296459284] 'range keys from in-memory index tree' (duration: 154.347621ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:43:44.968531Z","caller":"traceutil/trace.go:171","msg":"trace[203948220] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1132; }","duration":"154.879491ms","start":"2026-07-25T08:43:44.813633Z","end":"2026-07-25T08:43:44.968512Z","steps":["trace[203948220] 'range keys from in-memory index tree' (duration: 154.448693ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:43:44.968243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.335684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-07-25T08:43:44.96871Z","caller":"traceutil/trace.go:171","msg":"trace[739444304] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1132; }","duration":"201.857862ms","start":"2026-07-25T08:43:44.766836Z","end":"2026-07-25T08:43:44.968694Z","steps":["trace[739444304] 'range keys from in-memory index tree' (duration: 201.212732ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:43:45.235874Z","caller":"traceutil/trace.go:171","msg":"trace[858769251] transaction","detail":"{read_only:false; response_revision:1136; number_of_response:1; }","duration":"259.489859ms","start":"2026-07-25T08:43:44.976361Z","end":"2026-07-25T08:43:45.235851Z","steps":["trace[858769251] 'process raft request' (duration: 259.431748ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:43:45.236189Z","caller":"traceutil/trace.go:171","msg":"trace[1394009776] transaction","detail":"{read_only:false; response_revision:1137; number_of_response:1; }","duration":"259.03641ms","start":"2026-07-25T08:43:44.977118Z","end":"2026-07-25T08:43:45.236154Z","steps":["trace[1394009776] 'process raft request' (duration: 258.698014ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:43:45.236258Z","caller":"traceutil/trace.go:171","msg":"trace[1524421755] transaction","detail":"{read_only:false; response_revision:1134; number_of_response:1; }","duration":"260.416425ms","start":"2026-07-25T08:43:44.975833Z","end":"2026-07-25T08:43:45.236249Z","steps":["trace[1524421755] 'process raft request' (duration: 259.768083ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:43:45.236464Z","caller":"traceutil/trace.go:171","msg":"trace[1982564674] transaction","detail":"{read_only:false; response_revision:1135; number_of_response:1; }","duration":"260.575168ms","start":"2026-07-25T08:43:44.975881Z","end":"2026-07-25T08:43:45.236456Z","steps":["trace[1982564674] 'process raft request' (duration: 259.877195ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:43:47.315826Z","caller":"traceutil/trace.go:171","msg":"trace[1579841699] linearizableReadLoop","detail":"{readStateIndex:1184; appliedIndex:1183; }","duration":"203.89003ms","start":"2026-07-25T08:43:47.111911Z","end":"2026-07-25T08:43:47.315801Z","steps":["trace[1579841699] 'read index received' (duration: 203.631935ms)","trace[1579841699] 'applied index is now lower than readState.Index' (duration: 256.675µs)"],"step_count":2} {"level":"warn","ts":"2026-07-25T08:43:47.316081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.11341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T08:43:47.316142Z","caller":"traceutil/trace.go:171","msg":"trace[2056195847] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:1139; }","duration":"201.243032ms","start":"2026-07-25T08:43:47.114886Z","end":"2026-07-25T08:43:47.316129Z","steps":["trace[2056195847] 'agreement among raft nodes before linearized reading' (duration: 201.057008ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:43:47.316092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.102323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T08:43:47.315937Z","caller":"traceutil/trace.go:171","msg":"trace[27658192] transaction","detail":"{read_only:false; response_revision:1139; number_of_response:1; }","duration":"305.879581ms","start":"2026-07-25T08:43:47.01003Z","end":"2026-07-25T08:43:47.31591Z","steps":["trace[27658192] 'process raft request' (duration: 305.612276ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:43:47.31628Z","caller":"traceutil/trace.go:171","msg":"trace[950930149] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:1139; }","duration":"204.358369ms","start":"2026-07-25T08:43:47.111904Z","end":"2026-07-25T08:43:47.316262Z","steps":["trace[950930149] 'agreement among raft nodes before linearized reading' (duration: 204.026773ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:43:47.316391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:43:47.009997Z","time spent":"306.309468ms","remote":"127.0.0.1:59630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T08:43:47.828854Z","caller":"traceutil/trace.go:171","msg":"trace[892684102] transaction","detail":"{read_only:false; response_revision:1141; number_of_response:1; }","duration":"507.836065ms","start":"2026-07-25T08:43:47.320991Z","end":"2026-07-25T08:43:47.828827Z","steps":["trace[892684102] 'process raft request' (duration: 507.777884ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:43:47.82902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:43:47.320959Z","time spent":"507.972928ms","remote":"127.0.0.1:59630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T08:43:47.829202Z","caller":"traceutil/trace.go:171","msg":"trace[1162815416] transaction","detail":"{read_only:false; response_revision:1140; number_of_response:1; }","duration":"508.191661ms","start":"2026-07-25T08:43:47.320991Z","end":"2026-07-25T08:43:47.829182Z","steps":["trace[1162815416] 'process raft request' (duration: 507.57417ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:43:47.82932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:43:47.320959Z","time spent":"508.309744ms","remote":"127.0.0.1:59630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T08:43:47.836651Z","caller":"traceutil/trace.go:171","msg":"trace[118662008] transaction","detail":"{read_only:false; response_revision:1142; number_of_response:1; }","duration":"515.317761ms","start":"2026-07-25T08:43:47.321305Z","end":"2026-07-25T08:43:47.836623Z","steps":["trace[118662008] 'process raft request' (duration: 515.121338ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:43:47.83672Z","caller":"traceutil/trace.go:171","msg":"trace[234958950] transaction","detail":"{read_only:false; response_revision:1143; number_of_response:1; }","duration":"514.248541ms","start":"2026-07-25T08:43:47.322424Z","end":"2026-07-25T08:43:47.836672Z","steps":["trace[234958950] 'process raft request' (duration: 514.105448ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:43:47.836799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:43:47.321299Z","time spent":"515.410133ms","remote":"127.0.0.1:59630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T08:43:47.836973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:43:47.322418Z","time spent":"514.411184ms","remote":"127.0.0.1:59630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T08:43:47.867816Z","caller":"traceutil/trace.go:171","msg":"trace[1145280766] linearizableReadLoop","detail":"{readStateIndex:1189; appliedIndex:1184; }","duration":"352.441715ms","start":"2026-07-25T08:43:47.515333Z","end":"2026-07-25T08:43:47.867775Z","steps":["trace[1145280766] 'read index received' (duration: 313.241684ms)","trace[1145280766] 'applied index is now lower than readState.Index' (duration: 39.197991ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T08:43:47.867956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.595868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-25T08:43:47.86803Z","caller":"traceutil/trace.go:171","msg":"trace[1937878476] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1143; }","duration":"352.739741ms","start":"2026-07-25T08:43:47.515271Z","end":"2026-07-25T08:43:47.86801Z","steps":["trace[1937878476] 'agreement among raft nodes before linearized reading' (duration: 352.606068ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:43:47.868087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:43:47.515245Z","time spent":"352.831913ms","remote":"127.0.0.1:59554","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":30,"request content":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true "} {"level":"warn","ts":"2026-07-25T08:45:16.367002Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322104649794866149,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-25T08:45:16.394811Z","caller":"traceutil/trace.go:171","msg":"trace[1454286437] transaction","detail":"{read_only:false; response_revision:1429; number_of_response:1; }","duration":"684.728045ms","start":"2026-07-25T08:45:15.710054Z","end":"2026-07-25T08:45:16.394782Z","steps":["trace[1454286437] 'process raft request' (duration: 684.522799ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:45:16.395035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:45:15.710039Z","time spent":"684.853318ms","remote":"127.0.0.1:59630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T08:45:16.403715Z","caller":"traceutil/trace.go:171","msg":"trace[1652784643] linearizableReadLoop","detail":"{readStateIndex:1493; appliedIndex:1491; }","duration":"536.976171ms","start":"2026-07-25T08:45:15.866718Z","end":"2026-07-25T08:45:16.403694Z","steps":["trace[1652784643] 'read index received' (duration: 527.901792ms)","trace[1652784643] 'applied index is now lower than readState.Index' (duration: 9.073549ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T08:45:16.403929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.431459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-25T08:45:16.403941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"537.203778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T08:45:16.403985Z","caller":"traceutil/trace.go:171","msg":"trace[2113746062] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:1430; }","duration":"271.529312ms","start":"2026-07-25T08:45:16.132439Z","end":"2026-07-25T08:45:16.403968Z","steps":["trace[2113746062] 'agreement among raft nodes before linearized reading' (duration: 271.44619ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:45:16.404008Z","caller":"traceutil/trace.go:171","msg":"trace[690186402] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:1430; }","duration":"537.323962ms","start":"2026-07-25T08:45:15.866665Z","end":"2026-07-25T08:45:16.403989Z","steps":["trace[690186402] 'agreement among raft nodes before linearized reading' (duration: 537.193858ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:45:16.404038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:45:15.866643Z","time spent":"537.389643ms","remote":"127.0.0.1:59588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":28,"request content":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true "} {"level":"info","ts":"2026-07-25T08:45:16.404042Z","caller":"traceutil/trace.go:171","msg":"trace[1817791955] transaction","detail":"{read_only:false; response_revision:1430; number_of_response:1; }","duration":"242.165274ms","start":"2026-07-25T08:45:16.161848Z","end":"2026-07-25T08:45:16.404013Z","steps":["trace[1817791955] 'process raft request' (duration: 241.740402ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:45:16.404084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.752711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-07-25T08:45:16.40413Z","caller":"traceutil/trace.go:171","msg":"trace[1091602777] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1430; }","duration":"189.830793ms","start":"2026-07-25T08:45:16.214283Z","end":"2026-07-25T08:45:16.404114Z","steps":["trace[1091602777] 'agreement among raft nodes before linearized reading' (duration: 189.678319ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:45:16.404184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.710635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"warn","ts":"2026-07-25T08:45:16.404171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.080379ms","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-07-25T08:45:16.404208Z","caller":"traceutil/trace.go:171","msg":"trace[1251301721] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1430; }","duration":"205.774387ms","start":"2026-07-25T08:45:16.198426Z","end":"2026-07-25T08:45:16.4042Z","steps":["trace[1251301721] 'agreement among raft nodes before linearized reading' (duration: 205.708775ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:45:16.404243Z","caller":"traceutil/trace.go:171","msg":"trace[1336316429] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1430; }","duration":"164.193022ms","start":"2026-07-25T08:45:16.240031Z","end":"2026-07-25T08:45:16.404224Z","steps":["trace[1336316429] 'agreement among raft nodes before linearized reading' (duration: 163.959746ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:45:16.404298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.003847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-25T08:45:16.404329Z","caller":"traceutil/trace.go:171","msg":"trace[1880510477] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1430; }","duration":"164.361647ms","start":"2026-07-25T08:45:16.239959Z","end":"2026-07-25T08:45:16.404321Z","steps":["trace[1880510477] 'agreement among raft nodes before linearized reading' (duration: 163.956366ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:45:18.210649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.913379ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-07-25T08:45:18.210731Z","caller":"traceutil/trace.go:171","msg":"trace[1288708027] linearizableReadLoop","detail":"{readStateIndex:1499; appliedIndex:1498; }","duration":"225.914855ms","start":"2026-07-25T08:45:17.984803Z","end":"2026-07-25T08:45:18.210718Z","steps":["trace[1288708027] 'read index received' (duration: 31.681µs)","trace[1288708027] 'applied index is now lower than readState.Index' (duration: 225.882094ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T08:45:18.21079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.979336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T08:45:18.210807Z","caller":"traceutil/trace.go:171","msg":"trace[956220274] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1435; }","duration":"226.047358ms","start":"2026-07-25T08:45:17.984753Z","end":"2026-07-25T08:45:18.210801Z","steps":["trace[956220274] 'agreement among raft nodes before linearized reading' (duration: 225.997757ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:45:18.653398Z","caller":"traceutil/trace.go:171","msg":"trace[967828043] transaction","detail":"{read_only:false; response_revision:1436; number_of_response:1; }","duration":"249.983537ms","start":"2026-07-25T08:45:18.403397Z","end":"2026-07-25T08:45:18.65338Z","steps":["trace[967828043] 'process raft request' (duration: 249.874774ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:45:19.475605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"484.689169ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-25T08:45:19.475702Z","caller":"traceutil/trace.go:171","msg":"trace[1647466815] linearizableReadLoop","detail":"{readStateIndex:1501; appliedIndex:1499; }","duration":"1.059405318s","start":"2026-07-25T08:45:18.416281Z","end":"2026-07-25T08:45:19.475686Z","steps":["trace[1647466815] 'read index received' (duration: 237.0437ms)","trace[1647466815] 'applied index is now lower than readState.Index' (duration: 822.360608ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T08:45:19.475954Z","caller":"traceutil/trace.go:171","msg":"trace[343365719] transaction","detail":"{read_only:false; response_revision:1437; number_of_response:1; }","duration":"1.068229716s","start":"2026-07-25T08:45:18.40771Z","end":"2026-07-25T08:45:19.475939Z","steps":["trace[343365719] 'process raft request' (duration: 583.125486ms)","trace[343365719] 'compare' (duration: 483.859293ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T08:45:19.47602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:45:18.407701Z","time spent":"1.068283767s","remote":"127.0.0.1:59630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T08:45:19.476274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.059987555s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-25T08:45:19.476305Z","caller":"traceutil/trace.go:171","msg":"trace[1339310945] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1437; }","duration":"1.060031226s","start":"2026-07-25T08:45:18.416265Z","end":"2026-07-25T08:45:19.476296Z","steps":["trace[1339310945] 'agreement among raft nodes before linearized reading' (duration: 1.059917783s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:45:19.476334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:45:18.416258Z","time spent":"1.060069227s","remote":"127.0.0.1:59630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-25T08:45:19.476538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.044741459s","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-07-25T08:45:19.476568Z","caller":"traceutil/trace.go:171","msg":"trace[220640695] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1437; }","duration":"1.044807961s","start":"2026-07-25T08:45:18.431752Z","end":"2026-07-25T08:45:19.47656Z","steps":["trace[220640695] 'agreement among raft nodes before linearized reading' (duration: 1.044725449s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:45:19.476625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:45:18.431735Z","time spent":"1.044883494s","remote":"127.0.0.1:59630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-25T08:45:19.476862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.813058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T08:45:19.476898Z","caller":"traceutil/trace.go:171","msg":"trace[1016901110] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:1437; }","duration":"189.88553ms","start":"2026-07-25T08:45:19.286998Z","end":"2026-07-25T08:45:19.476884Z","steps":["trace[1016901110] 'agreement among raft nodes before linearized reading' (duration: 189.832699ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:45:19.477097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.044240574s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-07-25T08:45:19.477127Z","caller":"traceutil/trace.go:171","msg":"trace[291945929] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1437; }","duration":"1.044294136s","start":"2026-07-25T08:45:18.432824Z","end":"2026-07-25T08:45:19.477118Z","steps":["trace[291945929] 'agreement among raft nodes before linearized reading' (duration: 1.044206704s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:45:19.477154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:45:18.432811Z","time spent":"1.044336477s","remote":"127.0.0.1:59630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-25T08:45:19.477265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.044900304s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-07-25T08:45:19.477292Z","caller":"traceutil/trace.go:171","msg":"trace[1003320978] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1437; }","duration":"1.044945695s","start":"2026-07-25T08:45:18.432338Z","end":"2026-07-25T08:45:19.477284Z","steps":["trace[1003320978] 'agreement among raft nodes before linearized reading' (duration: 1.044874383s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:45:19.477317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:45:18.432326Z","time spent":"1.044985016s","remote":"127.0.0.1:59630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-07-25T08:45:19.619373Z","caller":"traceutil/trace.go:171","msg":"trace[2059100966] transaction","detail":"{read_only:false; response_revision:1438; number_of_response:1; }","duration":"136.258673ms","start":"2026-07-25T08:45:19.483098Z","end":"2026-07-25T08:45:19.619357Z","steps":["trace[2059100966] 'process raft request' (duration: 132.951897ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:45:19.625234Z","caller":"traceutil/trace.go:171","msg":"trace[2005957990] transaction","detail":"{read_only:false; response_revision:1440; number_of_response:1; }","duration":"141.851626ms","start":"2026-07-25T08:45:19.483359Z","end":"2026-07-25T08:45:19.625211Z","steps":["trace[2005957990] 'process raft request' (duration: 141.768794ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:45:19.625251Z","caller":"traceutil/trace.go:171","msg":"trace[443040103] transaction","detail":"{read_only:false; response_revision:1441; number_of_response:1; }","duration":"141.62642ms","start":"2026-07-25T08:45:19.483602Z","end":"2026-07-25T08:45:19.625229Z","steps":["trace[443040103] 'process raft request' (duration: 141.562908ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:45:19.625521Z","caller":"traceutil/trace.go:171","msg":"trace[1111966662] transaction","detail":"{read_only:false; response_revision:1439; number_of_response:1; }","duration":"142.243128ms","start":"2026-07-25T08:45:19.483235Z","end":"2026-07-25T08:45:19.625478Z","steps":["trace[1111966662] 'process raft request' (duration: 141.775234ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:45:25.844646Z","caller":"traceutil/trace.go:171","msg":"trace[217552455] linearizableReadLoop","detail":"{readStateIndex:1522; appliedIndex:1521; }","duration":"199.505952ms","start":"2026-07-25T08:45:25.645115Z","end":"2026-07-25T08:45:25.84462Z","steps":["trace[217552455] 'read index received' (duration: 199.297086ms)","trace[217552455] 'applied index is now lower than readState.Index' (duration: 207.836µs)"],"step_count":2} {"level":"info","ts":"2026-07-25T08:45:25.844706Z","caller":"traceutil/trace.go:171","msg":"trace[1432497847] transaction","detail":"{read_only:false; response_revision:1457; number_of_response:1; }","duration":"345.957243ms","start":"2026-07-25T08:45:25.498705Z","end":"2026-07-25T08:45:25.844662Z","steps":["trace[1432497847] 'process raft request' (duration: 345.765117ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:45:25.844886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.749759ms","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-07-25T08:45:25.844923Z","caller":"traceutil/trace.go:171","msg":"trace[1438789606] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1457; }","duration":"199.859102ms","start":"2026-07-25T08:45:25.645053Z","end":"2026-07-25T08:45:25.844912Z","steps":["trace[1438789606] 'agreement among raft nodes before linearized reading' (duration: 199.699598ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:45:25.844912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:45:25.498687Z","time spent":"346.086087ms","remote":"127.0.0.1:59630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T08:45:25.844969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.436236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-07-25T08:45:25.844992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.774448ms","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-07-25T08:45:25.845039Z","caller":"traceutil/trace.go:171","msg":"trace[221019159] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1457; }","duration":"177.558161ms","start":"2026-07-25T08:45:25.667465Z","end":"2026-07-25T08:45:25.845023Z","steps":["trace[221019159] 'agreement among raft nodes before linearized reading' (duration: 177.416516ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:45:25.845081Z","caller":"traceutil/trace.go:171","msg":"trace[881381308] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1457; }","duration":"175.888971ms","start":"2026-07-25T08:45:25.669178Z","end":"2026-07-25T08:45:25.845067Z","steps":["trace[881381308] 'agreement among raft nodes before linearized reading' (duration: 175.667744ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:45:25.845191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.738508ms","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-07-25T08:45:25.845219Z","caller":"traceutil/trace.go:171","msg":"trace[482767339] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1457; }","duration":"186.78737ms","start":"2026-07-25T08:45:25.658423Z","end":"2026-07-25T08:45:25.845211Z","steps":["trace[482767339] 'agreement among raft nodes before linearized reading' (duration: 186.363018ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:45:26.369349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.024821ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T08:45:26.369445Z","caller":"traceutil/trace.go:171","msg":"trace[1345993292] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1457; }","duration":"235.134044ms","start":"2026-07-25T08:45:26.134297Z","end":"2026-07-25T08:45:26.369431Z","steps":["trace[1345993292] 'range keys from in-memory index tree' (duration: 235.010059ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:45:26.566024Z","caller":"traceutil/trace.go:171","msg":"trace[717052228] transaction","detail":"{read_only:false; response_revision:1458; number_of_response:1; }","duration":"716.769772ms","start":"2026-07-25T08:45:25.849231Z","end":"2026-07-25T08:45:26.566Z","steps":["trace[717052228] 'process raft request' (duration: 716.618968ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:45:26.566164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:45:25.849208Z","time spent":"716.885456ms","remote":"127.0.0.1:59630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T08:45:26.605622Z","caller":"traceutil/trace.go:171","msg":"trace[1611972372] transaction","detail":"{read_only:false; response_revision:1459; number_of_response:1; }","duration":"755.970308ms","start":"2026-07-25T08:45:25.84963Z","end":"2026-07-25T08:45:26.605601Z","steps":["trace[1611972372] 'process raft request' (duration: 744.120222ms)","trace[1611972372] 'compare' (duration: 11.729123ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T08:45:26.605721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:45:25.849604Z","time spent":"756.068611ms","remote":"127.0.0.1:59630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T08:45:26.605835Z","caller":"traceutil/trace.go:171","msg":"trace[76485764] transaction","detail":"{read_only:false; response_revision:1460; number_of_response:1; }","duration":"755.740451ms","start":"2026-07-25T08:45:25.85008Z","end":"2026-07-25T08:45:26.605821Z","steps":["trace[76485764] 'process raft request' (duration: 755.488354ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:45:26.605902Z","caller":"traceutil/trace.go:171","msg":"trace[406527418] transaction","detail":"{read_only:false; response_revision:1461; number_of_response:1; }","duration":"755.746151ms","start":"2026-07-25T08:45:25.850146Z","end":"2026-07-25T08:45:26.605893Z","steps":["trace[406527418] 'process raft request' (duration: 755.621647ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:45:26.605911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:45:25.850069Z","time spent":"755.802943ms","remote":"127.0.0.1:59630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T08:45:26.605954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:45:25.85014Z","time spent":"755.784953ms","remote":"127.0.0.1:59630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T08:45:27.96717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.622814ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-07-25T08:45:27.967299Z","caller":"traceutil/trace.go:171","msg":"trace[1605244410] linearizableReadLoop","detail":"{readStateIndex:1529; appliedIndex:1528; }","duration":"536.73001ms","start":"2026-07-25T08:45:27.430536Z","end":"2026-07-25T08:45:27.967266Z","steps":["trace[1605244410] 'read index received' (duration: 180.033713ms)","trace[1605244410] 'applied index is now lower than readState.Index' (duration: 356.694287ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T08:45:27.967597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"537.030518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-25T08:45:27.967701Z","caller":"traceutil/trace.go:171","msg":"trace[1632699853] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:1463; }","duration":"537.175342ms","start":"2026-07-25T08:45:27.430475Z","end":"2026-07-25T08:45:27.96765Z","steps":["trace[1632699853] 'agreement among raft nodes before linearized reading' (duration: 536.935445ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:45:27.967886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:45:27.430444Z","time spent":"537.383629ms","remote":"127.0.0.1:59628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":30,"request content":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true "} {"level":"info","ts":"2026-07-25T08:45:28.012786Z","caller":"traceutil/trace.go:171","msg":"trace[900339280] transaction","detail":"{read_only:false; response_revision:1464; number_of_response:1; }","duration":"162.471209ms","start":"2026-07-25T08:45:27.850299Z","end":"2026-07-25T08:45:28.01277Z","steps":["trace[900339280] 'process raft request' (duration: 162.266403ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:51:04.447959Z","caller":"traceutil/trace.go:171","msg":"trace[656850307] transaction","detail":"{read_only:false; response_revision:2644; number_of_response:1; }","duration":"130.981399ms","start":"2026-07-25T08:51:04.316947Z","end":"2026-07-25T08:51:04.447928Z","steps":["trace[656850307] 'process raft request' (duration: 108.561634ms)","trace[656850307] 'compare' (duration: 22.177368ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T08:51:04.54512Z","caller":"traceutil/trace.go:171","msg":"trace[1800084821] linearizableReadLoop","detail":"{readStateIndex:2780; appliedIndex:2778; }","duration":"200.795484ms","start":"2026-07-25T08:51:04.344296Z","end":"2026-07-25T08:51:04.545091Z","steps":["trace[1800084821] 'read index received' (duration: 81.230783ms)","trace[1800084821] 'applied index is now lower than readState.Index' (duration: 119.563351ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T08:51:04.545265Z","caller":"traceutil/trace.go:171","msg":"trace[866704803] transaction","detail":"{read_only:false; response_revision:2645; number_of_response:1; }","duration":"227.145239ms","start":"2026-07-25T08:51:04.318078Z","end":"2026-07-25T08:51:04.545223Z","steps":["trace[866704803] 'process raft request' (duration: 226.868781ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:51:04.54545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.115672ms","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-07-25T08:51:04.54549Z","caller":"traceutil/trace.go:171","msg":"trace[1628200111] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2645; }","duration":"197.195904ms","start":"2026-07-25T08:51:04.348284Z","end":"2026-07-25T08:51:04.54548Z","steps":["trace[1628200111] 'agreement among raft nodes before linearized reading' (duration: 196.984668ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:51:04.545526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.101602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-07-25T08:51:04.54552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.629381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-07-25T08:51:04.545543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.577407ms","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-07-25T08:51:04.545619Z","caller":"traceutil/trace.go:171","msg":"trace[1472737647] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2645; }","duration":"190.754785ms","start":"2026-07-25T08:51:04.354834Z","end":"2026-07-25T08:51:04.545589Z","steps":["trace[1472737647] 'agreement among raft nodes before linearized reading' (duration: 190.507888ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:51:04.545677Z","caller":"traceutil/trace.go:171","msg":"trace[1614572533] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2645; }","duration":"159.750781ms","start":"2026-07-25T08:51:04.385902Z","end":"2026-07-25T08:51:04.545652Z","steps":["trace[1614572533] 'agreement among raft nodes before linearized reading' (duration: 159.389451ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:51:04.545592Z","caller":"traceutil/trace.go:171","msg":"trace[303329964] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2645; }","duration":"197.219665ms","start":"2026-07-25T08:51:04.348357Z","end":"2026-07-25T08:51:04.545576Z","steps":["trace[303329964] 'agreement among raft nodes before linearized reading' (duration: 197.022949ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:51:04.54624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.817034ms","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-07-25T08:51:04.546293Z","caller":"traceutil/trace.go:171","msg":"trace[1358746246] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2645; }","duration":"202.038259ms","start":"2026-07-25T08:51:04.344239Z","end":"2026-07-25T08:51:04.546278Z","steps":["trace[1358746246] 'agreement among raft nodes before linearized reading' (duration: 201.004851ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:51:04.725134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.211732ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:472"} {"level":"info","ts":"2026-07-25T08:51:04.725202Z","caller":"traceutil/trace.go:171","msg":"trace[1650828133] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2645; }","duration":"175.328235ms","start":"2026-07-25T08:51:04.54986Z","end":"2026-07-25T08:51:04.725188Z","steps":["trace[1650828133] 'range keys from in-memory index tree' (duration: 175.115159ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:51:04.725738Z","caller":"traceutil/trace.go:171","msg":"trace[1048390440] transaction","detail":"{read_only:false; response_revision:2646; number_of_response:1; }","duration":"175.123119ms","start":"2026-07-25T08:51:04.550605Z","end":"2026-07-25T08:51:04.725728Z","steps":["trace[1048390440] 'process raft request' (duration: 174.970915ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:51:04.82434Z","caller":"traceutil/trace.go:171","msg":"trace[874784443] transaction","detail":"{read_only:false; response_revision:2648; number_of_response:1; }","duration":"272.374319ms","start":"2026-07-25T08:51:04.551937Z","end":"2026-07-25T08:51:04.824311Z","steps":["trace[874784443] 'process raft request' (duration: 272.290657ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:51:04.824676Z","caller":"traceutil/trace.go:171","msg":"trace[1303412860] transaction","detail":"{read_only:false; response_revision:2647; number_of_response:1; }","duration":"273.775928ms","start":"2026-07-25T08:51:04.550889Z","end":"2026-07-25T08:51:04.824665Z","steps":["trace[1303412860] 'process raft request' (duration: 273.179491ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:51:04.824696Z","caller":"traceutil/trace.go:171","msg":"trace[918584100] transaction","detail":"{read_only:false; response_revision:2649; number_of_response:1; }","duration":"272.624876ms","start":"2026-07-25T08:51:04.552053Z","end":"2026-07-25T08:51:04.824678Z","steps":["trace[918584100] 'process raft request' (duration: 272.218655ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:51:04.825223Z","caller":"traceutil/trace.go:171","msg":"trace[2116018901] transaction","detail":"{read_only:false; response_revision:2650; number_of_response:1; }","duration":"273.091609ms","start":"2026-07-25T08:51:04.552117Z","end":"2026-07-25T08:51:04.825209Z","steps":["trace[2116018901] 'process raft request' (duration: 272.457921ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:51:04.825365Z","caller":"traceutil/trace.go:171","msg":"trace[1342725536] transaction","detail":"{read_only:false; response_revision:2651; number_of_response:1; }","duration":"273.233683ms","start":"2026-07-25T08:51:04.552116Z","end":"2026-07-25T08:51:04.82535Z","steps":["trace[1342725536] 'process raft request' (duration: 272.815431ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:51:04.84953Z","caller":"traceutil/trace.go:171","msg":"trace[1915395453] transaction","detail":"{read_only:false; response_revision:2652; number_of_response:1; }","duration":"120.171818ms","start":"2026-07-25T08:51:04.729312Z","end":"2026-07-25T08:51:04.849484Z","steps":["trace[1915395453] 'process raft request' (duration: 112.971707ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:51:17.195005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.681788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-25T08:51:17.195086Z","caller":"traceutil/trace.go:171","msg":"trace[750818866] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2729; }","duration":"309.810892ms","start":"2026-07-25T08:51:16.885256Z","end":"2026-07-25T08:51:17.195067Z","steps":["trace[750818866] 'range keys from in-memory index tree' (duration: 309.446472ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:51:17.195126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:51:16.885237Z","time spent":"309.880554ms","remote":"127.0.0.1:59630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-25T08:51:17.195213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.291224ms","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-07-25T08:51:17.195355Z","caller":"traceutil/trace.go:171","msg":"trace[97188970] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2729; }","duration":"320.51213ms","start":"2026-07-25T08:51:16.874817Z","end":"2026-07-25T08:51:17.195329Z","steps":["trace[97188970] 'range keys from in-memory index tree' (duration: 320.025206ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:51:17.195246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.394594ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-07-25T08:51:17.195422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:51:16.874793Z","time spent":"320.621743ms","remote":"127.0.0.1:59630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-25T08:51:17.19544Z","caller":"traceutil/trace.go:171","msg":"trace[1452331821] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2729; }","duration":"312.61732ms","start":"2026-07-25T08:51:16.882802Z","end":"2026-07-25T08:51:17.195419Z","steps":["trace[1452331821] 'range keys from in-memory index tree' (duration: 312.24799ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:51:17.195492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:51:16.882791Z","time spent":"312.691852ms","remote":"127.0.0.1:59630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-25T08:51:17.195246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.299268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-07-25T08:51:17.195604Z","caller":"traceutil/trace.go:171","msg":"trace[998096136] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2729; }","duration":"309.682428ms","start":"2026-07-25T08:51:16.885876Z","end":"2026-07-25T08:51:17.195558Z","steps":["trace[998096136] 'range keys from in-memory index tree' (duration: 309.114192ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:51:17.195737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:51:16.885855Z","time spent":"309.834223ms","remote":"127.0.0.1:59630","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-07-25T08:51:17.342936Z","caller":"traceutil/trace.go:171","msg":"trace[935852694] transaction","detail":"{read_only:false; response_revision:2730; number_of_response:1; }","duration":"143.338204ms","start":"2026-07-25T08:51:17.199576Z","end":"2026-07-25T08:51:17.342914Z","steps":["trace[935852694] 'process raft request' (duration: 143.224761ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:51:17.352897Z","caller":"traceutil/trace.go:171","msg":"trace[2098917374] linearizableReadLoop","detail":"{readStateIndex:2870; appliedIndex:2866; }","duration":"121.088724ms","start":"2026-07-25T08:51:17.231791Z","end":"2026-07-25T08:51:17.35288Z","steps":["trace[2098917374] 'read index received' (duration: 110.964161ms)","trace[2098917374] 'applied index is now lower than readState.Index' (duration: 10.123913ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T08:51:17.353182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.379992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-07-25T08:51:17.353266Z","caller":"traceutil/trace.go:171","msg":"trace[1989284204] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2734; }","duration":"121.519376ms","start":"2026-07-25T08:51:17.231734Z","end":"2026-07-25T08:51:17.353253Z","steps":["trace[1989284204] 'agreement among raft nodes before linearized reading' (duration: 121.268339ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:51:17.353572Z","caller":"traceutil/trace.go:171","msg":"trace[1645119426] transaction","detail":"{read_only:false; response_revision:2731; number_of_response:1; }","duration":"152.814778ms","start":"2026-07-25T08:51:17.200744Z","end":"2026-07-25T08:51:17.353559Z","steps":["trace[1645119426] 'process raft request' (duration: 151.908042ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:51:17.353771Z","caller":"traceutil/trace.go:171","msg":"trace[677129601] transaction","detail":"{read_only:false; response_revision:2732; number_of_response:1; }","duration":"152.675604ms","start":"2026-07-25T08:51:17.201084Z","end":"2026-07-25T08:51:17.35376Z","steps":["trace[677129601] 'process raft request' (duration: 151.682787ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:51:17.354138Z","caller":"traceutil/trace.go:171","msg":"trace[1736803752] transaction","detail":"{read_only:false; response_revision:2733; number_of_response:1; }","duration":"152.416337ms","start":"2026-07-25T08:51:17.201694Z","end":"2026-07-25T08:51:17.35411Z","steps":["trace[1736803752] 'process raft request' (duration: 151.110401ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:51:19.086779Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":1635} {"level":"info","ts":"2026-07-25T08:51:19.142272Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":1635,"took":"54.847388ms","hash":60388558,"current-db-size-bytes":24297472,"current-db-size":"24 MB","current-db-size-in-use-bytes":5849088,"current-db-size-in-use":"5.8 MB"} {"level":"info","ts":"2026-07-25T08:51:19.142383Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":60388558,"revision":1635,"compact-revision":-1} {"level":"info","ts":"2026-07-25T08:56:19.092765Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2739} {"level":"info","ts":"2026-07-25T08:56:19.11381Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2739,"took":"20.486624ms","hash":1767220577,"current-db-size-bytes":24297472,"current-db-size":"24 MB","current-db-size-in-use-bytes":6250496,"current-db-size-in-use":"6.3 MB"} {"level":"info","ts":"2026-07-25T08:56:19.113897Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1767220577,"revision":2739,"compact-revision":1635}