{"level":"warn","ts":"2026-08-22T10:31:38.830581Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-22T10:31:38.830687Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.222:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.222:2380","--initial-cluster=instance=https://199.204.45.222:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.222:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.222: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-08-22T10:31:38.830751Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-22T10:31:38.830764Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.222:2380"]} {"level":"info","ts":"2026-08-22T10:31:38.830781Z","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-08-22T10:31:38.831381Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.222:2379"]} {"level":"info","ts":"2026-08-22T10:31:38.831463Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.222:2380"],"listen-peer-urls":["https://199.204.45.222:2380"],"advertise-client-urls":["https://199.204.45.222:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.222:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.222: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-08-22T10:31:38.835567Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.884133ms"} {"level":"info","ts":"2026-08-22T10:31:38.840974Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"380f6760faea5f9e","cluster-id":"b87e8aca83a17eab"} {"level":"info","ts":"2026-08-22T10:31:38.841051Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e switched to configuration voters=()"} {"level":"info","ts":"2026-08-22T10:31:38.841076Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became follower at term 0"} {"level":"info","ts":"2026-08-22T10:31:38.841087Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 380f6760faea5f9e [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-22T10:31:38.841103Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became follower at term 1"} {"level":"info","ts":"2026-08-22T10:31:38.841152Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e switched to configuration voters=(4039561056998809502)"} {"level":"warn","ts":"2026-08-22T10:31:38.846922Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-22T10:31:38.848428Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-22T10:31:38.849668Z","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-08-22T10:31:38.852001Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"380f6760faea5f9e","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-22T10:31:38.852129Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"380f6760faea5f9e","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-22T10:31:38.852401Z","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-08-22T10:31:38.852437Z","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-08-22T10:31:38.852444Z","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-08-22T10:31:38.85311Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e switched to configuration voters=(4039561056998809502)"} {"level":"info","ts":"2026-08-22T10:31:38.85319Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b87e8aca83a17eab","local-member-id":"380f6760faea5f9e","added-peer-id":"380f6760faea5f9e","added-peer-peer-urls":["https://199.204.45.222:2380"]} {"level":"info","ts":"2026-08-22T10:31:38.856732Z","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-08-22T10:31:38.856895Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"380f6760faea5f9e","initial-advertise-peer-urls":["https://199.204.45.222:2380"],"listen-peer-urls":["https://199.204.45.222:2380"],"advertise-client-urls":["https://199.204.45.222:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.222:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-22T10:31:38.85692Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-22T10:31:38.856976Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.222:2380"} {"level":"info","ts":"2026-08-22T10:31:38.856989Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.222:2380"} {"level":"info","ts":"2026-08-22T10:31:39.541992Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e is starting a new election at term 1"} {"level":"info","ts":"2026-08-22T10:31:39.542082Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became pre-candidate at term 1"} {"level":"info","ts":"2026-08-22T10:31:39.542171Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e received MsgPreVoteResp from 380f6760faea5f9e at term 1"} {"level":"info","ts":"2026-08-22T10:31:39.542198Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became candidate at term 2"} {"level":"info","ts":"2026-08-22T10:31:39.542212Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e received MsgVoteResp from 380f6760faea5f9e at term 2"} {"level":"info","ts":"2026-08-22T10:31:39.542236Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became leader at term 2"} {"level":"info","ts":"2026-08-22T10:31:39.542253Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 380f6760faea5f9e elected leader 380f6760faea5f9e at term 2"} {"level":"info","ts":"2026-08-22T10:31:39.543448Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-22T10:31:39.544648Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-22T10:31:39.544665Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"380f6760faea5f9e","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.222:2379]}","request-path":"/0/members/380f6760faea5f9e/attributes","cluster-id":"b87e8aca83a17eab","publish-timeout":"7s"} {"level":"info","ts":"2026-08-22T10:31:39.545142Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-22T10:31:39.54565Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-22T10:31:39.54568Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-22T10:31:39.547836Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.222:2379"} {"level":"info","ts":"2026-08-22T10:31:39.548469Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-22T10:31:39.545113Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b87e8aca83a17eab","local-member-id":"380f6760faea5f9e","cluster-version":"3.5"} {"level":"info","ts":"2026-08-22T10:31:39.555089Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-22T10:31:39.555131Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-22T10:31:59.776765Z","caller":"traceutil/trace.go:171","msg":"trace[1530227347] transaction","detail":"{read_only:false; response_revision:383; number_of_response:1; }","duration":"131.706055ms","start":"2026-08-22T10:31:59.645026Z","end":"2026-08-22T10:31:59.776732Z","steps":["trace[1530227347] 'process raft request' (duration: 131.550951ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:32:13.826283Z","caller":"traceutil/trace.go:171","msg":"trace[1239985773] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"105.225352ms","start":"2026-08-22T10:32:13.721025Z","end":"2026-08-22T10:32:13.82625Z","steps":["trace[1239985773] 'process raft request' (duration: 105.056708ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:32:13.826591Z","caller":"traceutil/trace.go:171","msg":"trace[1804740182] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"105.794158ms","start":"2026-08-22T10:32:13.720789Z","end":"2026-08-22T10:32:13.826583Z","steps":["trace[1804740182] 'process raft request' (duration: 80.377153ms)","trace[1804740182] 'compare' (duration: 24.641814ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:32:13.826675Z","caller":"traceutil/trace.go:171","msg":"trace[803394715] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"105.839209ms","start":"2026-08-22T10:32:13.720828Z","end":"2026-08-22T10:32:13.826667Z","steps":["trace[803394715] 'process raft request' (duration: 105.12988ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:32:13.82782Z","caller":"traceutil/trace.go:171","msg":"trace[1276769727] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"106.67667ms","start":"2026-08-22T10:32:13.721112Z","end":"2026-08-22T10:32:13.827789Z","steps":["trace[1276769727] 'process raft request' (duration: 105.044397ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:32:13.827959Z","caller":"traceutil/trace.go:171","msg":"trace[1576121104] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"103.160678ms","start":"2026-08-22T10:32:13.724789Z","end":"2026-08-22T10:32:13.82795Z","steps":["trace[1576121104] 'process raft request' (duration: 101.978658ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:32:19.69186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.775286ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-22T10:32:19.691954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.33002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-22T10:32:19.691964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.33443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T10:32:19.692018Z","caller":"traceutil/trace.go:171","msg":"trace[55167033] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:583; }","duration":"109.004731ms","start":"2026-08-22T10:32:19.58299Z","end":"2026-08-22T10:32:19.691995Z","steps":["trace[55167033] 'range keys from in-memory index tree' (duration: 108.655132ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:32:19.69205Z","caller":"traceutil/trace.go:171","msg":"trace[1313785100] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:583; }","duration":"109.506794ms","start":"2026-08-22T10:32:19.582519Z","end":"2026-08-22T10:32:19.692025Z","steps":["trace[1313785100] 'range keys from in-memory index tree' (duration: 109.151065ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:32:19.692071Z","caller":"traceutil/trace.go:171","msg":"trace[60721594] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:583; }","duration":"109.468863ms","start":"2026-08-22T10:32:19.582573Z","end":"2026-08-22T10:32:19.692042Z","steps":["trace[60721594] 'count revisions from in-memory index tree' (duration: 109.138925ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:32:20.137034Z","caller":"traceutil/trace.go:171","msg":"trace[1725354364] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"255.164764ms","start":"2026-08-22T10:32:19.881812Z","end":"2026-08-22T10:32:20.136977Z","steps":["trace[1725354364] 'process raft request' (duration: 254.63295ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:32:20.137614Z","caller":"traceutil/trace.go:171","msg":"trace[1778297101] linearizableReadLoop","detail":"{readStateIndex:610; appliedIndex:607; }","duration":"238.249102ms","start":"2026-08-22T10:32:19.89933Z","end":"2026-08-22T10:32:20.137579Z","steps":["trace[1778297101] 'read index received' (duration: 13.645497ms)","trace[1778297101] 'applied index is now lower than readState.Index' (duration: 224.602415ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:32:20.13774Z","caller":"traceutil/trace.go:171","msg":"trace[1434944296] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"248.281005ms","start":"2026-08-22T10:32:19.889438Z","end":"2026-08-22T10:32:20.137719Z","steps":["trace[1434944296] 'process raft request' (duration: 247.565166ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:32:20.137912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.52052ms","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-08-22T10:32:20.138009Z","caller":"traceutil/trace.go:171","msg":"trace[5001297] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:586; }","duration":"238.712195ms","start":"2026-08-22T10:32:19.899276Z","end":"2026-08-22T10:32:20.137988Z","steps":["trace[5001297] 'agreement among raft nodes before linearized reading' (duration: 238.465078ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:32:20.138098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.655343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T10:32:20.138178Z","caller":"traceutil/trace.go:171","msg":"trace[1373117191] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:586; }","duration":"238.823258ms","start":"2026-08-22T10:32:19.89932Z","end":"2026-08-22T10:32:20.138144Z","steps":["trace[1373117191] 'agreement among raft nodes before linearized reading' (duration: 238.703445ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:32:20.138195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.105566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T10:32:20.138243Z","caller":"traceutil/trace.go:171","msg":"trace[717103633] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:586; }","duration":"163.208699ms","start":"2026-08-22T10:32:19.975021Z","end":"2026-08-22T10:32:20.138229Z","steps":["trace[717103633] 'agreement among raft nodes before linearized reading' (duration: 163.117557ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:32:20.138223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.698299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-22T10:32:20.138308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.953346ms","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-08-22T10:32:20.138341Z","caller":"traceutil/trace.go:171","msg":"trace[1428061667] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:586; }","duration":"182.870284ms","start":"2026-08-22T10:32:19.955424Z","end":"2026-08-22T10:32:20.138294Z","steps":["trace[1428061667] 'agreement among raft nodes before linearized reading' (duration: 182.688509ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:32:20.138405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.072958ms","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\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T10:32:20.138441Z","caller":"traceutil/trace.go:171","msg":"trace[497281032] 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:586; }","duration":"204.111079ms","start":"2026-08-22T10:32:19.934322Z","end":"2026-08-22T10:32:20.138433Z","steps":["trace[497281032] 'agreement among raft nodes before linearized reading' (duration: 204.054838ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:32:20.138497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.398688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-22T10:32:20.138552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.029638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T10:32:20.138591Z","caller":"traceutil/trace.go:171","msg":"trace[351107833] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:586; }","duration":"183.1164ms","start":"2026-08-22T10:32:19.955465Z","end":"2026-08-22T10:32:20.138581Z","steps":["trace[351107833] 'agreement among raft nodes before linearized reading' (duration: 183.046968ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:32:20.138599Z","caller":"traceutil/trace.go:171","msg":"trace[1210483066] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:586; }","duration":"162.552452ms","start":"2026-08-22T10:32:19.976023Z","end":"2026-08-22T10:32:20.138575Z","steps":["trace[1210483066] 'agreement among raft nodes before linearized reading' (duration: 162.342947ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:32:20.138356Z","caller":"traceutil/trace.go:171","msg":"trace[934211000] 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:586; }","duration":"204.012107ms","start":"2026-08-22T10:32:19.934333Z","end":"2026-08-22T10:32:20.138345Z","steps":["trace[934211000] 'agreement among raft nodes before linearized reading' (duration: 203.945985ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:32:20.138632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.798707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-22T10:32:20.138731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.442348ms","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\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T10:32:20.138767Z","caller":"traceutil/trace.go:171","msg":"trace[1755804928] 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:586; }","duration":"204.51551ms","start":"2026-08-22T10:32:19.934243Z","end":"2026-08-22T10:32:20.138759Z","steps":["trace[1755804928] 'agreement among raft nodes before linearized reading' (duration: 204.457818ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:32:20.140646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.722812ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T10:32:20.140904Z","caller":"traceutil/trace.go:171","msg":"trace[625230682] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:586; }","duration":"165.889839ms","start":"2026-08-22T10:32:19.974961Z","end":"2026-08-22T10:32:20.14085Z","steps":["trace[625230682] 'agreement among raft nodes before linearized reading' (duration: 163.654041ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:32:20.14538Z","caller":"traceutil/trace.go:171","msg":"trace[284476398] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:586; }","duration":"238.899669ms","start":"2026-08-22T10:32:19.899791Z","end":"2026-08-22T10:32:20.13869Z","steps":["trace[284476398] 'agreement among raft nodes before linearized reading' (duration: 238.801746ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:32:20.593842Z","caller":"traceutil/trace.go:171","msg":"trace[532985980] linearizableReadLoop","detail":"{readStateIndex:611; appliedIndex:610; }","duration":"229.506514ms","start":"2026-08-22T10:32:20.364301Z","end":"2026-08-22T10:32:20.593808Z","steps":["trace[532985980] 'read index received' (duration: 229.139534ms)","trace[532985980] 'applied index is now lower than readState.Index' (duration: 365.68µs)"],"step_count":2} {"level":"warn","ts":"2026-08-22T10:32:20.594164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.828652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-rmdpt\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-08-22T10:32:20.594196Z","caller":"traceutil/trace.go:171","msg":"trace[32949587] range","detail":"{range_begin:/registry/pods/kube-system/cilium-rmdpt; range_end:; response_count:1; response_revision:587; }","duration":"229.930325ms","start":"2026-08-22T10:32:20.364255Z","end":"2026-08-22T10:32:20.594185Z","steps":["trace[32949587] 'agreement among raft nodes before linearized reading' (duration: 229.715179ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:32:20.594358Z","caller":"traceutil/trace.go:171","msg":"trace[578459072] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"386.449379ms","start":"2026-08-22T10:32:20.207473Z","end":"2026-08-22T10:32:20.593923Z","steps":["trace[578459072] 'process raft request' (duration: 386.063089ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:32:20.59673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:32:20.207445Z","time spent":"388.734799ms","remote":"127.0.0.1:42940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-22T10:33:53.669248Z","caller":"traceutil/trace.go:171","msg":"trace[110506554] transaction","detail":"{read_only:false; response_revision:1831; number_of_response:1; }","duration":"189.389628ms","start":"2026-08-22T10:33:53.479828Z","end":"2026-08-22T10:33:53.669218Z","steps":["trace[110506554] 'process raft request' (duration: 189.141212ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:33:53.679899Z","caller":"traceutil/trace.go:171","msg":"trace[1188626317] transaction","detail":"{read_only:false; response_revision:1832; number_of_response:1; }","duration":"173.680035ms","start":"2026-08-22T10:33:53.504717Z","end":"2026-08-22T10:33:53.678397Z","steps":["trace[1188626317] 'process raft request' (duration: 173.48581ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:33:54.018039Z","caller":"traceutil/trace.go:171","msg":"trace[136860231] linearizableReadLoop","detail":"{readStateIndex:1905; appliedIndex:1904; }","duration":"117.148439ms","start":"2026-08-22T10:33:53.900866Z","end":"2026-08-22T10:33:54.018014Z","steps":["trace[136860231] 'read index received' (duration: 116.894062ms)","trace[136860231] 'applied index is now lower than readState.Index' (duration: 253.547µs)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:33:54.018199Z","caller":"traceutil/trace.go:171","msg":"trace[346132362] transaction","detail":"{read_only:false; response_revision:1833; number_of_response:1; }","duration":"133.487428ms","start":"2026-08-22T10:33:53.884655Z","end":"2026-08-22T10:33:54.018142Z","steps":["trace[346132362] 'process raft request' (duration: 133.15562ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:33:54.018458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.523159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-08-22T10:33:54.018514Z","caller":"traceutil/trace.go:171","msg":"trace[643746256] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1833; }","duration":"117.667983ms","start":"2026-08-22T10:33:53.90083Z","end":"2026-08-22T10:33:54.018498Z","steps":["trace[643746256] 'agreement among raft nodes before linearized reading' (duration: 117.290503ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:34:06.565456Z","caller":"traceutil/trace.go:171","msg":"trace[418479703] transaction","detail":"{read_only:false; response_revision:1938; number_of_response:1; }","duration":"124.640699ms","start":"2026-08-22T10:34:06.440772Z","end":"2026-08-22T10:34:06.565412Z","steps":["trace[418479703] 'process raft request' (duration: 78.034867ms)","trace[418479703] 'compare' (duration: 46.455718ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:34:49.075668Z","caller":"traceutil/trace.go:171","msg":"trace[1724788715] linearizableReadLoop","detail":"{readStateIndex:2265; appliedIndex:2264; }","duration":"101.021665ms","start":"2026-08-22T10:34:48.974621Z","end":"2026-08-22T10:34:49.075642Z","steps":["trace[1724788715] 'read index received' (duration: 100.84806ms)","trace[1724788715] 'applied index is now lower than readState.Index' (duration: 172.625µs)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:34:49.07581Z","caller":"traceutil/trace.go:171","msg":"trace[1316789144] transaction","detail":"{read_only:false; response_revision:2182; number_of_response:1; }","duration":"140.905786ms","start":"2026-08-22T10:34:48.934862Z","end":"2026-08-22T10:34:49.075768Z","steps":["trace[1316789144] 'process raft request' (duration: 140.604408ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:34:49.075952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.297582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-22T10:34:49.076065Z","caller":"traceutil/trace.go:171","msg":"trace[1657417111] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:2182; }","duration":"101.510738ms","start":"2026-08-22T10:34:48.974531Z","end":"2026-08-22T10:34:49.076042Z","steps":["trace[1657417111] 'agreement among raft nodes before linearized reading' (duration: 101.287492ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:34:49.330524Z","caller":"traceutil/trace.go:171","msg":"trace[747802064] transaction","detail":"{read_only:false; response_revision:2183; number_of_response:1; }","duration":"174.150047ms","start":"2026-08-22T10:34:49.156329Z","end":"2026-08-22T10:34:49.330479Z","steps":["trace[747802064] 'process raft request' (duration: 89.144742ms)","trace[747802064] 'compare' (duration: 84.707387ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:34:49.332876Z","caller":"traceutil/trace.go:171","msg":"trace[1781787849] transaction","detail":"{read_only:false; response_revision:2184; number_of_response:1; }","duration":"120.792081ms","start":"2026-08-22T10:34:49.212043Z","end":"2026-08-22T10:34:49.332835Z","steps":["trace[1781787849] 'process raft request' (duration: 120.573115ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:35:58.001019Z","caller":"traceutil/trace.go:171","msg":"trace[728339397] transaction","detail":"{read_only:false; response_revision:2753; number_of_response:1; }","duration":"141.930564ms","start":"2026-08-22T10:35:57.859046Z","end":"2026-08-22T10:35:58.000976Z","steps":["trace[728339397] 'process raft request' (duration: 141.712849ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:38:33.580533Z","caller":"traceutil/trace.go:171","msg":"trace[438447939] transaction","detail":"{read_only:false; response_revision:3772; number_of_response:1; }","duration":"126.35ms","start":"2026-08-22T10:38:33.454155Z","end":"2026-08-22T10:38:33.580505Z","steps":["trace[438447939] 'process raft request' (duration: 126.192306ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:39:52.875626Z","caller":"traceutil/trace.go:171","msg":"trace[1792533412] transaction","detail":"{read_only:false; response_revision:4772; number_of_response:1; }","duration":"100.338541ms","start":"2026-08-22T10:39:52.775261Z","end":"2026-08-22T10:39:52.8756Z","steps":["trace[1792533412] 'process raft request' (duration: 96.295156ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:39:56.73647Z","caller":"traceutil/trace.go:171","msg":"trace[1691351883] transaction","detail":"{read_only:false; response_revision:4933; number_of_response:1; }","duration":"254.493352ms","start":"2026-08-22T10:39:56.481951Z","end":"2026-08-22T10:39:56.736444Z","steps":["trace[1691351883] 'process raft request' (duration: 254.308767ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:39:56.770168Z","caller":"traceutil/trace.go:171","msg":"trace[605680408] linearizableReadLoop","detail":"{readStateIndex:5120; appliedIndex:5118; }","duration":"284.321748ms","start":"2026-08-22T10:39:56.485819Z","end":"2026-08-22T10:39:56.770141Z","steps":["trace[605680408] 'read index received' (duration: 250.532999ms)","trace[605680408] 'applied index is now lower than readState.Index' (duration: 33.787169ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:39:56.770304Z","caller":"traceutil/trace.go:171","msg":"trace[1683024787] transaction","detail":"{read_only:false; response_revision:4934; number_of_response:1; }","duration":"288.049176ms","start":"2026-08-22T10:39:56.482239Z","end":"2026-08-22T10:39:56.770288Z","steps":["trace[1683024787] 'process raft request' (duration: 287.694447ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:39:56.770465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.618857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T10:39:56.771067Z","caller":"traceutil/trace.go:171","msg":"trace[2011003283] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:4934; }","duration":"285.275904ms","start":"2026-08-22T10:39:56.485768Z","end":"2026-08-22T10:39:56.771044Z","steps":["trace[2011003283] 'agreement among raft nodes before linearized reading' (duration: 284.608036ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:39:56.78581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.164197ms","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-08-22T10:39:56.785894Z","caller":"traceutil/trace.go:171","msg":"trace[2142912067] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4935; }","duration":"223.27094ms","start":"2026-08-22T10:39:56.562605Z","end":"2026-08-22T10:39:56.785876Z","steps":["trace[2142912067] 'agreement among raft nodes before linearized reading' (duration: 222.981872ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:39:56.785941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.869394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/vector\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-22T10:39:56.785978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.608852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f1f7cf56-2a51-4833-b645-1145ecda31bd\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-08-22T10:39:56.786034Z","caller":"traceutil/trace.go:171","msg":"trace[73814148] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f1f7cf56-2a51-4833-b645-1145ecda31bd; range_end:; response_count:1; response_revision:4935; }","duration":"187.699644ms","start":"2026-08-22T10:39:56.59832Z","end":"2026-08-22T10:39:56.78602Z","steps":["trace[73814148] 'agreement among raft nodes before linearized reading' (duration: 187.499729ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:39:56.786025Z","caller":"traceutil/trace.go:171","msg":"trace[1397957104] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/vector; range_end:; response_count:0; response_revision:4935; }","duration":"256.986807ms","start":"2026-08-22T10:39:56.529015Z","end":"2026-08-22T10:39:56.786002Z","steps":["trace[1397957104] 'agreement among raft nodes before linearized reading' (duration: 256.832963ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:39:57.150079Z","caller":"traceutil/trace.go:171","msg":"trace[1225794591] transaction","detail":"{read_only:false; response_revision:4941; number_of_response:1; }","duration":"176.893383ms","start":"2026-08-22T10:39:56.973159Z","end":"2026-08-22T10:39:57.150052Z","steps":["trace[1225794591] 'process raft request' (duration: 121.127232ms)","trace[1225794591] 'compare' (duration: 55.485234ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:40:03.982321Z","caller":"traceutil/trace.go:171","msg":"trace[695751931] transaction","detail":"{read_only:false; response_revision:5080; number_of_response:1; }","duration":"112.686322ms","start":"2026-08-22T10:40:03.869607Z","end":"2026-08-22T10:40:03.982293Z","steps":["trace[695751931] 'process raft request' (duration: 112.482767ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:40:09.859441Z","caller":"traceutil/trace.go:171","msg":"trace[1975156637] transaction","detail":"{read_only:false; response_revision:5197; number_of_response:1; }","duration":"283.852476ms","start":"2026-08-22T10:40:09.575567Z","end":"2026-08-22T10:40:09.85942Z","steps":["trace[1975156637] 'process raft request' (duration: 283.692402ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:40:09.884051Z","caller":"traceutil/trace.go:171","msg":"trace[74994599] linearizableReadLoop","detail":"{readStateIndex:5394; appliedIndex:5392; }","duration":"152.824457ms","start":"2026-08-22T10:40:09.73121Z","end":"2026-08-22T10:40:09.884035Z","steps":["trace[74994599] 'read index received' (duration: 128.107804ms)","trace[74994599] 'applied index is now lower than readState.Index' (duration: 24.715633ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:40:09.884152Z","caller":"traceutil/trace.go:171","msg":"trace[1501269935] transaction","detail":"{read_only:false; response_revision:5198; number_of_response:1; }","duration":"251.229168ms","start":"2026-08-22T10:40:09.632899Z","end":"2026-08-22T10:40:09.884128Z","steps":["trace[1501269935] 'process raft request' (duration: 251.040953ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:40:09.884192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.94745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterrestores/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterrestores0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T10:40:09.884506Z","caller":"traceutil/trace.go:171","msg":"trace[1349153656] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterrestores/; range_end:/registry/pxc.percona.com/perconaxtradbclusterrestores0; response_count:0; response_revision:5198; }","duration":"153.306599ms","start":"2026-08-22T10:40:09.731151Z","end":"2026-08-22T10:40:09.884458Z","steps":["trace[1349153656] 'agreement among raft nodes before linearized reading' (duration: 152.96254ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:40:17.820407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.640788ms","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":"info","ts":"2026-08-22T10:40:17.820533Z","caller":"traceutil/trace.go:171","msg":"trace[1645952225] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:5393; }","duration":"148.789782ms","start":"2026-08-22T10:40:17.671717Z","end":"2026-08-22T10:40:17.820506Z","steps":["trace[1645952225] 'range keys from in-memory index tree' (duration: 148.440563ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:40:18.085391Z","caller":"traceutil/trace.go:171","msg":"trace[420132122] linearizableReadLoop","detail":"{readStateIndex:5594; appliedIndex:5593; }","duration":"126.074741ms","start":"2026-08-22T10:40:17.959287Z","end":"2026-08-22T10:40:18.085361Z","steps":["trace[420132122] 'read index received' (duration: 35.706079ms)","trace[420132122] 'applied index is now lower than readState.Index' (duration: 90.367202ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T10:40:18.085605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.297677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3684"} {"level":"info","ts":"2026-08-22T10:40:18.085685Z","caller":"traceutil/trace.go:171","msg":"trace[1694053455] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:5393; }","duration":"126.407449ms","start":"2026-08-22T10:40:17.959258Z","end":"2026-08-22T10:40:18.085666Z","steps":["trace[1694053455] 'agreement among raft nodes before linearized reading' (duration: 126.206424ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:40:20.416976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.323029ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-22T10:40:20.417149Z","caller":"traceutil/trace.go:171","msg":"trace[992334396] transaction","detail":"{read_only:false; response_revision:5428; number_of_response:1; }","duration":"251.382732ms","start":"2026-08-22T10:40:20.165746Z","end":"2026-08-22T10:40:20.417129Z","steps":["trace[992334396] 'process raft request' (duration: 142.511969ms)","trace[992334396] 'compare' (duration: 107.942409ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:40:20.439102Z","caller":"traceutil/trace.go:171","msg":"trace[1384483966] transaction","detail":"{read_only:false; response_revision:5429; number_of_response:1; }","duration":"272.901992ms","start":"2026-08-22T10:40:20.166164Z","end":"2026-08-22T10:40:20.439066Z","steps":["trace[1384483966] 'process raft request' (duration: 272.626675ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:40:20.439193Z","caller":"traceutil/trace.go:171","msg":"trace[1636761399] transaction","detail":"{read_only:false; response_revision:5430; number_of_response:1; }","duration":"272.06638ms","start":"2026-08-22T10:40:20.167086Z","end":"2026-08-22T10:40:20.439152Z","steps":["trace[1636761399] 'process raft request' (duration: 271.884405ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:40:20.439205Z","caller":"traceutil/trace.go:171","msg":"trace[361690542] linearizableReadLoop","detail":"{readStateIndex:5633; appliedIndex:5628; }","duration":"253.741363ms","start":"2026-08-22T10:40:20.185434Z","end":"2026-08-22T10:40:20.439176Z","steps":["trace[361690542] 'read index received' (duration: 122.782155ms)","trace[361690542] 'applied index is now lower than readState.Index' (duration: 130.958098ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:40:20.439314Z","caller":"traceutil/trace.go:171","msg":"trace[888958401] transaction","detail":"{read_only:false; response_revision:5431; number_of_response:1; }","duration":"272.161823ms","start":"2026-08-22T10:40:20.167127Z","end":"2026-08-22T10:40:20.439289Z","steps":["trace[888958401] 'process raft request' (duration: 271.909196ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:40:20.439299Z","caller":"traceutil/trace.go:171","msg":"trace[2078379940] transaction","detail":"{read_only:false; response_revision:5432; number_of_response:1; }","duration":"268.942598ms","start":"2026-08-22T10:40:20.170318Z","end":"2026-08-22T10:40:20.439261Z","steps":["trace[2078379940] 'process raft request' (duration: 268.769713ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:40:20.439478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.03018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-08-22T10:40:20.439521Z","caller":"traceutil/trace.go:171","msg":"trace[309886704] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5432; }","duration":"254.130072ms","start":"2026-08-22T10:40:20.18538Z","end":"2026-08-22T10:40:20.439511Z","steps":["trace[309886704] 'agreement among raft nodes before linearized reading' (duration: 253.965548ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:40:20.439528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.988374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-08-22T10:40:20.439579Z","caller":"traceutil/trace.go:171","msg":"trace[930738644] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5432; }","duration":"137.103038ms","start":"2026-08-22T10:40:20.302465Z","end":"2026-08-22T10:40:20.439568Z","steps":["trace[930738644] 'agreement among raft nodes before linearized reading' (duration: 136.913653ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:40:20.569337Z","caller":"traceutil/trace.go:171","msg":"trace[1383358957] transaction","detail":"{read_only:false; response_revision:5434; number_of_response:1; }","duration":"124.213832ms","start":"2026-08-22T10:40:20.445086Z","end":"2026-08-22T10:40:20.5693Z","steps":["trace[1383358957] 'process raft request' (duration: 93.870612ms)","trace[1383358957] 'compare' (duration: 29.130918ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:40:20.569565Z","caller":"traceutil/trace.go:171","msg":"trace[252273753] transaction","detail":"{read_only:false; response_revision:5435; number_of_response:1; }","duration":"120.603949ms","start":"2026-08-22T10:40:20.448922Z","end":"2026-08-22T10:40:20.569526Z","steps":["trace[252273753] 'process raft request' (duration: 120.246979ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:40:29.547103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.661968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T10:40:29.547189Z","caller":"traceutil/trace.go:171","msg":"trace[2131620834] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5528; }","duration":"133.811001ms","start":"2026-08-22T10:40:29.413359Z","end":"2026-08-22T10:40:29.54717Z","steps":["trace[2131620834] 'range keys from in-memory index tree' (duration: 133.568755ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:41:39.579259Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2980} {"level":"info","ts":"2026-08-22T10:41:39.660211Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2980,"took":"79.56097ms","hash":3931034550,"current-db-size-bytes":59641856,"current-db-size":"60 MB","current-db-size-in-use-bytes":34455552,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-08-22T10:41:39.660283Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3931034550,"revision":2980,"compact-revision":-1} {"level":"info","ts":"2026-08-22T10:45:38.041277Z","caller":"traceutil/trace.go:171","msg":"trace[1056591496] transaction","detail":"{read_only:false; response_revision:7746; number_of_response:1; }","duration":"113.053368ms","start":"2026-08-22T10:45:37.9282Z","end":"2026-08-22T10:45:38.041254Z","steps":["trace[1056591496] 'process raft request' (duration: 112.494594ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:46:29.223571Z","caller":"traceutil/trace.go:171","msg":"trace[1018310775] transaction","detail":"{read_only:false; response_revision:8219; number_of_response:1; }","duration":"310.570815ms","start":"2026-08-22T10:46:28.912953Z","end":"2026-08-22T10:46:29.223524Z","steps":["trace[1018310775] 'process raft request' (duration: 310.108923ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:46:29.223824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:46:28.912933Z","time spent":"310.765961ms","remote":"127.0.0.1:42738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T10:46:39.584755Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6109} {"level":"info","ts":"2026-08-22T10:46:39.675424Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6109,"took":"88.995997ms","hash":2106021279,"current-db-size-bytes":59641856,"current-db-size":"60 MB","current-db-size-in-use-bytes":23314432,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-08-22T10:46:39.675491Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2106021279,"revision":6109,"compact-revision":2980} {"level":"warn","ts":"2026-08-22T10:46:40.509166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.709544ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-22T10:46:40.50936Z","caller":"traceutil/trace.go:171","msg":"trace[213199995] transaction","detail":"{read_only:false; response_revision:8279; number_of_response:1; }","duration":"135.424216ms","start":"2026-08-22T10:46:40.373912Z","end":"2026-08-22T10:46:40.509336Z","steps":["trace[213199995] 'process raft request' (duration: 17.423284ms)","trace[213199995] 'compare' (duration: 117.596651ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:46:40.867873Z","caller":"traceutil/trace.go:171","msg":"trace[198802147] transaction","detail":"{read_only:false; response_revision:8283; number_of_response:1; }","duration":"133.224288ms","start":"2026-08-22T10:46:40.734594Z","end":"2026-08-22T10:46:40.867818Z","steps":["trace[198802147] 'process raft request' (duration: 132.955021ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:46:41.758815Z","caller":"traceutil/trace.go:171","msg":"trace[1546078549] transaction","detail":"{read_only:false; response_revision:8286; number_of_response:1; }","duration":"104.358216ms","start":"2026-08-22T10:46:41.654429Z","end":"2026-08-22T10:46:41.758787Z","steps":["trace[1546078549] 'process raft request' (duration: 104.186121ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:46:42.433593Z","caller":"traceutil/trace.go:171","msg":"trace[1050067776] transaction","detail":"{read_only:false; response_revision:8289; number_of_response:1; }","duration":"122.873549ms","start":"2026-08-22T10:46:42.310687Z","end":"2026-08-22T10:46:42.433561Z","steps":["trace[1050067776] 'process raft request' (duration: 122.619832ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:46:42.705472Z","caller":"traceutil/trace.go:171","msg":"trace[2086340017] linearizableReadLoop","detail":"{readStateIndex:8584; appliedIndex:8582; }","duration":"127.324494ms","start":"2026-08-22T10:46:42.578114Z","end":"2026-08-22T10:46:42.705438Z","steps":["trace[2086340017] 'read index received' (duration: 23.203934ms)","trace[2086340017] 'applied index is now lower than readState.Index' (duration: 104.11901ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:46:42.705514Z","caller":"traceutil/trace.go:171","msg":"trace[832230193] transaction","detail":"{read_only:false; response_revision:8293; number_of_response:1; }","duration":"142.127589ms","start":"2026-08-22T10:46:42.563358Z","end":"2026-08-22T10:46:42.705486Z","steps":["trace[832230193] 'process raft request' (duration: 115.972659ms)","trace[832230193] 'compare' (duration: 25.858613ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T10:46:42.705759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.626143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.222\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-22T10:46:42.705806Z","caller":"traceutil/trace.go:171","msg":"trace[1149761745] range","detail":"{range_begin:/registry/masterleases/199.204.45.222; range_end:; response_count:1; response_revision:8293; }","duration":"127.722265ms","start":"2026-08-22T10:46:42.578072Z","end":"2026-08-22T10:46:42.705794Z","steps":["trace[1149761745] 'agreement among raft nodes before linearized reading' (duration: 127.490018ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:47:09.871592Z","caller":"traceutil/trace.go:171","msg":"trace[951376164] linearizableReadLoop","detail":"{readStateIndex:8788; appliedIndex:8787; }","duration":"315.816462ms","start":"2026-08-22T10:47:09.555753Z","end":"2026-08-22T10:47:09.87157Z","steps":["trace[951376164] 'read index received' (duration: 304.807995ms)","trace[951376164] 'applied index is now lower than readState.Index' (duration: 11.007557ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T10:47:09.871851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.088209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/barbican-api-7659846558-qcf8p.18ce1acf407cd6ca\" ","response":"range_response_count:1 size:1135"} {"level":"info","ts":"2026-08-22T10:47:09.871825Z","caller":"traceutil/trace.go:171","msg":"trace[944432222] transaction","detail":"{read_only:false; response_revision:8489; number_of_response:1; }","duration":"422.351525ms","start":"2026-08-22T10:47:09.449436Z","end":"2026-08-22T10:47:09.871787Z","steps":["trace[944432222] 'process raft request' (duration: 411.045441ms)","trace[944432222] 'compare' (duration: 10.290438ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:47:09.871905Z","caller":"traceutil/trace.go:171","msg":"trace[1786059199] range","detail":"{range_begin:/registry/events/openstack/barbican-api-7659846558-qcf8p.18ce1acf407cd6ca; range_end:; response_count:1; response_revision:8489; }","duration":"316.181611ms","start":"2026-08-22T10:47:09.555712Z","end":"2026-08-22T10:47:09.871893Z","steps":["trace[1786059199] 'agreement among raft nodes before linearized reading' (duration: 315.997726ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:47:09.871935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:47:09.555693Z","time spent":"316.236023ms","remote":"127.0.0.1:42566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":1158,"request content":"key:\"/registry/events/openstack/barbican-api-7659846558-qcf8p.18ce1acf407cd6ca\" "} {"level":"info","ts":"2026-08-22T10:47:09.871948Z","caller":"traceutil/trace.go:171","msg":"trace[1056787924] transaction","detail":"{read_only:false; response_revision:8490; number_of_response:1; }","duration":"218.266612ms","start":"2026-08-22T10:47:09.653652Z","end":"2026-08-22T10:47:09.871918Z","steps":["trace[1056787924] 'process raft request' (duration: 218.074517ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:47:09.872037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:47:09.449424Z","time spent":"422.496319ms","remote":"127.0.0.1:42738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-22T10:47:09.872041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.09223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-8hklg\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-08-22T10:47:09.872106Z","caller":"traceutil/trace.go:171","msg":"trace[1212774605] range","detail":"{range_begin:/registry/pods/openstack/keepalived-8hklg; range_end:; response_count:1; response_revision:8490; }","duration":"288.230203ms","start":"2026-08-22T10:47:09.583859Z","end":"2026-08-22T10:47:09.872089Z","steps":["trace[1212774605] 'agreement among raft nodes before linearized reading' (duration: 288.011648ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:47:13.542818Z","caller":"traceutil/trace.go:171","msg":"trace[845749658] transaction","detail":"{read_only:false; response_revision:8512; number_of_response:1; }","duration":"109.562562ms","start":"2026-08-22T10:47:13.433224Z","end":"2026-08-22T10:47:13.542786Z","steps":["trace[845749658] 'process raft request' (duration: 109.397808ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:47:47.268016Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002397.wal"} {"level":"info","ts":"2026-08-22T10:48:50.860466Z","caller":"traceutil/trace.go:171","msg":"trace[344868156] transaction","detail":"{read_only:false; response_revision:9407; number_of_response:1; }","duration":"104.1554ms","start":"2026-08-22T10:48:50.75628Z","end":"2026-08-22T10:48:50.860436Z","steps":["trace[344868156] 'process raft request' (duration: 103.929144ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:49:27.794804Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"380f6760faea5f9e","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-08-22T10:49:27.799889Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-08-22T10:49:27.800017Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-08-22T10:51:39.590954Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8274} {"level":"info","ts":"2026-08-22T10:51:39.671613Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8274,"took":"77.739044ms","hash":3747719401,"current-db-size-bytes":59641856,"current-db-size":"60 MB","current-db-size-in-use-bytes":24158208,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-08-22T10:51:39.671688Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3747719401,"revision":8274,"compact-revision":6109} {"level":"info","ts":"2026-08-22T10:54:10.527385Z","caller":"traceutil/trace.go:171","msg":"trace[238928715] transaction","detail":"{read_only:false; response_revision:11734; number_of_response:1; }","duration":"112.177192ms","start":"2026-08-22T10:54:10.415183Z","end":"2026-08-22T10:54:10.52736Z","steps":["trace[238928715] 'process raft request' (duration: 111.970066ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:54:28.339834Z","caller":"traceutil/trace.go:171","msg":"trace[947006117] transaction","detail":"{read_only:false; response_revision:11831; number_of_response:1; }","duration":"164.491543ms","start":"2026-08-22T10:54:28.175315Z","end":"2026-08-22T10:54:28.339806Z","steps":["trace[947006117] 'process raft request' (duration: 164.293428ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:54:28.344897Z","caller":"traceutil/trace.go:171","msg":"trace[774290351] transaction","detail":"{read_only:false; response_revision:11832; number_of_response:1; }","duration":"122.219007ms","start":"2026-08-22T10:54:28.222654Z","end":"2026-08-22T10:54:28.344873Z","steps":["trace[774290351] 'process raft request' (duration: 121.9539ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:54:28.344958Z","caller":"traceutil/trace.go:171","msg":"trace[2028867425] transaction","detail":"{read_only:false; response_revision:11833; number_of_response:1; }","duration":"114.694358ms","start":"2026-08-22T10:54:28.230233Z","end":"2026-08-22T10:54:28.344927Z","steps":["trace[2028867425] 'process raft request' (duration: 114.560444ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:54:29.449579Z","caller":"traceutil/trace.go:171","msg":"trace[1555958640] linearizableReadLoop","detail":"{readStateIndex:12250; appliedIndex:12249; }","duration":"104.715471ms","start":"2026-08-22T10:54:29.344841Z","end":"2026-08-22T10:54:29.449556Z","steps":["trace[1555958640] 'read index received' (duration: 104.525505ms)","trace[1555958640] 'applied index is now lower than readState.Index' (duration: 188.565µs)"],"step_count":2} {"level":"warn","ts":"2026-08-22T10:54:29.449819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.970798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-8hklg\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-08-22T10:54:29.449868Z","caller":"traceutil/trace.go:171","msg":"trace[6336869] range","detail":"{range_begin:/registry/pods/openstack/keepalived-8hklg; range_end:; response_count:1; response_revision:11842; }","duration":"105.067911ms","start":"2026-08-22T10:54:29.344789Z","end":"2026-08-22T10:54:29.449857Z","steps":["trace[6336869] 'agreement among raft nodes before linearized reading' (duration: 104.918687ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:54:29.449672Z","caller":"traceutil/trace.go:171","msg":"trace[1660938915] transaction","detail":"{read_only:false; response_revision:11842; number_of_response:1; }","duration":"183.093634ms","start":"2026-08-22T10:54:29.266526Z","end":"2026-08-22T10:54:29.44962Z","steps":["trace[1660938915] 'process raft request' (duration: 182.787276ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:56:39.598457Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10495} {"level":"info","ts":"2026-08-22T10:56:39.679312Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10495,"took":"77.530614ms","hash":2601234765,"current-db-size-bytes":59641856,"current-db-size":"60 MB","current-db-size-in-use-bytes":26271744,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-08-22T10:56:39.679448Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2601234765,"revision":10495,"compact-revision":8274} {"level":"info","ts":"2026-08-22T11:01:39.605547Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12706} {"level":"info","ts":"2026-08-22T11:01:39.685471Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12706,"took":"76.702705ms","hash":325882179,"current-db-size-bytes":59641856,"current-db-size":"60 MB","current-db-size-in-use-bytes":27095040,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-08-22T11:01:39.685553Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":325882179,"revision":12706,"compact-revision":10495} {"level":"info","ts":"2026-08-22T11:02:41.410727Z","caller":"traceutil/trace.go:171","msg":"trace[1741999928] transaction","detail":"{read_only:false; response_revision:14958; number_of_response:1; }","duration":"102.754717ms","start":"2026-08-22T11:02:41.307936Z","end":"2026-08-22T11:02:41.410691Z","steps":["trace[1741999928] 'process raft request' (duration: 102.560732ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T11:02:49.139904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.468161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-08-22T11:02:49.139989Z","caller":"traceutil/trace.go:171","msg":"trace[1906368056] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:15014; }","duration":"125.845521ms","start":"2026-08-22T11:02:49.014121Z","end":"2026-08-22T11:02:49.139967Z","steps":["trace[1906368056] 'range keys from in-memory index tree' (duration: 125.229225ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T11:02:50.125231Z","caller":"traceutil/trace.go:171","msg":"trace[1076589208] transaction","detail":"{read_only:false; response_revision:15019; number_of_response:1; }","duration":"144.861388ms","start":"2026-08-22T11:02:49.980336Z","end":"2026-08-22T11:02:50.125197Z","steps":["trace[1076589208] 'process raft request' (duration: 144.618161ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T11:02:50.264978Z","caller":"traceutil/trace.go:171","msg":"trace[471161161] transaction","detail":"{read_only:false; response_revision:15020; number_of_response:1; }","duration":"281.278325ms","start":"2026-08-22T11:02:49.983661Z","end":"2026-08-22T11:02:50.264939Z","steps":["trace[471161161] 'process raft request' (duration: 272.710111ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T11:02:50.265142Z","caller":"traceutil/trace.go:171","msg":"trace[854767923] linearizableReadLoop","detail":"{readStateIndex:15546; appliedIndex:15543; }","duration":"272.941188ms","start":"2026-08-22T11:02:49.992176Z","end":"2026-08-22T11:02:50.265117Z","steps":["trace[854767923] 'read index received' (duration: 132.865045ms)","trace[854767923] 'applied index is now lower than readState.Index' (duration: 140.074893ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T11:02:50.2652Z","caller":"traceutil/trace.go:171","msg":"trace[2002452383] transaction","detail":"{read_only:false; response_revision:15021; number_of_response:1; }","duration":"281.482651ms","start":"2026-08-22T11:02:49.983693Z","end":"2026-08-22T11:02:50.265175Z","steps":["trace[2002452383] 'process raft request' (duration: 281.137472ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T11:02:50.265287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.087021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-22T11:02:50.265329Z","caller":"traceutil/trace.go:171","msg":"trace[377309398] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:15021; }","duration":"273.201424ms","start":"2026-08-22T11:02:49.992114Z","end":"2026-08-22T11:02:50.265315Z","steps":["trace[377309398] 'agreement among raft nodes before linearized reading' (duration: 273.088161ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T11:03:12.569175Z","caller":"traceutil/trace.go:171","msg":"trace[985473010] transaction","detail":"{read_only:false; response_revision:15327; number_of_response:1; }","duration":"187.579056ms","start":"2026-08-22T11:03:12.381566Z","end":"2026-08-22T11:03:12.569145Z","steps":["trace[985473010] 'process raft request' (duration: 156.40664ms)","trace[985473010] 'compare' (duration: 30.915989ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T11:03:12.573639Z","caller":"traceutil/trace.go:171","msg":"trace[1528604164] transaction","detail":"{read_only:false; response_revision:15328; number_of_response:1; }","duration":"189.316451ms","start":"2026-08-22T11:03:12.384278Z","end":"2026-08-22T11:03:12.573594Z","steps":["trace[1528604164] 'process raft request' (duration: 189.150376ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T11:03:12.573638Z","caller":"traceutil/trace.go:171","msg":"trace[377533872] transaction","detail":"{read_only:false; response_revision:15329; number_of_response:1; }","duration":"166.804462ms","start":"2026-08-22T11:03:12.406804Z","end":"2026-08-22T11:03:12.573608Z","steps":["trace[377533872] 'process raft request' (duration: 166.72419ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T11:03:12.574001Z","caller":"traceutil/trace.go:171","msg":"trace[1267536251] transaction","detail":"{read_only:false; response_revision:15330; number_of_response:1; }","duration":"150.771143ms","start":"2026-08-22T11:03:12.423208Z","end":"2026-08-22T11:03:12.573979Z","steps":["trace[1267536251] 'process raft request' (duration: 150.362962ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T11:03:12.574038Z","caller":"traceutil/trace.go:171","msg":"trace[1175528152] linearizableReadLoop","detail":"{readStateIndex:15867; appliedIndex:15864; }","duration":"162.079468ms","start":"2026-08-22T11:03:12.411926Z","end":"2026-08-22T11:03:12.574006Z","steps":["trace[1175528152] 'read index received' (duration: 126.109578ms)","trace[1175528152] 'applied index is now lower than readState.Index' (duration: 35.96876ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T11:03:12.574242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.289834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T11:03:12.574265Z","caller":"traceutil/trace.go:171","msg":"trace[88237750] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:15331; }","duration":"162.405457ms","start":"2026-08-22T11:03:12.411853Z","end":"2026-08-22T11:03:12.574258Z","steps":["trace[88237750] 'agreement among raft nodes before linearized reading' (duration: 162.248923ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T11:04:27.722863Z","caller":"traceutil/trace.go:171","msg":"trace[1582108421] transaction","detail":"{read_only:false; response_revision:16085; number_of_response:1; }","duration":"107.154732ms","start":"2026-08-22T11:04:27.615676Z","end":"2026-08-22T11:04:27.72283Z","steps":["trace[1582108421] 'process raft request' (duration: 106.70437ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T11:04:27.861649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.409856ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-08-22T11:04:27.861932Z","caller":"traceutil/trace.go:171","msg":"trace[1075230517] linearizableReadLoop","detail":"{readStateIndex:16645; appliedIndex:16644; }","duration":"139.311813ms","start":"2026-08-22T11:04:27.722562Z","end":"2026-08-22T11:04:27.861874Z","steps":["trace[1075230517] 'read index received' (duration: 12.792785ms)","trace[1075230517] 'applied index is now lower than readState.Index' (duration: 126.514218ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T11:04:27.862012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.604307ms","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-08-22T11:04:27.862076Z","caller":"traceutil/trace.go:171","msg":"trace[986165268] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:16085; }","duration":"140.750901ms","start":"2026-08-22T11:04:27.721307Z","end":"2026-08-22T11:04:27.862058Z","steps":["trace[986165268] 'agreement among raft nodes before linearized reading' (duration: 140.600267ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T11:04:27.86217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.111861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"} {"level":"info","ts":"2026-08-22T11:04:27.862235Z","caller":"traceutil/trace.go:171","msg":"trace[1218382748] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:16085; }","duration":"141.223573ms","start":"2026-08-22T11:04:27.720994Z","end":"2026-08-22T11:04:27.862218Z","steps":["trace[1218382748] 'agreement among raft nodes before linearized reading' (duration: 141.010438ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T11:04:27.862332Z","caller":"traceutil/trace.go:171","msg":"trace[1120659687] transaction","detail":"{read_only:false; response_revision:16086; number_of_response:1; }","duration":"135.707818ms","start":"2026-08-22T11:04:27.726594Z","end":"2026-08-22T11:04:27.862302Z","steps":["trace[1120659687] 'process raft request' (duration: 135.237846ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T11:04:28.119237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.989238ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-22T11:04:28.119377Z","caller":"traceutil/trace.go:171","msg":"trace[61142166] linearizableReadLoop","detail":"{readStateIndex:16647; appliedIndex:16646; }","duration":"257.319549ms","start":"2026-08-22T11:04:27.862038Z","end":"2026-08-22T11:04:28.119358Z","steps":["trace[61142166] 'read index received' (duration: 150.095905ms)","trace[61142166] 'applied index is now lower than readState.Index' (duration: 107.222164ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T11:04:28.119592Z","caller":"traceutil/trace.go:171","msg":"trace[122122822] transaction","detail":"{read_only:false; response_revision:16087; number_of_response:1; }","duration":"287.735964ms","start":"2026-08-22T11:04:27.831638Z","end":"2026-08-22T11:04:28.119374Z","steps":["trace[122122822] 'process raft request' (duration: 180.50225ms)","trace[122122822] 'compare' (duration: 106.770262ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T11:04:28.119802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.554854ms","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-08-22T11:04:28.119841Z","caller":"traceutil/trace.go:171","msg":"trace[1029409769] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16087; }","duration":"395.612275ms","start":"2026-08-22T11:04:27.724218Z","end":"2026-08-22T11:04:28.119831Z","steps":["trace[1029409769] 'agreement among raft nodes before linearized reading' (duration: 395.42816ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T11:04:28.119879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T11:04:27.724206Z","time spent":"395.665247ms","remote":"127.0.0.1:42722","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":5544,"request content":"key:\"/registry/jobs/openstack/nova-db-sync\" "} {"level":"warn","ts":"2026-08-22T11:04:28.119917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.517396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"} {"level":"warn","ts":"2026-08-22T11:04:28.119982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.948179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"} {"level":"info","ts":"2026-08-22T11:04:28.120029Z","caller":"traceutil/trace.go:171","msg":"trace[2094586562] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16087; }","duration":"189.65305ms","start":"2026-08-22T11:04:27.930351Z","end":"2026-08-22T11:04:28.120004Z","steps":["trace[2094586562] 'agreement among raft nodes before linearized reading' (duration: 189.421094ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T11:04:28.120081Z","caller":"traceutil/trace.go:171","msg":"trace[563256982] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:16087; }","duration":"192.076143ms","start":"2026-08-22T11:04:27.927981Z","end":"2026-08-22T11:04:28.120057Z","steps":["trace[563256982] 'agreement among raft nodes before linearized reading' (duration: 191.803716ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T11:04:28.119982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.751859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-7wbm9\" ","response":"range_response_count:1 size:20642"} {"level":"info","ts":"2026-08-22T11:04:28.120165Z","caller":"traceutil/trace.go:171","msg":"trace[2002944014] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-7wbm9; range_end:; response_count:1; response_revision:16087; }","duration":"112.976415ms","start":"2026-08-22T11:04:28.007179Z","end":"2026-08-22T11:04:28.120155Z","steps":["trace[2002944014] 'agreement among raft nodes before linearized reading' (duration: 112.650876ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T11:04:28.121066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.385447ms","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-08-22T11:04:28.121146Z","caller":"traceutil/trace.go:171","msg":"trace[356507994] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:16087; }","duration":"193.51647ms","start":"2026-08-22T11:04:27.927615Z","end":"2026-08-22T11:04:28.121131Z","steps":["trace[356507994] 'agreement among raft nodes before linearized reading' (duration: 192.144604ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T11:04:29.117547Z","caller":"traceutil/trace.go:171","msg":"trace[1613676632] transaction","detail":"{read_only:false; response_revision:16091; number_of_response:1; }","duration":"261.457187ms","start":"2026-08-22T11:04:28.85605Z","end":"2026-08-22T11:04:29.117507Z","steps":["trace[1613676632] 'process raft request' (duration: 168.480016ms)","trace[1613676632] 'compare' (duration: 92.752615ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T11:04:29.23493Z","caller":"traceutil/trace.go:171","msg":"trace[509002982] transaction","detail":"{read_only:false; response_revision:16092; number_of_response:1; }","duration":"378.778505ms","start":"2026-08-22T11:04:28.856121Z","end":"2026-08-22T11:04:29.234899Z","steps":["trace[509002982] 'process raft request' (duration: 378.544409ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T11:04:29.235056Z","caller":"traceutil/trace.go:171","msg":"trace[434725908] transaction","detail":"{read_only:false; response_revision:16093; number_of_response:1; }","duration":"281.300187ms","start":"2026-08-22T11:04:28.953733Z","end":"2026-08-22T11:04:29.235034Z","steps":["trace[434725908] 'process raft request' (duration: 281.117352ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T11:04:29.235074Z","caller":"traceutil/trace.go:171","msg":"trace[947808886] linearizableReadLoop","detail":"{readStateIndex:16652; appliedIndex:16650; }","duration":"311.894586ms","start":"2026-08-22T11:04:28.923127Z","end":"2026-08-22T11:04:29.235021Z","steps":["trace[947808886] 'read index received' (duration: 101.447853ms)","trace[947808886] 'applied index is now lower than readState.Index' (duration: 210.443043ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T11:04:29.235139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T11:04:28.856096Z","time spent":"378.928959ms","remote":"127.0.0.1:42738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-22T11:04:29.235259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.092721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-22T11:04:29.235374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.50791ms","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-08-22T11:04:29.23539Z","caller":"traceutil/trace.go:171","msg":"trace[1857426174] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:16093; }","duration":"312.293967ms","start":"2026-08-22T11:04:28.923071Z","end":"2026-08-22T11:04:29.235365Z","steps":["trace[1857426174] 'agreement among raft nodes before linearized reading' (duration: 312.068931ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T11:04:29.235416Z","caller":"traceutil/trace.go:171","msg":"trace[1501361480] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:16093; }","duration":"310.581962ms","start":"2026-08-22T11:04:28.92482Z","end":"2026-08-22T11:04:29.235402Z","steps":["trace[1501361480] 'agreement among raft nodes before linearized reading' (duration: 310.532331ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T11:04:29.235432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.148656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-08-22T11:04:29.235449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T11:04:28.923031Z","time spent":"312.40797ms","remote":"127.0.0.1:42722","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/openstack/nova-rabbit-init\" "} {"level":"warn","ts":"2026-08-22T11:04:29.235457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T11:04:28.924793Z","time spent":"310.656374ms","remote":"127.0.0.1:42722","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" "} {"level":"info","ts":"2026-08-22T11:04:29.235473Z","caller":"traceutil/trace.go:171","msg":"trace[47075845] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:16093; }","duration":"293.261019ms","start":"2026-08-22T11:04:28.9422Z","end":"2026-08-22T11:04:29.235461Z","steps":["trace[47075845] 'agreement among raft nodes before linearized reading' (duration: 293.104655ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T11:04:29.235322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.768873ms","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-08-22T11:04:29.235562Z","caller":"traceutil/trace.go:171","msg":"trace[1794787396] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:16093; }","duration":"312.067101ms","start":"2026-08-22T11:04:28.923482Z","end":"2026-08-22T11:04:29.235549Z","steps":["trace[1794787396] 'agreement among raft nodes before linearized reading' (duration: 311.764793ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T11:04:29.235576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.764071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"} {"level":"info","ts":"2026-08-22T11:04:29.235627Z","caller":"traceutil/trace.go:171","msg":"trace[1297624414] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:16093; }","duration":"179.862084ms","start":"2026-08-22T11:04:29.055754Z","end":"2026-08-22T11:04:29.235616Z","steps":["trace[1297624414] 'agreement among raft nodes before linearized reading' (duration: 179.69773ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T11:04:29.235593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.511978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"} {"level":"warn","ts":"2026-08-22T11:04:29.235754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.944212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-08-22T11:04:29.235583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T11:04:28.923465Z","time spent":"312.110462ms","remote":"127.0.0.1:42722","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/openstack/nova-ks-user\" "} {"level":"info","ts":"2026-08-22T11:04:29.235764Z","caller":"traceutil/trace.go:171","msg":"trace[191243882] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16093; }","duration":"308.694662ms","start":"2026-08-22T11:04:28.927049Z","end":"2026-08-22T11:04:29.235744Z","steps":["trace[191243882] 'agreement among raft nodes before linearized reading' (duration: 308.287582ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T11:04:29.23596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T11:04:28.927041Z","time spent":"308.904418ms","remote":"127.0.0.1:42722","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":5544,"request content":"key:\"/registry/jobs/openstack/nova-db-sync\" "} {"level":"info","ts":"2026-08-22T11:04:29.236011Z","caller":"traceutil/trace.go:171","msg":"trace[671241712] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:16093; }","duration":"303.045675ms","start":"2026-08-22T11:04:28.932764Z","end":"2026-08-22T11:04:29.23581Z","steps":["trace[671241712] 'agreement among raft nodes before linearized reading' (duration: 302.629864ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T11:04:29.236103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T11:04:28.932753Z","time spent":"303.314442ms","remote":"127.0.0.1:42738","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-08-22T11:06:39.612635Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14646} {"level":"info","ts":"2026-08-22T11:06:39.688575Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14646,"took":"72.561024ms","hash":1783666771,"current-db-size-bytes":59641856,"current-db-size":"60 MB","current-db-size-in-use-bytes":29855744,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-08-22T11:06:39.688654Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1783666771,"revision":14646,"compact-revision":12706} {"level":"info","ts":"2026-08-22T11:10:52.184739Z","caller":"traceutil/trace.go:171","msg":"trace[2079719290] transaction","detail":"{read_only:false; response_revision:18884; number_of_response:1; }","duration":"138.697699ms","start":"2026-08-22T11:10:52.046008Z","end":"2026-08-22T11:10:52.184706Z","steps":["trace[2079719290] 'process raft request' (duration: 138.498204ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T11:11:30.689423Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"380f6760faea5f9e","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-08-22T11:11:30.698514Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-08-22T11:11:30.698663Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-08-22T11:11:39.619654Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":16998} {"level":"info","ts":"2026-08-22T11:11:39.714482Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":16998,"took":"90.817147ms","hash":1224369224,"current-db-size-bytes":59641856,"current-db-size":"60 MB","current-db-size-in-use-bytes":33247232,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-08-22T11:11:39.71457Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1224369224,"revision":16998,"compact-revision":14646} {"level":"info","ts":"2026-08-22T11:16:39.62633Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19466} {"level":"info","ts":"2026-08-22T11:16:39.738217Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19466,"took":"107.701621ms","hash":3331367724,"current-db-size-bytes":59641856,"current-db-size":"60 MB","current-db-size-in-use-bytes":29929472,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-08-22T11:16:39.738303Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3331367724,"revision":19466,"compact-revision":16998} {"level":"info","ts":"2026-08-22T11:17:03.063376Z","caller":"traceutil/trace.go:171","msg":"trace[1444819665] transaction","detail":"{read_only:false; response_revision:21699; number_of_response:1; }","duration":"412.500834ms","start":"2026-08-22T11:17:02.650858Z","end":"2026-08-22T11:17:03.063359Z","steps":["trace[1444819665] 'process raft request' (duration: 412.383631ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T11:17:03.063484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T11:17:02.650833Z","time spent":"412.594626ms","remote":"127.0.0.1:42738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T11:17:03.063815Z","caller":"traceutil/trace.go:171","msg":"trace[2115484476] linearizableReadLoop","detail":"{readStateIndex:22449; appliedIndex:22449; }","duration":"380.53417ms","start":"2026-08-22T11:17:02.683274Z","end":"2026-08-22T11:17:03.063808Z","steps":["trace[2115484476] 'read index received' (duration: 380.530919ms)","trace[2115484476] 'applied index is now lower than readState.Index' (duration: 2.67µs)"],"step_count":2} {"level":"warn","ts":"2026-08-22T11:17:03.063947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.664713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.222\" ","response":"range_response_count:1 size:140"} {"level":"info","ts":"2026-08-22T11:17:03.064002Z","caller":"traceutil/trace.go:171","msg":"trace[900925461] range","detail":"{range_begin:/registry/masterleases/199.204.45.222; range_end:; response_count:1; response_revision:21699; }","duration":"380.750875ms","start":"2026-08-22T11:17:02.683237Z","end":"2026-08-22T11:17:03.063988Z","steps":["trace[900925461] 'agreement among raft nodes before linearized reading' (duration: 380.603731ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T11:17:03.064027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T11:17:02.683225Z","time spent":"380.798656ms","remote":"127.0.0.1:42518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":163,"request content":"key:\"/registry/masterleases/199.204.45.222\" "} {"level":"warn","ts":"2026-08-22T11:17:03.34899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.722778ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-22T11:17:03.349207Z","caller":"traceutil/trace.go:171","msg":"trace[782091125] transaction","detail":"{read_only:false; response_revision:21700; number_of_response:1; }","duration":"293.060477ms","start":"2026-08-22T11:17:03.05612Z","end":"2026-08-22T11:17:03.34918Z","steps":["trace[782091125] 'process raft request' (duration: 151.041731ms)","trace[782091125] 'compare' (duration: 141.612095ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T11:17:03.349285Z","caller":"traceutil/trace.go:171","msg":"trace[544906315] linearizableReadLoop","detail":"{readStateIndex:22450; appliedIndex:22449; }","duration":"285.417528ms","start":"2026-08-22T11:17:03.063839Z","end":"2026-08-22T11:17:03.349257Z","steps":["trace[544906315] 'read index received' (duration: 143.31501ms)","trace[544906315] 'applied index is now lower than readState.Index' (duration: 142.100598ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T11:17:03.349471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.308557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-08-22T11:17:03.349671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.817905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-08-22T11:17:03.349695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"651.037208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-22T11:17:03.349769Z","caller":"traceutil/trace.go:171","msg":"trace[1684226253] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:21700; }","duration":"651.145391ms","start":"2026-08-22T11:17:02.698606Z","end":"2026-08-22T11:17:03.349751Z","steps":["trace[1684226253] 'agreement among raft nodes before linearized reading' (duration: 651.035328ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T11:17:03.349772Z","caller":"traceutil/trace.go:171","msg":"trace[1168317221] range","detail":"{range_begin:/registry/rabbitmq.com/federations/; range_end:/registry/rabbitmq.com/federations0; response_count:0; response_revision:21700; }","duration":"250.938277ms","start":"2026-08-22T11:17:03.098808Z","end":"2026-08-22T11:17:03.349746Z","steps":["trace[1168317221] 'agreement among raft nodes before linearized reading' (duration: 250.810424ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T11:17:03.349805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T11:17:02.698588Z","time spent":"651.207432ms","remote":"127.0.0.1:42716","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":29,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"info","ts":"2026-08-22T11:17:03.350188Z","caller":"traceutil/trace.go:171","msg":"trace[515708954] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:21700; }","duration":"287.400679ms","start":"2026-08-22T11:17:03.062097Z","end":"2026-08-22T11:17:03.349498Z","steps":["trace[515708954] 'agreement among raft nodes before linearized reading' (duration: 287.305057ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T11:17:04.149803Z","caller":"traceutil/trace.go:171","msg":"trace[1624868738] transaction","detail":"{read_only:false; response_revision:21705; number_of_response:1; }","duration":"110.615766ms","start":"2026-08-22T11:17:04.039156Z","end":"2026-08-22T11:17:04.149772Z","steps":["trace[1624868738] 'process raft request' (duration: 110.354609ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T11:21:27.026316Z","caller":"traceutil/trace.go:171","msg":"trace[2025889114] transaction","detail":"{read_only:false; response_revision:24337; number_of_response:1; }","duration":"156.574958ms","start":"2026-08-22T11:21:26.869712Z","end":"2026-08-22T11:21:27.026287Z","steps":["trace[2025889114] 'process raft request' (duration: 156.328502ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T11:21:27.026998Z","caller":"traceutil/trace.go:171","msg":"trace[2087712745] transaction","detail":"{read_only:false; response_revision:24338; number_of_response:1; }","duration":"156.24206ms","start":"2026-08-22T11:21:26.87073Z","end":"2026-08-22T11:21:27.026972Z","steps":["trace[2087712745] 'process raft request' (duration: 155.967333ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T11:21:39.63196Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21575} {"level":"info","ts":"2026-08-22T11:21:39.740075Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21575,"took":"104.530239ms","hash":1187607778,"current-db-size-bytes":59641856,"current-db-size":"60 MB","current-db-size-in-use-bytes":42033152,"current-db-size-in-use":"42 MB"} {"level":"info","ts":"2026-08-22T11:21:39.740147Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1187607778,"revision":21575,"compact-revision":19466} {"level":"info","ts":"2026-08-22T11:22:48.118749Z","caller":"traceutil/trace.go:171","msg":"trace[241561305] transaction","detail":"{read_only:false; response_revision:25218; number_of_response:1; }","duration":"130.611714ms","start":"2026-08-22T11:22:47.988097Z","end":"2026-08-22T11:22:48.118709Z","steps":["trace[241561305] 'process raft request' (duration: 70.930638ms)","trace[241561305] 'compare' (duration: 59.302316ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T11:26:39.638028Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":24451} {"level":"info","ts":"2026-08-22T11:26:39.782769Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":24451,"took":"141.025036ms","hash":664411221,"current-db-size-bytes":59641856,"current-db-size":"60 MB","current-db-size-in-use-bytes":32956416,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-08-22T11:26:39.782821Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":664411221,"revision":24451,"compact-revision":21575} {"level":"info","ts":"2026-08-22T11:27:57.0526Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006f31.wal"} {"level":"info","ts":"2026-08-22T11:31:17.313471Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"380f6760faea5f9e","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-08-22T11:31:17.318636Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-08-22T11:31:17.318738Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}