{"level":"warn","ts":"2026-06-03T07:22:39.832095Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-03T07:22:39.832171Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.38: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.38:2380","--initial-cluster=instance=https://199.204.45.38:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.38:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.38:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-06-03T07:22:39.832252Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-03T07:22:39.832267Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.38:2380"]} {"level":"info","ts":"2026-06-03T07:22:39.832305Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-03T07:22:39.833015Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"]} {"level":"info","ts":"2026-06-03T07:22:39.833111Z","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.38:2380"],"listen-peer-urls":["https://199.204.45.38:2380"],"advertise-client-urls":["https://199.204.45.38:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.38:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-06-03T07:22:39.903706Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"70.340395ms"} {"level":"info","ts":"2026-06-03T07:22:39.917869Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"331455d6226d3423","cluster-id":"25c7803fb83a1455"} {"level":"info","ts":"2026-06-03T07:22:39.918009Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=()"} {"level":"info","ts":"2026-06-03T07:22:39.918038Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became follower at term 0"} {"level":"info","ts":"2026-06-03T07:22:39.918059Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 331455d6226d3423 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-03T07:22:39.918076Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became follower at term 1"} {"level":"info","ts":"2026-06-03T07:22:39.918137Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=(3680661173657482275)"} {"level":"warn","ts":"2026-06-03T07:22:39.928977Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-03T07:22:39.930501Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-03T07:22:39.93191Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-06-03T07:22:39.933991Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"331455d6226d3423","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-03T07:22:39.934094Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-03T07:22:39.934176Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-03T07:22:39.934189Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-03T07:22:39.934536Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"331455d6226d3423","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-03T07:22:39.935146Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=(3680661173657482275)"} {"level":"info","ts":"2026-06-03T07:22:39.935294Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"25c7803fb83a1455","local-member-id":"331455d6226d3423","added-peer-id":"331455d6226d3423","added-peer-peer-urls":["https://199.204.45.38:2380"]} {"level":"info","ts":"2026-06-03T07:22:39.9385Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-03T07:22:39.938653Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"331455d6226d3423","initial-advertise-peer-urls":["https://199.204.45.38:2380"],"listen-peer-urls":["https://199.204.45.38:2380"],"advertise-client-urls":["https://199.204.45.38:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-03T07:22:39.938678Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-03T07:22:39.938765Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.38:2380"} {"level":"info","ts":"2026-06-03T07:22:39.938779Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.38:2380"} {"level":"info","ts":"2026-06-03T07:22:40.719038Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 is starting a new election at term 1"} {"level":"info","ts":"2026-06-03T07:22:40.719095Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-03T07:22:40.719214Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 received MsgPreVoteResp from 331455d6226d3423 at term 1"} {"level":"info","ts":"2026-06-03T07:22:40.719292Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became candidate at term 2"} {"level":"info","ts":"2026-06-03T07:22:40.719311Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 received MsgVoteResp from 331455d6226d3423 at term 2"} {"level":"info","ts":"2026-06-03T07:22:40.719332Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became leader at term 2"} {"level":"info","ts":"2026-06-03T07:22:40.719372Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 331455d6226d3423 elected leader 331455d6226d3423 at term 2"} {"level":"info","ts":"2026-06-03T07:22:40.720739Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"331455d6226d3423","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.38:2379]}","request-path":"/0/members/331455d6226d3423/attributes","cluster-id":"25c7803fb83a1455","publish-timeout":"7s"} {"level":"info","ts":"2026-06-03T07:22:40.72083Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-03T07:22:40.720925Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-03T07:22:40.721105Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-03T07:22:40.72261Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-03T07:22:40.72294Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-03T07:22:40.722979Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-03T07:22:40.72637Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"25c7803fb83a1455","local-member-id":"331455d6226d3423","cluster-version":"3.5"} {"level":"info","ts":"2026-06-03T07:22:40.726713Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-03T07:22:40.726834Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-03T07:22:40.727806Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.38:2379"} {"level":"info","ts":"2026-06-03T07:23:04.851015Z","caller":"traceutil/trace.go:171","msg":"trace[843389584] transaction","detail":"{read_only:false; response_revision:465; number_of_response:1; }","duration":"159.67997ms","start":"2026-06-03T07:23:04.69131Z","end":"2026-06-03T07:23:04.85099Z","steps":["trace[843389584] 'process raft request' (duration: 159.545088ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:23:18.169816Z","caller":"traceutil/trace.go:171","msg":"trace[1871730373] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"242.282762ms","start":"2026-06-03T07:23:17.927507Z","end":"2026-06-03T07:23:18.169789Z","steps":["trace[1871730373] 'process raft request' (duration: 242.143276ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:23:18.17726Z","caller":"traceutil/trace.go:171","msg":"trace[825099967] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"234.279291ms","start":"2026-06-03T07:23:17.942948Z","end":"2026-06-03T07:23:18.177227Z","steps":["trace[825099967] 'process raft request' (duration: 233.575302ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:23:18.177492Z","caller":"traceutil/trace.go:171","msg":"trace[1211660830] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"232.572419ms","start":"2026-06-03T07:23:17.944893Z","end":"2026-06-03T07:23:18.177465Z","steps":["trace[1211660830] 'process raft request' (duration: 231.758806ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:23:18.177583Z","caller":"traceutil/trace.go:171","msg":"trace[2106433966] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"245.453243ms","start":"2026-06-03T07:23:17.931931Z","end":"2026-06-03T07:23:18.177385Z","steps":["trace[2106433966] 'process raft request' (duration: 244.348417ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:23:18.177691Z","caller":"traceutil/trace.go:171","msg":"trace[1831745589] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"234.622136ms","start":"2026-06-03T07:23:17.943Z","end":"2026-06-03T07:23:18.177622Z","steps":["trace[1831745589] 'process raft request' (duration: 233.566322ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:23:18.177928Z","caller":"traceutil/trace.go:171","msg":"trace[1916892231] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"245.926283ms","start":"2026-06-03T07:23:17.931989Z","end":"2026-06-03T07:23:18.177916Z","steps":["trace[1916892231] 'process raft request' (duration: 244.39654ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:23:18.178014Z","caller":"traceutil/trace.go:171","msg":"trace[1344480784] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"222.858409ms","start":"2026-06-03T07:23:17.955146Z","end":"2026-06-03T07:23:18.178004Z","steps":["trace[1344480784] 'process raft request' (duration: 221.617917ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:23:18.177999Z","caller":"traceutil/trace.go:171","msg":"trace[306659548] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"236.740084ms","start":"2026-06-03T07:23:17.94124Z","end":"2026-06-03T07:23:18.17798Z","steps":["trace[306659548] 'process raft request' (duration: 235.221332ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:23:18.178095Z","caller":"traceutil/trace.go:171","msg":"trace[731620574] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"235.009102ms","start":"2026-06-03T07:23:17.943079Z","end":"2026-06-03T07:23:18.178088Z","steps":["trace[731620574] 'process raft request' (duration: 233.529421ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:23:18.178167Z","caller":"traceutil/trace.go:171","msg":"trace[1209710670] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"184.870347ms","start":"2026-06-03T07:23:17.993158Z","end":"2026-06-03T07:23:18.178029Z","steps":["trace[1209710670] 'process raft request' (duration: 183.811833ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:23:18.178493Z","caller":"traceutil/trace.go:171","msg":"trace[1770692896] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"217.019322ms","start":"2026-06-03T07:23:17.960924Z","end":"2026-06-03T07:23:18.177943Z","steps":["trace[1770692896] 'process raft request' (duration: 215.893685ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:23:24.424687Z","caller":"traceutil/trace.go:171","msg":"trace[2133676444] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"461.578859ms","start":"2026-06-03T07:23:23.963072Z","end":"2026-06-03T07:23:24.424651Z","steps":["trace[2133676444] 'process raft request' (duration: 459.745698ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:23:24.425276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:23:23.963035Z","time spent":"461.739256ms","remote":"127.0.0.1:35566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036105,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T07:23:24.663844Z","caller":"traceutil/trace.go:171","msg":"trace[1057808968] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"233.369666ms","start":"2026-06-03T07:23:24.430404Z","end":"2026-06-03T07:23:24.663774Z","steps":["trace[1057808968] 'process raft request' (duration: 153.341877ms)","trace[1057808968] 'compare' (duration: 79.898954ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T07:23:25.062255Z","caller":"traceutil/trace.go:171","msg":"trace[1628524759] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"631.779031ms","start":"2026-06-03T07:23:24.430437Z","end":"2026-06-03T07:23:25.062216Z","steps":["trace[1628524759] 'process raft request' (duration: 584.651494ms)","trace[1628524759] 'compare' (duration: 46.414179ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T07:23:25.062376Z","caller":"traceutil/trace.go:171","msg":"trace[534985271] linearizableReadLoop","detail":"{readStateIndex:653; appliedIndex:649; }","duration":"506.337921ms","start":"2026-06-03T07:23:24.556014Z","end":"2026-06-03T07:23:25.062352Z","steps":["trace[534985271] 'read index received' (duration: 27.853986ms)","trace[534985271] 'applied index is now lower than readState.Index' (duration: 478.482525ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T07:23:25.062501Z","caller":"traceutil/trace.go:171","msg":"trace[1184159643] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"615.447974ms","start":"2026-06-03T07:23:24.447037Z","end":"2026-06-03T07:23:25.062485Z","steps":["trace[1184159643] 'process raft request' (duration: 615.047689ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:23:25.062531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:23:24.430406Z","time spent":"632.02032ms","remote":"127.0.0.1:35698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-03T07:23:25.0626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:23:24.447014Z","time spent":"615.529568ms","remote":"127.0.0.1:35638","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T07:23:25.062807Z","caller":"traceutil/trace.go:171","msg":"trace[1948665207] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"588.556435ms","start":"2026-06-03T07:23:24.474238Z","end":"2026-06-03T07:23:25.062794Z","steps":["trace[1948665207] 'process raft request' (duration: 588.036065ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:23:25.062874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:23:24.474212Z","time spent":"588.631358ms","remote":"127.0.0.1:35664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":818,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-03T07:23:25.062904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.298708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-03T07:23:25.06297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.076273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-03T07:23:25.063036Z","caller":"traceutil/trace.go:171","msg":"trace[1901551033] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:629; }","duration":"145.476236ms","start":"2026-06-03T07:23:24.917534Z","end":"2026-06-03T07:23:25.063011Z","steps":["trace[1901551033] 'agreement among raft nodes before linearized reading' (duration: 145.247887ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:23:25.063052Z","caller":"traceutil/trace.go:171","msg":"trace[1915543073] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:629; }","duration":"103.210278ms","start":"2026-06-03T07:23:24.959819Z","end":"2026-06-03T07:23:25.063029Z","steps":["trace[1915543073] 'agreement among raft nodes before linearized reading' (duration: 102.970069ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:23:25.063256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.217285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-03T07:23:25.063346Z","caller":"traceutil/trace.go:171","msg":"trace[2010545446] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:629; }","duration":"507.345751ms","start":"2026-06-03T07:23:24.555978Z","end":"2026-06-03T07:23:25.063323Z","steps":["trace[2010545446] 'agreement among raft nodes before linearized reading' (duration: 506.520849ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:23:25.063397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:23:24.55596Z","time spent":"507.428393ms","remote":"127.0.0.1:35698","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":"info","ts":"2026-06-03T07:23:26.248011Z","caller":"traceutil/trace.go:171","msg":"trace[1805380477] linearizableReadLoop","detail":"{readStateIndex:656; appliedIndex:655; }","duration":"329.445036ms","start":"2026-06-03T07:23:25.918541Z","end":"2026-06-03T07:23:26.247986Z","steps":["trace[1805380477] 'read index received' (duration: 328.611974ms)","trace[1805380477] 'applied index is now lower than readState.Index' (duration: 831.832µs)"],"step_count":2} {"level":"warn","ts":"2026-06-03T07:23:26.248135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.579881ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-03T07:23:26.248167Z","caller":"traceutil/trace.go:171","msg":"trace[365823870] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:632; }","duration":"329.667794ms","start":"2026-06-03T07:23:25.918489Z","end":"2026-06-03T07:23:26.248156Z","steps":["trace[365823870] 'agreement among raft nodes before linearized reading' (duration: 329.592131ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:23:26.248161Z","caller":"traceutil/trace.go:171","msg":"trace[153987925] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"744.427283ms","start":"2026-06-03T07:23:25.503694Z","end":"2026-06-03T07:23:26.248121Z","steps":["trace[153987925] 'process raft request' (duration: 743.672554ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:23:26.248204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:23:25.918458Z","time spent":"329.738917ms","remote":"127.0.0.1:35472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-03T07:23:26.24833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:23:25.503666Z","time spent":"744.572318ms","remote":"127.0.0.1:35566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036161,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T07:23:27.783333Z","caller":"traceutil/trace.go:171","msg":"trace[724013980] transaction","detail":"{read_only:false; response_revision:665; number_of_response:1; }","duration":"134.133948ms","start":"2026-06-03T07:23:27.649158Z","end":"2026-06-03T07:23:27.783292Z","steps":["trace[724013980] 'process raft request' (duration: 134.029394ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:23:40.857044Z","caller":"traceutil/trace.go:171","msg":"trace[806934328] linearizableReadLoop","detail":"{readStateIndex:834; appliedIndex:833; }","duration":"129.493062ms","start":"2026-06-03T07:23:40.727518Z","end":"2026-06-03T07:23:40.857011Z","steps":["trace[806934328] 'read index received' (duration: 129.230233ms)","trace[806934328] 'applied index is now lower than readState.Index' (duration: 261.209µs)"],"step_count":2} {"level":"info","ts":"2026-06-03T07:23:40.857267Z","caller":"traceutil/trace.go:171","msg":"trace[611759021] transaction","detail":"{read_only:false; response_revision:805; number_of_response:1; }","duration":"380.696722ms","start":"2026-06-03T07:23:40.476536Z","end":"2026-06-03T07:23:40.857232Z","steps":["trace[611759021] 'process raft request' (duration: 380.289159ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:23:40.857311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.777291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-03T07:23:40.857382Z","caller":"traceutil/trace.go:171","msg":"trace[120331] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:805; }","duration":"129.905786ms","start":"2026-06-03T07:23:40.72746Z","end":"2026-06-03T07:23:40.857366Z","steps":["trace[120331] 'agreement among raft nodes before linearized reading' (duration: 129.676488ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:23:40.857459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:23:40.476517Z","time spent":"380.830636ms","remote":"127.0.0.1:35638","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4027,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T07:24:09.924105Z","caller":"traceutil/trace.go:171","msg":"trace[852519093] transaction","detail":"{read_only:false; response_revision:1201; number_of_response:1; }","duration":"646.717148ms","start":"2026-06-03T07:24:09.277369Z","end":"2026-06-03T07:24:09.924086Z","steps":["trace[852519093] 'process raft request' (duration: 646.546973ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:24:09.924235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:24:09.277355Z","time spent":"646.81293ms","remote":"127.0.0.1:35698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T07:24:09.925918Z","caller":"traceutil/trace.go:171","msg":"trace[2021450564] linearizableReadLoop","detail":"{readStateIndex:1240; appliedIndex:1237; }","duration":"253.289768ms","start":"2026-06-03T07:24:09.672597Z","end":"2026-06-03T07:24:09.925887Z","steps":["trace[2021450564] 'read index received' (duration: 251.387211ms)","trace[2021450564] 'applied index is now lower than readState.Index' (duration: 1.901117ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T07:24:09.925987Z","caller":"traceutil/trace.go:171","msg":"trace[911088539] transaction","detail":"{read_only:false; response_revision:1202; number_of_response:1; }","duration":"646.553782ms","start":"2026-06-03T07:24:09.279415Z","end":"2026-06-03T07:24:09.925969Z","steps":["trace[911088539] 'process raft request' (duration: 646.154972ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:24:09.926072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:24:09.279396Z","time spent":"646.632985ms","remote":"127.0.0.1:35698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T07:24:09.926168Z","caller":"traceutil/trace.go:171","msg":"trace[334042372] transaction","detail":"{read_only:false; response_revision:1203; number_of_response:1; }","duration":"645.233901ms","start":"2026-06-03T07:24:09.280905Z","end":"2026-06-03T07:24:09.926139Z","steps":["trace[334042372] 'process raft request' (duration: 644.929763ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:24:09.926335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.632167ms","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":"warn","ts":"2026-06-03T07:24:09.926415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:24:09.280887Z","time spent":"645.418285ms","remote":"127.0.0.1:35698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T07:24:09.92649Z","caller":"traceutil/trace.go:171","msg":"trace[470535763] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1203; }","duration":"253.831712ms","start":"2026-06-03T07:24:09.672544Z","end":"2026-06-03T07:24:09.926375Z","steps":["trace[470535763] 'agreement among raft nodes before linearized reading' (duration: 253.474503ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:24:32.280556Z","caller":"traceutil/trace.go:171","msg":"trace[1256428324] transaction","detail":"{read_only:false; response_revision:1454; number_of_response:1; }","duration":"247.170306ms","start":"2026-06-03T07:24:32.033365Z","end":"2026-06-03T07:24:32.280536Z","steps":["trace[1256428324] 'process raft request' (duration: 247.056444ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:24:32.287559Z","caller":"traceutil/trace.go:171","msg":"trace[447871207] linearizableReadLoop","detail":"{readStateIndex:1500; appliedIndex:1498; }","duration":"243.617382ms","start":"2026-06-03T07:24:32.043918Z","end":"2026-06-03T07:24:32.287535Z","steps":["trace[447871207] 'read index received' (duration: 236.515133ms)","trace[447871207] 'applied index is now lower than readState.Index' (duration: 7.100949ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T07:24:32.287612Z","caller":"traceutil/trace.go:171","msg":"trace[1454584106] transaction","detail":"{read_only:false; response_revision:1455; number_of_response:1; }","duration":"252.231262ms","start":"2026-06-03T07:24:32.035367Z","end":"2026-06-03T07:24:32.287598Z","steps":["trace[1454584106] 'process raft request' (duration: 252.008627ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:24:32.287823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.988024ms","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-06-03T07:24:32.287821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.308647ms","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-06-03T07:24:32.287863Z","caller":"traceutil/trace.go:171","msg":"trace[2105740245] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1456; }","duration":"214.080195ms","start":"2026-06-03T07:24:32.07377Z","end":"2026-06-03T07:24:32.28785Z","steps":["trace[2105740245] 'agreement among raft nodes before linearized reading' (duration: 213.904752ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:24:32.287885Z","caller":"traceutil/trace.go:171","msg":"trace[660044277] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1456; }","duration":"209.399388ms","start":"2026-06-03T07:24:32.078461Z","end":"2026-06-03T07:24:32.28786Z","steps":["trace[660044277] 'agreement among raft nodes before linearized reading' (duration: 209.241855ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:24:32.287878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.948488ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-03T07:24:32.287938Z","caller":"traceutil/trace.go:171","msg":"trace[463737087] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:1456; }","duration":"244.033501ms","start":"2026-06-03T07:24:32.043897Z","end":"2026-06-03T07:24:32.287931Z","steps":["trace[463737087] 'agreement among raft nodes before linearized reading' (duration: 243.944959ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:24:58.942525Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3757020839848557843,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-03T07:24:59.158178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"873.790149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-39098139-14ce-455c-82de-3a3c54d55846\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-06-03T07:24:59.158184Z","caller":"traceutil/trace.go:171","msg":"trace[197970575] linearizableReadLoop","detail":"{readStateIndex:1958; appliedIndex:1957; }","duration":"715.791835ms","start":"2026-06-03T07:24:58.44237Z","end":"2026-06-03T07:24:59.158162Z","steps":["trace[197970575] 'read index received' (duration: 709.403192ms)","trace[197970575] 'applied index is now lower than readState.Index' (duration: 6.387253ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T07:24:59.158234Z","caller":"traceutil/trace.go:171","msg":"trace[1688130303] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-39098139-14ce-455c-82de-3a3c54d55846; range_end:; response_count:1; response_revision:1885; }","duration":"873.88824ms","start":"2026-06-03T07:24:58.284335Z","end":"2026-06-03T07:24:59.158224Z","steps":["trace[1688130303] 'range keys from in-memory index tree' (duration: 873.655207ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:24:59.158259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:24:58.284317Z","time spent":"873.936411ms","remote":"127.0.0.1:35638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3648,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-39098139-14ce-455c-82de-3a3c54d55846\" "} {"level":"warn","ts":"2026-06-03T07:24:59.158358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"715.989938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-03T07:24:59.158392Z","caller":"traceutil/trace.go:171","msg":"trace[1134047279] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1886; }","duration":"716.06412ms","start":"2026-06-03T07:24:58.442318Z","end":"2026-06-03T07:24:59.158382Z","steps":["trace[1134047279] 'agreement among raft nodes before linearized reading' (duration: 715.935887ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:24:59.158423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:24:58.442293Z","time spent":"716.12224ms","remote":"127.0.0.1:35698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-03T07:24:59.1583Z","caller":"traceutil/trace.go:171","msg":"trace[918437255] transaction","detail":"{read_only:false; response_revision:1886; number_of_response:1; }","duration":"770.130465ms","start":"2026-06-03T07:24:58.388106Z","end":"2026-06-03T07:24:59.158237Z","steps":["trace[918437255] 'process raft request' (duration: 763.455137ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:24:59.158774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:24:58.388078Z","time spent":"770.598253ms","remote":"127.0.0.1:35698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T07:24:59.279774Z","caller":"traceutil/trace.go:171","msg":"trace[560279986] linearizableReadLoop","detail":"{readStateIndex:1959; appliedIndex:1958; }","duration":"121.517657ms","start":"2026-06-03T07:24:59.15823Z","end":"2026-06-03T07:24:59.279747Z","steps":["trace[560279986] 'read index received' (duration: 58.896806ms)","trace[560279986] 'applied index is now lower than readState.Index' (duration: 62.619071ms)"],"step_count":2} {"level":"warn","ts":"2026-06-03T07:24:59.280044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"833.204388ms","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-06-03T07:24:59.280201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"440.823318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-39098139-14ce-455c-82de-3a3c54d55846\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-06-03T07:24:59.280189Z","caller":"traceutil/trace.go:171","msg":"trace[750563733] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1886; }","duration":"833.469703ms","start":"2026-06-03T07:24:58.4467Z","end":"2026-06-03T07:24:59.28017Z","steps":["trace[750563733] 'agreement among raft nodes before linearized reading' (duration: 833.145717ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:24:59.28028Z","caller":"traceutil/trace.go:171","msg":"trace[735889979] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-39098139-14ce-455c-82de-3a3c54d55846; range_end:; response_count:1; response_revision:1886; }","duration":"440.891069ms","start":"2026-06-03T07:24:58.839361Z","end":"2026-06-03T07:24:59.280252Z","steps":["trace[735889979] 'agreement among raft nodes before linearized reading' (duration: 440.737087ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:24:59.280349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:24:58.836363Z","time spent":"443.971545ms","remote":"127.0.0.1:35638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3648,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-39098139-14ce-455c-82de-3a3c54d55846\" "} {"level":"warn","ts":"2026-06-03T07:24:59.280357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:24:58.446679Z","time spent":"833.607565ms","remote":"127.0.0.1:35698","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-06-03T07:24:59.279929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"823.1164ms","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":"warn","ts":"2026-06-03T07:24:59.280496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"833.360171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-03T07:24:59.280532Z","caller":"traceutil/trace.go:171","msg":"trace[25239210] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1886; }","duration":"823.760423ms","start":"2026-06-03T07:24:58.456751Z","end":"2026-06-03T07:24:59.280512Z","steps":["trace[25239210] 'agreement among raft nodes before linearized reading' (duration: 823.021569ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:24:59.280556Z","caller":"traceutil/trace.go:171","msg":"trace[1739454972] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1886; }","duration":"833.533225ms","start":"2026-06-03T07:24:58.447003Z","end":"2026-06-03T07:24:59.280536Z","steps":["trace[1739454972] 'agreement among raft nodes before linearized reading' (duration: 833.26204ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:24:59.279908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"754.449206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"warn","ts":"2026-06-03T07:24:59.280598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:24:58.446977Z","time spent":"833.608816ms","remote":"127.0.0.1:35698","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-06-03T07:24:59.280598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:24:58.45674Z","time spent":"823.840324ms","remote":"127.0.0.1:35698","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":"info","ts":"2026-06-03T07:24:59.280656Z","caller":"traceutil/trace.go:171","msg":"trace[1338433947] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1886; }","duration":"755.21429ms","start":"2026-06-03T07:24:58.525404Z","end":"2026-06-03T07:24:59.280619Z","steps":["trace[1338433947] 'agreement among raft nodes before linearized reading' (duration: 754.350014ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:24:59.280758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:24:58.525388Z","time spent":"755.333641ms","remote":"127.0.0.1:39694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5434,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-06-03T07:24:59.393832Z","caller":"traceutil/trace.go:171","msg":"trace[558029511] transaction","detail":"{read_only:false; response_revision:1887; number_of_response:1; }","duration":"230.097907ms","start":"2026-06-03T07:24:59.16371Z","end":"2026-06-03T07:24:59.393807Z","steps":["trace[558029511] 'process raft request' (duration: 229.932674ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:24:59.457472Z","caller":"traceutil/trace.go:171","msg":"trace[61156358] transaction","detail":"{read_only:false; response_revision:1888; number_of_response:1; }","duration":"169.091045ms","start":"2026-06-03T07:24:59.288364Z","end":"2026-06-03T07:24:59.457455Z","steps":["trace[61156358] 'process raft request' (duration: 168.943452ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:24:59.45774Z","caller":"traceutil/trace.go:171","msg":"trace[1322244388] transaction","detail":"{read_only:false; response_revision:1889; number_of_response:1; }","duration":"169.259837ms","start":"2026-06-03T07:24:59.288455Z","end":"2026-06-03T07:24:59.457715Z","steps":["trace[1322244388] 'process raft request' (duration: 168.952022ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:24:59.457855Z","caller":"traceutil/trace.go:171","msg":"trace[1148886825] transaction","detail":"{read_only:false; response_revision:1890; number_of_response:1; }","duration":"169.326309ms","start":"2026-06-03T07:24:59.288499Z","end":"2026-06-03T07:24:59.457825Z","steps":["trace[1148886825] 'process raft request' (duration: 169.109385ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:24:59.45811Z","caller":"traceutil/trace.go:171","msg":"trace[1433859922] linearizableReadLoop","detail":"{readStateIndex:1964; appliedIndex:1959; }","duration":"150.788502ms","start":"2026-06-03T07:24:59.307297Z","end":"2026-06-03T07:24:59.458086Z","steps":["trace[1433859922] 'read index received' (duration: 86.478181ms)","trace[1433859922] 'applied index is now lower than readState.Index' (duration: 64.309151ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T07:24:59.458231Z","caller":"traceutil/trace.go:171","msg":"trace[1546707551] transaction","detail":"{read_only:false; response_revision:1891; number_of_response:1; }","duration":"165.657114ms","start":"2026-06-03T07:24:59.29256Z","end":"2026-06-03T07:24:59.458217Z","steps":["trace[1546707551] 'process raft request' (duration: 165.188246ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:24:59.458298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.982236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-03T07:24:59.458342Z","caller":"traceutil/trace.go:171","msg":"trace[1909809794] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1892; }","duration":"151.065627ms","start":"2026-06-03T07:24:59.307265Z","end":"2026-06-03T07:24:59.458331Z","steps":["trace[1909809794] 'agreement among raft nodes before linearized reading' (duration: 150.920484ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:24:59.910654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.630871ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-03T07:24:59.910779Z","caller":"traceutil/trace.go:171","msg":"trace[2009226174] transaction","detail":"{read_only:false; response_revision:1893; number_of_response:1; }","duration":"446.321199ms","start":"2026-06-03T07:24:59.464432Z","end":"2026-06-03T07:24:59.910753Z","steps":["trace[2009226174] 'process raft request' (duration: 275.310922ms)","trace[2009226174] 'compare' (duration: 170.369656ms)"],"step_count":2} {"level":"warn","ts":"2026-06-03T07:24:59.910871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:24:59.464377Z","time spent":"446.445332ms","remote":"127.0.0.1:35698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T07:24:59.920148Z","caller":"traceutil/trace.go:171","msg":"trace[2121348405] transaction","detail":"{read_only:false; response_revision:1894; number_of_response:1; }","duration":"425.921311ms","start":"2026-06-03T07:24:59.494196Z","end":"2026-06-03T07:24:59.920117Z","steps":["trace[2121348405] 'process raft request' (duration: 425.803799ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:24:59.920475Z","caller":"traceutil/trace.go:171","msg":"trace[1057559779] transaction","detail":"{read_only:false; response_revision:1895; number_of_response:1; }","duration":"218.346841ms","start":"2026-06-03T07:24:59.702112Z","end":"2026-06-03T07:24:59.920459Z","steps":["trace[1057559779] 'process raft request' (duration: 217.958654ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:24:59.920525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:24:59.494174Z","time spent":"426.060334ms","remote":"127.0.0.1:35698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T07:25:11.827428Z","caller":"traceutil/trace.go:171","msg":"trace[2012498456] transaction","detail":"{read_only:false; response_revision:1987; number_of_response:1; }","duration":"375.22045ms","start":"2026-06-03T07:25:11.452181Z","end":"2026-06-03T07:25:11.827402Z","steps":["trace[2012498456] 'process raft request' (duration: 375.012387ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:25:11.827582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:25:11.452156Z","time spent":"375.353923ms","remote":"127.0.0.1:35698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-03T07:25:11.987063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.812195ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-03T07:25:11.987139Z","caller":"traceutil/trace.go:171","msg":"trace[1936544327] linearizableReadLoop","detail":"{readStateIndex:2063; appliedIndex:2061; }","duration":"478.367544ms","start":"2026-06-03T07:25:11.50876Z","end":"2026-06-03T07:25:11.987127Z","steps":["trace[1936544327] 'read index received' (duration: 318.426901ms)","trace[1936544327] 'applied index is now lower than readState.Index' (duration: 159.939653ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T07:25:11.987218Z","caller":"traceutil/trace.go:171","msg":"trace[34702740] transaction","detail":"{read_only:false; response_revision:1988; number_of_response:1; }","duration":"488.221207ms","start":"2026-06-03T07:25:11.498945Z","end":"2026-06-03T07:25:11.987167Z","steps":["trace[34702740] 'process raft request' (duration: 381.24152ms)","trace[34702740] 'compare' (duration: 106.716193ms)"],"step_count":2} {"level":"warn","ts":"2026-06-03T07:25:11.987273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"478.501857ms","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-06-03T07:25:11.987374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:25:11.498931Z","time spent":"488.364009ms","remote":"127.0.0.1:35698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T07:25:11.987425Z","caller":"traceutil/trace.go:171","msg":"trace[281553420] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1988; }","duration":"478.636008ms","start":"2026-06-03T07:25:11.508732Z","end":"2026-06-03T07:25:11.987368Z","steps":["trace[281553420] 'agreement among raft nodes before linearized reading' (duration: 478.429715ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:25:11.987464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:25:11.508725Z","time spent":"478.730271ms","remote":"127.0.0.1:35698","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-06-03T07:25:11.991799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"480.625103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-03T07:25:11.991836Z","caller":"traceutil/trace.go:171","msg":"trace[453555196] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1991; }","duration":"480.697743ms","start":"2026-06-03T07:25:11.511129Z","end":"2026-06-03T07:25:11.991827Z","steps":["trace[453555196] 'agreement among raft nodes before linearized reading' (duration: 480.596002ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:25:11.991856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:25:11.511111Z","time spent":"480.739545ms","remote":"127.0.0.1:35698","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-06-03T07:25:11.992077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.136714ms","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":"warn","ts":"2026-06-03T07:25:11.99211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.025326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-03T07:25:11.992132Z","caller":"traceutil/trace.go:171","msg":"trace[445741859] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1991; }","duration":"479.059536ms","start":"2026-06-03T07:25:11.513067Z","end":"2026-06-03T07:25:11.992126Z","steps":["trace[445741859] 'agreement among raft nodes before linearized reading' (duration: 478.992345ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:25:11.992135Z","caller":"traceutil/trace.go:171","msg":"trace[1919236313] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1991; }","duration":"414.235875ms","start":"2026-06-03T07:25:11.577883Z","end":"2026-06-03T07:25:11.992119Z","steps":["trace[1919236313] 'agreement among raft nodes before linearized reading' (duration: 414.127573ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:25:11.99215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:25:11.513061Z","time spent":"479.084296ms","remote":"127.0.0.1:35698","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-06-03T07:25:11.992174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:25:11.577868Z","time spent":"414.295126ms","remote":"127.0.0.1:35858","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":29,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"info","ts":"2026-06-03T07:25:33.521174Z","caller":"traceutil/trace.go:171","msg":"trace[1471235196] transaction","detail":"{read_only:false; response_revision:2123; number_of_response:1; }","duration":"260.098288ms","start":"2026-06-03T07:25:33.261026Z","end":"2026-06-03T07:25:33.521125Z","steps":["trace[1471235196] 'process raft request' (duration: 259.911395ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:25:33.531743Z","caller":"traceutil/trace.go:171","msg":"trace[1118184926] transaction","detail":"{read_only:false; response_revision:2124; number_of_response:1; }","duration":"249.083224ms","start":"2026-06-03T07:25:33.282634Z","end":"2026-06-03T07:25:33.531718Z","steps":["trace[1118184926] 'process raft request' (duration: 248.524985ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:25:36.045133Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3757020839848558386,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-03T07:25:36.151269Z","caller":"traceutil/trace.go:171","msg":"trace[1945989862] transaction","detail":"{read_only:false; response_revision:2134; number_of_response:1; }","duration":"843.554534ms","start":"2026-06-03T07:25:35.307405Z","end":"2026-06-03T07:25:36.15096Z","steps":["trace[1945989862] 'process raft request' (duration: 843.373781ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:25:36.151418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:25:35.307384Z","time spent":"843.966279ms","remote":"127.0.0.1:35698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T07:25:36.341216Z","caller":"traceutil/trace.go:171","msg":"trace[118391998] linearizableReadLoop","detail":"{readStateIndex:2215; appliedIndex:2213; }","duration":"796.50761ms","start":"2026-06-03T07:25:35.544685Z","end":"2026-06-03T07:25:36.341192Z","steps":["trace[118391998] 'read index received' (duration: 606.01646ms)","trace[118391998] 'applied index is now lower than readState.Index' (duration: 190.48949ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T07:25:36.341321Z","caller":"traceutil/trace.go:171","msg":"trace[688091773] transaction","detail":"{read_only:false; response_revision:2135; number_of_response:1; }","duration":"804.865115ms","start":"2026-06-03T07:25:35.536442Z","end":"2026-06-03T07:25:36.341307Z","steps":["trace[688091773] 'process raft request' (duration: 784.352811ms)","trace[688091773] 'compare' (duration: 19.897375ms)"],"step_count":2} {"level":"warn","ts":"2026-06-03T07:25:36.34142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:25:35.536393Z","time spent":"804.953327ms","remote":"127.0.0.1:35698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T07:25:36.341633Z","caller":"traceutil/trace.go:171","msg":"trace[1100844988] transaction","detail":"{read_only:false; response_revision:2136; number_of_response:1; }","duration":"239.581789ms","start":"2026-06-03T07:25:36.102019Z","end":"2026-06-03T07:25:36.341601Z","steps":["trace[1100844988] 'process raft request' (duration: 239.089702ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:25:36.341781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"797.076279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-03T07:25:36.341861Z","caller":"traceutil/trace.go:171","msg":"trace[2070139201] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2136; }","duration":"797.197571ms","start":"2026-06-03T07:25:35.544646Z","end":"2026-06-03T07:25:36.341843Z","steps":["trace[2070139201] 'agreement among raft nodes before linearized reading' (duration: 796.959147ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:25:36.341912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:25:35.544634Z","time spent":"797.269132ms","remote":"127.0.0.1:39694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5434,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-06-03T07:25:36.710208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.59222ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-03T07:25:36.710412Z","caller":"traceutil/trace.go:171","msg":"trace[2001923825] linearizableReadLoop","detail":"{readStateIndex:2218; appliedIndex:2216; }","duration":"369.122655ms","start":"2026-06-03T07:25:36.341277Z","end":"2026-06-03T07:25:36.710399Z","steps":["trace[2001923825] 'read index received' (duration: 160.316782ms)","trace[2001923825] 'applied index is now lower than readState.Index' (duration: 208.805023ms)"],"step_count":2} {"level":"warn","ts":"2026-06-03T07:25:36.710829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.092717828s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-03T07:25:36.710835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.106991632s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-03T07:25:36.710889Z","caller":"traceutil/trace.go:171","msg":"trace[1789177155] range","detail":"{range_begin:/registry/cert-manager.io/certificaterequests/; range_end:/registry/cert-manager.io/certificaterequests0; response_count:0; response_revision:2138; }","duration":"1.107088773s","start":"2026-06-03T07:25:35.603785Z","end":"2026-06-03T07:25:36.710874Z","steps":["trace[1789177155] 'agreement among raft nodes before linearized reading' (duration: 1.107021272s)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:25:36.71101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.137033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18b5816b894411ae\" ","response":"range_response_count:1 size:846"} {"level":"info","ts":"2026-06-03T07:25:36.711072Z","caller":"traceutil/trace.go:171","msg":"trace[584306540] range","detail":"{range_begin:/registry/events/openstack/percona-xtradb-haproxy-0.18b5816b894411ae; range_end:; response_count:1; response_revision:2138; }","duration":"142.229704ms","start":"2026-06-03T07:25:36.56883Z","end":"2026-06-03T07:25:36.71106Z","steps":["trace[584306540] 'agreement among raft nodes before linearized reading' (duration: 142.128373ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:25:36.710889Z","caller":"traceutil/trace.go:171","msg":"trace[1400977942] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:2138; }","duration":"1.09279551s","start":"2026-06-03T07:25:35.618076Z","end":"2026-06-03T07:25:36.710872Z","steps":["trace[1400977942] 'agreement among raft nodes before linearized reading' (duration: 1.092723639s)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:25:36.71075Z","caller":"traceutil/trace.go:171","msg":"trace[601231413] transaction","detail":"{read_only:false; response_revision:2138; number_of_response:1; }","duration":"517.245226ms","start":"2026-06-03T07:25:36.193491Z","end":"2026-06-03T07:25:36.710736Z","steps":["trace[601231413] 'process raft request' (duration: 516.84127ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:25:36.711198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:25:35.618064Z","time spent":"1.093105145s","remote":"127.0.0.1:35788","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":2,"response size":29,"request content":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true "} {"level":"warn","ts":"2026-06-03T07:25:36.711313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:25:36.193476Z","time spent":"517.771735ms","remote":"127.0.0.1:35698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-03T07:25:36.710735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"748.695498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-03T07:25:36.711431Z","caller":"traceutil/trace.go:171","msg":"trace[463524436] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2138; }","duration":"749.447428ms","start":"2026-06-03T07:25:35.961974Z","end":"2026-06-03T07:25:36.711421Z","steps":["trace[463524436] 'agreement among raft nodes before linearized reading' (duration: 748.584456ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:25:36.711483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:25:35.961952Z","time spent":"749.521179ms","remote":"127.0.0.1:35698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-03T07:25:36.710756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"483.053637ms","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-06-03T07:25:36.711587Z","caller":"traceutil/trace.go:171","msg":"trace[100006926] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2138; }","duration":"483.92378ms","start":"2026-06-03T07:25:36.227656Z","end":"2026-06-03T07:25:36.711579Z","steps":["trace[100006926] 'agreement among raft nodes before linearized reading' (duration: 482.988027ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:25:36.711638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:25:36.227636Z","time spent":"483.993251ms","remote":"127.0.0.1:35698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-03T07:25:36.710721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"792.251147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-03T07:25:36.711756Z","caller":"traceutil/trace.go:171","msg":"trace[473278002] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2138; }","duration":"793.339764ms","start":"2026-06-03T07:25:35.918383Z","end":"2026-06-03T07:25:36.711723Z","steps":["trace[473278002] 'agreement among raft nodes before linearized reading' (duration: 792.216687ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:25:36.711222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:25:35.603758Z","time spent":"1.107446408s","remote":"127.0.0.1:56576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":2,"response size":29,"request content":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" count_only:true "} {"level":"warn","ts":"2026-06-03T07:25:36.711804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:25:35.918359Z","time spent":"793.432055ms","remote":"127.0.0.1:35472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-03T07:25:36.710818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.777193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-03T07:25:36.712021Z","caller":"traceutil/trace.go:171","msg":"trace[484285888] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2138; }","duration":"483.980191ms","start":"2026-06-03T07:25:36.228011Z","end":"2026-06-03T07:25:36.711991Z","steps":["trace[484285888] 'agreement among raft nodes before linearized reading' (duration: 482.752724ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:25:36.712074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:25:36.228Z","time spent":"484.059732ms","remote":"127.0.0.1:35698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-03T07:25:36.710841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"501.612424ms","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-06-03T07:25:36.712172Z","caller":"traceutil/trace.go:171","msg":"trace[515646378] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2138; }","duration":"502.969774ms","start":"2026-06-03T07:25:36.20919Z","end":"2026-06-03T07:25:36.71216Z","steps":["trace[515646378] 'agreement among raft nodes before linearized reading' (duration: 501.591944ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:25:36.712241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:25:36.209166Z","time spent":"503.062036ms","remote":"127.0.0.1:35698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-03T07:25:36.710573Z","caller":"traceutil/trace.go:171","msg":"trace[470943595] transaction","detail":"{read_only:false; response_revision:2137; number_of_response:1; }","duration":"517.076745ms","start":"2026-06-03T07:25:36.193482Z","end":"2026-06-03T07:25:36.710559Z","steps":["trace[470943595] 'process raft request' (duration: 308.041938ms)","trace[470943595] 'compare' (duration: 208.229925ms)"],"step_count":2} {"level":"warn","ts":"2026-06-03T07:25:36.712355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:25:36.193459Z","time spent":"518.865171ms","remote":"127.0.0.1:35698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-03T07:25:36.710698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.677993ms","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-06-03T07:25:36.712603Z","caller":"traceutil/trace.go:171","msg":"trace[1400533604] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2138; }","duration":"484.587831ms","start":"2026-06-03T07:25:36.228005Z","end":"2026-06-03T07:25:36.712593Z","steps":["trace[1400533604] 'agreement among raft nodes before linearized reading' (duration: 482.51577ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:25:36.712652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:25:36.227978Z","time spent":"484.662442ms","remote":"127.0.0.1:35698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-03T07:25:37.018537Z","caller":"traceutil/trace.go:171","msg":"trace[1582982413] transaction","detail":"{read_only:false; response_revision:2139; number_of_response:1; }","duration":"303.547321ms","start":"2026-06-03T07:25:36.714961Z","end":"2026-06-03T07:25:37.018508Z","steps":["trace[1582982413] 'process raft request' (duration: 301.427269ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:25:37.018718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:25:36.714948Z","time spent":"303.672423ms","remote":"127.0.0.1:35552","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":831,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T07:25:37.01974Z","caller":"traceutil/trace.go:171","msg":"trace[56042835] transaction","detail":"{read_only:false; response_revision:2140; number_of_response:1; }","duration":"303.062443ms","start":"2026-06-03T07:25:36.716648Z","end":"2026-06-03T07:25:37.019711Z","steps":["trace[56042835] 'process raft request' (duration: 302.87989ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:25:37.019762Z","caller":"traceutil/trace.go:171","msg":"trace[1222368338] transaction","detail":"{read_only:false; response_revision:2141; number_of_response:1; }","duration":"302.664357ms","start":"2026-06-03T07:25:36.717078Z","end":"2026-06-03T07:25:37.019742Z","steps":["trace[1222368338] 'process raft request' (duration: 302.548656ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:25:37.02067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:25:36.717063Z","time spent":"303.548091ms","remote":"127.0.0.1:35698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T07:25:37.020065Z","caller":"traceutil/trace.go:171","msg":"trace[2121566816] transaction","detail":"{read_only:false; response_revision:2142; number_of_response:1; }","duration":"302.639467ms","start":"2026-06-03T07:25:36.7174Z","end":"2026-06-03T07:25:37.020039Z","steps":["trace[2121566816] 'process raft request' (duration: 302.274131ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:25:37.020931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:25:36.717392Z","time spent":"303.49406ms","remote":"127.0.0.1:35698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T07:25:37.020126Z","caller":"traceutil/trace.go:171","msg":"trace[551268999] transaction","detail":"{read_only:false; response_revision:2144; number_of_response:1; }","duration":"302.222ms","start":"2026-06-03T07:25:36.717886Z","end":"2026-06-03T07:25:37.020108Z","steps":["trace[551268999] 'process raft request' (duration: 302.148159ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:25:37.020197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:25:36.716639Z","time spent":"303.172254ms","remote":"127.0.0.1:35698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-03T07:25:37.021132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:25:36.717879Z","time spent":"303.195685ms","remote":"127.0.0.1:35698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T07:25:37.020355Z","caller":"traceutil/trace.go:171","msg":"trace[1140629487] transaction","detail":"{read_only:false; response_revision:2143; number_of_response:1; }","duration":"302.671067ms","start":"2026-06-03T07:25:36.717598Z","end":"2026-06-03T07:25:37.020269Z","steps":["trace[1140629487] 'process raft request' (duration: 302.363062ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:25:37.025684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:25:36.717579Z","time spent":"307.402597ms","remote":"127.0.0.1:35698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-03T07:26:25.818667Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3757020839848559042,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-03T07:26:26.194281Z","caller":"traceutil/trace.go:171","msg":"trace[1935868677] transaction","detail":"{read_only:false; response_revision:2404; number_of_response:1; }","duration":"879.619315ms","start":"2026-06-03T07:26:25.314641Z","end":"2026-06-03T07:26:26.194261Z","steps":["trace[1935868677] 'process raft request' (duration: 879.510334ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:26:26.194446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:26:25.314606Z","time spent":"879.772507ms","remote":"127.0.0.1:35698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T07:26:26.647362Z","caller":"traceutil/trace.go:171","msg":"trace[1140024477] linearizableReadLoop","detail":"{readStateIndex:2496; appliedIndex:2494; }","duration":"1.328904777s","start":"2026-06-03T07:26:25.318433Z","end":"2026-06-03T07:26:26.647338Z","steps":["trace[1140024477] 'read index received' (duration: 875.764964ms)","trace[1140024477] 'applied index is now lower than readState.Index' (duration: 453.138593ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T07:26:26.647444Z","caller":"traceutil/trace.go:171","msg":"trace[1485468678] transaction","detail":"{read_only:false; response_revision:2405; number_of_response:1; }","duration":"1.332586916s","start":"2026-06-03T07:26:25.314819Z","end":"2026-06-03T07:26:26.647406Z","steps":["trace[1485468678] 'process raft request' (duration: 1.331991099s)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:26:26.647604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.32914177s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-03T07:26:26.647649Z","caller":"traceutil/trace.go:171","msg":"trace[1514663674] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2405; }","duration":"1.329236191s","start":"2026-06-03T07:26:25.318403Z","end":"2026-06-03T07:26:26.647639Z","steps":["trace[1514663674] 'agreement among raft nodes before linearized reading' (duration: 1.329057189s)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:26:26.647688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:26:25.318393Z","time spent":"1.329282421s","remote":"127.0.0.1:35698","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-06-03T07:26:26.647635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:26:25.314801Z","time spent":"1.332725888s","remote":"127.0.0.1:35698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T07:26:26.648778Z","caller":"traceutil/trace.go:171","msg":"trace[785777184] transaction","detail":"{read_only:false; response_revision:2406; number_of_response:1; }","duration":"126.032776ms","start":"2026-06-03T07:26:26.522722Z","end":"2026-06-03T07:26:26.648754Z","steps":["trace[785777184] 'process raft request' (duration: 125.767483ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:26:26.648883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"589.159158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5428"} {"level":"warn","ts":"2026-06-03T07:26:26.648851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.329573056s","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-06-03T07:26:26.649214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"702.930327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-03T07:26:26.649259Z","caller":"traceutil/trace.go:171","msg":"trace[777457122] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:2406; }","duration":"703.030657ms","start":"2026-06-03T07:26:25.946216Z","end":"2026-06-03T07:26:26.649246Z","steps":["trace[777457122] 'agreement among raft nodes before linearized reading' (duration: 702.949346ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:26:26.64932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:26:25.946193Z","time spent":"703.113918ms","remote":"127.0.0.1:35834","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":27,"request content":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true "} {"level":"warn","ts":"2026-06-03T07:26:26.649213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"729.760285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-03T07:26:26.649349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.179053348s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-03T07:26:26.649241Z","caller":"traceutil/trace.go:171","msg":"trace[1777864832] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2406; }","duration":"1.329977242s","start":"2026-06-03T07:26:25.319232Z","end":"2026-06-03T07:26:26.649209Z","steps":["trace[1777864832] 'agreement among raft nodes before linearized reading' (duration: 1.329380723s)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:26:26.649546Z","caller":"traceutil/trace.go:171","msg":"trace[1543508911] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2406; }","duration":"1.179273351s","start":"2026-06-03T07:26:25.470255Z","end":"2026-06-03T07:26:26.649528Z","steps":["trace[1543508911] 'agreement among raft nodes before linearized reading' (duration: 1.178990797s)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:26:26.649593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:26:25.470242Z","time spent":"1.179335551s","remote":"127.0.0.1:35698","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-06-03T07:26:26.649593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:26:25.319221Z","time spent":"1.330352846s","remote":"127.0.0.1:35698","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":"info","ts":"2026-06-03T07:26:26.649117Z","caller":"traceutil/trace.go:171","msg":"trace[135240983] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2406; }","duration":"589.353921ms","start":"2026-06-03T07:26:26.059615Z","end":"2026-06-03T07:26:26.648969Z","steps":["trace[135240983] 'agreement among raft nodes before linearized reading' (duration: 589.029947ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:26:26.649756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:26:26.059594Z","time spent":"590.144501ms","remote":"127.0.0.1:39694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5450,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-06-03T07:26:26.650443Z","caller":"traceutil/trace.go:171","msg":"trace[722707390] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2406; }","duration":"730.15277ms","start":"2026-06-03T07:26:25.919371Z","end":"2026-06-03T07:26:26.649524Z","steps":["trace[722707390] 'agreement among raft nodes before linearized reading' (duration: 729.711724ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:26:26.650542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:26:25.919345Z","time spent":"731.180493ms","remote":"127.0.0.1:35472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-03T07:26:34.694089Z","caller":"traceutil/trace.go:171","msg":"trace[1768494823] linearizableReadLoop","detail":"{readStateIndex:2565; appliedIndex:2564; }","duration":"220.912216ms","start":"2026-06-03T07:26:34.47316Z","end":"2026-06-03T07:26:34.694072Z","steps":["trace[1768494823] 'read index received' (duration: 208.910473ms)","trace[1768494823] 'applied index is now lower than readState.Index' (duration: 11.999663ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T07:26:34.694192Z","caller":"traceutil/trace.go:171","msg":"trace[532994386] transaction","detail":"{read_only:false; response_revision:2471; number_of_response:1; }","duration":"222.266544ms","start":"2026-06-03T07:26:34.471912Z","end":"2026-06-03T07:26:34.694178Z","steps":["trace[532994386] 'process raft request' (duration: 210.19735ms)","trace[532994386] 'compare' (duration: 11.783761ms)"],"step_count":2} {"level":"warn","ts":"2026-06-03T07:26:34.694382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.204849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/openstack/\" range_end:\"/registry/limitranges/openstack0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-03T07:26:34.694425Z","caller":"traceutil/trace.go:171","msg":"trace[1591354152] range","detail":"{range_begin:/registry/limitranges/openstack/; range_end:/registry/limitranges/openstack0; response_count:0; response_revision:2473; }","duration":"221.280451ms","start":"2026-06-03T07:26:34.473134Z","end":"2026-06-03T07:26:34.694414Z","steps":["trace[1591354152] 'agreement among raft nodes before linearized reading' (duration: 221.2022ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:26:34.694472Z","caller":"traceutil/trace.go:171","msg":"trace[367488950] transaction","detail":"{read_only:false; response_revision:2472; number_of_response:1; }","duration":"218.917941ms","start":"2026-06-03T07:26:34.475517Z","end":"2026-06-03T07:26:34.694435Z","steps":["trace[367488950] 'process raft request' (duration: 218.483896ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:26:34.694617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.499732ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-03T07:26:34.694671Z","caller":"traceutil/trace.go:171","msg":"trace[1194846552] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:2473; }","duration":"206.577084ms","start":"2026-06-03T07:26:34.488083Z","end":"2026-06-03T07:26:34.69466Z","steps":["trace[1194846552] 'agreement among raft nodes before linearized reading' (duration: 206.500163ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:26:34.695188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.705558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/\" range_end:\"/registry/secrets/openstack0\" ","response":"range_response_count:6 size:236304"} {"level":"info","ts":"2026-06-03T07:26:34.695265Z","caller":"traceutil/trace.go:171","msg":"trace[1834305099] range","detail":"{range_begin:/registry/secrets/openstack/; range_end:/registry/secrets/openstack0; response_count:6; response_revision:2473; }","duration":"175.814709ms","start":"2026-06-03T07:26:34.519433Z","end":"2026-06-03T07:26:34.695248Z","steps":["trace[1834305099] 'agreement among raft nodes before linearized reading' (duration: 175.496335ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:26:36.865951Z","caller":"traceutil/trace.go:171","msg":"trace[1078117954] transaction","detail":"{read_only:false; response_revision:2501; number_of_response:1; }","duration":"164.396847ms","start":"2026-06-03T07:26:36.701519Z","end":"2026-06-03T07:26:36.865915Z","steps":["trace[1078117954] 'process raft request' (duration: 146.035542ms)","trace[1078117954] 'compare' (duration: 17.766367ms)"],"step_count":2} {"level":"warn","ts":"2026-06-03T07:26:36.866144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.419286ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-03T07:26:36.866218Z","caller":"traceutil/trace.go:171","msg":"trace[731371184] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2501; }","duration":"160.529717ms","start":"2026-06-03T07:26:36.705669Z","end":"2026-06-03T07:26:36.866198Z","steps":["trace[731371184] 'agreement among raft nodes before linearized reading' (duration: 160.355015ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:26:36.865988Z","caller":"traceutil/trace.go:171","msg":"trace[1837003919] linearizableReadLoop","detail":"{readStateIndex:2595; appliedIndex:2594; }","duration":"160.071132ms","start":"2026-06-03T07:26:36.705715Z","end":"2026-06-03T07:26:36.865786Z","steps":["trace[1837003919] 'read index received' (duration: 141.783179ms)","trace[1837003919] 'applied index is now lower than readState.Index' (duration: 18.286423ms)"],"step_count":2} {"level":"warn","ts":"2026-06-03T07:26:36.866573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.272808ms","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":"warn","ts":"2026-06-03T07:26:36.866609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.414044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-03T07:26:36.866608Z","caller":"traceutil/trace.go:171","msg":"trace[1687884512] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2501; }","duration":"147.345529ms","start":"2026-06-03T07:26:36.719254Z","end":"2026-06-03T07:26:36.866599Z","steps":["trace[1687884512] 'agreement among raft nodes before linearized reading' (duration: 147.253208ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:26:36.866633Z","caller":"traceutil/trace.go:171","msg":"trace[897788870] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2501; }","duration":"156.481926ms","start":"2026-06-03T07:26:36.710144Z","end":"2026-06-03T07:26:36.866626Z","steps":["trace[897788870] 'agreement among raft nodes before linearized reading' (duration: 156.417565ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:26:36.866763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.89233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-03T07:26:36.86679Z","caller":"traceutil/trace.go:171","msg":"trace[1591509663] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2501; }","duration":"156.952832ms","start":"2026-06-03T07:26:36.709829Z","end":"2026-06-03T07:26:36.866781Z","steps":["trace[1591509663] 'agreement among raft nodes before linearized reading' (duration: 156.654328ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:26:45.344892Z","caller":"traceutil/trace.go:171","msg":"trace[1161180002] transaction","detail":"{read_only:false; response_revision:2605; number_of_response:1; }","duration":"194.356713ms","start":"2026-06-03T07:26:45.150506Z","end":"2026-06-03T07:26:45.344863Z","steps":["trace[1161180002] 'process raft request' (duration: 194.07137ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:26:45.345689Z","caller":"traceutil/trace.go:171","msg":"trace[40367299] transaction","detail":"{read_only:false; response_revision:2607; number_of_response:1; }","duration":"184.440239ms","start":"2026-06-03T07:26:45.161221Z","end":"2026-06-03T07:26:45.345661Z","steps":["trace[40367299] 'process raft request' (duration: 184.352698ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:26:45.345792Z","caller":"traceutil/trace.go:171","msg":"trace[483636171] transaction","detail":"{read_only:false; response_revision:2606; number_of_response:1; }","duration":"192.089566ms","start":"2026-06-03T07:26:45.153638Z","end":"2026-06-03T07:26:45.345728Z","steps":["trace[483636171] 'process raft request' (duration: 191.674141ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:26:45.946035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"554.17351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-06-03T07:26:45.946111Z","caller":"traceutil/trace.go:171","msg":"trace[629626352] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2607; }","duration":"554.290551ms","start":"2026-06-03T07:26:45.391802Z","end":"2026-06-03T07:26:45.946092Z","steps":["trace[629626352] 'range keys from in-memory index tree' (duration: 553.962767ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:26:45.946153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:26:45.391781Z","time spent":"554.363961ms","remote":"127.0.0.1:35652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":1391,"request content":"key:\"/registry/services/specs/auth-system/keycloak-headless\" "} {"level":"info","ts":"2026-06-03T07:27:13.215052Z","caller":"traceutil/trace.go:171","msg":"trace[1176175092] linearizableReadLoop","detail":"{readStateIndex:2861; appliedIndex:2859; }","duration":"142.263341ms","start":"2026-06-03T07:27:13.072753Z","end":"2026-06-03T07:27:13.215016Z","steps":["trace[1176175092] 'read index received' (duration: 48.039576ms)","trace[1176175092] 'applied index is now lower than readState.Index' (duration: 94.222085ms)"],"step_count":2} {"level":"warn","ts":"2026-06-03T07:27:13.215395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.592955ms","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-06-03T07:27:13.215441Z","caller":"traceutil/trace.go:171","msg":"trace[2102512830] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2759; }","duration":"142.711716ms","start":"2026-06-03T07:27:13.072717Z","end":"2026-06-03T07:27:13.215429Z","steps":["trace[2102512830] 'agreement among raft nodes before linearized reading' (duration: 142.411722ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:27:13.215815Z","caller":"traceutil/trace.go:171","msg":"trace[1316275936] transaction","detail":"{read_only:false; response_revision:2759; number_of_response:1; }","duration":"143.91991ms","start":"2026-06-03T07:27:13.07119Z","end":"2026-06-03T07:27:13.21511Z","steps":["trace[1316275936] 'process raft request' (duration: 64.005599ms)","trace[1316275936] 'compare' (duration: 79.435115ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T07:27:18.673116Z","caller":"traceutil/trace.go:171","msg":"trace[1756986660] transaction","detail":"{read_only:false; response_revision:2787; number_of_response:1; }","duration":"217.608504ms","start":"2026-06-03T07:27:18.455475Z","end":"2026-06-03T07:27:18.673083Z","steps":["trace[1756986660] 'process raft request' (duration: 217.216679ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:27:19.31888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.231339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-03T07:27:19.318979Z","caller":"traceutil/trace.go:171","msg":"trace[519273928] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2789; }","duration":"399.37697ms","start":"2026-06-03T07:27:18.91958Z","end":"2026-06-03T07:27:19.318957Z","steps":["trace[519273928] 'range keys from in-memory index tree' (duration: 399.082787ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:27:19.31903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:27:18.919558Z","time spent":"399.459451ms","remote":"127.0.0.1:35472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-03T07:27:19.643627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.699828ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-06-03T07:27:19.644824Z","caller":"traceutil/trace.go:171","msg":"trace[1284684510] linearizableReadLoop","detail":"{readStateIndex:2894; appliedIndex:2892; }","duration":"572.310001ms","start":"2026-06-03T07:27:19.072486Z","end":"2026-06-03T07:27:19.644796Z","steps":["trace[1284684510] 'read index received' (duration: 212.435609ms)","trace[1284684510] 'applied index is now lower than readState.Index' (duration: 359.873152ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T07:27:19.645133Z","caller":"traceutil/trace.go:171","msg":"trace[1270643496] transaction","detail":"{read_only:false; response_revision:2790; number_of_response:1; }","duration":"591.96347ms","start":"2026-06-03T07:27:19.05313Z","end":"2026-06-03T07:27:19.645094Z","steps":["trace[1270643496] 'process raft request' (duration: 591.497184ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:27:19.64517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"572.745797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-03T07:27:19.645214Z","caller":"traceutil/trace.go:171","msg":"trace[1251031060] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2790; }","duration":"572.835259ms","start":"2026-06-03T07:27:19.072368Z","end":"2026-06-03T07:27:19.645203Z","steps":["trace[1251031060] 'agreement among raft nodes before linearized reading' (duration: 572.700087ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:27:19.645246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:27:19.072353Z","time spent":"572.885359ms","remote":"127.0.0.1:35698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-03T07:27:19.645283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:27:19.053113Z","time spent":"592.082391ms","remote":"127.0.0.1:35698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T07:27:19.685948Z","caller":"traceutil/trace.go:171","msg":"trace[1400098559] transaction","detail":"{read_only:false; response_revision:2791; number_of_response:1; }","duration":"210.376844ms","start":"2026-06-03T07:27:19.475543Z","end":"2026-06-03T07:27:19.68592Z","steps":["trace[1400098559] 'process raft request' (duration: 210.140971ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:27:19.686402Z","caller":"traceutil/trace.go:171","msg":"trace[1771311908] transaction","detail":"{read_only:false; response_revision:2792; number_of_response:1; }","duration":"210.122931ms","start":"2026-06-03T07:27:19.476252Z","end":"2026-06-03T07:27:19.686374Z","steps":["trace[1771311908] 'process raft request' (duration: 209.629965ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:27:19.686468Z","caller":"traceutil/trace.go:171","msg":"trace[1004136341] transaction","detail":"{read_only:false; response_revision:2793; number_of_response:1; }","duration":"208.954906ms","start":"2026-06-03T07:27:19.477482Z","end":"2026-06-03T07:27:19.686437Z","steps":["trace[1004136341] 'process raft request' (duration: 208.827625ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:27:19.686552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.255807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-03T07:27:19.686652Z","caller":"traceutil/trace.go:171","msg":"trace[1273611713] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2793; }","duration":"365.344558ms","start":"2026-06-03T07:27:19.32125Z","end":"2026-06-03T07:27:19.686595Z","steps":["trace[1273611713] 'agreement among raft nodes before linearized reading' (duration: 365.236537ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:27:19.686713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:27:19.321238Z","time spent":"365.458729ms","remote":"127.0.0.1:35476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-03T07:27:19.686749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.0322ms","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-06-03T07:27:19.686842Z","caller":"traceutil/trace.go:171","msg":"trace[2090697512] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2793; }","duration":"425.159551ms","start":"2026-06-03T07:27:19.261663Z","end":"2026-06-03T07:27:19.686823Z","steps":["trace[2090697512] 'agreement among raft nodes before linearized reading' (duration: 424.911698ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:27:19.686841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.003433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-03T07:27:19.686947Z","caller":"traceutil/trace.go:171","msg":"trace[1306699256] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2793; }","duration":"441.167056ms","start":"2026-06-03T07:27:19.245761Z","end":"2026-06-03T07:27:19.686928Z","steps":["trace[1306699256] 'agreement among raft nodes before linearized reading' (duration: 440.830901ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:27:19.686891Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:27:19.261651Z","time spent":"425.231143ms","remote":"127.0.0.1:35698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-03T07:27:19.686974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.035684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-06-03T07:27:19.687154Z","caller":"traceutil/trace.go:171","msg":"trace[166190449] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2793; }","duration":"293.309508ms","start":"2026-06-03T07:27:19.393824Z","end":"2026-06-03T07:27:19.687134Z","steps":["trace[166190449] 'agreement among raft nodes before linearized reading' (duration: 292.74628ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:27:19.68719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"538.816517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-03T07:27:19.687253Z","caller":"traceutil/trace.go:171","msg":"trace[1067657188] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2793; }","duration":"538.912928ms","start":"2026-06-03T07:27:19.148323Z","end":"2026-06-03T07:27:19.687236Z","steps":["trace[1067657188] 'agreement among raft nodes before linearized reading' (duration: 538.105817ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:27:19.687307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:27:19.148279Z","time spent":"539.016659ms","remote":"127.0.0.1:35698","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-06-03T07:27:19.68701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:27:19.245744Z","time spent":"441.256567ms","remote":"127.0.0.1:35698","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-06-03T07:29:30.748527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.145522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-03T07:29:30.74862Z","caller":"traceutil/trace.go:171","msg":"trace[378873032] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:3572; }","duration":"391.291616ms","start":"2026-06-03T07:29:30.357314Z","end":"2026-06-03T07:29:30.748606Z","steps":["trace[378873032] 'count revisions from in-memory index tree' (duration: 391.082731ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:29:30.748649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:29:30.357299Z","time spent":"391.342607ms","remote":"127.0.0.1:40778","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true "} {"level":"warn","ts":"2026-06-03T07:29:30.748688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.090289ms","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-06-03T07:29:30.748757Z","caller":"traceutil/trace.go:171","msg":"trace[1911505876] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3572; }","duration":"378.178551ms","start":"2026-06-03T07:29:30.370563Z","end":"2026-06-03T07:29:30.748742Z","steps":["trace[1911505876] 'range keys from in-memory index tree' (duration: 377.932684ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:29:30.748788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:29:30.370507Z","time spent":"378.273433ms","remote":"127.0.0.1:35698","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-06-03T07:29:30.749046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.758099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-03T07:29:30.749064Z","caller":"traceutil/trace.go:171","msg":"trace[787778394] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3572; }","duration":"379.82019ms","start":"2026-06-03T07:29:30.369238Z","end":"2026-06-03T07:29:30.749059Z","steps":["trace[787778394] 'range keys from in-memory index tree' (duration: 379.664666ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:29:30.749079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:29:30.369216Z","time spent":"379.859222ms","remote":"127.0.0.1:35698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-03T07:29:30.749219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.769625ms","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-06-03T07:29:30.749245Z","caller":"traceutil/trace.go:171","msg":"trace[1189595847] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3572; }","duration":"378.816066ms","start":"2026-06-03T07:29:30.37042Z","end":"2026-06-03T07:29:30.749236Z","steps":["trace[1189595847] 'range keys from in-memory index tree' (duration: 378.664863ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:29:30.749277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:29:30.370408Z","time spent":"378.860408ms","remote":"127.0.0.1:35698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-03T07:31:11.350079Z","caller":"traceutil/trace.go:171","msg":"trace[582212279] linearizableReadLoop","detail":"{readStateIndex:4905; appliedIndex:4904; }","duration":"130.710549ms","start":"2026-06-03T07:31:11.219346Z","end":"2026-06-03T07:31:11.350056Z","steps":["trace[582212279] 'read index received' (duration: 130.569896ms)","trace[582212279] 'applied index is now lower than readState.Index' (duration: 139.353µs)"],"step_count":2} {"level":"info","ts":"2026-06-03T07:31:11.350104Z","caller":"traceutil/trace.go:171","msg":"trace[316076555] transaction","detail":"{read_only:false; response_revision:4726; number_of_response:1; }","duration":"194.941987ms","start":"2026-06-03T07:31:11.155133Z","end":"2026-06-03T07:31:11.350075Z","steps":["trace[316076555] 'process raft request' (duration: 194.790913ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:31:11.350365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.010495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-06-03T07:31:11.350404Z","caller":"traceutil/trace.go:171","msg":"trace[1153182420] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4726; }","duration":"131.095697ms","start":"2026-06-03T07:31:11.219299Z","end":"2026-06-03T07:31:11.350395Z","steps":["trace[1153182420] 'agreement among raft nodes before linearized reading' (duration: 130.888243ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:31:11.764834Z","caller":"traceutil/trace.go:171","msg":"trace[1914006196] linearizableReadLoop","detail":"{readStateIndex:4907; appliedIndex:4905; }","duration":"406.440263ms","start":"2026-06-03T07:31:11.35837Z","end":"2026-06-03T07:31:11.76481Z","steps":["trace[1914006196] 'read index received' (duration: 34.865092ms)","trace[1914006196] 'applied index is now lower than readState.Index' (duration: 371.574021ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T07:31:11.764889Z","caller":"traceutil/trace.go:171","msg":"trace[942351596] transaction","detail":"{read_only:false; response_revision:4728; number_of_response:1; }","duration":"406.617327ms","start":"2026-06-03T07:31:11.358232Z","end":"2026-06-03T07:31:11.764849Z","steps":["trace[942351596] 'process raft request' (duration: 406.366441ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:31:11.764952Z","caller":"traceutil/trace.go:171","msg":"trace[1949830755] transaction","detail":"{read_only:false; response_revision:4729; number_of_response:1; }","duration":"406.507953ms","start":"2026-06-03T07:31:11.358432Z","end":"2026-06-03T07:31:11.76494Z","steps":["trace[1949830755] 'process raft request' (duration: 406.337ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:31:11.765038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:31:11.358225Z","time spent":"406.735769ms","remote":"127.0.0.1:35698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-03T07:31:11.765062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:31:11.358411Z","time spent":"406.572596ms","remote":"127.0.0.1:35698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-03T07:31:11.765225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.8255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:9426"} {"level":"info","ts":"2026-06-03T07:31:11.765317Z","caller":"traceutil/trace.go:171","msg":"trace[1019563692] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:4729; }","duration":"406.962403ms","start":"2026-06-03T07:31:11.358336Z","end":"2026-06-03T07:31:11.765298Z","steps":["trace[1019563692] 'agreement among raft nodes before linearized reading' (duration: 406.659537ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:31:11.765367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:31:11.358321Z","time spent":"407.034354ms","remote":"127.0.0.1:35626","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":9448,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-06-03T07:31:11.778395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.128263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-03T07:31:11.778474Z","caller":"traceutil/trace.go:171","msg":"trace[425377812] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4730; }","duration":"123.224805ms","start":"2026-06-03T07:31:11.655234Z","end":"2026-06-03T07:31:11.778459Z","steps":["trace[425377812] 'agreement among raft nodes before linearized reading' (duration: 123.067162ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:31:11.974919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.715137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5651"} {"level":"info","ts":"2026-06-03T07:31:11.974994Z","caller":"traceutil/trace.go:171","msg":"trace[1052018725] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:4739; }","duration":"105.81736ms","start":"2026-06-03T07:31:11.869157Z","end":"2026-06-03T07:31:11.974975Z","steps":["trace[1052018725] 'agreement among raft nodes before linearized reading' (duration: 105.642757ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:31:12.139373Z","caller":"traceutil/trace.go:171","msg":"trace[794683482] transaction","detail":"{read_only:false; response_revision:4740; number_of_response:1; }","duration":"151.921643ms","start":"2026-06-03T07:31:11.987427Z","end":"2026-06-03T07:31:12.139349Z","steps":["trace[794683482] 'process raft request' (duration: 151.7543ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:31:12.163546Z","caller":"traceutil/trace.go:171","msg":"trace[2075606876] transaction","detail":"{read_only:false; response_revision:4741; number_of_response:1; }","duration":"105.704634ms","start":"2026-06-03T07:31:12.057818Z","end":"2026-06-03T07:31:12.163523Z","steps":["trace[2075606876] 'process raft request' (duration: 105.595541ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:31:12.274148Z","caller":"traceutil/trace.go:171","msg":"trace[1418426715] transaction","detail":"{read_only:false; response_revision:4742; number_of_response:1; }","duration":"128.633984ms","start":"2026-06-03T07:31:12.145486Z","end":"2026-06-03T07:31:12.27412Z","steps":["trace[1418426715] 'process raft request' (duration: 128.39405ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:31:12.274406Z","caller":"traceutil/trace.go:171","msg":"trace[1843097538] transaction","detail":"{read_only:false; response_revision:4743; number_of_response:1; }","duration":"128.143164ms","start":"2026-06-03T07:31:12.146247Z","end":"2026-06-03T07:31:12.27439Z","steps":["trace[1843097538] 'process raft request' (duration: 127.797328ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:31:12.27468Z","caller":"traceutil/trace.go:171","msg":"trace[1020633553] linearizableReadLoop","detail":"{readStateIndex:4924; appliedIndex:4920; }","duration":"104.571172ms","start":"2026-06-03T07:31:12.170083Z","end":"2026-06-03T07:31:12.274654Z","steps":["trace[1020633553] 'read index received' (duration: 103.673684ms)","trace[1020633553] 'applied index is now lower than readState.Index' (duration: 896.188µs)"],"step_count":2} {"level":"info","ts":"2026-06-03T07:31:12.274713Z","caller":"traceutil/trace.go:171","msg":"trace[1691428519] transaction","detail":"{read_only:false; response_revision:4744; number_of_response:1; }","duration":"128.263708ms","start":"2026-06-03T07:31:12.146406Z","end":"2026-06-03T07:31:12.274669Z","steps":["trace[1691428519] 'process raft request' (duration: 127.90968ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:31:12.274756Z","caller":"traceutil/trace.go:171","msg":"trace[1322855916] transaction","detail":"{read_only:false; response_revision:4745; number_of_response:1; }","duration":"127.146016ms","start":"2026-06-03T07:31:12.147595Z","end":"2026-06-03T07:31:12.274741Z","steps":["trace[1322855916] 'process raft request' (duration: 126.958672ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:31:12.274781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.685124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/rabbitmq-keystone-default-user\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-03T07:31:12.276223Z","caller":"traceutil/trace.go:171","msg":"trace[1344563091] range","detail":"{range_begin:/registry/secrets/openstack/rabbitmq-keystone-default-user; range_end:; response_count:0; response_revision:4745; }","duration":"106.162093ms","start":"2026-06-03T07:31:12.170044Z","end":"2026-06-03T07:31:12.276207Z","steps":["trace[1344563091] 'agreement among raft nodes before linearized reading' (duration: 104.689905ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:31:12.451184Z","caller":"traceutil/trace.go:171","msg":"trace[7862254] linearizableReadLoop","detail":"{readStateIndex:4927; appliedIndex:4926; }","duration":"144.100773ms","start":"2026-06-03T07:31:12.307066Z","end":"2026-06-03T07:31:12.451167Z","steps":["trace[7862254] 'read index received' (duration: 11.305628ms)","trace[7862254] 'applied index is now lower than readState.Index' (duration: 132.794275ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T07:31:12.451241Z","caller":"traceutil/trace.go:171","msg":"trace[2101527893] transaction","detail":"{read_only:false; response_revision:4748; number_of_response:1; }","duration":"144.330357ms","start":"2026-06-03T07:31:12.306884Z","end":"2026-06-03T07:31:12.451214Z","steps":["trace[2101527893] 'process raft request' (duration: 65.218974ms)","trace[2101527893] 'compare' (duration: 78.769305ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T07:31:12.451287Z","caller":"traceutil/trace.go:171","msg":"trace[1910292627] transaction","detail":"{read_only:false; response_revision:4749; number_of_response:1; }","duration":"143.9413ms","start":"2026-06-03T07:31:12.307338Z","end":"2026-06-03T07:31:12.451279Z","steps":["trace[1910292627] 'process raft request' (duration: 143.769276ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:31:12.452681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.590461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:129530"} {"level":"info","ts":"2026-06-03T07:31:12.452763Z","caller":"traceutil/trace.go:171","msg":"trace[1503603517] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:4749; }","duration":"145.713062ms","start":"2026-06-03T07:31:12.307033Z","end":"2026-06-03T07:31:12.452746Z","steps":["trace[1503603517] 'agreement among raft nodes before linearized reading' (duration: 145.264124ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:31:12.665361Z","caller":"traceutil/trace.go:171","msg":"trace[1745279344] transaction","detail":"{read_only:false; response_revision:4754; number_of_response:1; }","duration":"172.265644ms","start":"2026-06-03T07:31:12.492939Z","end":"2026-06-03T07:31:12.665205Z","steps":["trace[1745279344] 'process raft request' (duration: 172.207613ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:31:12.665584Z","caller":"traceutil/trace.go:171","msg":"trace[2007935206] transaction","detail":"{read_only:false; response_revision:4751; number_of_response:1; }","duration":"192.911831ms","start":"2026-06-03T07:31:12.472642Z","end":"2026-06-03T07:31:12.665554Z","steps":["trace[2007935206] 'process raft request' (duration: 140.40067ms)","trace[2007935206] 'compare' (duration: 51.831118ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T07:31:12.665613Z","caller":"traceutil/trace.go:171","msg":"trace[1960534290] transaction","detail":"{read_only:false; response_revision:4752; number_of_response:1; }","duration":"191.32882ms","start":"2026-06-03T07:31:12.474263Z","end":"2026-06-03T07:31:12.665592Z","steps":["trace[1960534290] 'process raft request' (duration: 190.77587ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:31:12.66583Z","caller":"traceutil/trace.go:171","msg":"trace[1104527768] transaction","detail":"{read_only:false; response_revision:4753; number_of_response:1; }","duration":"172.872595ms","start":"2026-06-03T07:31:12.492921Z","end":"2026-06-03T07:31:12.665793Z","steps":["trace[1104527768] 'process raft request' (duration: 172.178752ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:31:12.668769Z","caller":"traceutil/trace.go:171","msg":"trace[1230394582] transaction","detail":"{read_only:false; response_revision:4755; number_of_response:1; }","duration":"141.097034ms","start":"2026-06-03T07:31:12.527655Z","end":"2026-06-03T07:31:12.668752Z","steps":["trace[1230394582] 'process raft request' (duration: 140.627845ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:31:16.481636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.21944ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-03T07:31:16.481794Z","caller":"traceutil/trace.go:171","msg":"trace[1377671891] transaction","detail":"{read_only:false; response_revision:4829; number_of_response:1; }","duration":"303.78215ms","start":"2026-06-03T07:31:16.178Z","end":"2026-06-03T07:31:16.481782Z","steps":["trace[1377671891] 'process raft request' (duration: 303.713239ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:31:16.48277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:31:16.177977Z","time spent":"303.954013ms","remote":"127.0.0.1:35698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T07:31:16.483133Z","caller":"traceutil/trace.go:171","msg":"trace[1872594860] linearizableReadLoop","detail":"{readStateIndex:5008; appliedIndex:5007; }","duration":"567.302615ms","start":"2026-06-03T07:31:15.915806Z","end":"2026-06-03T07:31:16.483109Z","steps":["trace[1872594860] 'read index received' (duration: 241.466054ms)","trace[1872594860] 'applied index is now lower than readState.Index' (duration: 325.834631ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T07:31:16.48317Z","caller":"traceutil/trace.go:171","msg":"trace[1661821170] transaction","detail":"{read_only:false; response_revision:4828; number_of_response:1; }","duration":"608.373971ms","start":"2026-06-03T07:31:15.874765Z","end":"2026-06-03T07:31:16.483139Z","steps":["trace[1661821170] 'process raft request' (duration: 282.58864ms)","trace[1661821170] 'compare' (duration: 323.563848ms)"],"step_count":2} {"level":"warn","ts":"2026-06-03T07:31:16.483328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:31:15.874746Z","time spent":"608.486462ms","remote":"127.0.0.1:35626","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11113,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-03T07:31:16.483367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"567.550611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-03T07:31:16.483704Z","caller":"traceutil/trace.go:171","msg":"trace[2064152328] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4829; }","duration":"567.927517ms","start":"2026-06-03T07:31:15.915764Z","end":"2026-06-03T07:31:16.483691Z","steps":["trace[2064152328] 'agreement among raft nodes before linearized reading' (duration: 567.516359ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:31:16.483793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:31:15.915744Z","time spent":"568.03488ms","remote":"127.0.0.1:35472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-03T07:31:16.575782Z","caller":"traceutil/trace.go:171","msg":"trace[518224018] transaction","detail":"{read_only:false; response_revision:4830; number_of_response:1; }","duration":"349.569475ms","start":"2026-06-03T07:31:16.226183Z","end":"2026-06-03T07:31:16.575752Z","steps":["trace[518224018] 'process raft request' (duration: 349.393742ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:31:16.575914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.704994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-03T07:31:16.575989Z","caller":"traceutil/trace.go:171","msg":"trace[2076755885] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:4830; }","duration":"298.838986ms","start":"2026-06-03T07:31:16.277136Z","end":"2026-06-03T07:31:16.575975Z","steps":["trace[2076755885] 'agreement among raft nodes before linearized reading' (duration: 298.625182ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:31:16.575936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.761409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:529"} {"level":"warn","ts":"2026-06-03T07:31:16.576023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:31:16.226156Z","time spent":"349.695917ms","remote":"127.0.0.1:35698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T07:31:16.576123Z","caller":"traceutil/trace.go:171","msg":"trace[113692624] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:4830; }","duration":"194.989254ms","start":"2026-06-03T07:31:16.381119Z","end":"2026-06-03T07:31:16.576109Z","steps":["trace[113692624] 'agreement among raft nodes before linearized reading' (duration: 194.686218ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:31:21.567391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.901919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-03T07:31:21.567472Z","caller":"traceutil/trace.go:171","msg":"trace[1745357795] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4925; }","duration":"130.017731ms","start":"2026-06-03T07:31:21.437435Z","end":"2026-06-03T07:31:21.567453Z","steps":["trace[1745357795] 'range keys from in-memory index tree' (duration: 129.712225ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:31:21.567747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.609401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/vhosts/\" range_end:\"/registry/rabbitmq.com/vhosts0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-03T07:31:21.567786Z","caller":"traceutil/trace.go:171","msg":"trace[693689842] range","detail":"{range_begin:/registry/rabbitmq.com/vhosts/; range_end:/registry/rabbitmq.com/vhosts0; response_count:0; response_revision:4925; }","duration":"113.677811ms","start":"2026-06-03T07:31:21.454097Z","end":"2026-06-03T07:31:21.567775Z","steps":["trace[693689842] 'count revisions from in-memory index tree' (duration: 113.522829ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:31:27.164354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.468381ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-03T07:31:27.164739Z","caller":"traceutil/trace.go:171","msg":"trace[1247727108] linearizableReadLoop","detail":"{readStateIndex:5161; appliedIndex:5157; }","duration":"295.53689ms","start":"2026-06-03T07:31:26.869185Z","end":"2026-06-03T07:31:27.164722Z","steps":["trace[1247727108] 'read index received' (duration: 85.431µs)","trace[1247727108] 'applied index is now lower than readState.Index' (duration: 295.450259ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T07:31:27.164872Z","caller":"traceutil/trace.go:171","msg":"trace[1058348102] transaction","detail":"{read_only:false; response_revision:4973; number_of_response:1; }","duration":"418.802252ms","start":"2026-06-03T07:31:26.746056Z","end":"2026-06-03T07:31:27.164858Z","steps":["trace[1058348102] 'process raft request' (duration: 100.75598ms)","trace[1058348102] 'compare' (duration: 317.249717ms)"],"step_count":2} {"level":"warn","ts":"2026-06-03T07:31:27.165062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:31:26.746029Z","time spent":"418.899893ms","remote":"127.0.0.1:35698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T07:31:27.165295Z","caller":"traceutil/trace.go:171","msg":"trace[207796187] transaction","detail":"{read_only:false; response_revision:4974; number_of_response:1; }","duration":"419.21892ms","start":"2026-06-03T07:31:26.746065Z","end":"2026-06-03T07:31:27.165284Z","steps":["trace[207796187] 'process raft request' (duration: 418.506517ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:31:27.165398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:31:26.746039Z","time spent":"419.323511ms","remote":"127.0.0.1:35698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T07:31:27.165386Z","caller":"traceutil/trace.go:171","msg":"trace[1571181524] transaction","detail":"{read_only:false; response_revision:4975; number_of_response:1; }","duration":"418.73467ms","start":"2026-06-03T07:31:26.746625Z","end":"2026-06-03T07:31:27.16536Z","steps":["trace[1571181524] 'process raft request' (duration: 418.000907ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:31:27.165544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.697617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3316"} {"level":"info","ts":"2026-06-03T07:31:27.165583Z","caller":"traceutil/trace.go:171","msg":"trace[1159753193] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4976; }","duration":"291.775408ms","start":"2026-06-03T07:31:26.873797Z","end":"2026-06-03T07:31:27.165573Z","steps":["trace[1159753193] 'agreement among raft nodes before linearized reading' (duration: 291.640546ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:31:27.165641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.447267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-03T07:31:27.165735Z","caller":"traceutil/trace.go:171","msg":"trace[780917123] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:4976; }","duration":"296.554979ms","start":"2026-06-03T07:31:26.869164Z","end":"2026-06-03T07:31:27.165719Z","steps":["trace[780917123] 'agreement among raft nodes before linearized reading' (duration: 296.167462ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:31:27.165885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.975046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-06-03T07:31:27.165911Z","caller":"traceutil/trace.go:171","msg":"trace[1149105227] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4976; }","duration":"160.041717ms","start":"2026-06-03T07:31:27.005861Z","end":"2026-06-03T07:31:27.165903Z","steps":["trace[1149105227] 'agreement among raft nodes before linearized reading' (duration: 159.889004ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:31:27.166094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:31:26.746613Z","time spent":"418.947994ms","remote":"127.0.0.1:35698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-03T07:31:27.166267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.220435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-06-03T07:31:27.166321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.53836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-grafana-77d8c47c99-dp9mr\" ","response":"range_response_count:1 size:11844"} {"level":"info","ts":"2026-06-03T07:31:27.166343Z","caller":"traceutil/trace.go:171","msg":"trace[1308274483] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-grafana-77d8c47c99-dp9mr; range_end:; response_count:1; response_revision:4976; }","duration":"246.601201ms","start":"2026-06-03T07:31:26.919736Z","end":"2026-06-03T07:31:27.166338Z","steps":["trace[1308274483] 'agreement among raft nodes before linearized reading' (duration: 246.52332ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:31:27.16635Z","caller":"traceutil/trace.go:171","msg":"trace[1123628837] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4976; }","duration":"285.333017ms","start":"2026-06-03T07:31:26.881Z","end":"2026-06-03T07:31:27.166333Z","steps":["trace[1123628837] 'agreement among raft nodes before linearized reading' (duration: 284.759827ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:31:27.166037Z","caller":"traceutil/trace.go:171","msg":"trace[2103282570] transaction","detail":"{read_only:false; response_revision:4976; number_of_response:1; }","duration":"411.167117ms","start":"2026-06-03T07:31:26.754855Z","end":"2026-06-03T07:31:27.166022Z","steps":["trace[2103282570] 'process raft request' (duration: 409.802112ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:31:27.166488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:31:26.75483Z","time spent":"411.586266ms","remote":"127.0.0.1:35698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T07:31:27.385969Z","caller":"traceutil/trace.go:171","msg":"trace[1668869351] transaction","detail":"{read_only:false; response_revision:4982; number_of_response:1; }","duration":"146.906361ms","start":"2026-06-03T07:31:27.239029Z","end":"2026-06-03T07:31:27.385935Z","steps":["trace[1668869351] 'process raft request' (duration: 146.680537ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:31:37.105247Z","caller":"traceutil/trace.go:171","msg":"trace[692957518] linearizableReadLoop","detail":"{readStateIndex:5231; appliedIndex:5230; }","duration":"185.803725ms","start":"2026-06-03T07:31:36.919419Z","end":"2026-06-03T07:31:37.105223Z","steps":["trace[692957518] 'read index received' (duration: 185.193624ms)","trace[692957518] 'applied index is now lower than readState.Index' (duration: 608.581µs)"],"step_count":2} {"level":"info","ts":"2026-06-03T07:31:37.105412Z","caller":"traceutil/trace.go:171","msg":"trace[1432888085] transaction","detail":"{read_only:false; response_revision:5044; number_of_response:1; }","duration":"310.811142ms","start":"2026-06-03T07:31:36.794491Z","end":"2026-06-03T07:31:37.105302Z","steps":["trace[1432888085] 'process raft request' (duration: 310.195451ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:31:37.105504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.08128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-03T07:31:37.105548Z","caller":"traceutil/trace.go:171","msg":"trace[1647209360] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5044; }","duration":"186.173592ms","start":"2026-06-03T07:31:36.919364Z","end":"2026-06-03T07:31:37.105538Z","steps":["trace[1647209360] 'agreement among raft nodes before linearized reading' (duration: 185.973488ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:31:37.105579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:31:36.79447Z","time spent":"310.990066ms","remote":"127.0.0.1:35698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T07:32:05.528998Z","caller":"traceutil/trace.go:171","msg":"trace[827394758] transaction","detail":"{read_only:false; response_revision:5311; number_of_response:1; }","duration":"159.686263ms","start":"2026-06-03T07:32:05.369288Z","end":"2026-06-03T07:32:05.528975Z","steps":["trace[827394758] 'process raft request' (duration: 129.926097ms)","trace[827394758] 'compare' (duration: 29.532563ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T07:32:05.529051Z","caller":"traceutil/trace.go:171","msg":"trace[1778814539] transaction","detail":"{read_only:false; response_revision:5312; number_of_response:1; }","duration":"158.695466ms","start":"2026-06-03T07:32:05.370335Z","end":"2026-06-03T07:32:05.52903Z","steps":["trace[1778814539] 'process raft request' (duration: 158.561434ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:32:05.528989Z","caller":"traceutil/trace.go:171","msg":"trace[945537928] linearizableReadLoop","detail":"{readStateIndex:5506; appliedIndex:5503; }","duration":"143.5938ms","start":"2026-06-03T07:32:05.385367Z","end":"2026-06-03T07:32:05.528961Z","steps":["trace[945537928] 'read index received' (duration: 33.112696ms)","trace[945537928] 'applied index is now lower than readState.Index' (duration: 110.479764ms)"],"step_count":2} {"level":"warn","ts":"2026-06-03T07:32:05.529439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.041928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-06-03T07:32:05.529545Z","caller":"traceutil/trace.go:171","msg":"trace[1151905106] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5312; }","duration":"144.19755ms","start":"2026-06-03T07:32:05.385327Z","end":"2026-06-03T07:32:05.529525Z","steps":["trace[1151905106] 'agreement among raft nodes before linearized reading' (duration: 143.722962ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:32:40.747765Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2904} {"level":"info","ts":"2026-06-03T07:32:40.82901Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2904,"took":"80.035428ms","hash":3612115033,"current-db-size-bytes":53907456,"current-db-size":"54 MB","current-db-size-in-use-bytes":29229056,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-06-03T07:32:40.829159Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3612115033,"revision":2904,"compact-revision":-1} {"level":"info","ts":"2026-06-03T07:33:12.637176Z","caller":"traceutil/trace.go:171","msg":"trace[941850832] linearizableReadLoop","detail":"{readStateIndex:5998; appliedIndex:5997; }","duration":"137.674694ms","start":"2026-06-03T07:33:12.499484Z","end":"2026-06-03T07:33:12.637158Z","steps":["trace[941850832] 'read index received' (duration: 137.3884ms)","trace[941850832] 'applied index is now lower than readState.Index' (duration: 285.264µs)"],"step_count":2} {"level":"info","ts":"2026-06-03T07:33:12.637407Z","caller":"traceutil/trace.go:171","msg":"trace[1212440411] transaction","detail":"{read_only:false; response_revision:5789; number_of_response:1; }","duration":"224.567954ms","start":"2026-06-03T07:33:12.412827Z","end":"2026-06-03T07:33:12.637395Z","steps":["trace[1212440411] 'process raft request' (duration: 224.133087ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:33:12.637613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.528336ms","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-06-03T07:33:12.637815Z","caller":"traceutil/trace.go:171","msg":"trace[71579886] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:5789; }","duration":"133.786891ms","start":"2026-06-03T07:33:12.504002Z","end":"2026-06-03T07:33:12.637789Z","steps":["trace[71579886] 'agreement among raft nodes before linearized reading' (duration: 133.530476ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:33:12.637862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.12154ms","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-06-03T07:33:12.638463Z","caller":"traceutil/trace.go:171","msg":"trace[1278205238] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5789; }","duration":"119.75825ms","start":"2026-06-03T07:33:12.518695Z","end":"2026-06-03T07:33:12.638454Z","steps":["trace[1278205238] 'agreement among raft nodes before linearized reading' (duration: 118.987098ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:33:12.637927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.439618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/keystone-api\" ","response":"range_response_count:1 size:675"} {"level":"info","ts":"2026-06-03T07:33:12.638589Z","caller":"traceutil/trace.go:171","msg":"trace[2001600343] range","detail":"{range_begin:/registry/services/endpoints/openstack/keystone-api; range_end:; response_count:1; response_revision:5789; }","duration":"139.148719ms","start":"2026-06-03T07:33:12.499433Z","end":"2026-06-03T07:33:12.638582Z","steps":["trace[2001600343] 'agreement among raft nodes before linearized reading' (duration: 138.329496ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:33:21.13734Z","caller":"traceutil/trace.go:171","msg":"trace[1848102817] transaction","detail":"{read_only:false; response_revision:5831; number_of_response:1; }","duration":"457.225091ms","start":"2026-06-03T07:33:20.680075Z","end":"2026-06-03T07:33:21.1373Z","steps":["trace[1848102817] 'process raft request' (duration: 456.955836ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:33:21.137628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:33:20.680055Z","time spent":"457.398093ms","remote":"127.0.0.1:35698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T07:33:21.183371Z","caller":"traceutil/trace.go:171","msg":"trace[254515435] transaction","detail":"{read_only:false; response_revision:5832; number_of_response:1; }","duration":"501.400771ms","start":"2026-06-03T07:33:20.681938Z","end":"2026-06-03T07:33:21.183339Z","steps":["trace[254515435] 'process raft request' (duration: 500.617878ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:33:21.183631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:33:20.681913Z","time spent":"501.632954ms","remote":"127.0.0.1:35698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-03T07:33:33.897845Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3757020839848567486,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-03T07:33:34.398211Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3757020839848567486,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-03T07:33:34.717035Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.384911079s","expected-duration":"1s"} {"level":"info","ts":"2026-06-03T07:33:34.717527Z","caller":"traceutil/trace.go:171","msg":"trace[1279501108] transaction","detail":"{read_only:false; response_revision:5891; number_of_response:1; }","duration":"1.385480187s","start":"2026-06-03T07:33:33.332024Z","end":"2026-06-03T07:33:34.717504Z","steps":["trace[1279501108] 'process raft request' (duration: 1.385331925s)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:33:34.717687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:33:33.332006Z","time spent":"1.385586039s","remote":"127.0.0.1:35698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T07:33:34.721679Z","caller":"traceutil/trace.go:171","msg":"trace[431409111] transaction","detail":"{read_only:false; response_revision:5892; number_of_response:1; }","duration":"851.325596ms","start":"2026-06-03T07:33:33.870322Z","end":"2026-06-03T07:33:34.721648Z","steps":["trace[431409111] 'process raft request' (duration: 851.091492ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:33:34.721824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:33:33.870297Z","time spent":"851.442158ms","remote":"127.0.0.1:35698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T07:33:34.721925Z","caller":"traceutil/trace.go:171","msg":"trace[1223197008] transaction","detail":"{read_only:false; response_revision:5893; number_of_response:1; }","duration":"851.396827ms","start":"2026-06-03T07:33:33.870458Z","end":"2026-06-03T07:33:34.721855Z","steps":["trace[1223197008] 'process raft request' (duration: 851.080442ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:33:34.722053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:33:33.870451Z","time spent":"851.555129ms","remote":"127.0.0.1:35698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T07:33:34.722408Z","caller":"traceutil/trace.go:171","msg":"trace[801740361] transaction","detail":"{read_only:false; response_revision:5894; number_of_response:1; }","duration":"851.903005ms","start":"2026-06-03T07:33:33.87049Z","end":"2026-06-03T07:33:34.722393Z","steps":["trace[801740361] 'process raft request' (duration: 851.799654ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:33:34.722492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:33:33.870478Z","time spent":"851.971186ms","remote":"127.0.0.1:35698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T07:33:34.722584Z","caller":"traceutil/trace.go:171","msg":"trace[1023257668] transaction","detail":"{read_only:false; response_revision:5895; number_of_response:1; }","duration":"852.053467ms","start":"2026-06-03T07:33:33.870513Z","end":"2026-06-03T07:33:34.722566Z","steps":["trace[1023257668] 'process raft request' (duration: 851.846364ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:33:34.722602Z","caller":"traceutil/trace.go:171","msg":"trace[1891986697] linearizableReadLoop","detail":"{readStateIndex:6108; appliedIndex:6103; }","duration":"1.325525407s","start":"2026-06-03T07:33:33.397047Z","end":"2026-06-03T07:33:34.722573Z","steps":["trace[1891986697] 'read index received' (duration: 1.320294063s)","trace[1891986697] 'applied index is now lower than readState.Index' (duration: 5.139753ms)"],"step_count":2} {"level":"warn","ts":"2026-06-03T07:33:34.722729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:33:33.870502Z","time spent":"852.15511ms","remote":"127.0.0.1:35698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-03T07:33:34.72283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.325749271s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-03T07:33:34.722962Z","caller":"traceutil/trace.go:171","msg":"trace[1187040844] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:5895; }","duration":"1.325866622s","start":"2026-06-03T07:33:33.397035Z","end":"2026-06-03T07:33:34.722901Z","steps":["trace[1187040844] 'agreement among raft nodes before linearized reading' (duration: 1.325672259s)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:33:34.723039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:33:33.396975Z","time spent":"1.326046245s","remote":"127.0.0.1:40694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-03T07:33:34.723264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"855.540684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/probes/\" range_end:\"/registry/monitoring.coreos.com/probes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-03T07:33:34.723337Z","caller":"traceutil/trace.go:171","msg":"trace[903110537] range","detail":"{range_begin:/registry/monitoring.coreos.com/probes/; range_end:/registry/monitoring.coreos.com/probes0; response_count:0; response_revision:5895; }","duration":"855.642595ms","start":"2026-06-03T07:33:33.867678Z","end":"2026-06-03T07:33:34.72332Z","steps":["trace[903110537] 'agreement among raft nodes before linearized reading' (duration: 855.541523ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:33:34.723372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:33:33.867665Z","time spent":"855.697396ms","remote":"127.0.0.1:37856","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":0,"response size":27,"request content":"key:\"/registry/monitoring.coreos.com/probes/\" range_end:\"/registry/monitoring.coreos.com/probes0\" count_only:true "} {"level":"warn","ts":"2026-06-03T07:33:34.72339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"764.880645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-06-03T07:33:34.72347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"806.82715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-03T07:33:34.72348Z","caller":"traceutil/trace.go:171","msg":"trace[1672990802] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5895; }","duration":"764.993876ms","start":"2026-06-03T07:33:33.958471Z","end":"2026-06-03T07:33:34.723465Z","steps":["trace[1672990802] 'agreement among raft nodes before linearized reading' (duration: 764.766833ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:33:34.723519Z","caller":"traceutil/trace.go:171","msg":"trace[579822442] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5895; }","duration":"806.900631ms","start":"2026-06-03T07:33:33.9166Z","end":"2026-06-03T07:33:34.723501Z","steps":["trace[579822442] 'agreement among raft nodes before linearized reading' (duration: 806.85096ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:33:34.723555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:33:33.916578Z","time spent":"806.972234ms","remote":"127.0.0.1:35472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-03T07:33:34.723553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:33:33.958458Z","time spent":"765.052418ms","remote":"127.0.0.1:35698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-03T07:33:34.723608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"855.833099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.38\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-06-03T07:33:34.72367Z","caller":"traceutil/trace.go:171","msg":"trace[1617534467] range","detail":"{range_begin:/registry/masterleases/199.204.45.38; range_end:; response_count:1; response_revision:5895; }","duration":"855.90162ms","start":"2026-06-03T07:33:33.867754Z","end":"2026-06-03T07:33:34.723655Z","steps":["trace[1617534467] 'agreement among raft nodes before linearized reading' (duration: 855.724946ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:33:34.723711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:33:33.867751Z","time spent":"855.949731ms","remote":"127.0.0.1:35512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":155,"request content":"key:\"/registry/masterleases/199.204.45.38\" "} {"level":"warn","ts":"2026-06-03T07:33:34.723813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.129083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"warn","ts":"2026-06-03T07:33:34.723929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"755.697327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"warn","ts":"2026-06-03T07:33:34.72393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.216407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-03T07:33:34.723965Z","caller":"traceutil/trace.go:171","msg":"trace[1811560452] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:5895; }","duration":"755.726218ms","start":"2026-06-03T07:33:33.968227Z","end":"2026-06-03T07:33:34.723953Z","steps":["trace[1811560452] 'agreement among raft nodes before linearized reading' (duration: 755.652457ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:33:34.72399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:33:33.968191Z","time spent":"755.794068ms","remote":"127.0.0.1:35698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":580,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"info","ts":"2026-06-03T07:33:34.724008Z","caller":"traceutil/trace.go:171","msg":"trace[1064842846] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5895; }","duration":"380.304449ms","start":"2026-06-03T07:33:34.343656Z","end":"2026-06-03T07:33:34.723961Z","steps":["trace[1064842846] 'agreement among raft nodes before linearized reading' (duration: 380.069905ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:33:34.723408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"852.945792ms","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-06-03T07:33:34.72405Z","caller":"traceutil/trace.go:171","msg":"trace[12381327] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5895; }","duration":"232.359227ms","start":"2026-06-03T07:33:34.491577Z","end":"2026-06-03T07:33:34.723937Z","steps":["trace[12381327] 'agreement among raft nodes before linearized reading' (duration: 231.696995ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:33:34.723837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"853.4143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-06-03T07:33:34.724214Z","caller":"traceutil/trace.go:171","msg":"trace[817039301] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5895; }","duration":"853.814036ms","start":"2026-06-03T07:33:33.870389Z","end":"2026-06-03T07:33:34.724203Z","steps":["trace[817039301] 'agreement among raft nodes before linearized reading' (duration: 853.390599ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:33:34.724298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:33:33.87038Z","time spent":"853.905548ms","remote":"127.0.0.1:35698","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":"info","ts":"2026-06-03T07:33:34.724092Z","caller":"traceutil/trace.go:171","msg":"trace[762707480] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5895; }","duration":"853.641104ms","start":"2026-06-03T07:33:33.87043Z","end":"2026-06-03T07:33:34.724071Z","steps":["trace[762707480] 'agreement among raft nodes before linearized reading' (duration: 852.8241ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:33:34.724103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:33:34.343636Z","time spent":"380.455471ms","remote":"127.0.0.1:35698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-03T07:33:34.724628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T07:33:33.870373Z","time spent":"854.237433ms","remote":"127.0.0.1:35698","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":"info","ts":"2026-06-03T07:35:15.438703Z","caller":"traceutil/trace.go:171","msg":"trace[806696249] transaction","detail":"{read_only:false; response_revision:6615; number_of_response:1; }","duration":"125.582227ms","start":"2026-06-03T07:35:15.313082Z","end":"2026-06-03T07:35:15.438664Z","steps":["trace[806696249] 'process raft request' (duration: 125.324373ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:35:15.43879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.362123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-06-03T07:35:15.438867Z","caller":"traceutil/trace.go:171","msg":"trace[682210088] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6615; }","duration":"121.453204ms","start":"2026-06-03T07:35:15.317395Z","end":"2026-06-03T07:35:15.438848Z","steps":["trace[682210088] 'agreement among raft nodes before linearized reading' (duration: 121.17655ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:35:15.439064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.870917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-03T07:35:15.439119Z","caller":"traceutil/trace.go:171","msg":"trace[1271923303] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6615; }","duration":"111.959448ms","start":"2026-06-03T07:35:15.327147Z","end":"2026-06-03T07:35:15.439106Z","steps":["trace[1271923303] 'agreement among raft nodes before linearized reading' (duration: 111.830216ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T07:35:17.584251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.959944ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-03T07:35:17.584466Z","caller":"traceutil/trace.go:171","msg":"trace[1292065047] linearizableReadLoop","detail":"{readStateIndex:6866; appliedIndex:6864; }","duration":"114.655558ms","start":"2026-06-03T07:35:17.469794Z","end":"2026-06-03T07:35:17.584449Z","steps":["trace[1292065047] 'read index received' (duration: 12.43447ms)","trace[1292065047] 'applied index is now lower than readState.Index' (duration: 102.219708ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T07:35:17.58456Z","caller":"traceutil/trace.go:171","msg":"trace[2105354762] transaction","detail":"{read_only:false; response_revision:6626; number_of_response:1; }","duration":"141.924037ms","start":"2026-06-03T07:35:17.442624Z","end":"2026-06-03T07:35:17.584548Z","steps":["trace[2105354762] 'process raft request' (duration: 39.590878ms)","trace[2105354762] 'compare' (duration: 101.852082ms)"],"step_count":2} {"level":"warn","ts":"2026-06-03T07:35:17.584964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.175657ms","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-06-03T07:35:17.585006Z","caller":"traceutil/trace.go:171","msg":"trace[2106086330] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6627; }","duration":"115.266207ms","start":"2026-06-03T07:35:17.469729Z","end":"2026-06-03T07:35:17.584995Z","steps":["trace[2106086330] 'agreement among raft nodes before linearized reading' (duration: 115.131785ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:35:17.585261Z","caller":"traceutil/trace.go:171","msg":"trace[1552825937] transaction","detail":"{read_only:false; response_revision:6627; number_of_response:1; }","duration":"141.285497ms","start":"2026-06-03T07:35:17.443957Z","end":"2026-06-03T07:35:17.585242Z","steps":["trace[1552825937] 'process raft request' (duration: 140.402944ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:35:17.755947Z","caller":"traceutil/trace.go:171","msg":"trace[1708852210] transaction","detail":"{read_only:false; response_revision:6628; number_of_response:1; }","duration":"166.617735ms","start":"2026-06-03T07:35:17.589295Z","end":"2026-06-03T07:35:17.755913Z","steps":["trace[1708852210] 'process raft request' (duration: 106.92577ms)","trace[1708852210] 'compare' (duration: 59.41121ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T07:35:17.771076Z","caller":"traceutil/trace.go:171","msg":"trace[1631973927] transaction","detail":"{read_only:false; response_revision:6629; number_of_response:1; }","duration":"181.169148ms","start":"2026-06-03T07:35:17.589876Z","end":"2026-06-03T07:35:17.771045Z","steps":["trace[1631973927] 'process raft request' (duration: 180.838843ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:35:17.771816Z","caller":"traceutil/trace.go:171","msg":"trace[960686936] transaction","detail":"{read_only:false; response_revision:6631; number_of_response:1; }","duration":"142.110659ms","start":"2026-06-03T07:35:17.629687Z","end":"2026-06-03T07:35:17.771797Z","steps":["trace[960686936] 'process raft request' (duration: 142.038428ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:35:17.772064Z","caller":"traceutil/trace.go:171","msg":"trace[1602813175] transaction","detail":"{read_only:false; response_revision:6630; number_of_response:1; }","duration":"182.088562ms","start":"2026-06-03T07:35:17.589966Z","end":"2026-06-03T07:35:17.772055Z","steps":["trace[1602813175] 'process raft request' (duration: 180.998815ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T07:37:40.754004Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5578} {"level":"info","ts":"2026-06-03T07:37:40.846709Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5578,"took":"91.581015ms","hash":3642465296,"current-db-size-bytes":53907456,"current-db-size":"54 MB","current-db-size-in-use-bytes":18399232,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-06-03T07:37:40.846771Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3642465296,"revision":5578,"compact-revision":2904}