{"level":"warn","ts":"2026-08-27T20:11:11.404406Z","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-27T20:11:11.404546Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.108:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.108:2380","--initial-cluster=instance=https://162.253.55.108:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.108:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.108: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-27T20:11:11.404636Z","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-27T20:11:11.404654Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.108:2380"]} {"level":"info","ts":"2026-08-27T20:11:11.404683Z","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-27T20:11:11.40572Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.108:2379"]} {"level":"info","ts":"2026-08-27T20:11:11.405827Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.108:2380"],"listen-peer-urls":["https://162.253.55.108:2380"],"advertise-client-urls":["https://162.253.55.108:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.108:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.108: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-27T20:11:11.409327Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.162704ms"} {"level":"info","ts":"2026-08-27T20:11:11.415283Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"806c7300a47a7256","cluster-id":"5fa6fbb9053710a8"} {"level":"info","ts":"2026-08-27T20:11:11.41538Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"806c7300a47a7256 switched to configuration voters=()"} {"level":"info","ts":"2026-08-27T20:11:11.415402Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"806c7300a47a7256 became follower at term 0"} {"level":"info","ts":"2026-08-27T20:11:11.415441Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 806c7300a47a7256 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-27T20:11:11.41546Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"806c7300a47a7256 became follower at term 1"} {"level":"info","ts":"2026-08-27T20:11:11.415506Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"806c7300a47a7256 switched to configuration voters=(9253897780936208982)"} {"level":"warn","ts":"2026-08-27T20:11:11.422673Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-27T20:11:11.424398Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-27T20:11:11.426413Z","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-27T20:11:11.429064Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"806c7300a47a7256","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-27T20:11:11.429319Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"806c7300a47a7256","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-27T20:11:11.429542Z","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-27T20:11:11.42974Z","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-27T20:11:11.429859Z","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-27T20:11:11.431125Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"806c7300a47a7256 switched to configuration voters=(9253897780936208982)"} {"level":"info","ts":"2026-08-27T20:11:11.4325Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"5fa6fbb9053710a8","local-member-id":"806c7300a47a7256","added-peer-id":"806c7300a47a7256","added-peer-peer-urls":["https://162.253.55.108:2380"]} {"level":"info","ts":"2026-08-27T20:11:11.434375Z","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-27T20:11:11.434514Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.108:2380"} {"level":"info","ts":"2026-08-27T20:11:11.434568Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.108:2380"} {"level":"info","ts":"2026-08-27T20:11:11.434965Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"806c7300a47a7256","initial-advertise-peer-urls":["https://162.253.55.108:2380"],"listen-peer-urls":["https://162.253.55.108:2380"],"advertise-client-urls":["https://162.253.55.108:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.108:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-27T20:11:11.435025Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-27T20:11:12.016231Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"806c7300a47a7256 is starting a new election at term 1"} {"level":"info","ts":"2026-08-27T20:11:12.016286Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"806c7300a47a7256 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-27T20:11:12.016321Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"806c7300a47a7256 received MsgPreVoteResp from 806c7300a47a7256 at term 1"} {"level":"info","ts":"2026-08-27T20:11:12.016336Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"806c7300a47a7256 became candidate at term 2"} {"level":"info","ts":"2026-08-27T20:11:12.016343Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"806c7300a47a7256 received MsgVoteResp from 806c7300a47a7256 at term 2"} {"level":"info","ts":"2026-08-27T20:11:12.016354Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"806c7300a47a7256 became leader at term 2"} {"level":"info","ts":"2026-08-27T20:11:12.016381Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 806c7300a47a7256 elected leader 806c7300a47a7256 at term 2"} {"level":"info","ts":"2026-08-27T20:11:12.017903Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-27T20:11:12.019153Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-27T20:11:12.019155Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"806c7300a47a7256","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.108:2379]}","request-path":"/0/members/806c7300a47a7256/attributes","cluster-id":"5fa6fbb9053710a8","publish-timeout":"7s"} {"level":"info","ts":"2026-08-27T20:11:12.019217Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-27T20:11:12.019796Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"5fa6fbb9053710a8","local-member-id":"806c7300a47a7256","cluster-version":"3.5"} {"level":"info","ts":"2026-08-27T20:11:12.019935Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-27T20:11:12.019998Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-27T20:11:12.020863Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-27T20:11:12.020949Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-27T20:11:12.022803Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-27T20:11:12.022875Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.108:2379"} {"level":"info","ts":"2026-08-27T20:11:20.331234Z","caller":"traceutil/trace.go:171","msg":"trace[1155204436] transaction","detail":"{read_only:false; response_revision:288; number_of_response:1; }","duration":"159.581379ms","start":"2026-08-27T20:11:20.171631Z","end":"2026-08-27T20:11:20.331212Z","steps":["trace[1155204436] 'process raft request' (duration: 159.479686ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:11:25.927108Z","caller":"traceutil/trace.go:171","msg":"trace[1106025329] transaction","detail":"{read_only:false; response_revision:363; number_of_response:1; }","duration":"120.721092ms","start":"2026-08-27T20:11:25.806314Z","end":"2026-08-27T20:11:25.927035Z","steps":["trace[1106025329] 'process raft request' (duration: 120.445654ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:11:36.20245Z","caller":"traceutil/trace.go:171","msg":"trace[1341788203] transaction","detail":"{read_only:false; response_revision:392; number_of_response:1; }","duration":"113.359507ms","start":"2026-08-27T20:11:36.089037Z","end":"2026-08-27T20:11:36.202396Z","steps":["trace[1341788203] 'process raft request' (duration: 113.106769ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:11:36.329674Z","caller":"traceutil/trace.go:171","msg":"trace[1625764635] transaction","detail":"{read_only:false; response_revision:393; number_of_response:1; }","duration":"122.460495ms","start":"2026-08-27T20:11:36.207183Z","end":"2026-08-27T20:11:36.329644Z","steps":["trace[1625764635] 'process raft request' (duration: 98.577557ms)","trace[1625764635] 'compare' (duration: 23.760954ms)"],"step_count":2} {"level":"info","ts":"2026-08-27T20:12:00.626053Z","caller":"traceutil/trace.go:171","msg":"trace[1824396148] linearizableReadLoop","detail":"{readStateIndex:680; appliedIndex:679; }","duration":"160.798023ms","start":"2026-08-27T20:12:00.465224Z","end":"2026-08-27T20:12:00.626022Z","steps":["trace[1824396148] 'read index received' (duration: 160.589927ms)","trace[1824396148] 'applied index is now lower than readState.Index' (duration: 207.106µs)"],"step_count":2} {"level":"info","ts":"2026-08-27T20:12:00.626117Z","caller":"traceutil/trace.go:171","msg":"trace[702230524] transaction","detail":"{read_only:false; response_revision:660; number_of_response:1; }","duration":"237.86534ms","start":"2026-08-27T20:12:00.388219Z","end":"2026-08-27T20:12:00.626084Z","steps":["trace[702230524] 'process raft request' (duration: 237.659264ms)"],"step_count":1} {"level":"warn","ts":"2026-08-27T20:12:00.626337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.090651ms","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-27T20:12:00.626412Z","caller":"traceutil/trace.go:171","msg":"trace[1798065365] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:660; }","duration":"161.262076ms","start":"2026-08-27T20:12:00.465138Z","end":"2026-08-27T20:12:00.6264Z","steps":["trace[1798065365] 'agreement among raft nodes before linearized reading' (duration: 160.996838ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:12:01.057004Z","caller":"traceutil/trace.go:171","msg":"trace[591460627] transaction","detail":"{read_only:false; response_revision:662; number_of_response:1; }","duration":"167.181844ms","start":"2026-08-27T20:12:00.889794Z","end":"2026-08-27T20:12:01.056975Z","steps":["trace[591460627] 'process raft request' (duration: 166.972848ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:12:14.58108Z","caller":"traceutil/trace.go:171","msg":"trace[1607961576] transaction","detail":"{read_only:false; response_revision:755; number_of_response:1; }","duration":"104.000861ms","start":"2026-08-27T20:12:14.47705Z","end":"2026-08-27T20:12:14.581051Z","steps":["trace[1607961576] 'process raft request' (duration: 88.637555ms)","trace[1607961576] 'compare' (duration: 15.221382ms)"],"step_count":2} {"level":"info","ts":"2026-08-27T20:12:47.562763Z","caller":"traceutil/trace.go:171","msg":"trace[684259925] transaction","detail":"{read_only:false; response_revision:1176; number_of_response:1; }","duration":"180.395994ms","start":"2026-08-27T20:12:47.38234Z","end":"2026-08-27T20:12:47.562736Z","steps":["trace[684259925] 'process raft request' (duration: 180.213639ms)"],"step_count":1} {"level":"warn","ts":"2026-08-27T20:13:37.666678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.343795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-27T20:13:37.666801Z","caller":"traceutil/trace.go:171","msg":"trace[56040916] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1866; }","duration":"300.497518ms","start":"2026-08-27T20:13:37.366251Z","end":"2026-08-27T20:13:37.666749Z","steps":["trace[56040916] 'range keys from in-memory index tree' (duration: 300.203301ms)"],"step_count":1} {"level":"warn","ts":"2026-08-27T20:13:37.666839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-27T20:13:37.366212Z","time spent":"300.618312ms","remote":"127.0.0.1:57556","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-27T20:13:37.679209Z","caller":"traceutil/trace.go:171","msg":"trace[275716012] transaction","detail":"{read_only:false; response_revision:1867; number_of_response:1; }","duration":"165.269547ms","start":"2026-08-27T20:13:37.513897Z","end":"2026-08-27T20:13:37.679167Z","steps":["trace[275716012] 'process raft request' (duration: 164.983229ms)"],"step_count":1} {"level":"warn","ts":"2026-08-27T20:13:38.052993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.537502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-08-27T20:13:38.053098Z","caller":"traceutil/trace.go:171","msg":"trace[768551689] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1868; }","duration":"211.712487ms","start":"2026-08-27T20:13:37.841362Z","end":"2026-08-27T20:13:38.053074Z","steps":["trace[768551689] 'range keys from in-memory index tree' (duration: 211.249992ms)"],"step_count":1} {"level":"warn","ts":"2026-08-27T20:13:38.053157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.079844ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-fbfcfe11-6d27-45e2-b07f-6765a12e3a1f\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-08-27T20:13:38.053242Z","caller":"traceutil/trace.go:171","msg":"trace[175951771] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-fbfcfe11-6d27-45e2-b07f-6765a12e3a1f; range_end:; response_count:1; response_revision:1868; }","duration":"115.224728ms","start":"2026-08-27T20:13:37.937997Z","end":"2026-08-27T20:13:38.053222Z","steps":["trace[175951771] 'range keys from in-memory index tree' (duration: 114.522217ms)"],"step_count":1} {"level":"warn","ts":"2026-08-27T20:14:28.2663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.17204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-27T20:14:28.266466Z","caller":"traceutil/trace.go:171","msg":"trace[1305021315] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:2193; }","duration":"119.44391ms","start":"2026-08-27T20:14:28.14699Z","end":"2026-08-27T20:14:28.266434Z","steps":["trace[1305021315] 'count revisions from in-memory index tree' (duration: 119.009046ms)"],"step_count":1} {"level":"warn","ts":"2026-08-27T20:14:33.758509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.200802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-27T20:14:33.758599Z","caller":"traceutil/trace.go:171","msg":"trace[1919403023] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:2220; }","duration":"146.343566ms","start":"2026-08-27T20:14:33.612235Z","end":"2026-08-27T20:14:33.758578Z","steps":["trace[1919403023] 'count revisions from in-memory index tree' (duration: 146.066568ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:14:34.150576Z","caller":"traceutil/trace.go:171","msg":"trace[615235538] transaction","detail":"{read_only:false; response_revision:2222; number_of_response:1; }","duration":"138.284835ms","start":"2026-08-27T20:14:34.012266Z","end":"2026-08-27T20:14:34.150551Z","steps":["trace[615235538] 'process raft request' (duration: 137.505071ms)"],"step_count":1} {"level":"warn","ts":"2026-08-27T20:15:58.039334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.738087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-08-27T20:15:58.039451Z","caller":"traceutil/trace.go:171","msg":"trace[309496329] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2868; }","duration":"203.897722ms","start":"2026-08-27T20:15:57.835514Z","end":"2026-08-27T20:15:58.039412Z","steps":["trace[309496329] 'range keys from in-memory index tree' (duration: 203.507191ms)"],"step_count":1} {"level":"warn","ts":"2026-08-27T20:15:58.040586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.261028ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-27T20:15:58.040884Z","caller":"traceutil/trace.go:171","msg":"trace[317168596] transaction","detail":"{read_only:false; response_revision:2869; number_of_response:1; }","duration":"161.695321ms","start":"2026-08-27T20:15:57.879114Z","end":"2026-08-27T20:15:58.04081Z","steps":["trace[317168596] 'process raft request' (duration: 24.103284ms)","trace[317168596] 'compare' (duration: 135.869497ms)"],"step_count":2} {"level":"info","ts":"2026-08-27T20:18:50.126906Z","caller":"traceutil/trace.go:171","msg":"trace[1723167920] transaction","detail":"{read_only:false; response_revision:3896; number_of_response:1; }","duration":"108.719113ms","start":"2026-08-27T20:18:50.018146Z","end":"2026-08-27T20:18:50.126865Z","steps":["trace[1723167920] 'process raft request' (duration: 100.341496ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:18:50.127613Z","caller":"traceutil/trace.go:171","msg":"trace[1946521915] transaction","detail":"{read_only:false; response_revision:3897; number_of_response:1; }","duration":"101.698635ms","start":"2026-08-27T20:18:50.025876Z","end":"2026-08-27T20:18:50.127575Z","steps":["trace[1946521915] 'process raft request' (duration: 101.51369ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:19:21.357302Z","caller":"traceutil/trace.go:171","msg":"trace[1232219994] linearizableReadLoop","detail":"{readStateIndex:4298; appliedIndex:4297; }","duration":"121.44713ms","start":"2026-08-27T20:19:21.235817Z","end":"2026-08-27T20:19:21.357264Z","steps":["trace[1232219994] 'read index received' (duration: 85.149347ms)","trace[1232219994] 'applied index is now lower than readState.Index' (duration: 36.296193ms)"],"step_count":2} {"level":"info","ts":"2026-08-27T20:19:21.357369Z","caller":"traceutil/trace.go:171","msg":"trace[481351378] transaction","detail":"{read_only:false; response_revision:4140; number_of_response:1; }","duration":"173.985522ms","start":"2026-08-27T20:19:21.183333Z","end":"2026-08-27T20:19:21.357319Z","steps":["trace[481351378] 'process raft request' (duration: 137.516414ms)","trace[481351378] 'compare' (duration: 36.222471ms)"],"step_count":2} {"level":"warn","ts":"2026-08-27T20:19:21.357635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.79868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-08-27T20:19:21.357676Z","caller":"traceutil/trace.go:171","msg":"trace[758958500] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4140; }","duration":"121.930914ms","start":"2026-08-27T20:19:21.235734Z","end":"2026-08-27T20:19:21.357665Z","steps":["trace[758958500] 'agreement among raft nodes before linearized reading' (duration: 121.682417ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:21:00.596256Z","caller":"traceutil/trace.go:171","msg":"trace[941380383] transaction","detail":"{read_only:false; response_revision:5333; number_of_response:1; }","duration":"152.115515ms","start":"2026-08-27T20:21:00.444111Z","end":"2026-08-27T20:21:00.596226Z","steps":["trace[941380383] 'process raft request' (duration: 148.219211ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:21:00.624772Z","caller":"traceutil/trace.go:171","msg":"trace[383453317] transaction","detail":"{read_only:false; response_revision:5335; number_of_response:1; }","duration":"126.550271ms","start":"2026-08-27T20:21:00.49817Z","end":"2026-08-27T20:21:00.62472Z","steps":["trace[383453317] 'process raft request' (duration: 126.300314ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:21:00.62482Z","caller":"traceutil/trace.go:171","msg":"trace[367713181] transaction","detail":"{read_only:false; response_revision:5334; number_of_response:1; }","duration":"130.476077ms","start":"2026-08-27T20:21:00.494318Z","end":"2026-08-27T20:21:00.624794Z","steps":["trace[367713181] 'process raft request' (duration: 130.015662ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:21:02.135569Z","caller":"traceutil/trace.go:171","msg":"trace[1107500090] transaction","detail":"{read_only:false; response_revision:5384; number_of_response:1; }","duration":"144.156881ms","start":"2026-08-27T20:21:01.991378Z","end":"2026-08-27T20:21:02.135535Z","steps":["trace[1107500090] 'process raft request' (duration: 143.870793ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:21:12.054406Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2947} {"level":"info","ts":"2026-08-27T20:21:12.150951Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2947,"took":"94.106611ms","hash":4205485504,"current-db-size-bytes":55996416,"current-db-size":"56 MB","current-db-size-in-use-bytes":30932992,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-08-27T20:21:12.151057Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4205485504,"revision":2947,"compact-revision":-1} {"level":"info","ts":"2026-08-27T20:21:12.881916Z","caller":"traceutil/trace.go:171","msg":"trace[1810433158] transaction","detail":"{read_only:false; response_revision:5576; number_of_response:1; }","duration":"134.396913ms","start":"2026-08-27T20:21:12.747492Z","end":"2026-08-27T20:21:12.881889Z","steps":["trace[1810433158] 'process raft request' (duration: 105.862919ms)","trace[1810433158] 'compare' (duration: 28.380089ms)"],"step_count":2} {"level":"info","ts":"2026-08-27T20:21:12.882199Z","caller":"traceutil/trace.go:171","msg":"trace[242285485] transaction","detail":"{read_only:false; response_revision:5577; number_of_response:1; }","duration":"131.091524ms","start":"2026-08-27T20:21:12.751088Z","end":"2026-08-27T20:21:12.882179Z","steps":["trace[242285485] 'process raft request' (duration: 130.745574ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:21:12.882256Z","caller":"traceutil/trace.go:171","msg":"trace[21521467] transaction","detail":"{read_only:false; response_revision:5578; number_of_response:1; }","duration":"131.026742ms","start":"2026-08-27T20:21:12.751195Z","end":"2026-08-27T20:21:12.882221Z","steps":["trace[21521467] 'process raft request' (duration: 130.870878ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:21:12.88247Z","caller":"traceutil/trace.go:171","msg":"trace[1270712684] transaction","detail":"{read_only:false; response_revision:5579; number_of_response:1; }","duration":"130.743574ms","start":"2026-08-27T20:21:12.751618Z","end":"2026-08-27T20:21:12.882362Z","steps":["trace[1270712684] 'process raft request' (duration: 130.553249ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:21:25.406001Z","caller":"traceutil/trace.go:171","msg":"trace[1055086773] transaction","detail":"{read_only:false; response_revision:5819; number_of_response:1; }","duration":"134.994304ms","start":"2026-08-27T20:21:25.270962Z","end":"2026-08-27T20:21:25.405957Z","steps":["trace[1055086773] 'process raft request' (duration: 96.824667ms)","trace[1055086773] 'compare' (duration: 37.949451ms)"],"step_count":2} {"level":"info","ts":"2026-08-27T20:21:27.980282Z","caller":"traceutil/trace.go:171","msg":"trace[747220603] transaction","detail":"{read_only:false; response_revision:5843; number_of_response:1; }","duration":"109.147783ms","start":"2026-08-27T20:21:27.871093Z","end":"2026-08-27T20:21:27.980241Z","steps":["trace[747220603] 'process raft request' (duration: 108.942867ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:22:19.92557Z","caller":"traceutil/trace.go:171","msg":"trace[1490240631] transaction","detail":"{read_only:false; response_revision:6348; number_of_response:1; }","duration":"126.933172ms","start":"2026-08-27T20:22:19.798607Z","end":"2026-08-27T20:22:19.92554Z","steps":["trace[1490240631] 'process raft request' (duration: 126.360796ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:26:12.095546Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5564} {"level":"info","ts":"2026-08-27T20:26:12.195784Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5564,"took":"97.820894ms","hash":1727718577,"current-db-size-bytes":55996416,"current-db-size":"56 MB","current-db-size-in-use-bytes":28782592,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-08-27T20:26:12.195883Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1727718577,"revision":5564,"compact-revision":2947} {"level":"info","ts":"2026-08-27T20:27:57.065214Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000238a.wal"} {"level":"warn","ts":"2026-08-27T20:28:04.618945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.671523ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-27T20:28:04.619029Z","caller":"traceutil/trace.go:171","msg":"trace[1374436000] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8825; }","duration":"252.830348ms","start":"2026-08-27T20:28:04.366178Z","end":"2026-08-27T20:28:04.619009Z","steps":["trace[1374436000] 'range keys from in-memory index tree' (duration: 252.497559ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:28:13.00752Z","caller":"traceutil/trace.go:171","msg":"trace[1565118605] transaction","detail":"{read_only:false; response_revision:8868; number_of_response:1; }","duration":"308.928145ms","start":"2026-08-27T20:28:12.698552Z","end":"2026-08-27T20:28:13.007481Z","steps":["trace[1565118605] 'process raft request' (duration: 308.695078ms)"],"step_count":1} {"level":"warn","ts":"2026-08-27T20:28:13.007742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-27T20:28:12.698517Z","time spent":"309.1091ms","remote":"127.0.0.1:57896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-27T20:28:13.034695Z","caller":"traceutil/trace.go:171","msg":"trace[1463591653] transaction","detail":"{read_only:false; response_revision:8870; number_of_response:1; }","duration":"164.645533ms","start":"2026-08-27T20:28:12.870016Z","end":"2026-08-27T20:28:13.034661Z","steps":["trace[1463591653] 'process raft request' (duration: 164.568441ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:28:13.034782Z","caller":"traceutil/trace.go:171","msg":"trace[1876803883] transaction","detail":"{read_only:false; response_revision:8869; number_of_response:1; }","duration":"335.631203ms","start":"2026-08-27T20:28:12.699054Z","end":"2026-08-27T20:28:13.034685Z","steps":["trace[1876803883] 'process raft request' (duration: 335.356755ms)"],"step_count":1} {"level":"warn","ts":"2026-08-27T20:28:13.035075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-27T20:28:12.699033Z","time spent":"335.846458ms","remote":"127.0.0.1:57930","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":855,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-27T20:28:13.800635Z","caller":"traceutil/trace.go:171","msg":"trace[2015649648] linearizableReadLoop","detail":"{readStateIndex:9191; appliedIndex:9190; }","duration":"122.554065ms","start":"2026-08-27T20:28:13.678026Z","end":"2026-08-27T20:28:13.80058Z","steps":["trace[2015649648] 'read index received' (duration: 115.982214ms)","trace[2015649648] 'applied index is now lower than readState.Index' (duration: 6.569871ms)"],"step_count":2} {"level":"info","ts":"2026-08-27T20:28:13.800781Z","caller":"traceutil/trace.go:171","msg":"trace[735451416] transaction","detail":"{read_only:false; response_revision:8875; number_of_response:1; }","duration":"135.123182ms","start":"2026-08-27T20:28:13.665576Z","end":"2026-08-27T20:28:13.8007Z","steps":["trace[735451416] 'process raft request' (duration: 128.50194ms)"],"step_count":1} {"level":"warn","ts":"2026-08-27T20:28:13.800928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.877266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-nf7b8\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-08-27T20:28:13.800987Z","caller":"traceutil/trace.go:171","msg":"trace[1461238716] range","detail":"{range_begin:/registry/pods/openstack/keepalived-nf7b8; range_end:; response_count:1; response_revision:8875; }","duration":"123.006709ms","start":"2026-08-27T20:28:13.677962Z","end":"2026-08-27T20:28:13.800968Z","steps":["trace[1461238716] 'agreement among raft nodes before linearized reading' (duration: 122.766881ms)"],"step_count":1} {"level":"warn","ts":"2026-08-27T20:28:29.740918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.787636ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-27T20:28:29.741074Z","caller":"traceutil/trace.go:171","msg":"trace[571780911] transaction","detail":"{read_only:false; response_revision:8967; number_of_response:1; }","duration":"203.157638ms","start":"2026-08-27T20:28:29.537892Z","end":"2026-08-27T20:28:29.741049Z","steps":["trace[571780911] 'process raft request' (duration: 36.113754ms)","trace[571780911] 'compare' (duration: 166.622692ms)"],"step_count":2} {"level":"warn","ts":"2026-08-27T20:28:44.574722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.233176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-27T20:28:44.574845Z","caller":"traceutil/trace.go:171","msg":"trace[589529509] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:9091; }","duration":"294.35352ms","start":"2026-08-27T20:28:44.280448Z","end":"2026-08-27T20:28:44.574801Z","steps":["trace[589529509] 'range keys from in-memory index tree' (duration: 294.008919ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:28:44.710384Z","caller":"traceutil/trace.go:171","msg":"trace[1562789984] transaction","detail":"{read_only:false; response_revision:9092; number_of_response:1; }","duration":"127.375396ms","start":"2026-08-27T20:28:44.582983Z","end":"2026-08-27T20:28:44.710345Z","steps":["trace[1562789984] 'process raft request' (duration: 127.168001ms)"],"step_count":1} {"level":"warn","ts":"2026-08-27T20:28:55.515364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.58934ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-27T20:28:55.515495Z","caller":"traceutil/trace.go:171","msg":"trace[919203711] linearizableReadLoop","detail":"{readStateIndex:9477; appliedIndex:9476; }","duration":"148.512624ms","start":"2026-08-27T20:28:55.366959Z","end":"2026-08-27T20:28:55.515471Z","steps":["trace[919203711] 'read index received' (duration: 16.525603ms)","trace[919203711] 'applied index is now lower than readState.Index' (duration: 131.985131ms)"],"step_count":2} {"level":"info","ts":"2026-08-27T20:28:55.515511Z","caller":"traceutil/trace.go:171","msg":"trace[502070922] transaction","detail":"{read_only:false; response_revision:9150; number_of_response:1; }","duration":"231.380923ms","start":"2026-08-27T20:28:55.284095Z","end":"2026-08-27T20:28:55.515476Z","steps":["trace[502070922] 'process raft request' (duration: 99.494404ms)","trace[502070922] 'compare' (duration: 131.182738ms)"],"step_count":2} {"level":"warn","ts":"2026-08-27T20:28:55.515589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.641147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-27T20:28:55.515645Z","caller":"traceutil/trace.go:171","msg":"trace[1767762904] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9150; }","duration":"148.734141ms","start":"2026-08-27T20:28:55.366891Z","end":"2026-08-27T20:28:55.515625Z","steps":["trace[1767762904] 'agreement among raft nodes before linearized reading' (duration: 148.636518ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:28:55.691261Z","caller":"traceutil/trace.go:171","msg":"trace[865529937] linearizableReadLoop","detail":"{readStateIndex:9478; appliedIndex:9477; }","duration":"143.473346ms","start":"2026-08-27T20:28:55.547765Z","end":"2026-08-27T20:28:55.691238Z","steps":["trace[865529937] 'read index received' (duration: 108.831965ms)","trace[865529937] 'applied index is now lower than readState.Index' (duration: 34.639971ms)"],"step_count":2} {"level":"info","ts":"2026-08-27T20:28:55.691635Z","caller":"traceutil/trace.go:171","msg":"trace[215981568] transaction","detail":"{read_only:false; response_revision:9151; number_of_response:1; }","duration":"148.665297ms","start":"2026-08-27T20:28:55.542947Z","end":"2026-08-27T20:28:55.691613Z","steps":["trace[215981568] 'process raft request' (duration: 113.719338ms)","trace[215981568] 'compare' (duration: 34.444985ms)"],"step_count":2} {"level":"warn","ts":"2026-08-27T20:28:55.691852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.064353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.108\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-27T20:28:55.691896Z","caller":"traceutil/trace.go:171","msg":"trace[45915534] range","detail":"{range_begin:/registry/masterleases/162.253.55.108; range_end:; response_count:1; response_revision:9151; }","duration":"144.152666ms","start":"2026-08-27T20:28:55.547732Z","end":"2026-08-27T20:28:55.691885Z","steps":["trace[45915534] 'agreement among raft nodes before linearized reading' (duration: 144.012101ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:29:52.194621Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"806c7300a47a7256","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-08-27T20:29:52.201145Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-08-27T20:29:52.201224Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-08-27T20:30:27.172953Z","caller":"traceutil/trace.go:171","msg":"trace[546926827] linearizableReadLoop","detail":"{readStateIndex:10377; appliedIndex:10376; }","duration":"126.758573ms","start":"2026-08-27T20:30:27.046148Z","end":"2026-08-27T20:30:27.172906Z","steps":["trace[546926827] 'read index received' (duration: 126.424454ms)","trace[546926827] 'applied index is now lower than readState.Index' (duration: 332.409µs)"],"step_count":2} {"level":"info","ts":"2026-08-27T20:30:27.173094Z","caller":"traceutil/trace.go:171","msg":"trace[686522605] transaction","detail":"{read_only:false; response_revision:10023; number_of_response:1; }","duration":"151.405116ms","start":"2026-08-27T20:30:27.021626Z","end":"2026-08-27T20:30:27.173031Z","steps":["trace[686522605] 'process raft request' (duration: 150.993494ms)"],"step_count":1} {"level":"warn","ts":"2026-08-27T20:30:27.173203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.997799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretimports/\" range_end:\"/registry/secretgen.carvel.dev/secretimports0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-27T20:30:27.173275Z","caller":"traceutil/trace.go:171","msg":"trace[1319975050] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretimports/; range_end:/registry/secretgen.carvel.dev/secretimports0; response_count:0; response_revision:10023; }","duration":"127.173916ms","start":"2026-08-27T20:30:27.046078Z","end":"2026-08-27T20:30:27.173252Z","steps":["trace[1319975050] 'agreement among raft nodes before linearized reading' (duration: 127.00434ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:31:12.104069Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7957} {"level":"info","ts":"2026-08-27T20:31:12.201033Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7957,"took":"93.268346ms","hash":1953938889,"current-db-size-bytes":55996416,"current-db-size":"56 MB","current-db-size-in-use-bytes":25382912,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-08-27T20:31:12.201144Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1953938889,"revision":7957,"compact-revision":5564} {"level":"info","ts":"2026-08-27T20:35:50.295761Z","caller":"traceutil/trace.go:171","msg":"trace[2058811948] transaction","detail":"{read_only:false; response_revision:12362; number_of_response:1; }","duration":"133.035755ms","start":"2026-08-27T20:35:50.162695Z","end":"2026-08-27T20:35:50.29573Z","steps":["trace[2058811948] 'process raft request' (duration: 132.850109ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:36:12.111156Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10346} {"level":"info","ts":"2026-08-27T20:36:12.201065Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10346,"took":"86.608048ms","hash":2443743881,"current-db-size-bytes":55996416,"current-db-size":"56 MB","current-db-size-in-use-bytes":25165824,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-08-27T20:36:12.20114Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2443743881,"revision":10346,"compact-revision":7957} {"level":"info","ts":"2026-08-27T20:41:12.119998Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12489} {"level":"info","ts":"2026-08-27T20:41:12.212957Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12489,"took":"89.168227ms","hash":274851958,"current-db-size-bytes":55996416,"current-db-size":"56 MB","current-db-size-in-use-bytes":27541504,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-08-27T20:41:12.213049Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":274851958,"revision":12489,"compact-revision":10346} {"level":"info","ts":"2026-08-27T20:42:23.739282Z","caller":"traceutil/trace.go:171","msg":"trace[2011314496] transaction","detail":"{read_only:false; response_revision:14987; number_of_response:1; }","duration":"178.837939ms","start":"2026-08-27T20:42:23.560423Z","end":"2026-08-27T20:42:23.73926Z","steps":["trace[2011314496] 'process raft request' (duration: 178.701125ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:43:06.695974Z","caller":"traceutil/trace.go:171","msg":"trace[520543958] transaction","detail":"{read_only:false; response_revision:15224; number_of_response:1; }","duration":"229.906496ms","start":"2026-08-27T20:43:06.46603Z","end":"2026-08-27T20:43:06.695937Z","steps":["trace[520543958] 'process raft request' (duration: 229.634628ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:43:06.714025Z","caller":"traceutil/trace.go:171","msg":"trace[678770974] transaction","detail":"{read_only:false; response_revision:15225; number_of_response:1; }","duration":"246.888186ms","start":"2026-08-27T20:43:06.467101Z","end":"2026-08-27T20:43:06.713989Z","steps":["trace[678770974] 'process raft request' (duration: 246.698971ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:43:07.484123Z","caller":"traceutil/trace.go:171","msg":"trace[858370884] linearizableReadLoop","detail":"{readStateIndex:15761; appliedIndex:15760; }","duration":"233.518411ms","start":"2026-08-27T20:43:07.250577Z","end":"2026-08-27T20:43:07.484096Z","steps":["trace[858370884] 'read index received' (duration: 233.352947ms)","trace[858370884] 'applied index is now lower than readState.Index' (duration: 163.824µs)"],"step_count":2} {"level":"info","ts":"2026-08-27T20:43:07.484221Z","caller":"traceutil/trace.go:171","msg":"trace[2032426039] transaction","detail":"{read_only:false; response_revision:15228; number_of_response:1; }","duration":"306.70524ms","start":"2026-08-27T20:43:07.177474Z","end":"2026-08-27T20:43:07.484179Z","steps":["trace[2032426039] 'process raft request' (duration: 306.436452ms)"],"step_count":1} {"level":"warn","ts":"2026-08-27T20:43:07.4844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.1855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1781"} {"level":"warn","ts":"2026-08-27T20:43:07.484405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.824341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/openvswitch-8777n\" ","response":"range_response_count:1 size:12364"} {"level":"warn","ts":"2026-08-27T20:43:07.48441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-27T20:43:07.177433Z","time spent":"306.873144ms","remote":"127.0.0.1:57896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-27T20:43:07.484446Z","caller":"traceutil/trace.go:171","msg":"trace[345065126] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:15228; }","duration":"218.258183ms","start":"2026-08-27T20:43:07.266169Z","end":"2026-08-27T20:43:07.484427Z","steps":["trace[345065126] 'agreement among raft nodes before linearized reading' (duration: 218.090317ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:43:07.484449Z","caller":"traceutil/trace.go:171","msg":"trace[1587472312] range","detail":"{range_begin:/registry/pods/openstack/openvswitch-8777n; range_end:; response_count:1; response_revision:15228; }","duration":"233.923434ms","start":"2026-08-27T20:43:07.250512Z","end":"2026-08-27T20:43:07.484436Z","steps":["trace[1587472312] 'agreement among raft nodes before linearized reading' (duration: 233.727588ms)"],"step_count":1} {"level":"warn","ts":"2026-08-27T20:43:07.484544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.494363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-27T20:43:07.484659Z","caller":"traceutil/trace.go:171","msg":"trace[260386121] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:15228; }","duration":"118.681228ms","start":"2026-08-27T20:43:07.36595Z","end":"2026-08-27T20:43:07.484631Z","steps":["trace[260386121] 'agreement among raft nodes before linearized reading' (duration: 118.41047ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:43:07.613811Z","caller":"traceutil/trace.go:171","msg":"trace[588781873] transaction","detail":"{read_only:false; response_revision:15229; number_of_response:1; }","duration":"113.821044ms","start":"2026-08-27T20:43:07.499959Z","end":"2026-08-27T20:43:07.61378Z","steps":["trace[588781873] 'process raft request' (duration: 113.417322ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:43:32.938909Z","caller":"traceutil/trace.go:171","msg":"trace[1849119377] transaction","detail":"{read_only:false; response_revision:15557; number_of_response:1; }","duration":"288.165252ms","start":"2026-08-27T20:43:32.650711Z","end":"2026-08-27T20:43:32.938877Z","steps":["trace[1849119377] 'process raft request' (duration: 287.906034ms)"],"step_count":1} {"level":"warn","ts":"2026-08-27T20:45:01.115464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.037757ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-08-27T20:45:01.115592Z","caller":"traceutil/trace.go:171","msg":"trace[1033019294] linearizableReadLoop","detail":"{readStateIndex:16948; appliedIndex:16947; }","duration":"204.672042ms","start":"2026-08-27T20:45:00.9109Z","end":"2026-08-27T20:45:01.115572Z","steps":["trace[1033019294] 'read index received' (duration: 27.440089ms)","trace[1033019294] 'applied index is now lower than readState.Index' (duration: 177.229903ms)"],"step_count":2} {"level":"warn","ts":"2026-08-27T20:45:01.115913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.993401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/topicpermissions/\" range_end:\"/registry/rabbitmq.com/topicpermissions0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-27T20:45:01.115961Z","caller":"traceutil/trace.go:171","msg":"trace[1689411587] range","detail":"{range_begin:/registry/rabbitmq.com/topicpermissions/; range_end:/registry/rabbitmq.com/topicpermissions0; response_count:0; response_revision:16379; }","duration":"205.072654ms","start":"2026-08-27T20:45:00.910874Z","end":"2026-08-27T20:45:01.115947Z","steps":["trace[1689411587] 'agreement among raft nodes before linearized reading' (duration: 204.973891ms)"],"step_count":1} {"level":"warn","ts":"2026-08-27T20:45:01.116168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.942171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/glance-api-7cf99c68dd-zxr96.18cfc3cd05e5967f\" ","response":"range_response_count:1 size:2106"} {"level":"info","ts":"2026-08-27T20:45:01.11628Z","caller":"traceutil/trace.go:171","msg":"trace[971045085] range","detail":"{range_begin:/registry/events/openstack/glance-api-7cf99c68dd-zxr96.18cfc3cd05e5967f; range_end:; response_count:1; response_revision:16379; }","duration":"184.099167ms","start":"2026-08-27T20:45:00.932153Z","end":"2026-08-27T20:45:01.116252Z","steps":["trace[971045085] 'agreement among raft nodes before linearized reading' (duration: 183.828688ms)"],"step_count":1} {"level":"warn","ts":"2026-08-27T20:45:01.116563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.730288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-nf7b8\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-08-27T20:45:01.116601Z","caller":"traceutil/trace.go:171","msg":"trace[167023450] range","detail":"{range_begin:/registry/pods/openstack/keepalived-nf7b8; range_end:; response_count:1; response_revision:16379; }","duration":"139.872432ms","start":"2026-08-27T20:45:00.976719Z","end":"2026-08-27T20:45:01.116591Z","steps":["trace[167023450] 'agreement among raft nodes before linearized reading' (duration: 139.759349ms)"],"step_count":1} {"level":"warn","ts":"2026-08-27T20:45:01.116857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.314915ms","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-27T20:45:01.116895Z","caller":"traceutil/trace.go:171","msg":"trace[160452691] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16379; }","duration":"178.373547ms","start":"2026-08-27T20:45:00.938513Z","end":"2026-08-27T20:45:01.116886Z","steps":["trace[160452691] 'agreement among raft nodes before linearized reading' (duration: 178.247853ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:45:01.278116Z","caller":"traceutil/trace.go:171","msg":"trace[1638004551] linearizableReadLoop","detail":"{readStateIndex:16949; appliedIndex:16948; }","duration":"151.506825ms","start":"2026-08-27T20:45:01.126578Z","end":"2026-08-27T20:45:01.278085Z","steps":["trace[1638004551] 'read index received' (duration: 151.131924ms)","trace[1638004551] 'applied index is now lower than readState.Index' (duration: 373.291µs)"],"step_count":2} {"level":"info","ts":"2026-08-27T20:45:01.278223Z","caller":"traceutil/trace.go:171","msg":"trace[486992271] transaction","detail":"{read_only:false; response_revision:16380; number_of_response:1; }","duration":"155.637736ms","start":"2026-08-27T20:45:01.12254Z","end":"2026-08-27T20:45:01.278178Z","steps":["trace[486992271] 'process raft request' (duration: 155.266116ms)"],"step_count":1} {"level":"warn","ts":"2026-08-27T20:45:01.279573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.981648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:76 size:737366"} {"level":"info","ts":"2026-08-27T20:45:01.279633Z","caller":"traceutil/trace.go:171","msg":"trace[1603429480] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:76; response_revision:16380; }","duration":"153.099822ms","start":"2026-08-27T20:45:01.126519Z","end":"2026-08-27T20:45:01.279618Z","steps":["trace[1603429480] 'agreement among raft nodes before linearized reading' (duration: 151.69683ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:46:12.126331Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14515} {"level":"info","ts":"2026-08-27T20:46:12.215504Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14515,"took":"85.979424ms","hash":586629986,"current-db-size-bytes":55996416,"current-db-size":"56 MB","current-db-size-in-use-bytes":30449664,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-08-27T20:46:12.215663Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":586629986,"revision":14515,"compact-revision":12489} {"level":"info","ts":"2026-08-27T20:51:12.134424Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":16828} {"level":"info","ts":"2026-08-27T20:51:12.244718Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":16828,"took":"105.563859ms","hash":1537526704,"current-db-size-bytes":55996416,"current-db-size":"56 MB","current-db-size-in-use-bytes":31752192,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-08-27T20:51:12.244846Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1537526704,"revision":16828,"compact-revision":14515} {"level":"warn","ts":"2026-08-27T20:51:36.485675Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8238948785880926576,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-27T20:51:36.524879Z","caller":"traceutil/trace.go:171","msg":"trace[43422646] transaction","detail":"{read_only:false; response_revision:19207; number_of_response:1; }","duration":"583.360416ms","start":"2026-08-27T20:51:35.941426Z","end":"2026-08-27T20:51:36.524786Z","steps":["trace[43422646] 'process raft request' (duration: 583.120509ms)"],"step_count":1} {"level":"warn","ts":"2026-08-27T20:51:36.525102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-27T20:51:35.941401Z","time spent":"583.580884ms","remote":"127.0.0.1:57896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-27T20:51:36.645364Z","caller":"traceutil/trace.go:171","msg":"trace[152975147] transaction","detail":"{read_only:false; response_revision:19208; number_of_response:1; }","duration":"703.596728ms","start":"2026-08-27T20:51:35.941711Z","end":"2026-08-27T20:51:36.645307Z","steps":["trace[152975147] 'process raft request' (duration: 630.319266ms)","trace[152975147] 'compare' (duration: 73.036514ms)"],"step_count":2} {"level":"info","ts":"2026-08-27T20:51:36.645491Z","caller":"traceutil/trace.go:171","msg":"trace[1571279745] linearizableReadLoop","detail":"{readStateIndex:19873; appliedIndex:19870; }","duration":"660.474762ms","start":"2026-08-27T20:51:35.984973Z","end":"2026-08-27T20:51:36.645447Z","steps":["trace[1571279745] 'read index received' (duration: 539.546541ms)","trace[1571279745] 'applied index is now lower than readState.Index' (duration: 120.924251ms)"],"step_count":2} {"level":"info","ts":"2026-08-27T20:51:36.64553Z","caller":"traceutil/trace.go:171","msg":"trace[1525402321] transaction","detail":"{read_only:false; response_revision:19209; number_of_response:1; }","duration":"684.453136ms","start":"2026-08-27T20:51:35.961034Z","end":"2026-08-27T20:51:36.645487Z","steps":["trace[1525402321] 'process raft request' (duration: 684.214168ms)"],"step_count":1} {"level":"warn","ts":"2026-08-27T20:51:36.645592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-27T20:51:35.9417Z","time spent":"703.766182ms","remote":"127.0.0.1:57896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-27T20:51:36.645819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-27T20:51:35.960997Z","time spent":"684.625941ms","remote":"127.0.0.1:57896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-27T20:51:36.645861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"660.870073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-08-27T20:51:36.645921Z","caller":"traceutil/trace.go:171","msg":"trace[1730717088] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:19209; }","duration":"660.958666ms","start":"2026-08-27T20:51:35.98495Z","end":"2026-08-27T20:51:36.645909Z","steps":["trace[1730717088] 'agreement among raft nodes before linearized reading' (duration: 660.706149ms)"],"step_count":1} {"level":"warn","ts":"2026-08-27T20:51:36.645964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-27T20:51:35.984882Z","time spent":"661.073359ms","remote":"127.0.0.1:57896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-27T20:51:36.645995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"633.447007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"warn","ts":"2026-08-27T20:51:36.646064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.028049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-27T20:51:36.646095Z","caller":"traceutil/trace.go:171","msg":"trace[1858462421] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:19209; }","duration":"633.574781ms","start":"2026-08-27T20:51:36.012491Z","end":"2026-08-27T20:51:36.646065Z","steps":["trace[1858462421] 'agreement among raft nodes before linearized reading' (duration: 633.253282ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:51:36.646126Z","caller":"traceutil/trace.go:171","msg":"trace[609954442] range","detail":"{range_begin:/registry/acme.cert-manager.io/orders/; range_end:/registry/acme.cert-manager.io/orders0; response_count:0; response_revision:19209; }","duration":"472.08972ms","start":"2026-08-27T20:51:36.174015Z","end":"2026-08-27T20:51:36.646105Z","steps":["trace[609954442] 'agreement among raft nodes before linearized reading' (duration: 471.984457ms)"],"step_count":1} {"level":"warn","ts":"2026-08-27T20:51:36.646146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-27T20:51:36.012442Z","time spent":"633.694234ms","remote":"127.0.0.1:57896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-27T20:51:36.646174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-27T20:51:36.173904Z","time spent":"472.259725ms","remote":"127.0.0.1:58064","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":29,"request content":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true "} {"level":"warn","ts":"2026-08-27T20:51:36.646269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.892631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-08-27T20:51:36.646325Z","caller":"traceutil/trace.go:171","msg":"trace[1040650410] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:19209; }","duration":"181.967582ms","start":"2026-08-27T20:51:36.464342Z","end":"2026-08-27T20:51:36.646309Z","steps":["trace[1040650410] 'agreement among raft nodes before linearized reading' (duration: 181.780877ms)"],"step_count":1} {"level":"warn","ts":"2026-08-27T20:51:36.646496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"590.989961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-l9bxv\" ","response":"range_response_count:1 size:20745"} {"level":"info","ts":"2026-08-27T20:51:36.646545Z","caller":"traceutil/trace.go:171","msg":"trace[747481631] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-l9bxv; range_end:; response_count:1; response_revision:19209; }","duration":"591.075494ms","start":"2026-08-27T20:51:36.055458Z","end":"2026-08-27T20:51:36.646534Z","steps":["trace[747481631] 'agreement among raft nodes before linearized reading' (duration: 590.94596ms)"],"step_count":1} {"level":"warn","ts":"2026-08-27T20:51:36.646575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-27T20:51:36.055441Z","time spent":"591.127536ms","remote":"127.0.0.1:57788","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":20768,"request content":"key:\"/registry/pods/openstack/libvirt-libvirt-default-l9bxv\" "} {"level":"warn","ts":"2026-08-27T20:51:36.646506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.418415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-khkp8\" ","response":"range_response_count:1 size:22101"} {"level":"info","ts":"2026-08-27T20:51:36.646722Z","caller":"traceutil/trace.go:171","msg":"trace[1531867699] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-khkp8; range_end:; response_count:1; response_revision:19209; }","duration":"215.660161ms","start":"2026-08-27T20:51:36.431039Z","end":"2026-08-27T20:51:36.646699Z","steps":["trace[1531867699] 'agreement among raft nodes before linearized reading' (duration: 215.311391ms)"],"step_count":1} {"level":"warn","ts":"2026-08-27T20:51:36.647147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"631.505022ms","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-27T20:51:36.647211Z","caller":"traceutil/trace.go:171","msg":"trace[1162919620] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:19209; }","duration":"632.029147ms","start":"2026-08-27T20:51:36.015164Z","end":"2026-08-27T20:51:36.647193Z","steps":["trace[1162919620] 'agreement among raft nodes before linearized reading' (duration: 631.46979ms)"],"step_count":1} {"level":"warn","ts":"2026-08-27T20:51:36.647248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-27T20:51:36.015146Z","time spent":"632.088479ms","remote":"127.0.0.1:57896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-08-27T20:51:36.819352Z","caller":"traceutil/trace.go:171","msg":"trace[120585126] transaction","detail":"{read_only:false; response_revision:19211; number_of_response:1; }","duration":"166.054376ms","start":"2026-08-27T20:51:36.653265Z","end":"2026-08-27T20:51:36.819319Z","steps":["trace[120585126] 'process raft request' (duration: 165.771397ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:51:36.819603Z","caller":"traceutil/trace.go:171","msg":"trace[1340191561] transaction","detail":"{read_only:false; response_revision:19212; number_of_response:1; }","duration":"166.256502ms","start":"2026-08-27T20:51:36.653325Z","end":"2026-08-27T20:51:36.819582Z","steps":["trace[1340191561] 'process raft request' (duration: 165.928913ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:51:36.819782Z","caller":"traceutil/trace.go:171","msg":"trace[591572120] transaction","detail":"{read_only:false; response_revision:19213; number_of_response:1; }","duration":"166.400135ms","start":"2026-08-27T20:51:36.65337Z","end":"2026-08-27T20:51:36.81977Z","steps":["trace[591572120] 'process raft request' (duration: 166.130368ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:51:36.819938Z","caller":"traceutil/trace.go:171","msg":"trace[436012758] transaction","detail":"{read_only:false; response_revision:19214; number_of_response:1; }","duration":"148.884481ms","start":"2026-08-27T20:51:36.671002Z","end":"2026-08-27T20:51:36.819887Z","steps":["trace[436012758] 'process raft request' (duration: 148.674305ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:51:36.819829Z","caller":"traceutil/trace.go:171","msg":"trace[102856253] linearizableReadLoop","detail":"{readStateIndex:19877; appliedIndex:19873; }","duration":"162.473661ms","start":"2026-08-27T20:51:36.657307Z","end":"2026-08-27T20:51:36.819781Z","steps":["trace[102856253] 'read index received' (duration: 25.702135ms)","trace[102856253] 'applied index is now lower than readState.Index' (duration: 136.769976ms)"],"step_count":2} {"level":"warn","ts":"2026-08-27T20:51:36.821264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.923993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:94 size:946822"} {"level":"info","ts":"2026-08-27T20:51:36.821326Z","caller":"traceutil/trace.go:171","msg":"trace[263969849] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:94; response_revision:19214; }","duration":"164.039707ms","start":"2026-08-27T20:51:36.657273Z","end":"2026-08-27T20:51:36.821313Z","steps":["trace[263969849] 'agreement among raft nodes before linearized reading' (duration: 162.722558ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:51:41.085629Z","caller":"traceutil/trace.go:171","msg":"trace[1456334009] transaction","detail":"{read_only:false; response_revision:19247; number_of_response:1; }","duration":"101.822529ms","start":"2026-08-27T20:51:40.983785Z","end":"2026-08-27T20:51:41.085607Z","steps":["trace[1456334009] 'process raft request' (duration: 101.674055ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:51:44.688805Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"806c7300a47a7256","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-08-27T20:51:44.695153Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-08-27T20:51:44.695312Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-08-27T20:56:12.145223Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19047} {"level":"info","ts":"2026-08-27T20:56:12.26125Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19047,"took":"110.822279ms","hash":2423410787,"current-db-size-bytes":55996416,"current-db-size":"56 MB","current-db-size-in-use-bytes":33947648,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-08-27T20:56:12.261351Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2423410787,"revision":19047,"compact-revision":16828} {"level":"info","ts":"2026-08-27T20:57:51.219541Z","caller":"traceutil/trace.go:171","msg":"trace[1217750519] transaction","detail":"{read_only:false; response_revision:22062; number_of_response:1; }","duration":"126.506501ms","start":"2026-08-27T20:57:51.093004Z","end":"2026-08-27T20:57:51.21951Z","steps":["trace[1217750519] 'process raft request' (duration: 126.10804ms)"],"step_count":1} {"level":"warn","ts":"2026-08-27T20:58:51.990397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.872362ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-27T20:58:51.990574Z","caller":"traceutil/trace.go:171","msg":"trace[156185026] transaction","detail":"{read_only:false; response_revision:22372; number_of_response:1; }","duration":"341.999529ms","start":"2026-08-27T20:58:51.648548Z","end":"2026-08-27T20:58:51.990547Z","steps":["trace[156185026] 'process raft request' (duration: 76.871038ms)","trace[156185026] 'compare' (duration: 264.578484ms)"],"step_count":2} {"level":"warn","ts":"2026-08-27T20:58:51.990649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-27T20:58:51.648498Z","time spent":"342.117582ms","remote":"127.0.0.1:57896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-27T20:58:52.032995Z","caller":"traceutil/trace.go:171","msg":"trace[1952714665] transaction","detail":"{read_only:false; response_revision:22374; number_of_response:1; }","duration":"381.851454ms","start":"2026-08-27T20:58:51.651088Z","end":"2026-08-27T20:58:52.032939Z","steps":["trace[1952714665] 'process raft request' (duration: 381.557385ms)"],"step_count":1} {"level":"warn","ts":"2026-08-27T20:58:52.033199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-27T20:58:51.651079Z","time spent":"382.017768ms","remote":"127.0.0.1:57896","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-27T20:58:52.033214Z","caller":"traceutil/trace.go:171","msg":"trace[598388268] transaction","detail":"{read_only:false; response_revision:22373; number_of_response:1; }","duration":"381.713469ms","start":"2026-08-27T20:58:51.651008Z","end":"2026-08-27T20:58:52.032721Z","steps":["trace[598388268] 'process raft request' (duration: 381.492863ms)"],"step_count":1} {"level":"warn","ts":"2026-08-27T20:58:52.033484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-27T20:58:51.650991Z","time spent":"382.372619ms","remote":"127.0.0.1:57896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-27T20:58:52.86274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.614828ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-27T20:58:52.862904Z","caller":"traceutil/trace.go:171","msg":"trace[427340347] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:22375; }","duration":"158.788544ms","start":"2026-08-27T20:58:52.704093Z","end":"2026-08-27T20:58:52.862881Z","steps":["trace[427340347] 'range keys from in-memory index tree' (duration: 158.574917ms)"],"step_count":1} {"level":"warn","ts":"2026-08-27T20:58:52.863966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.624504ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-27T20:58:52.864619Z","caller":"traceutil/trace.go:171","msg":"trace[2116888116] transaction","detail":"{read_only:false; response_revision:22377; number_of_response:1; }","duration":"310.589001ms","start":"2026-08-27T20:58:52.554008Z","end":"2026-08-27T20:58:52.864597Z","steps":["trace[2116888116] 'process raft request' (duration: 310.276502ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:58:52.86467Z","caller":"traceutil/trace.go:171","msg":"trace[478129935] transaction","detail":"{read_only:false; response_revision:22376; number_of_response:1; }","duration":"341.141492ms","start":"2026-08-27T20:58:52.523493Z","end":"2026-08-27T20:58:52.864635Z","steps":["trace[478129935] 'process raft request' (duration: 153.156608ms)","trace[478129935] 'compare' (duration: 185.857731ms)"],"step_count":2} {"level":"warn","ts":"2026-08-27T20:58:52.864824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-27T20:58:52.553977Z","time spent":"310.708055ms","remote":"127.0.0.1:57896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-27T20:58:52.864842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-27T20:58:52.523466Z","time spent":"341.280917ms","remote":"127.0.0.1:57896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-27T20:58:52.864418Z","caller":"traceutil/trace.go:171","msg":"trace[1637018095] linearizableReadLoop","detail":"{readStateIndex:23150; appliedIndex:23148; }","duration":"148.458409ms","start":"2026-08-27T20:58:52.715937Z","end":"2026-08-27T20:58:52.864396Z","steps":["trace[1637018095] 'read index received' (duration: 65.522µs)","trace[1637018095] 'applied index is now lower than readState.Index' (duration: 148.391487ms)"],"step_count":2} {"level":"warn","ts":"2026-08-27T20:58:52.865212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.229831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" ","response":"range_response_count:1 size:418288"} {"level":"info","ts":"2026-08-27T20:58:52.865484Z","caller":"traceutil/trace.go:171","msg":"trace[960098119] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance; range_end:; response_count:1; response_revision:22377; }","duration":"149.594582ms","start":"2026-08-27T20:58:52.715869Z","end":"2026-08-27T20:58:52.865464Z","steps":["trace[960098119] 'agreement among raft nodes before linearized reading' (duration: 148.895002ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:58:53.200163Z","caller":"traceutil/trace.go:171","msg":"trace[613813489] transaction","detail":"{read_only:false; response_revision:22378; number_of_response:1; }","duration":"201.397249ms","start":"2026-08-27T20:58:52.998736Z","end":"2026-08-27T20:58:53.200134Z","steps":["trace[613813489] 'process raft request' (duration: 201.197234ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T21:01:12.154913Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21387} {"level":"info","ts":"2026-08-27T21:01:12.291197Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21387,"took":"131.363095ms","hash":207601007,"current-db-size-bytes":55996416,"current-db-size":"56 MB","current-db-size-in-use-bytes":29696000,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-08-27T21:01:12.291289Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":207601007,"revision":21387,"compact-revision":19047} {"level":"info","ts":"2026-08-27T21:03:10.956688Z","caller":"traceutil/trace.go:171","msg":"trace[1796876464] linearizableReadLoop","detail":"{readStateIndex:25862; appliedIndex:25861; }","duration":"165.941995ms","start":"2026-08-27T21:03:10.790715Z","end":"2026-08-27T21:03:10.956657Z","steps":["trace[1796876464] 'read index received' (duration: 101.175225ms)","trace[1796876464] 'applied index is now lower than readState.Index' (duration: 64.76486ms)"],"step_count":2} {"level":"warn","ts":"2026-08-27T21:03:10.956976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.53573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-27T21:03:10.957017Z","caller":"traceutil/trace.go:171","msg":"trace[1371826271] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25012; }","duration":"151.603981ms","start":"2026-08-27T21:03:10.805403Z","end":"2026-08-27T21:03:10.957007Z","steps":["trace[1371826271] 'agreement among raft nodes before linearized reading' (duration: 151.493308ms)"],"step_count":1} {"level":"warn","ts":"2026-08-27T21:03:10.957191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.711391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-08-27T21:03:10.957302Z","caller":"traceutil/trace.go:171","msg":"trace[589166350] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:25012; }","duration":"121.852074ms","start":"2026-08-27T21:03:10.835421Z","end":"2026-08-27T21:03:10.957274Z","steps":["trace[589166350] 'agreement among raft nodes before linearized reading' (duration: 121.562926ms)"],"step_count":1} {"level":"warn","ts":"2026-08-27T21:03:10.957276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.109257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"warn","ts":"2026-08-27T21:03:10.957185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.431109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" ","response":"range_response_count:1 size:626"} {"level":"info","ts":"2026-08-27T21:03:10.957424Z","caller":"traceutil/trace.go:171","msg":"trace[375183041] range","detail":"{range_begin:/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi; range_end:; response_count:1; response_revision:25012; }","duration":"166.758649ms","start":"2026-08-27T21:03:10.790646Z","end":"2026-08-27T21:03:10.957404Z","steps":["trace[375183041] 'agreement among raft nodes before linearized reading' (duration: 166.138041ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T21:03:10.957418Z","caller":"traceutil/trace.go:171","msg":"trace[828263394] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25012; }","duration":"111.316753ms","start":"2026-08-27T21:03:10.846056Z","end":"2026-08-27T21:03:10.957372Z","steps":["trace[828263394] 'agreement among raft nodes before linearized reading' (duration: 110.887291ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T21:04:53.302894Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-000000000000692f.wal"} {"level":"info","ts":"2026-08-27T21:06:12.164844Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23578} {"level":"info","ts":"2026-08-27T21:06:12.304125Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23578,"took":"128.720973ms","hash":3427117577,"current-db-size-bytes":55996416,"current-db-size":"56 MB","current-db-size-in-use-bytes":43507712,"current-db-size-in-use":"44 MB"} {"level":"info","ts":"2026-08-27T21:06:12.304223Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3427117577,"revision":23578,"compact-revision":21387} {"level":"info","ts":"2026-08-27T21:11:12.178214Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":26713} {"level":"info","ts":"2026-08-27T21:11:12.342119Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":26713,"took":"158.143741ms","hash":923283012,"current-db-size-bytes":55996416,"current-db-size":"56 MB","current-db-size-in-use-bytes":30531584,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-08-27T21:11:12.342196Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":923283012,"revision":26713,"compact-revision":23578} {"level":"info","ts":"2026-08-27T21:11:25.776316Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"806c7300a47a7256","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-08-27T21:11:25.782213Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-08-27T21:11:25.782383Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}