{"level":"warn","ts":"2026-06-02T01:06:33.560803Z","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-02T01:06:33.56094Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.206:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.206:2380","--initial-cluster=instance=https://162.253.55.206:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.206:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.206: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-02T01:06:33.561025Z","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-02T01:06:33.561039Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.206:2380"]} {"level":"info","ts":"2026-06-02T01:06:33.561061Z","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-02T01:06:33.561941Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.206:2379"]} {"level":"info","ts":"2026-06-02T01:06:33.562038Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.206:2380"],"listen-peer-urls":["https://162.253.55.206:2380"],"advertise-client-urls":["https://162.253.55.206:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.206:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.206: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-02T01:06:33.566857Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.917215ms"} {"level":"info","ts":"2026-06-02T01:06:33.57415Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"cfc9fec265e3384a","cluster-id":"9866fe2b0d49ed88"} {"level":"info","ts":"2026-06-02T01:06:33.574233Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cfc9fec265e3384a switched to configuration voters=()"} {"level":"info","ts":"2026-06-02T01:06:33.574254Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cfc9fec265e3384a became follower at term 0"} {"level":"info","ts":"2026-06-02T01:06:33.574269Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft cfc9fec265e3384a [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-02T01:06:33.574299Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cfc9fec265e3384a became follower at term 1"} {"level":"info","ts":"2026-06-02T01:06:33.574342Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cfc9fec265e3384a switched to configuration voters=(14972778547056425034)"} {"level":"warn","ts":"2026-06-02T01:06:33.581657Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-02T01:06:33.58329Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-02T01:06:33.584415Z","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-02T01:06:33.586297Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"cfc9fec265e3384a","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-02T01:06:33.586528Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"cfc9fec265e3384a","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-02T01:06:33.586621Z","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-02T01:06:33.586764Z","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-02T01:06:33.586794Z","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-02T01:06:33.58784Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cfc9fec265e3384a switched to configuration voters=(14972778547056425034)"} {"level":"info","ts":"2026-06-02T01:06:33.588728Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9866fe2b0d49ed88","local-member-id":"cfc9fec265e3384a","added-peer-id":"cfc9fec265e3384a","added-peer-peer-urls":["https://162.253.55.206:2380"]} {"level":"info","ts":"2026-06-02T01:06:33.589539Z","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-02T01:06:33.58972Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"cfc9fec265e3384a","initial-advertise-peer-urls":["https://162.253.55.206:2380"],"listen-peer-urls":["https://162.253.55.206:2380"],"advertise-client-urls":["https://162.253.55.206:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.206:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-02T01:06:33.589763Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-02T01:06:33.589708Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.206:2380"} {"level":"info","ts":"2026-06-02T01:06:33.589909Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.206:2380"} {"level":"info","ts":"2026-06-02T01:06:34.074906Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cfc9fec265e3384a is starting a new election at term 1"} {"level":"info","ts":"2026-06-02T01:06:34.074972Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cfc9fec265e3384a became pre-candidate at term 1"} {"level":"info","ts":"2026-06-02T01:06:34.075005Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cfc9fec265e3384a received MsgPreVoteResp from cfc9fec265e3384a at term 1"} {"level":"info","ts":"2026-06-02T01:06:34.075024Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cfc9fec265e3384a became candidate at term 2"} {"level":"info","ts":"2026-06-02T01:06:34.075045Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cfc9fec265e3384a received MsgVoteResp from cfc9fec265e3384a at term 2"} {"level":"info","ts":"2026-06-02T01:06:34.07506Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cfc9fec265e3384a became leader at term 2"} {"level":"info","ts":"2026-06-02T01:06:34.07508Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: cfc9fec265e3384a elected leader cfc9fec265e3384a at term 2"} {"level":"info","ts":"2026-06-02T01:06:34.075944Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"cfc9fec265e3384a","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.206:2379]}","request-path":"/0/members/cfc9fec265e3384a/attributes","cluster-id":"9866fe2b0d49ed88","publish-timeout":"7s"} {"level":"info","ts":"2026-06-02T01:06:34.076254Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-02T01:06:34.077129Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-02T01:06:34.077625Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-02T01:06:34.077884Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-02T01:06:34.077913Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-02T01:06:34.077959Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9866fe2b0d49ed88","local-member-id":"cfc9fec265e3384a","cluster-version":"3.5"} {"level":"info","ts":"2026-06-02T01:06:34.078056Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-02T01:06:34.078101Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-02T01:06:34.080727Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.206:2379"} {"level":"info","ts":"2026-06-02T01:06:34.083197Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-02T01:07:21.663902Z","caller":"traceutil/trace.go:171","msg":"trace[725216399] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"194.433948ms","start":"2026-06-02T01:07:21.469434Z","end":"2026-06-02T01:07:21.663868Z","steps":["trace[725216399] 'process raft request' (duration: 190.232344ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:07:22.062189Z","caller":"traceutil/trace.go:171","msg":"trace[1182696183] linearizableReadLoop","detail":"{readStateIndex:669; appliedIndex:668; }","duration":"197.940942ms","start":"2026-06-02T01:07:21.864221Z","end":"2026-06-02T01:07:22.062162Z","steps":["trace[1182696183] 'read index received' (duration: 197.747117ms)","trace[1182696183] 'applied index is now lower than readState.Index' (duration: 192.955µs)"],"step_count":2} {"level":"info","ts":"2026-06-02T01:07:22.062257Z","caller":"traceutil/trace.go:171","msg":"trace[1481295463] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"344.95476ms","start":"2026-06-02T01:07:21.717265Z","end":"2026-06-02T01:07:22.06222Z","steps":["trace[1481295463] 'process raft request' (duration: 344.771966ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:07:22.062467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.227919ms","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-02T01:07:22.062714Z","caller":"traceutil/trace.go:171","msg":"trace[709239124] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:642; }","duration":"198.527169ms","start":"2026-06-02T01:07:21.864171Z","end":"2026-06-02T01:07:22.062698Z","steps":["trace[709239124] 'agreement among raft nodes before linearized reading' (duration: 198.118607ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:07:22.062737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T01:07:21.717247Z","time spent":"345.082224ms","remote":"127.0.0.1:52712","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-02T01:07:22.976749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"581.970887ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-06-02T01:07:22.977888Z","caller":"traceutil/trace.go:171","msg":"trace[1665187711] linearizableReadLoop","detail":"{readStateIndex:675; appliedIndex:673; }","duration":"100.933655ms","start":"2026-06-02T01:07:22.876935Z","end":"2026-06-02T01:07:22.977869Z","steps":["trace[1665187711] 'read index received' (duration: 96.526836ms)","trace[1665187711] 'applied index is now lower than readState.Index' (duration: 4.405839ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T01:07:22.97802Z","caller":"traceutil/trace.go:171","msg":"trace[618088765] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"497.919089ms","start":"2026-06-02T01:07:22.480062Z","end":"2026-06-02T01:07:22.977981Z","steps":["trace[618088765] 'process raft request' (duration: 497.137007ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:07:22.978133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.180951ms","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-02T01:07:22.978195Z","caller":"traceutil/trace.go:171","msg":"trace[785744374] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:647; }","duration":"101.285203ms","start":"2026-06-02T01:07:22.876891Z","end":"2026-06-02T01:07:22.978176Z","steps":["trace[785744374] 'agreement among raft nodes before linearized reading' (duration: 101.119529ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:07:22.978478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T01:07:22.480033Z","time spent":"498.092983ms","remote":"127.0.0.1:52320","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036317,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T01:07:24.259178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.097031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-06-02T01:07:24.259273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.647381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-02T01:07:24.259273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.968619ms","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-02T01:07:24.259349Z","caller":"traceutil/trace.go:171","msg":"trace[680523825] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:672; }","duration":"152.811014ms","start":"2026-06-02T01:07:24.106519Z","end":"2026-06-02T01:07:24.25933Z","steps":["trace[680523825] 'range keys from in-memory index tree' (duration: 152.375692ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:07:24.259352Z","caller":"traceutil/trace.go:171","msg":"trace[485258504] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:672; }","duration":"153.104073ms","start":"2026-06-02T01:07:24.106234Z","end":"2026-06-02T01:07:24.259338Z","steps":["trace[485258504] 'range keys from in-memory index tree' (duration: 152.827695ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:07:24.259287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.061406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T01:07:24.259633Z","caller":"traceutil/trace.go:171","msg":"trace[918532561] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:672; }","duration":"148.455106ms","start":"2026-06-02T01:07:24.111154Z","end":"2026-06-02T01:07:24.259609Z","steps":["trace[918532561] 'range keys from in-memory index tree' (duration: 147.926903ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:07:24.259529Z","caller":"traceutil/trace.go:171","msg":"trace[1406819905] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:672; }","duration":"170.503641ms","start":"2026-06-02T01:07:24.089003Z","end":"2026-06-02T01:07:24.259507Z","steps":["trace[1406819905] 'range keys from in-memory index tree' (duration: 169.872896ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:08:04.769037Z","caller":"traceutil/trace.go:171","msg":"trace[2072740621] transaction","detail":"{read_only:false; response_revision:1201; number_of_response:1; }","duration":"297.262423ms","start":"2026-06-02T01:08:04.471737Z","end":"2026-06-02T01:08:04.769Z","steps":["trace[2072740621] 'process raft request' (duration: 296.714388ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:08:04.769585Z","caller":"traceutil/trace.go:171","msg":"trace[209832155] linearizableReadLoop","detail":"{readStateIndex:1241; appliedIndex:1239; }","duration":"297.207391ms","start":"2026-06-02T01:08:04.472327Z","end":"2026-06-02T01:08:04.769535Z","steps":["trace[209832155] 'read index received' (duration: 296.296697ms)","trace[209832155] 'applied index is now lower than readState.Index' (duration: 909.554µs)"],"step_count":2} {"level":"info","ts":"2026-06-02T01:08:04.76971Z","caller":"traceutil/trace.go:171","msg":"trace[433466187] transaction","detail":"{read_only:false; response_revision:1202; number_of_response:1; }","duration":"297.51934ms","start":"2026-06-02T01:08:04.472171Z","end":"2026-06-02T01:08:04.769691Z","steps":["trace[433466187] 'process raft request' (duration: 297.226452ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:08:04.769815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.469728ms","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-02T01:08:04.769859Z","caller":"traceutil/trace.go:171","msg":"trace[1771465845] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1202; }","duration":"297.579181ms","start":"2026-06-02T01:08:04.472268Z","end":"2026-06-02T01:08:04.769847Z","steps":["trace[1771465845] 'agreement among raft nodes before linearized reading' (duration: 297.393566ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:08:50.806444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.799963ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-02T01:08:50.806775Z","caller":"traceutil/trace.go:171","msg":"trace[1989009695] transaction","detail":"{read_only:false; response_revision:1877; number_of_response:1; }","duration":"279.843517ms","start":"2026-06-02T01:08:50.526889Z","end":"2026-06-02T01:08:50.806733Z","steps":["trace[1989009695] 'process raft request' (duration: 85.652184ms)","trace[1989009695] 'compare' (duration: 193.557927ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T01:08:50.806857Z","caller":"traceutil/trace.go:171","msg":"trace[201714637] linearizableReadLoop","detail":"{readStateIndex:1951; appliedIndex:1950; }","duration":"225.701771ms","start":"2026-06-02T01:08:50.581124Z","end":"2026-06-02T01:08:50.806826Z","steps":["trace[201714637] 'read index received' (duration: 31.389665ms)","trace[201714637] 'applied index is now lower than readState.Index' (duration: 194.310056ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T01:08:50.807061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.917777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-19dc8701-1de9-4074-a240-3212a6bcaf1f\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-06-02T01:08:50.807286Z","caller":"traceutil/trace.go:171","msg":"trace[841057561] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-19dc8701-1de9-4074-a240-3212a6bcaf1f; range_end:; response_count:1; response_revision:1878; }","duration":"226.191555ms","start":"2026-06-02T01:08:50.581078Z","end":"2026-06-02T01:08:50.80727Z","steps":["trace[841057561] 'agreement among raft nodes before linearized reading' (duration: 225.830836ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:08:51.16455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.622798ms","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-02T01:08:51.164658Z","caller":"traceutil/trace.go:171","msg":"trace[1796377979] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1878; }","duration":"164.773132ms","start":"2026-06-02T01:08:50.999856Z","end":"2026-06-02T01:08:51.164629Z","steps":["trace[1796377979] 'range keys from in-memory index tree' (duration: 164.390452ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:08:51.164768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.814343ms","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-02T01:08:51.164858Z","caller":"traceutil/trace.go:171","msg":"trace[1479478107] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1878; }","duration":"164.966507ms","start":"2026-06-02T01:08:50.999872Z","end":"2026-06-02T01:08:51.164839Z","steps":["trace[1479478107] 'range keys from in-memory index tree' (duration: 164.609956ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:08:51.164855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.124194ms","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-02T01:08:51.164965Z","caller":"traceutil/trace.go:171","msg":"trace[173051856] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1878; }","duration":"164.310309ms","start":"2026-06-02T01:08:51.000632Z","end":"2026-06-02T01:08:51.164943Z","steps":["trace[173051856] 'range keys from in-memory index tree' (duration: 163.874057ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:08:51.444359Z","caller":"traceutil/trace.go:171","msg":"trace[418845930] transaction","detail":"{read_only:false; response_revision:1881; number_of_response:1; }","duration":"274.498152ms","start":"2026-06-02T01:08:51.169832Z","end":"2026-06-02T01:08:51.44433Z","steps":["trace[418845930] 'process raft request' (duration: 274.447951ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:08:51.444559Z","caller":"traceutil/trace.go:171","msg":"trace[99980354] transaction","detail":"{read_only:false; response_revision:1880; number_of_response:1; }","duration":"274.950964ms","start":"2026-06-02T01:08:51.169598Z","end":"2026-06-02T01:08:51.444549Z","steps":["trace[99980354] 'process raft request' (duration: 274.533033ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:09:39.907801Z","caller":"traceutil/trace.go:171","msg":"trace[1104123345] transaction","detail":"{read_only:false; response_revision:2196; number_of_response:1; }","duration":"160.502825ms","start":"2026-06-02T01:09:39.747269Z","end":"2026-06-02T01:09:39.907772Z","steps":["trace[1104123345] 'process raft request' (duration: 135.718429ms)","trace[1104123345] 'compare' (duration: 24.497108ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T01:09:40.27601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.731819ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-02T01:09:40.276136Z","caller":"traceutil/trace.go:171","msg":"trace[1189535277] linearizableReadLoop","detail":"{readStateIndex:2283; appliedIndex:2282; }","duration":"124.517064ms","start":"2026-06-02T01:09:40.151598Z","end":"2026-06-02T01:09:40.276115Z","steps":["trace[1189535277] 'read index received' (duration: 43.922µs)","trace[1189535277] 'applied index is now lower than readState.Index' (duration: 124.471692ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T01:09:40.276184Z","caller":"traceutil/trace.go:171","msg":"trace[690168837] transaction","detail":"{read_only:false; response_revision:2197; number_of_response:1; }","duration":"242.721877ms","start":"2026-06-02T01:09:40.033432Z","end":"2026-06-02T01:09:40.276154Z","steps":["trace[690168837] 'process raft request' (duration: 102.769121ms)","trace[690168837] 'compare' (duration: 139.582465ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T01:09:40.276231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.631727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T01:09:40.276283Z","caller":"traceutil/trace.go:171","msg":"trace[1979017911] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:2197; }","duration":"124.71875ms","start":"2026-06-02T01:09:40.151548Z","end":"2026-06-02T01:09:40.276267Z","steps":["trace[1979017911] 'agreement among raft nodes before linearized reading' (duration: 124.632837ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:09:45.963448Z","caller":"traceutil/trace.go:171","msg":"trace[1984371059] transaction","detail":"{read_only:false; response_revision:2223; number_of_response:1; }","duration":"296.365539ms","start":"2026-06-02T01:09:45.667061Z","end":"2026-06-02T01:09:45.963427Z","steps":["trace[1984371059] 'process raft request' (duration: 296.247306ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:09:46.122871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.991942ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-02T01:09:46.123096Z","caller":"traceutil/trace.go:171","msg":"trace[656236977] transaction","detail":"{read_only:false; response_revision:2224; number_of_response:1; }","duration":"455.871396ms","start":"2026-06-02T01:09:45.667195Z","end":"2026-06-02T01:09:46.123066Z","steps":["trace[656236977] 'process raft request' (duration: 321.556485ms)","trace[656236977] 'compare' (duration: 133.774656ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T01:09:46.123135Z","caller":"traceutil/trace.go:171","msg":"trace[507356647] transaction","detail":"{read_only:false; response_revision:2225; number_of_response:1; }","duration":"455.25102ms","start":"2026-06-02T01:09:45.667861Z","end":"2026-06-02T01:09:46.123112Z","steps":["trace[507356647] 'process raft request' (duration: 455.147677ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:09:46.123269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T01:09:45.667177Z","time spent":"455.99452ms","remote":"127.0.0.1:52464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T01:09:46.123326Z","caller":"traceutil/trace.go:171","msg":"trace[1705790924] linearizableReadLoop","detail":"{readStateIndex:2313; appliedIndex:2309; }","duration":"360.252729ms","start":"2026-06-02T01:09:45.763049Z","end":"2026-06-02T01:09:46.123302Z","steps":["trace[1705790924] 'read index received' (duration: 200.352611ms)","trace[1705790924] 'applied index is now lower than readState.Index' (duration: 159.898298ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T01:09:46.123409Z","caller":"traceutil/trace.go:171","msg":"trace[1195639203] transaction","detail":"{read_only:false; response_revision:2226; number_of_response:1; }","duration":"440.22784ms","start":"2026-06-02T01:09:45.683156Z","end":"2026-06-02T01:09:46.123384Z","steps":["trace[1195639203] 'process raft request' (duration: 439.910231ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:09:46.123533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T01:09:45.683148Z","time spent":"440.325712ms","remote":"127.0.0.1:52464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T01:09:46.123546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.499027ms","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-02T01:09:46.123598Z","caller":"traceutil/trace.go:171","msg":"trace[1012192492] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2226; }","duration":"360.576868ms","start":"2026-06-02T01:09:45.763004Z","end":"2026-06-02T01:09:46.123581Z","steps":["trace[1012192492] 'agreement among raft nodes before linearized reading' (duration: 360.408983ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:09:46.123588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.501367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-06-02T01:09:46.123636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T01:09:45.762991Z","time spent":"360.638049ms","remote":"127.0.0.1:52464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-02T01:09:46.123649Z","caller":"traceutil/trace.go:171","msg":"trace[902061685] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2226; }","duration":"356.59996ms","start":"2026-06-02T01:09:45.767031Z","end":"2026-06-02T01:09:46.123631Z","steps":["trace[902061685] 'agreement among raft nodes before linearized reading' (duration: 356.421356ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:09:46.123698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T01:09:45.767009Z","time spent":"356.672472ms","remote":"127.0.0.1:52464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-02T01:09:46.123693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.482463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-02T01:09:46.123715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.812333ms","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-02T01:09:46.12376Z","caller":"traceutil/trace.go:171","msg":"trace[1528402995] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2226; }","duration":"193.900996ms","start":"2026-06-02T01:09:45.929849Z","end":"2026-06-02T01:09:46.12375Z","steps":["trace[1528402995] 'agreement among raft nodes before linearized reading' (duration: 193.794823ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:09:46.123772Z","caller":"traceutil/trace.go:171","msg":"trace[650295018] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:2226; }","duration":"146.619897ms","start":"2026-06-02T01:09:45.977127Z","end":"2026-06-02T01:09:46.123747Z","steps":["trace[650295018] 'agreement among raft nodes before linearized reading' (duration: 146.458372ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:09:46.12323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T01:09:45.66784Z","time spent":"455.349892ms","remote":"127.0.0.1:52464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T01:09:46.327464Z","caller":"traceutil/trace.go:171","msg":"trace[1209851048] transaction","detail":"{read_only:false; response_revision:2227; number_of_response:1; }","duration":"199.278733ms","start":"2026-06-02T01:09:46.128139Z","end":"2026-06-02T01:09:46.327418Z","steps":["trace[1209851048] 'process raft request' (duration: 173.009966ms)","trace[1209851048] 'compare' (duration: 25.994079ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T01:09:46.484697Z","caller":"traceutil/trace.go:171","msg":"trace[1481976379] transaction","detail":"{read_only:false; response_revision:2228; number_of_response:1; }","duration":"356.404135ms","start":"2026-06-02T01:09:46.128265Z","end":"2026-06-02T01:09:46.484669Z","steps":["trace[1481976379] 'process raft request' (duration: 354.550394ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:09:46.485003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T01:09:46.128246Z","time spent":"356.533269ms","remote":"127.0.0.1:52464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T01:09:46.485032Z","caller":"traceutil/trace.go:171","msg":"trace[1810328939] linearizableReadLoop","detail":"{readStateIndex:2316; appliedIndex:2313; }","duration":"227.175392ms","start":"2026-06-02T01:09:46.257815Z","end":"2026-06-02T01:09:46.48499Z","steps":["trace[1810328939] 'read index received' (duration: 43.325151ms)","trace[1810328939] 'applied index is now lower than readState.Index' (duration: 183.848261ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T01:09:46.485067Z","caller":"traceutil/trace.go:171","msg":"trace[1167504987] transaction","detail":"{read_only:false; response_revision:2229; number_of_response:1; }","duration":"356.035464ms","start":"2026-06-02T01:09:46.129012Z","end":"2026-06-02T01:09:46.485047Z","steps":["trace[1167504987] 'process raft request' (duration: 355.602233ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:09:46.485096Z","caller":"traceutil/trace.go:171","msg":"trace[302278781] transaction","detail":"{read_only:false; response_revision:2230; number_of_response:1; }","duration":"191.85747ms","start":"2026-06-02T01:09:46.293221Z","end":"2026-06-02T01:09:46.485079Z","steps":["trace[302278781] 'process raft request' (duration: 191.609842ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:09:46.485214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.350876ms","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-02T01:09:46.485275Z","caller":"traceutil/trace.go:171","msg":"trace[995473164] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:2230; }","duration":"227.49181ms","start":"2026-06-02T01:09:46.257767Z","end":"2026-06-02T01:09:46.485259Z","steps":["trace[995473164] 'agreement among raft nodes before linearized reading' (duration: 227.349587ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:09:46.485305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T01:09:46.128977Z","time spent":"356.164988ms","remote":"127.0.0.1:52464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T01:10:54.960081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.486475ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-02T01:10:54.960701Z","caller":"traceutil/trace.go:171","msg":"trace[993079017] linearizableReadLoop","detail":"{readStateIndex:2905; appliedIndex:2904; }","duration":"157.271706ms","start":"2026-06-02T01:10:54.803408Z","end":"2026-06-02T01:10:54.960679Z","steps":["trace[993079017] 'read index received' (duration: 22.060331ms)","trace[993079017] 'applied index is now lower than readState.Index' (duration: 135.209745ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T01:10:54.960934Z","caller":"traceutil/trace.go:171","msg":"trace[1582182924] transaction","detail":"{read_only:false; response_revision:2797; number_of_response:1; }","duration":"233.212282ms","start":"2026-06-02T01:10:54.727495Z","end":"2026-06-02T01:10:54.960707Z","steps":["trace[1582182924] 'process raft request' (duration: 98.014388ms)","trace[1582182924] 'compare' (duration: 134.374592ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T01:10:54.961168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.224425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-02T01:10:54.96123Z","caller":"traceutil/trace.go:171","msg":"trace[1747656509] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2797; }","duration":"154.303817ms","start":"2026-06-02T01:10:54.806911Z","end":"2026-06-02T01:10:54.961215Z","steps":["trace[1747656509] 'agreement among raft nodes before linearized reading' (duration: 154.204254ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:10:54.961075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.668157ms","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-02T01:10:54.961604Z","caller":"traceutil/trace.go:171","msg":"trace[1068612160] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2797; }","duration":"158.183641ms","start":"2026-06-02T01:10:54.803358Z","end":"2026-06-02T01:10:54.961542Z","steps":["trace[1068612160] 'agreement among raft nodes before linearized reading' (duration: 157.564474ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:10:55.262147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.719316ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-02T01:10:55.262284Z","caller":"traceutil/trace.go:171","msg":"trace[1770188018] linearizableReadLoop","detail":"{readStateIndex:2907; appliedIndex:2905; }","duration":"193.98792ms","start":"2026-06-02T01:10:55.068281Z","end":"2026-06-02T01:10:55.262269Z","steps":["trace[1770188018] 'read index received' (duration: 51.075479ms)","trace[1770188018] 'applied index is now lower than readState.Index' (duration: 142.911301ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T01:10:55.262368Z","caller":"traceutil/trace.go:171","msg":"trace[1638384011] transaction","detail":"{read_only:false; response_revision:2798; number_of_response:1; }","duration":"298.115111ms","start":"2026-06-02T01:10:54.964241Z","end":"2026-06-02T01:10:55.262356Z","steps":["trace[1638384011] 'process raft request' (duration: 155.118048ms)","trace[1638384011] 'compare' (duration: 142.605243ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T01:10:55.262478Z","caller":"traceutil/trace.go:171","msg":"trace[1791543695] transaction","detail":"{read_only:false; response_revision:2799; number_of_response:1; }","duration":"297.815323ms","start":"2026-06-02T01:10:54.964656Z","end":"2026-06-02T01:10:55.262471Z","steps":["trace[1791543695] 'process raft request' (duration: 297.574477ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:10:55.262577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.465313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-02T01:10:55.2626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.304328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T01:10:55.262664Z","caller":"traceutil/trace.go:171","msg":"trace[163482802] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2799; }","duration":"147.603117ms","start":"2026-06-02T01:10:55.115043Z","end":"2026-06-02T01:10:55.262646Z","steps":["trace[163482802] 'agreement among raft nodes before linearized reading' (duration: 147.468554ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:10:55.262671Z","caller":"traceutil/trace.go:171","msg":"trace[699114498] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:2799; }","duration":"194.436583ms","start":"2026-06-02T01:10:55.068217Z","end":"2026-06-02T01:10:55.262654Z","steps":["trace[699114498] 'agreement among raft nodes before linearized reading' (duration: 194.296209ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:14:40.539607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.137517ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-02T01:14:40.539721Z","caller":"traceutil/trace.go:171","msg":"trace[980014788] transaction","detail":"{read_only:false; response_revision:4735; number_of_response:1; }","duration":"250.718242ms","start":"2026-06-02T01:14:40.288985Z","end":"2026-06-02T01:14:40.539703Z","steps":["trace[980014788] 'process raft request' (duration: 141.40745ms)","trace[980014788] 'compare' (duration: 108.892921ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T01:14:40.549188Z","caller":"traceutil/trace.go:171","msg":"trace[2143370146] linearizableReadLoop","detail":"{readStateIndex:4918; appliedIndex:4916; }","duration":"135.68071ms","start":"2026-06-02T01:14:40.41348Z","end":"2026-06-02T01:14:40.54916Z","steps":["trace[2143370146] 'read index received' (duration: 16.924691ms)","trace[2143370146] 'applied index is now lower than readState.Index' (duration: 118.755199ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T01:14:40.549406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.406284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-02T01:14:40.549454Z","caller":"traceutil/trace.go:171","msg":"trace[1628546242] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4736; }","duration":"135.477715ms","start":"2026-06-02T01:14:40.413964Z","end":"2026-06-02T01:14:40.549442Z","steps":["trace[1628546242] 'agreement among raft nodes before linearized reading' (duration: 135.350061ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:14:40.549382Z","caller":"traceutil/trace.go:171","msg":"trace[34358169] transaction","detail":"{read_only:false; response_revision:4736; number_of_response:1; }","duration":"259.675525ms","start":"2026-06-02T01:14:40.289669Z","end":"2026-06-02T01:14:40.549345Z","steps":["trace[34358169] 'process raft request' (duration: 259.390428ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:14:40.549415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.916786ms","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-02T01:14:40.549544Z","caller":"traceutil/trace.go:171","msg":"trace[1628323721] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4736; }","duration":"136.167552ms","start":"2026-06-02T01:14:40.413362Z","end":"2026-06-02T01:14:40.54953Z","steps":["trace[1628323721] 'agreement among raft nodes before linearized reading' (duration: 135.925596ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:14:40.681923Z","caller":"traceutil/trace.go:171","msg":"trace[24738423] transaction","detail":"{read_only:false; response_revision:4738; number_of_response:1; }","duration":"128.654938ms","start":"2026-06-02T01:14:40.553226Z","end":"2026-06-02T01:14:40.681881Z","steps":["trace[24738423] 'process raft request' (duration: 128.569235ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:14:40.682052Z","caller":"traceutil/trace.go:171","msg":"trace[166184176] transaction","detail":"{read_only:false; response_revision:4739; number_of_response:1; }","duration":"128.718629ms","start":"2026-06-02T01:14:40.553284Z","end":"2026-06-02T01:14:40.682003Z","steps":["trace[166184176] 'process raft request' (duration: 128.542354ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:14:40.681966Z","caller":"traceutil/trace.go:171","msg":"trace[901117397] transaction","detail":"{read_only:false; response_revision:4737; number_of_response:1; }","duration":"129.800706ms","start":"2026-06-02T01:14:40.552127Z","end":"2026-06-02T01:14:40.681927Z","steps":["trace[901117397] 'process raft request' (duration: 110.950425ms)","trace[901117397] 'compare' (duration: 18.604015ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T01:14:46.468892Z","caller":"traceutil/trace.go:171","msg":"trace[1068989468] linearizableReadLoop","detail":"{readStateIndex:5154; appliedIndex:5153; }","duration":"197.937215ms","start":"2026-06-02T01:14:46.270932Z","end":"2026-06-02T01:14:46.46887Z","steps":["trace[1068989468] 'read index received' (duration: 197.720819ms)","trace[1068989468] 'applied index is now lower than readState.Index' (duration: 215.296µs)"],"step_count":2} {"level":"info","ts":"2026-06-02T01:14:46.468964Z","caller":"traceutil/trace.go:171","msg":"trace[1280599437] transaction","detail":"{read_only:false; response_revision:4964; number_of_response:1; }","duration":"207.584027ms","start":"2026-06-02T01:14:46.261341Z","end":"2026-06-02T01:14:46.468925Z","steps":["trace[1280599437] 'process raft request' (duration: 207.392282ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:14:46.469084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.13821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-2hn9x-tls\" ","response":"range_response_count:1 size:1967"} {"level":"info","ts":"2026-06-02T01:14:46.469128Z","caller":"traceutil/trace.go:171","msg":"trace[930471184] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-2hn9x-tls; range_end:; response_count:1; response_revision:4964; }","duration":"198.195621ms","start":"2026-06-02T01:14:46.27092Z","end":"2026-06-02T01:14:46.469116Z","steps":["trace[930471184] 'agreement among raft nodes before linearized reading' (duration: 198.045917ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:14:46.776578Z","caller":"traceutil/trace.go:171","msg":"trace[240961505] transaction","detail":"{read_only:false; response_revision:4967; number_of_response:1; }","duration":"120.72441ms","start":"2026-06-02T01:14:46.655818Z","end":"2026-06-02T01:14:46.776542Z","steps":["trace[240961505] 'process raft request' (duration: 114.829546ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:15:03.818543Z","caller":"traceutil/trace.go:171","msg":"trace[613113090] transaction","detail":"{read_only:false; response_revision:5293; number_of_response:1; }","duration":"105.459621ms","start":"2026-06-02T01:15:03.713057Z","end":"2026-06-02T01:15:03.818517Z","steps":["trace[613113090] 'process raft request' (duration: 105.325208ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:15:07.171876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.202052ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-02T01:15:07.171963Z","caller":"traceutil/trace.go:171","msg":"trace[690289084] linearizableReadLoop","detail":"{readStateIndex:5617; appliedIndex:5616; }","duration":"168.120386ms","start":"2026-06-02T01:15:07.00383Z","end":"2026-06-02T01:15:07.17195Z","steps":["trace[690289084] 'read index received' (duration: 706.178µs)","trace[690289084] 'applied index is now lower than readState.Index' (duration: 167.412858ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T01:15:07.172268Z","caller":"traceutil/trace.go:171","msg":"trace[1021446178] transaction","detail":"{read_only:false; response_revision:5414; number_of_response:1; }","duration":"180.994001ms","start":"2026-06-02T01:15:06.991249Z","end":"2026-06-02T01:15:07.172243Z","steps":["trace[1021446178] 'process raft request' (duration: 13.347138ms)","trace[1021446178] 'compare' (duration: 167.002086ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T01:15:07.172249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.402314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:7614"} {"level":"warn","ts":"2026-06-02T01:15:07.172273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.852358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-06-02T01:15:07.172333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.790825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-6r2qg\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-06-02T01:15:07.172338Z","caller":"traceutil/trace.go:171","msg":"trace[1671560438] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5414; }","duration":"139.951051ms","start":"2026-06-02T01:15:07.032369Z","end":"2026-06-02T01:15:07.172321Z","steps":["trace[1671560438] 'agreement among raft nodes before linearized reading' (duration: 139.761325ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:15:07.172331Z","caller":"traceutil/trace.go:171","msg":"trace[1533053846] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:5414; }","duration":"168.527317ms","start":"2026-06-02T01:15:07.003783Z","end":"2026-06-02T01:15:07.17231Z","steps":["trace[1533053846] 'agreement among raft nodes before linearized reading' (duration: 168.269211ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:15:07.172388Z","caller":"traceutil/trace.go:171","msg":"trace[888704060] range","detail":"{range_begin:/registry/pods/openstack/keepalived-6r2qg; range_end:; response_count:1; response_revision:5414; }","duration":"132.848205ms","start":"2026-06-02T01:15:07.039508Z","end":"2026-06-02T01:15:07.172356Z","steps":["trace[888704060] 'agreement among raft nodes before linearized reading' (duration: 132.737682ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:15:07.387917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.387617ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:41"} {"level":"info","ts":"2026-06-02T01:15:07.388358Z","caller":"traceutil/trace.go:171","msg":"trace[1123712310] transaction","detail":"{read_only:false; response_revision:5415; number_of_response:1; }","duration":"212.346591ms","start":"2026-06-02T01:15:07.175981Z","end":"2026-06-02T01:15:07.388327Z","steps":["trace[1123712310] 'process raft request' (duration: 212.065253ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:15:07.388584Z","caller":"traceutil/trace.go:171","msg":"trace[1950959372] transaction","detail":"{read_only:false; response_revision:5416; number_of_response:1; }","duration":"120.72271ms","start":"2026-06-02T01:15:07.267832Z","end":"2026-06-02T01:15:07.388555Z","steps":["trace[1950959372] 'process raft request' (duration: 120.428442ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:15:07.388661Z","caller":"traceutil/trace.go:171","msg":"trace[229802203] linearizableReadLoop","detail":"{readStateIndex:5619; appliedIndex:5617; }","duration":"212.532326ms","start":"2026-06-02T01:15:07.176089Z","end":"2026-06-02T01:15:07.388621Z","steps":["trace[229802203] 'read index received' (duration: 100.530914ms)","trace[229802203] 'applied index is now lower than readState.Index' (duration: 111.998512ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T01:15:07.38904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.938945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:9 size:80607"} {"level":"info","ts":"2026-06-02T01:15:07.389118Z","caller":"traceutil/trace.go:171","msg":"trace[1897579342] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:9; response_revision:5417; }","duration":"213.065209ms","start":"2026-06-02T01:15:07.176035Z","end":"2026-06-02T01:15:07.3891Z","steps":["trace[1897579342] 'agreement among raft nodes before linearized reading' (duration: 212.782941ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:15:07.579213Z","caller":"traceutil/trace.go:171","msg":"trace[487874743] linearizableReadLoop","detail":"{readStateIndex:5622; appliedIndex:5621; }","duration":"190.444738ms","start":"2026-06-02T01:15:07.388739Z","end":"2026-06-02T01:15:07.579183Z","steps":["trace[487874743] 'read index received' (duration: 190.10988ms)","trace[487874743] 'applied index is now lower than readState.Index' (duration: 332.058µs)"],"step_count":2} {"level":"warn","ts":"2026-06-02T01:15:07.579323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.33416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-02T01:15:07.579417Z","caller":"traceutil/trace.go:171","msg":"trace[725607427] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:5418; }","duration":"317.518184ms","start":"2026-06-02T01:15:07.261877Z","end":"2026-06-02T01:15:07.579395Z","steps":["trace[725607427] 'agreement among raft nodes before linearized reading' (duration: 317.320548ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:15:07.57947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T01:15:07.261845Z","time spent":"317.613318ms","remote":"127.0.0.1:52332","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":12,"response size":31,"request content":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true "} {"level":"info","ts":"2026-06-02T01:15:07.579837Z","caller":"traceutil/trace.go:171","msg":"trace[306354340] transaction","detail":"{read_only:false; response_revision:5418; number_of_response:1; }","duration":"246.678737ms","start":"2026-06-02T01:15:07.333124Z","end":"2026-06-02T01:15:07.579803Z","steps":["trace[306354340] 'process raft request' (duration: 245.763972ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:15:07.580419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.08798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:57 size:2224963"} {"level":"info","ts":"2026-06-02T01:15:07.5805Z","caller":"traceutil/trace.go:171","msg":"trace[2008515428] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:57; response_revision:5418; }","duration":"351.220903ms","start":"2026-06-02T01:15:07.22926Z","end":"2026-06-02T01:15:07.580481Z","steps":["trace[2008515428] 'agreement among raft nodes before linearized reading' (duration: 350.009752ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:15:07.580552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T01:15:07.229237Z","time spent":"351.298906ms","remote":"127.0.0.1:52322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":57,"response size":2224987,"request content":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" "} {"level":"info","ts":"2026-06-02T01:15:07.584455Z","caller":"traceutil/trace.go:171","msg":"trace[1609733601] transaction","detail":"{read_only:false; response_revision:5419; number_of_response:1; }","duration":"195.151761ms","start":"2026-06-02T01:15:07.389281Z","end":"2026-06-02T01:15:07.584432Z","steps":["trace[1609733601] 'process raft request' (duration: 195.008957ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:15:07.584582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.770512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9e425ad2-c80b-4509-93b4-c84dcf8094be\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-06-02T01:15:07.584654Z","caller":"traceutil/trace.go:171","msg":"trace[1735063924] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-9e425ad2-c80b-4509-93b4-c84dcf8094be; range_end:; response_count:1; response_revision:5419; }","duration":"125.870574ms","start":"2026-06-02T01:15:07.458765Z","end":"2026-06-02T01:15:07.584636Z","steps":["trace[1735063924] 'agreement among raft nodes before linearized reading' (duration: 125.662668ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:15:18.714222Z","caller":"traceutil/trace.go:171","msg":"trace[1479470800] transaction","detail":"{read_only:false; response_revision:5536; number_of_response:1; }","duration":"106.630712ms","start":"2026-06-02T01:15:18.607563Z","end":"2026-06-02T01:15:18.714194Z","steps":["trace[1479470800] 'compare' (duration: 98.749857ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:15:18.743539Z","caller":"traceutil/trace.go:171","msg":"trace[1698963138] transaction","detail":"{read_only:false; response_revision:5538; number_of_response:1; }","duration":"135.333502ms","start":"2026-06-02T01:15:18.60818Z","end":"2026-06-02T01:15:18.743513Z","steps":["trace[1698963138] 'process raft request' (duration: 135.232789ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:15:18.743696Z","caller":"traceutil/trace.go:171","msg":"trace[223738095] transaction","detail":"{read_only:false; response_revision:5539; number_of_response:1; }","duration":"135.412533ms","start":"2026-06-02T01:15:18.608255Z","end":"2026-06-02T01:15:18.743667Z","steps":["trace[223738095] 'process raft request' (duration: 135.222977ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:15:18.743769Z","caller":"traceutil/trace.go:171","msg":"trace[1175667156] transaction","detail":"{read_only:false; response_revision:5537; number_of_response:1; }","duration":"135.745813ms","start":"2026-06-02T01:15:18.607981Z","end":"2026-06-02T01:15:18.743727Z","steps":["trace[1175667156] 'process raft request' (duration: 135.30918ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:16:34.161781Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3011} {"level":"info","ts":"2026-06-02T01:16:34.248192Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3011,"took":"84.883728ms","hash":1896775185,"current-db-size-bytes":58540032,"current-db-size":"58 MB","current-db-size-in-use-bytes":32145408,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-02T01:16:34.24825Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1896775185,"revision":3011,"compact-revision":-1} {"level":"warn","ts":"2026-06-02T01:21:15.38487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.407261ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-02T01:21:15.385063Z","caller":"traceutil/trace.go:171","msg":"trace[1329267142] transaction","detail":"{read_only:false; response_revision:8213; number_of_response:1; }","duration":"538.166446ms","start":"2026-06-02T01:21:14.846871Z","end":"2026-06-02T01:21:15.385038Z","steps":["trace[1329267142] 'process raft request' (duration: 340.500487ms)","trace[1329267142] 'compare' (duration: 197.197396ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T01:21:15.38512Z","caller":"traceutil/trace.go:171","msg":"trace[1269637357] linearizableReadLoop","detail":"{readStateIndex:8504; appliedIndex:8503; }","duration":"478.080964ms","start":"2026-06-02T01:21:14.907026Z","end":"2026-06-02T01:21:15.385107Z","steps":["trace[1269637357] 'read index received' (duration: 280.359155ms)","trace[1269637357] 'applied index is now lower than readState.Index' (duration: 197.720969ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T01:21:15.385225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T01:21:14.846854Z","time spent":"538.28075ms","remote":"127.0.0.1:52464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T01:21:15.385344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"478.318522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T01:21:15.385083Z","caller":"traceutil/trace.go:171","msg":"trace[1317239252] transaction","detail":"{read_only:false; response_revision:8214; number_of_response:1; }","duration":"235.121376ms","start":"2026-06-02T01:21:15.149947Z","end":"2026-06-02T01:21:15.385068Z","steps":["trace[1317239252] 'process raft request' (duration: 235.045383ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:21:15.385389Z","caller":"traceutil/trace.go:171","msg":"trace[834279898] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:8214; }","duration":"478.393283ms","start":"2026-06-02T01:21:14.906984Z","end":"2026-06-02T01:21:15.385377Z","steps":["trace[834279898] 'agreement among raft nodes before linearized reading' (duration: 478.323551ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:21:15.385428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T01:21:14.906967Z","time spent":"478.451694ms","remote":"127.0.0.1:44230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true "} {"level":"warn","ts":"2026-06-02T01:21:15.385544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.209214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-02T01:21:15.385619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.576657ms","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-02T01:21:15.385617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.466249ms","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-02T01:21:15.385688Z","caller":"traceutil/trace.go:171","msg":"trace[552486943] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8214; }","duration":"275.39762ms","start":"2026-06-02T01:21:15.110266Z","end":"2026-06-02T01:21:15.385663Z","steps":["trace[552486943] 'agreement among raft nodes before linearized reading' (duration: 275.172764ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:21:15.385701Z","caller":"traceutil/trace.go:171","msg":"trace[1679853401] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8214; }","duration":"216.590373ms","start":"2026-06-02T01:21:15.169092Z","end":"2026-06-02T01:21:15.385682Z","steps":["trace[1679853401] 'agreement among raft nodes before linearized reading' (duration: 216.342035ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:21:15.385646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.914606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-06-02T01:21:15.385706Z","caller":"traceutil/trace.go:171","msg":"trace[1248279557] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8214; }","duration":"429.688861ms","start":"2026-06-02T01:21:14.955985Z","end":"2026-06-02T01:21:15.385674Z","steps":["trace[1248279557] 'agreement among raft nodes before linearized reading' (duration: 429.453714ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:21:15.38576Z","caller":"traceutil/trace.go:171","msg":"trace[972490297] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8214; }","duration":"145.111711ms","start":"2026-06-02T01:21:15.240623Z","end":"2026-06-02T01:21:15.385735Z","steps":["trace[972490297] 'agreement among raft nodes before linearized reading' (duration: 144.844694ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:21:15.385766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T01:21:14.955966Z","time spent":"429.785012ms","remote":"127.0.0.1:52464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-02T01:21:27.02468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.06724ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-02T01:21:27.024833Z","caller":"traceutil/trace.go:171","msg":"trace[1778053642] transaction","detail":"{read_only:false; response_revision:8272; number_of_response:1; }","duration":"335.504283ms","start":"2026-06-02T01:21:26.689298Z","end":"2026-06-02T01:21:27.024803Z","steps":["trace[1778053642] 'process raft request' (duration: 190.194076ms)","trace[1778053642] 'compare' (duration: 144.879475ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T01:21:27.024978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T01:21:26.689276Z","time spent":"335.629336ms","remote":"127.0.0.1:52464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T01:21:27.024986Z","caller":"traceutil/trace.go:171","msg":"trace[908948825] transaction","detail":"{read_only:false; response_revision:8273; number_of_response:1; }","duration":"226.489741ms","start":"2026-06-02T01:21:26.798467Z","end":"2026-06-02T01:21:27.024956Z","steps":["trace[908948825] 'process raft request' (duration: 226.353348ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:21:27.025031Z","caller":"traceutil/trace.go:171","msg":"trace[942952109] linearizableReadLoop","detail":"{readStateIndex:8566; appliedIndex:8565; }","duration":"227.501309ms","start":"2026-06-02T01:21:26.797501Z","end":"2026-06-02T01:21:27.025002Z","steps":["trace[942952109] 'read index received' (duration: 82.010828ms)","trace[942952109] 'applied index is now lower than readState.Index' (duration: 145.487161ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T01:21:27.025291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.795167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-02T01:21:27.02535Z","caller":"traceutil/trace.go:171","msg":"trace[1431678012] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8273; }","duration":"227.90378ms","start":"2026-06-02T01:21:26.797431Z","end":"2026-06-02T01:21:27.025334Z","steps":["trace[1431678012] 'agreement among raft nodes before linearized reading' (duration: 227.688894ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:21:27.735189Z","caller":"traceutil/trace.go:171","msg":"trace[1454696464] linearizableReadLoop","detail":"{readStateIndex:8573; appliedIndex:8571; }","duration":"285.467363ms","start":"2026-06-02T01:21:27.449698Z","end":"2026-06-02T01:21:27.735165Z","steps":["trace[1454696464] 'read index received' (duration: 18.07629ms)","trace[1454696464] 'applied index is now lower than readState.Index' (duration: 267.389753ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T01:21:27.735234Z","caller":"traceutil/trace.go:171","msg":"trace[2111895630] transaction","detail":"{read_only:false; response_revision:8278; number_of_response:1; }","duration":"301.116668ms","start":"2026-06-02T01:21:27.434069Z","end":"2026-06-02T01:21:27.735186Z","steps":["trace[2111895630] 'process raft request' (duration: 300.948664ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:21:27.735424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T01:21:27.434051Z","time spent":"301.293133ms","remote":"127.0.0.1:52464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T01:21:27.735521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.761121ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-6r2qg\" ","response":"range_response_count:1 size:6524"} {"level":"warn","ts":"2026-06-02T01:21:27.735529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.738723ms","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-02T01:21:27.735564Z","caller":"traceutil/trace.go:171","msg":"trace[118360868] range","detail":"{range_begin:/registry/pods/openstack/keepalived-6r2qg; range_end:; response_count:1; response_revision:8278; }","duration":"144.827334ms","start":"2026-06-02T01:21:27.590726Z","end":"2026-06-02T01:21:27.735553Z","steps":["trace[118360868] 'agreement among raft nodes before linearized reading' (duration: 144.736261ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:21:27.735576Z","caller":"traceutil/trace.go:171","msg":"trace[230305873] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8278; }","duration":"284.812716ms","start":"2026-06-02T01:21:27.450751Z","end":"2026-06-02T01:21:27.735564Z","steps":["trace[230305873] 'agreement among raft nodes before linearized reading' (duration: 284.688492ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:21:27.735431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.717539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-06-02T01:21:27.73567Z","caller":"traceutil/trace.go:171","msg":"trace[742383371] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8278; }","duration":"285.994148ms","start":"2026-06-02T01:21:27.449666Z","end":"2026-06-02T01:21:27.73566Z","steps":["trace[742383371] 'agreement among raft nodes before linearized reading' (duration: 285.650098ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:21:27.735772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.576092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-02T01:21:27.735817Z","caller":"traceutil/trace.go:171","msg":"trace[1733841497] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:8278; }","duration":"223.649274ms","start":"2026-06-02T01:21:27.512154Z","end":"2026-06-02T01:21:27.735803Z","steps":["trace[1733841497] 'agreement among raft nodes before linearized reading' (duration: 223.561912ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:21:27.862825Z","caller":"traceutil/trace.go:171","msg":"trace[194382847] transaction","detail":"{read_only:false; response_revision:8280; number_of_response:1; }","duration":"122.855377ms","start":"2026-06-02T01:21:27.739946Z","end":"2026-06-02T01:21:27.862802Z","steps":["trace[194382847] 'process raft request' (duration: 94.778525ms)","trace[194382847] 'compare' (duration: 27.943239ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T01:21:27.863035Z","caller":"traceutil/trace.go:171","msg":"trace[1069083840] transaction","detail":"{read_only:false; response_revision:8281; number_of_response:1; }","duration":"122.98336ms","start":"2026-06-02T01:21:27.740013Z","end":"2026-06-02T01:21:27.862997Z","steps":["trace[1069083840] 'process raft request' (duration: 122.757894ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:21:29.173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.782335ms","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-02T01:21:29.173113Z","caller":"traceutil/trace.go:171","msg":"trace[1572033765] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8283; }","duration":"143.97512ms","start":"2026-06-02T01:21:29.029121Z","end":"2026-06-02T01:21:29.173096Z","steps":["trace[1572033765] 'range keys from in-memory index tree' (duration: 143.494547ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:21:29.175467Z","caller":"traceutil/trace.go:171","msg":"trace[1372689034] linearizableReadLoop","detail":"{readStateIndex:8579; appliedIndex:8578; }","duration":"133.878156ms","start":"2026-06-02T01:21:29.041571Z","end":"2026-06-02T01:21:29.175449Z","steps":["trace[1372689034] 'read index received' (duration: 133.65642ms)","trace[1372689034] 'applied index is now lower than readState.Index' (duration: 220.606µs)"],"step_count":2} {"level":"info","ts":"2026-06-02T01:21:29.175685Z","caller":"traceutil/trace.go:171","msg":"trace[1915398320] transaction","detail":"{read_only:false; response_revision:8284; number_of_response:1; }","duration":"145.167473ms","start":"2026-06-02T01:21:29.03048Z","end":"2026-06-02T01:21:29.175648Z","steps":["trace[1915398320] 'process raft request' (duration: 144.791642ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:21:29.17582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.226865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-02T01:21:29.1759Z","caller":"traceutil/trace.go:171","msg":"trace[1255093123] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8284; }","duration":"134.34505ms","start":"2026-06-02T01:21:29.041537Z","end":"2026-06-02T01:21:29.175882Z","steps":["trace[1255093123] 'agreement among raft nodes before linearized reading' (duration: 134.112444ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:21:34.168106Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6151} {"level":"info","ts":"2026-06-02T01:21:34.266297Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6151,"took":"96.312237ms","hash":3428852374,"current-db-size-bytes":58540032,"current-db-size":"58 MB","current-db-size-in-use-bytes":23187456,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-06-02T01:21:34.266365Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3428852374,"revision":6151,"compact-revision":3011} {"level":"info","ts":"2026-06-02T01:21:54.548003Z","caller":"traceutil/trace.go:171","msg":"trace[2044778989] linearizableReadLoop","detail":"{readStateIndex:8780; appliedIndex:8779; }","duration":"114.51248ms","start":"2026-06-02T01:21:54.433458Z","end":"2026-06-02T01:21:54.54797Z","steps":["trace[2044778989] 'read index received' (duration: 114.237473ms)","trace[2044778989] 'applied index is now lower than readState.Index' (duration: 273.837µs)"],"step_count":2} {"level":"warn","ts":"2026-06-02T01:21:54.548145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.662853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T01:21:54.548133Z","caller":"traceutil/trace.go:171","msg":"trace[124734775] transaction","detail":"{read_only:false; response_revision:8477; number_of_response:1; }","duration":"144.278228ms","start":"2026-06-02T01:21:54.403821Z","end":"2026-06-02T01:21:54.548099Z","steps":["trace[124734775] 'process raft request' (duration: 143.982391ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:21:54.548188Z","caller":"traceutil/trace.go:171","msg":"trace[1084565895] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:8477; }","duration":"114.763867ms","start":"2026-06-02T01:21:54.433412Z","end":"2026-06-02T01:21:54.548176Z","steps":["trace[1084565895] 'agreement among raft nodes before linearized reading' (duration: 114.668845ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:21:54.841466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.912841ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T01:21:54.841605Z","caller":"traceutil/trace.go:171","msg":"trace[1405875086] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:8477; }","duration":"178.064656ms","start":"2026-06-02T01:21:54.663525Z","end":"2026-06-02T01:21:54.841589Z","steps":["trace[1405875086] 'range keys from in-memory index tree' (duration: 177.896871ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:21:59.42734Z","caller":"traceutil/trace.go:171","msg":"trace[1322867417] linearizableReadLoop","detail":"{readStateIndex:8805; appliedIndex:8804; }","duration":"146.064267ms","start":"2026-06-02T01:21:59.281246Z","end":"2026-06-02T01:21:59.427311Z","steps":["trace[1322867417] 'read index received' (duration: 145.864502ms)","trace[1322867417] 'applied index is now lower than readState.Index' (duration: 198.485µs)"],"step_count":2} {"level":"info","ts":"2026-06-02T01:21:59.427453Z","caller":"traceutil/trace.go:171","msg":"trace[465885945] transaction","detail":"{read_only:false; response_revision:8501; number_of_response:1; }","duration":"152.469332ms","start":"2026-06-02T01:21:59.274926Z","end":"2026-06-02T01:21:59.427395Z","steps":["trace[465885945] 'process raft request' (duration: 152.180643ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:21:59.427542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.268683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/operatorpolicies/\" range_end:\"/registry/rabbitmq.com/operatorpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-02T01:21:59.427619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.153558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-06-02T01:21:59.427619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.544371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-02T01:21:59.427673Z","caller":"traceutil/trace.go:171","msg":"trace[1911907392] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8501; }","duration":"111.247951ms","start":"2026-06-02T01:21:59.316416Z","end":"2026-06-02T01:21:59.427664Z","steps":["trace[1911907392] 'agreement among raft nodes before linearized reading' (duration: 111.081736ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:21:59.427669Z","caller":"traceutil/trace.go:171","msg":"trace[544598486] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8501; }","duration":"114.645464ms","start":"2026-06-02T01:21:59.313012Z","end":"2026-06-02T01:21:59.427658Z","steps":["trace[544598486] 'agreement among raft nodes before linearized reading' (duration: 114.459559ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:21:59.427677Z","caller":"traceutil/trace.go:171","msg":"trace[1221893234] range","detail":"{range_begin:/registry/rabbitmq.com/operatorpolicies/; range_end:/registry/rabbitmq.com/operatorpolicies0; response_count:0; response_revision:8501; }","duration":"146.449507ms","start":"2026-06-02T01:21:59.281205Z","end":"2026-06-02T01:21:59.427655Z","steps":["trace[1221893234] 'agreement among raft nodes before linearized reading' (duration: 146.253142ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:22:07.993051Z","caller":"traceutil/trace.go:171","msg":"trace[724752645] transaction","detail":"{read_only:false; response_revision:8589; number_of_response:1; }","duration":"160.15545ms","start":"2026-06-02T01:22:07.832868Z","end":"2026-06-02T01:22:07.993023Z","steps":["trace[724752645] 'process raft request' (duration: 150.045435ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:22:08.01601Z","caller":"traceutil/trace.go:171","msg":"trace[2056804140] transaction","detail":"{read_only:false; response_revision:8590; number_of_response:1; }","duration":"135.414247ms","start":"2026-06-02T01:22:07.880576Z","end":"2026-06-02T01:22:08.01599Z","steps":["trace[2056804140] 'process raft request' (duration: 134.961805ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:22:08.176692Z","caller":"traceutil/trace.go:171","msg":"trace[1770687182] linearizableReadLoop","detail":"{readStateIndex:8900; appliedIndex:8899; }","duration":"152.149852ms","start":"2026-06-02T01:22:08.024518Z","end":"2026-06-02T01:22:08.176668Z","steps":["trace[1770687182] 'read index received' (duration: 92.175344ms)","trace[1770687182] 'applied index is now lower than readState.Index' (duration: 59.973628ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T01:22:08.176756Z","caller":"traceutil/trace.go:171","msg":"trace[1215785073] transaction","detail":"{read_only:false; response_revision:8591; number_of_response:1; }","duration":"156.84428ms","start":"2026-06-02T01:22:08.019877Z","end":"2026-06-02T01:22:08.176722Z","steps":["trace[1215785073] 'process raft request' (duration: 96.862291ms)","trace[1215785073] 'compare' (duration: 59.823054ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T01:22:08.176937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.873578ms","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-02T01:22:08.176999Z","caller":"traceutil/trace.go:171","msg":"trace[1421791360] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8591; }","duration":"104.97269ms","start":"2026-06-02T01:22:08.072011Z","end":"2026-06-02T01:22:08.176984Z","steps":["trace[1421791360] 'agreement among raft nodes before linearized reading' (duration: 104.787075ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:22:08.177014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.186999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-06-02T01:22:08.176931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.377659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-6r2qg\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-06-02T01:22:08.177109Z","caller":"traceutil/trace.go:171","msg":"trace[305373281] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8591; }","duration":"104.323292ms","start":"2026-06-02T01:22:08.072759Z","end":"2026-06-02T01:22:08.177082Z","steps":["trace[305373281] 'agreement among raft nodes before linearized reading' (duration: 104.064316ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:22:08.177129Z","caller":"traceutil/trace.go:171","msg":"trace[953857110] range","detail":"{range_begin:/registry/pods/openstack/keepalived-6r2qg; range_end:; response_count:1; response_revision:8591; }","duration":"152.626726ms","start":"2026-06-02T01:22:08.024493Z","end":"2026-06-02T01:22:08.17712Z","steps":["trace[953857110] 'agreement among raft nodes before linearized reading' (duration: 152.287517ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:22:08.36032Z","caller":"traceutil/trace.go:171","msg":"trace[847634014] transaction","detail":"{read_only:false; response_revision:8593; number_of_response:1; }","duration":"178.52964ms","start":"2026-06-02T01:22:08.181766Z","end":"2026-06-02T01:22:08.360295Z","steps":["trace[847634014] 'process raft request' (duration: 178.381955ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:22:09.344084Z","caller":"traceutil/trace.go:171","msg":"trace[1256457545] transaction","detail":"{read_only:false; response_revision:8596; number_of_response:1; }","duration":"179.799043ms","start":"2026-06-02T01:22:09.16426Z","end":"2026-06-02T01:22:09.344059Z","steps":["trace[1256457545] 'process raft request' (duration: 179.637719ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:22:32.090016Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023d5.wal"} {"level":"info","ts":"2026-06-02T01:24:09.175387Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"cfc9fec265e3384a","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-02T01:24:09.181374Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-06-02T01:24:09.181477Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-06-02T01:26:34.174298Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8322} {"level":"info","ts":"2026-06-02T01:26:34.252571Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8322,"took":"76.159061ms","hash":317539749,"current-db-size-bytes":58540032,"current-db-size":"58 MB","current-db-size-in-use-bytes":24002560,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-06-02T01:26:34.252683Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":317539749,"revision":8322,"compact-revision":6151} {"level":"info","ts":"2026-06-02T01:31:34.180372Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10537} {"level":"info","ts":"2026-06-02T01:31:34.257761Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10537,"took":"75.016562ms","hash":3161263605,"current-db-size-bytes":58540032,"current-db-size":"58 MB","current-db-size-in-use-bytes":26202112,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-06-02T01:31:34.257848Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3161263605,"revision":10537,"compact-revision":8322} {"level":"info","ts":"2026-06-02T01:35:02.322906Z","caller":"traceutil/trace.go:171","msg":"trace[221175601] transaction","detail":"{read_only:false; response_revision:14214; number_of_response:1; }","duration":"130.001931ms","start":"2026-06-02T01:35:02.192863Z","end":"2026-06-02T01:35:02.322864Z","steps":["trace[221175601] 'process raft request' (duration: 129.848427ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:35:24.589279Z","caller":"traceutil/trace.go:171","msg":"trace[1952532530] transaction","detail":"{read_only:false; response_revision:14331; number_of_response:1; }","duration":"152.665449ms","start":"2026-06-02T01:35:24.436585Z","end":"2026-06-02T01:35:24.589251Z","steps":["trace[1952532530] 'process raft request' (duration: 152.467283ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:35:24.730833Z","caller":"traceutil/trace.go:171","msg":"trace[1341506184] transaction","detail":"{read_only:false; response_revision:14332; number_of_response:1; }","duration":"254.882395ms","start":"2026-06-02T01:35:24.475931Z","end":"2026-06-02T01:35:24.730814Z","steps":["trace[1341506184] 'process raft request' (duration: 254.765931ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:35:32.661025Z","caller":"traceutil/trace.go:171","msg":"trace[236468299] transaction","detail":"{read_only:false; response_revision:14374; number_of_response:1; }","duration":"158.578638ms","start":"2026-06-02T01:35:32.502417Z","end":"2026-06-02T01:35:32.660996Z","steps":["trace[236468299] 'process raft request' (duration: 158.332211ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:35:37.493073Z","caller":"traceutil/trace.go:171","msg":"trace[1170474471] transaction","detail":"{read_only:false; response_revision:14399; number_of_response:1; }","duration":"104.212177ms","start":"2026-06-02T01:35:37.388814Z","end":"2026-06-02T01:35:37.493026Z","steps":["trace[1170474471] 'process raft request' (duration: 61.595173ms)","trace[1170474471] 'compare' (duration: 42.41836ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T01:35:40.315061Z","caller":"traceutil/trace.go:171","msg":"trace[208344924] transaction","detail":"{read_only:false; response_revision:14427; number_of_response:1; }","duration":"149.33551ms","start":"2026-06-02T01:35:40.165698Z","end":"2026-06-02T01:35:40.315034Z","steps":["trace[208344924] 'process raft request' (duration: 148.544799ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:35:42.434256Z","caller":"traceutil/trace.go:171","msg":"trace[291726851] linearizableReadLoop","detail":"{readStateIndex:14946; appliedIndex:14944; }","duration":"100.250812ms","start":"2026-06-02T01:35:42.333961Z","end":"2026-06-02T01:35:42.434212Z","steps":["trace[291726851] 'read index received' (duration: 62.147918ms)","trace[291726851] 'applied index is now lower than readState.Index' (duration: 38.100404ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T01:35:42.4344Z","caller":"traceutil/trace.go:171","msg":"trace[379264436] transaction","detail":"{read_only:false; response_revision:14446; number_of_response:1; }","duration":"101.109345ms","start":"2026-06-02T01:35:42.333267Z","end":"2026-06-02T01:35:42.434377Z","steps":["trace[379264436] 'process raft request' (duration: 95.517624ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:35:42.43475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.785447ms","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-02T01:35:42.434799Z","caller":"traceutil/trace.go:171","msg":"trace[1709962842] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:14446; }","duration":"100.878699ms","start":"2026-06-02T01:35:42.333905Z","end":"2026-06-02T01:35:42.434783Z","steps":["trace[1709962842] 'agreement among raft nodes before linearized reading' (duration: 100.734865ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:35:49.884546Z","caller":"traceutil/trace.go:171","msg":"trace[957627230] linearizableReadLoop","detail":"{readStateIndex:15099; appliedIndex:15098; }","duration":"285.771544ms","start":"2026-06-02T01:35:49.598747Z","end":"2026-06-02T01:35:49.884519Z","steps":["trace[957627230] 'read index received' (duration: 285.524577ms)","trace[957627230] 'applied index is now lower than readState.Index' (duration: 245.927µs)"],"step_count":2} {"level":"info","ts":"2026-06-02T01:35:49.884643Z","caller":"traceutil/trace.go:171","msg":"trace[2046924079] transaction","detail":"{read_only:false; response_revision:14596; number_of_response:1; }","duration":"345.22116ms","start":"2026-06-02T01:35:49.539385Z","end":"2026-06-02T01:35:49.884606Z","steps":["trace[2046924079] 'process raft request' (duration: 344.913422ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:35:49.884916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.626985ms","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-02T01:35:49.884999Z","caller":"traceutil/trace.go:171","msg":"trace[1450759301] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:14596; }","duration":"258.762699ms","start":"2026-06-02T01:35:49.626216Z","end":"2026-06-02T01:35:49.884978Z","steps":["trace[1450759301] 'agreement among raft nodes before linearized reading' (duration: 258.490791ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:35:49.885053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T01:35:49.539357Z","time spent":"345.559268ms","remote":"127.0.0.1:52406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3712,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T01:35:49.885286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.39681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-02T01:35:49.885359Z","caller":"traceutil/trace.go:171","msg":"trace[368509527] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:14596; }","duration":"286.640306ms","start":"2026-06-02T01:35:49.598701Z","end":"2026-06-02T01:35:49.885341Z","steps":["trace[368509527] 'agreement among raft nodes before linearized reading' (duration: 285.974779ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:36:26.954882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.700092ms","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-02T01:36:26.954982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.28922ms","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-02T01:36:26.955006Z","caller":"traceutil/trace.go:171","msg":"trace[931330548] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:15019; }","duration":"316.866756ms","start":"2026-06-02T01:36:26.638106Z","end":"2026-06-02T01:36:26.954972Z","steps":["trace[931330548] 'range keys from in-memory index tree' (duration: 316.493676ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:36:26.955076Z","caller":"traceutil/trace.go:171","msg":"trace[1910356244] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:15019; }","duration":"364.452655ms","start":"2026-06-02T01:36:26.590601Z","end":"2026-06-02T01:36:26.955053Z","steps":["trace[1910356244] 'range keys from in-memory index tree' (duration: 364.054605ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:36:26.955092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T01:36:26.638092Z","time spent":"316.981429ms","remote":"127.0.0.1:52464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-02T01:36:26.955116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T01:36:26.590573Z","time spent":"364.534257ms","remote":"127.0.0.1:52464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-02T01:36:30.994612Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4056228712196635634,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-02T01:36:31.293256Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.168111093s","expected-duration":"1s"} {"level":"warn","ts":"2026-06-02T01:36:31.29485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.232968247s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T01:36:31.294926Z","caller":"traceutil/trace.go:171","msg":"trace[1357404924] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:15051; }","duration":"1.233107171s","start":"2026-06-02T01:36:30.061803Z","end":"2026-06-02T01:36:31.29491Z","steps":["trace[1357404924] 'count revisions from in-memory index tree' (duration: 1.232852093s)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:36:31.294959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T01:36:30.061784Z","time spent":"1.233166701s","remote":"127.0.0.1:53784","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true "} {"level":"info","ts":"2026-06-02T01:36:31.295849Z","caller":"traceutil/trace.go:171","msg":"trace[1948642730] transaction","detail":"{read_only:false; response_revision:15052; number_of_response:1; }","duration":"1.170804846s","start":"2026-06-02T01:36:30.125019Z","end":"2026-06-02T01:36:31.295824Z","steps":["trace[1948642730] 'process raft request' (duration: 1.168556255s)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:36:31.296012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.231648622s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:69 size:665007"} {"level":"warn","ts":"2026-06-02T01:36:31.295998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T01:36:30.124991Z","time spent":"1.170928808s","remote":"127.0.0.1:52464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T01:36:31.29608Z","caller":"traceutil/trace.go:171","msg":"trace[1238153272] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:69; response_revision:15051; }","duration":"1.231747334s","start":"2026-06-02T01:36:30.064318Z","end":"2026-06-02T01:36:31.296065Z","steps":["trace[1238153272] 'range keys from in-memory index tree' (duration: 1.230960052s)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:36:31.29612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T01:36:30.064303Z","time spent":"1.231806296s","remote":"127.0.0.1:52406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":69,"response size":665031,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "} {"level":"info","ts":"2026-06-02T01:36:31.297791Z","caller":"traceutil/trace.go:171","msg":"trace[524424500] linearizableReadLoop","detail":"{readStateIndex:15573; appliedIndex:15570; }","duration":"803.761111ms","start":"2026-06-02T01:36:30.494011Z","end":"2026-06-02T01:36:31.297772Z","steps":["trace[524424500] 'read index received' (duration: 799.569069ms)","trace[524424500] 'applied index is now lower than readState.Index' (duration: 4.191232ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T01:36:31.297887Z","caller":"traceutil/trace.go:171","msg":"trace[544798812] transaction","detail":"{read_only:false; response_revision:15055; number_of_response:1; }","duration":"282.695758ms","start":"2026-06-02T01:36:31.015181Z","end":"2026-06-02T01:36:31.297877Z","steps":["trace[544798812] 'process raft request' (duration: 282.525634ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:36:31.297873Z","caller":"traceutil/trace.go:171","msg":"trace[906868501] transaction","detail":"{read_only:false; response_revision:15053; number_of_response:1; }","duration":"710.145615ms","start":"2026-06-02T01:36:30.587704Z","end":"2026-06-02T01:36:31.297849Z","steps":["trace[906868501] 'process raft request' (duration: 709.848387ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:36:31.297884Z","caller":"traceutil/trace.go:171","msg":"trace[801293246] transaction","detail":"{read_only:false; response_revision:15054; number_of_response:1; }","duration":"304.154584ms","start":"2026-06-02T01:36:30.993689Z","end":"2026-06-02T01:36:31.297844Z","steps":["trace[801293246] 'process raft request' (duration: 303.98052ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:36:31.298016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T01:36:30.587676Z","time spent":"710.248668ms","remote":"127.0.0.1:52464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T01:36:31.298038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T01:36:30.993667Z","time spent":"304.289237ms","remote":"127.0.0.1:52464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T01:36:31.298076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"804.052959ms","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-02T01:36:31.298108Z","caller":"traceutil/trace.go:171","msg":"trace[46587827] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:15055; }","duration":"804.130092ms","start":"2026-06-02T01:36:30.493971Z","end":"2026-06-02T01:36:31.298101Z","steps":["trace[46587827] 'agreement among raft nodes before linearized reading' (duration: 804.005768ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:36:31.298144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T01:36:30.49395Z","time spent":"804.187042ms","remote":"127.0.0.1:52464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-02T01:36:31.298192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.54968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T01:36:31.298247Z","caller":"traceutil/trace.go:171","msg":"trace[637825101] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:15055; }","duration":"187.629922ms","start":"2026-06-02T01:36:31.110602Z","end":"2026-06-02T01:36:31.298232Z","steps":["trace[637825101] 'agreement among raft nodes before linearized reading' (duration: 187.54636ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:36:31.298236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.929114ms","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-02T01:36:31.298301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.697329ms","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-02T01:36:31.298312Z","caller":"traceutil/trace.go:171","msg":"trace[1440004792] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:15055; }","duration":"325.034115ms","start":"2026-06-02T01:36:30.973258Z","end":"2026-06-02T01:36:31.298292Z","steps":["trace[1440004792] 'agreement among raft nodes before linearized reading' (duration: 324.806419ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:36:31.298328Z","caller":"traceutil/trace.go:171","msg":"trace[316198610] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:15055; }","duration":"326.772593ms","start":"2026-06-02T01:36:30.971549Z","end":"2026-06-02T01:36:31.298322Z","steps":["trace[316198610] 'agreement among raft nodes before linearized reading' (duration: 326.67197ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:36:31.298264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"678.071083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1982"} {"level":"warn","ts":"2026-06-02T01:36:31.298346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T01:36:30.973247Z","time spent":"325.092387ms","remote":"127.0.0.1:52464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-02T01:36:31.298334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"804.071111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-02T01:36:31.298312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.896356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeatures0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-02T01:36:31.298469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"803.817053ms","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-02T01:36:31.298435Z","caller":"traceutil/trace.go:171","msg":"trace[2055243976] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:15055; }","duration":"678.243308ms","start":"2026-06-02T01:36:30.620132Z","end":"2026-06-02T01:36:31.298376Z","steps":["trace[2055243976] 'agreement among raft nodes before linearized reading' (duration: 678.048602ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:36:31.298494Z","caller":"traceutil/trace.go:171","msg":"trace[552902637] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:15055; }","duration":"803.858223ms","start":"2026-06-02T01:36:30.494629Z","end":"2026-06-02T01:36:31.298488Z","steps":["trace[552902637] 'agreement among raft nodes before linearized reading' (duration: 803.73623ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:36:31.298513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T01:36:30.494619Z","time spent":"803.889844ms","remote":"127.0.0.1:52464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-02T01:36:31.298548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.73411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-06-02T01:36:31.298586Z","caller":"traceutil/trace.go:171","msg":"trace[50849925] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:15055; }","duration":"320.795622ms","start":"2026-06-02T01:36:30.977782Z","end":"2026-06-02T01:36:31.298578Z","steps":["trace[50849925] 'agreement among raft nodes before linearized reading' (duration: 320.422182ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:36:31.298606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T01:36:30.977771Z","time spent":"320.830032ms","remote":"127.0.0.1:52464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-02T01:36:31.298567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T01:36:30.62011Z","time spent":"678.438344ms","remote":"127.0.0.1:52408","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":1,"response size":2006,"request content":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" "} {"level":"info","ts":"2026-06-02T01:36:31.298631Z","caller":"traceutil/trace.go:171","msg":"trace[432181278] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:15055; }","duration":"804.382658ms","start":"2026-06-02T01:36:30.494004Z","end":"2026-06-02T01:36:31.298387Z","steps":["trace[432181278] 'agreement among raft nodes before linearized reading' (duration: 804.044179ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:36:31.298705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T01:36:30.493984Z","time spent":"804.700927ms","remote":"127.0.0.1:52512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":29,"request content":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true "} {"level":"info","ts":"2026-06-02T01:36:31.298457Z","caller":"traceutil/trace.go:171","msg":"trace[260319522] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/; range_end:/registry/nfd.k8s-sigs.io/nodefeatures0; response_count:0; response_revision:15055; }","duration":"132.098861ms","start":"2026-06-02T01:36:31.166333Z","end":"2026-06-02T01:36:31.298432Z","steps":["trace[260319522] 'agreement among raft nodes before linearized reading' (duration: 131.852043ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:36:31.298413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"726.208176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-6r2qg\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-06-02T01:36:31.298901Z","caller":"traceutil/trace.go:171","msg":"trace[1406834381] range","detail":"{range_begin:/registry/pods/openstack/keepalived-6r2qg; range_end:; response_count:1; response_revision:15055; }","duration":"726.69792ms","start":"2026-06-02T01:36:30.572165Z","end":"2026-06-02T01:36:31.298863Z","steps":["trace[1406834381] 'agreement among raft nodes before linearized reading' (duration: 726.089723ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:36:31.298948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T01:36:30.572132Z","time spent":"726.800832ms","remote":"127.0.0.1:52406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6548,"request content":"key:\"/registry/pods/openstack/keepalived-6r2qg\" "} {"level":"warn","ts":"2026-06-02T01:36:31.298347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T01:36:30.971526Z","time spent":"326.817104ms","remote":"127.0.0.1:52464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-02T01:36:34.187335Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12793} {"level":"info","ts":"2026-06-02T01:36:34.263226Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12793,"took":"74.161113ms","hash":3096959190,"current-db-size-bytes":58540032,"current-db-size":"58 MB","current-db-size-in-use-bytes":29249536,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-06-02T01:36:34.263306Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3096959190,"revision":12793,"compact-revision":10537} {"level":"info","ts":"2026-06-02T01:37:28.564624Z","caller":"traceutil/trace.go:171","msg":"trace[2133715911] linearizableReadLoop","detail":"{readStateIndex:16214; appliedIndex:16213; }","duration":"135.195985ms","start":"2026-06-02T01:37:28.429392Z","end":"2026-06-02T01:37:28.564588Z","steps":["trace[2133715911] 'read index received' (duration: 134.929247ms)","trace[2133715911] 'applied index is now lower than readState.Index' (duration: 265.638µs)"],"step_count":2} {"level":"info","ts":"2026-06-02T01:37:28.564813Z","caller":"traceutil/trace.go:171","msg":"trace[1638438604] transaction","detail":"{read_only:false; response_revision:15678; number_of_response:1; }","duration":"143.669981ms","start":"2026-06-02T01:37:28.421099Z","end":"2026-06-02T01:37:28.564769Z","steps":["trace[1638438604] 'process raft request' (duration: 143.302851ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:37:28.564939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.516253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:667"} {"level":"warn","ts":"2026-06-02T01:37:28.56497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.40751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T01:37:28.565016Z","caller":"traceutil/trace.go:171","msg":"trace[815358549] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15678; }","duration":"135.634725ms","start":"2026-06-02T01:37:28.429362Z","end":"2026-06-02T01:37:28.564996Z","steps":["trace[815358549] 'agreement among raft nodes before linearized reading' (duration: 135.415629ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:37:28.565064Z","caller":"traceutil/trace.go:171","msg":"trace[520225456] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15678; }","duration":"135.537994ms","start":"2026-06-02T01:37:28.429504Z","end":"2026-06-02T01:37:28.565042Z","steps":["trace[520225456] 'agreement among raft nodes before linearized reading' (duration: 135.362359ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:37:28.565086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.322775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:356"} {"level":"warn","ts":"2026-06-02T01:37:28.565167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.503792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-02T01:37:28.565088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.92928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"} {"level":"info","ts":"2026-06-02T01:37:28.565224Z","caller":"traceutil/trace.go:171","msg":"trace[1871863920] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:0; response_revision:15678; }","duration":"135.563743ms","start":"2026-06-02T01:37:28.429644Z","end":"2026-06-02T01:37:28.565208Z","steps":["trace[1871863920] 'agreement among raft nodes before linearized reading' (duration: 135.495421ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:37:28.565133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.795772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-metadata\" ","response":"range_response_count:1 size:682"} {"level":"info","ts":"2026-06-02T01:37:28.565286Z","caller":"traceutil/trace.go:171","msg":"trace[1551458158] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-metadata; range_end:; response_count:1; response_revision:15678; }","duration":"134.971007ms","start":"2026-06-02T01:37:28.430293Z","end":"2026-06-02T01:37:28.565264Z","steps":["trace[1551458158] 'agreement among raft nodes before linearized reading' (duration: 134.69226ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:37:28.565164Z","caller":"traceutil/trace.go:171","msg":"trace[844956505] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:15678; }","duration":"110.430798ms","start":"2026-06-02T01:37:28.454714Z","end":"2026-06-02T01:37:28.565144Z","steps":["trace[844956505] 'agreement among raft nodes before linearized reading' (duration: 110.240843ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:37:28.565307Z","caller":"traceutil/trace.go:171","msg":"trace[161401971] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15678; }","duration":"134.128255ms","start":"2026-06-02T01:37:28.431127Z","end":"2026-06-02T01:37:28.565255Z","steps":["trace[161401971] 'agreement among raft nodes before linearized reading' (duration: 133.794496ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:37:29.694369Z","caller":"traceutil/trace.go:171","msg":"trace[185865794] transaction","detail":"{read_only:false; response_revision:15679; number_of_response:1; }","duration":"163.277778ms","start":"2026-06-02T01:37:29.53106Z","end":"2026-06-02T01:37:29.694338Z","steps":["trace[185865794] 'process raft request' (duration: 163.087833ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:37:30.096865Z","caller":"traceutil/trace.go:171","msg":"trace[874597841] transaction","detail":"{read_only:false; response_revision:15680; number_of_response:1; }","duration":"564.002848ms","start":"2026-06-02T01:37:29.532838Z","end":"2026-06-02T01:37:30.096841Z","steps":["trace[874597841] 'process raft request' (duration: 563.825364ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:37:30.097044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T01:37:29.532822Z","time spent":"564.106881ms","remote":"127.0.0.1:52464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T01:37:30.097079Z","caller":"traceutil/trace.go:171","msg":"trace[1650695345] transaction","detail":"{read_only:false; response_revision:15681; number_of_response:1; }","duration":"563.098043ms","start":"2026-06-02T01:37:29.53397Z","end":"2026-06-02T01:37:30.097068Z","steps":["trace[1650695345] 'process raft request' (duration: 562.829106ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:37:30.097137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T01:37:29.533942Z","time spent":"563.163685ms","remote":"127.0.0.1:52464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T01:37:30.097335Z","caller":"traceutil/trace.go:171","msg":"trace[73016810] linearizableReadLoop","detail":"{readStateIndex:16218; appliedIndex:16214; }","duration":"509.980977ms","start":"2026-06-02T01:37:29.587344Z","end":"2026-06-02T01:37:30.097325Z","steps":["trace[73016810] 'read index received' (duration: 106.77307ms)","trace[73016810] 'applied index is now lower than readState.Index' (duration: 403.204176ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T01:37:30.097445Z","caller":"traceutil/trace.go:171","msg":"trace[481734526] transaction","detail":"{read_only:false; response_revision:15682; number_of_response:1; }","duration":"562.166748ms","start":"2026-06-02T01:37:29.535246Z","end":"2026-06-02T01:37:30.097412Z","steps":["trace[481734526] 'process raft request' (duration: 561.784637ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:37:30.09756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.76396ms","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-02T01:37:30.097593Z","caller":"traceutil/trace.go:171","msg":"trace[148132515] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:15682; }","duration":"471.837051ms","start":"2026-06-02T01:37:29.625748Z","end":"2026-06-02T01:37:30.097585Z","steps":["trace[148132515] 'agreement among raft nodes before linearized reading' (duration: 471.77256ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:37:30.09762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T01:37:29.625725Z","time spent":"471.888873ms","remote":"127.0.0.1:52464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-02T01:37:30.097702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T01:37:29.535221Z","time spent":"562.329654ms","remote":"127.0.0.1:52464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T01:37:30.097494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"510.14682ms","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-02T01:37:30.097925Z","caller":"traceutil/trace.go:171","msg":"trace[1472816505] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:15682; }","duration":"510.604443ms","start":"2026-06-02T01:37:29.587307Z","end":"2026-06-02T01:37:30.097912Z","steps":["trace[1472816505] 'agreement among raft nodes before linearized reading' (duration: 510.079659ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:37:30.097989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T01:37:29.587294Z","time spent":"510.682255ms","remote":"127.0.0.1:52464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-02T01:37:30.098057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.759959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-zswzv\" ","response":"range_response_count:1 size:20746"} {"level":"info","ts":"2026-06-02T01:37:30.098089Z","caller":"traceutil/trace.go:171","msg":"trace[1227519863] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-zswzv; range_end:; response_count:1; response_revision:15682; }","duration":"170.819451ms","start":"2026-06-02T01:37:29.927262Z","end":"2026-06-02T01:37:30.098081Z","steps":["trace[1227519863] 'agreement among raft nodes before linearized reading' (duration: 170.739978ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:37:30.098294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.006626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-6r2qg\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-06-02T01:37:30.098325Z","caller":"traceutil/trace.go:171","msg":"trace[64189813] range","detail":"{range_begin:/registry/pods/openstack/keepalived-6r2qg; range_end:; response_count:1; response_revision:15682; }","duration":"184.081777ms","start":"2026-06-02T01:37:29.914236Z","end":"2026-06-02T01:37:30.098318Z","steps":["trace[64189813] 'agreement among raft nodes before linearized reading' (duration: 184.001265ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:37:30.098634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.329761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"} {"level":"info","ts":"2026-06-02T01:37:30.098662Z","caller":"traceutil/trace.go:171","msg":"trace[1670953848] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15682; }","duration":"217.385912ms","start":"2026-06-02T01:37:29.881268Z","end":"2026-06-02T01:37:30.098654Z","steps":["trace[1670953848] 'agreement among raft nodes before linearized reading' (duration: 217.320771ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:37:30.098795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.989314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-06-02T01:37:30.098823Z","caller":"traceutil/trace.go:171","msg":"trace[366481299] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:15682; }","duration":"472.059148ms","start":"2026-06-02T01:37:29.626757Z","end":"2026-06-02T01:37:30.098816Z","steps":["trace[366481299] 'agreement among raft nodes before linearized reading' (duration: 471.992376ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:37:30.098843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T01:37:29.626731Z","time spent":"472.106698ms","remote":"127.0.0.1:52464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-02T01:37:30.098862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.167703ms","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-02T01:37:30.09896Z","caller":"traceutil/trace.go:171","msg":"trace[1068082101] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:15682; }","duration":"471.314038ms","start":"2026-06-02T01:37:29.627619Z","end":"2026-06-02T01:37:30.098933Z","steps":["trace[1068082101] 'agreement among raft nodes before linearized reading' (duration: 471.03804ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:37:30.099021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T01:37:29.627608Z","time spent":"471.400289ms","remote":"127.0.0.1:52464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-02T01:37:30.099256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.935002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-nova-server-0\" ","response":"range_response_count:1 size:1849"} {"level":"warn","ts":"2026-06-02T01:37:30.099295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.051923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-user\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T01:37:30.09932Z","caller":"traceutil/trace.go:171","msg":"trace[936825762] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:15682; }","duration":"246.150855ms","start":"2026-06-02T01:37:29.85316Z","end":"2026-06-02T01:37:30.099311Z","steps":["trace[936825762] 'agreement among raft nodes before linearized reading' (duration: 246.118974ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:37:30.099312Z","caller":"traceutil/trace.go:171","msg":"trace[508877586] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-nova-server-0; range_end:; response_count:1; response_revision:15682; }","duration":"242.030094ms","start":"2026-06-02T01:37:29.857266Z","end":"2026-06-02T01:37:30.099296Z","steps":["trace[508877586] 'agreement among raft nodes before linearized reading' (duration: 241.889661ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:37:30.099263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.150916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T01:37:30.09957Z","caller":"traceutil/trace.go:171","msg":"trace[1478216115] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15682; }","duration":"246.467125ms","start":"2026-06-02T01:37:29.853086Z","end":"2026-06-02T01:37:30.099553Z","steps":["trace[1478216115] 'agreement among raft nodes before linearized reading' (duration: 246.152906ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:37:30.099673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.38618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-02T01:37:30.099738Z","caller":"traceutil/trace.go:171","msg":"trace[1000542277] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:15682; }","duration":"471.472171ms","start":"2026-06-02T01:37:29.628254Z","end":"2026-06-02T01:37:30.099726Z","steps":["trace[1000542277] 'agreement among raft nodes before linearized reading' (duration: 471.239795ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:37:30.099794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T01:37:29.628246Z","time spent":"471.537613ms","remote":"127.0.0.1:52464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-02T01:37:30.099854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.781232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T01:37:30.099922Z","caller":"traceutil/trace.go:171","msg":"trace[1815622128] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:15682; }","duration":"246.886276ms","start":"2026-06-02T01:37:29.85302Z","end":"2026-06-02T01:37:30.099906Z","steps":["trace[1815622128] 'agreement among raft nodes before linearized reading' (duration: 246.785083ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:41:34.194017Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15072} {"level":"info","ts":"2026-06-02T01:41:34.288403Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15072,"took":"91.445595ms","hash":949765267,"current-db-size-bytes":58540032,"current-db-size":"58 MB","current-db-size-in-use-bytes":30449664,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-02T01:41:34.288472Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":949765267,"revision":15072,"compact-revision":12793} {"level":"warn","ts":"2026-06-02T01:43:13.305991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.633277ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-02T01:43:13.306102Z","caller":"traceutil/trace.go:171","msg":"trace[786028077] linearizableReadLoop","detail":"{readStateIndex:18836; appliedIndex:18835; }","duration":"365.998137ms","start":"2026-06-02T01:43:12.940088Z","end":"2026-06-02T01:43:13.306087Z","steps":["trace[786028077] 'read index received' (duration: 253.171224ms)","trace[786028077] 'applied index is now lower than readState.Index' (duration: 112.825783ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T01:43:13.30617Z","caller":"traceutil/trace.go:171","msg":"trace[1737727232] transaction","detail":"{read_only:false; response_revision:18216; number_of_response:1; }","duration":"381.779059ms","start":"2026-06-02T01:43:12.924379Z","end":"2026-06-02T01:43:13.306158Z","steps":["trace[1737727232] 'process raft request' (duration: 268.879185ms)","trace[1737727232] 'compare' (duration: 112.278398ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T01:43:13.306225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T01:43:12.924336Z","time spent":"381.859751ms","remote":"127.0.0.1:52406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":20966,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T01:43:13.306404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.321644ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:562"} {"level":"info","ts":"2026-06-02T01:43:13.306476Z","caller":"traceutil/trace.go:171","msg":"trace[1943459672] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:18216; }","duration":"366.437797ms","start":"2026-06-02T01:43:12.940021Z","end":"2026-06-02T01:43:13.306459Z","steps":["trace[1943459672] 'agreement among raft nodes before linearized reading' (duration: 366.257712ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:43:13.306508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T01:43:12.939984Z","time spent":"366.517741ms","remote":"127.0.0.1:52464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":586,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"info","ts":"2026-06-02T01:43:13.798308Z","caller":"traceutil/trace.go:171","msg":"trace[1454967645] linearizableReadLoop","detail":"{readStateIndex:18837; appliedIndex:18836; }","duration":"492.156706ms","start":"2026-06-02T01:43:13.306127Z","end":"2026-06-02T01:43:13.798284Z","steps":["trace[1454967645] 'read index received' (duration: 408.125355ms)","trace[1454967645] 'applied index is now lower than readState.Index' (duration: 84.030711ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T01:43:13.798476Z","caller":"traceutil/trace.go:171","msg":"trace[718441216] transaction","detail":"{read_only:false; response_revision:18218; number_of_response:1; }","duration":"484.777529ms","start":"2026-06-02T01:43:13.313691Z","end":"2026-06-02T01:43:13.798469Z","steps":["trace[718441216] 'process raft request' (duration: 484.517852ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:43:13.7983Z","caller":"traceutil/trace.go:171","msg":"trace[150136396] transaction","detail":"{read_only:false; response_revision:18217; number_of_response:1; }","duration":"506.609873ms","start":"2026-06-02T01:43:13.291644Z","end":"2026-06-02T01:43:13.798254Z","steps":["trace[150136396] 'process raft request' (duration: 422.591542ms)","trace[150136396] 'compare' (duration: 83.188749ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T01:43:13.798745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"695.997298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-7p7nr\" ","response":"range_response_count:1 size:22094"} {"level":"warn","ts":"2026-06-02T01:43:13.798815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"743.547482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-zz9xn\" ","response":"range_response_count:1 size:9792"} {"level":"info","ts":"2026-06-02T01:43:13.798813Z","caller":"traceutil/trace.go:171","msg":"trace[1732404702] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-7p7nr; range_end:; response_count:1; response_revision:18218; }","duration":"696.090451ms","start":"2026-06-02T01:43:13.102704Z","end":"2026-06-02T01:43:13.798794Z","steps":["trace[1732404702] 'agreement among raft nodes before linearized reading' (duration: 695.617517ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:43:13.798837Z","caller":"traceutil/trace.go:171","msg":"trace[742472477] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-zz9xn; range_end:; response_count:1; response_revision:18219; }","duration":"743.600773ms","start":"2026-06-02T01:43:13.055231Z","end":"2026-06-02T01:43:13.798832Z","steps":["trace[742472477] 'agreement among raft nodes before linearized reading' (duration: 743.166272ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:43:13.798861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T01:43:13.055217Z","time spent":"743.640654ms","remote":"127.0.0.1:52406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":9816,"request content":"key:\"/registry/pods/openstack/nova-cell-setup-zz9xn\" "} {"level":"warn","ts":"2026-06-02T01:43:13.798853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T01:43:13.102694Z","time spent":"696.148072ms","remote":"127.0.0.1:52406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":22118,"request content":"key:\"/registry/pods/openstack/nova-compute-default-7p7nr\" "} {"level":"warn","ts":"2026-06-02T01:43:13.7989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T01:43:13.291578Z","time spent":"507.083695ms","remote":"127.0.0.1:52464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T01:43:13.798996Z","caller":"traceutil/trace.go:171","msg":"trace[1914886249] transaction","detail":"{read_only:false; response_revision:18219; number_of_response:1; }","duration":"447.88548ms","start":"2026-06-02T01:43:13.351064Z","end":"2026-06-02T01:43:13.798949Z","steps":["trace[1914886249] 'process raft request' (duration: 447.370696ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:43:13.798572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T01:43:13.313669Z","time spent":"484.82878ms","remote":"127.0.0.1:52464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T01:43:13.799002Z","caller":"traceutil/trace.go:171","msg":"trace[212463601] transaction","detail":"{read_only:false; response_revision:18220; number_of_response:1; }","duration":"423.179328ms","start":"2026-06-02T01:43:13.375761Z","end":"2026-06-02T01:43:13.79894Z","steps":["trace[212463601] 'process raft request' (duration: 422.952842ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:43:13.798529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"685.25802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-02T01:43:13.799151Z","caller":"traceutil/trace.go:171","msg":"trace[851418063] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:18218; }","duration":"685.915548ms","start":"2026-06-02T01:43:13.113229Z","end":"2026-06-02T01:43:13.799144Z","steps":["trace[851418063] 'agreement among raft nodes before linearized reading' (duration: 685.135097ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:43:13.799174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T01:43:13.113198Z","time spent":"685.970408ms","remote":"127.0.0.1:52238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-02T01:43:13.79916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T01:43:13.351029Z","time spent":"448.038804ms","remote":"127.0.0.1:52464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T01:43:13.799238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T01:43:13.375739Z","time spent":"423.376234ms","remote":"127.0.0.1:52464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T01:43:13.798617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"704.2794ms","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:6"} {"level":"info","ts":"2026-06-02T01:43:13.799335Z","caller":"traceutil/trace.go:171","msg":"trace[701781441] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:18218; }","duration":"705.02119ms","start":"2026-06-02T01:43:13.094303Z","end":"2026-06-02T01:43:13.799325Z","steps":["trace[701781441] 'agreement among raft nodes before linearized reading' (duration: 704.088385ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:43:13.799367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T01:43:13.094292Z","time spent":"705.064971ms","remote":"127.0.0.1:44402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true "} {"level":"warn","ts":"2026-06-02T01:43:13.803053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.852452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:701"} {"level":"info","ts":"2026-06-02T01:43:13.803171Z","caller":"traceutil/trace.go:171","msg":"trace[1108853852] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:18220; }","duration":"419.020527ms","start":"2026-06-02T01:43:13.384123Z","end":"2026-06-02T01:43:13.803143Z","steps":["trace[1108853852] 'agreement among raft nodes before linearized reading' (duration: 414.736332ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T01:43:13.803224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T01:43:13.384097Z","time spent":"419.116219ms","remote":"127.0.0.1:52376","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":725,"request content":"key:\"/registry/services/endpoints/openstack/neutron-server\" "} {"level":"info","ts":"2026-06-02T01:43:48.01198Z","caller":"traceutil/trace.go:171","msg":"trace[1936411169] transaction","detail":"{read_only:false; response_revision:18485; number_of_response:1; }","duration":"109.188106ms","start":"2026-06-02T01:43:47.902766Z","end":"2026-06-02T01:43:48.011954Z","steps":["trace[1936411169] 'process raft request' (duration: 109.048002ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:43:48.022816Z","caller":"traceutil/trace.go:171","msg":"trace[45455842] transaction","detail":"{read_only:false; response_revision:18486; number_of_response:1; }","duration":"113.271395ms","start":"2026-06-02T01:43:47.909526Z","end":"2026-06-02T01:43:48.022797Z","steps":["trace[45455842] 'process raft request' (duration: 113.10403ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:43:48.023104Z","caller":"traceutil/trace.go:171","msg":"trace[1558441651] transaction","detail":"{read_only:false; response_revision:18487; number_of_response:1; }","duration":"103.894275ms","start":"2026-06-02T01:43:47.919165Z","end":"2026-06-02T01:43:48.02306Z","steps":["trace[1558441651] 'process raft request' (duration: 103.580406ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T01:46:28.89273Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"cfc9fec265e3384a","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-02T01:46:28.89862Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-06-02T01:46:28.898776Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-06-02T01:46:34.20392Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17530} {"level":"info","ts":"2026-06-02T01:46:34.299097Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17530,"took":"91.515295ms","hash":2499470723,"current-db-size-bytes":58540032,"current-db-size":"58 MB","current-db-size-in-use-bytes":29483008,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-02T01:46:34.299158Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2499470723,"revision":17530,"compact-revision":15072}