{"level":"warn","ts":"2026-04-12T20:49:19.915957Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-12T20:49:19.916099Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.157: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.157:2380","--initial-cluster=instance=https://199.204.45.157:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.157:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.157: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-04-12T20:49:19.916193Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-12T20:49:19.916215Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.157:2380"]} {"level":"info","ts":"2026-04-12T20:49:19.916249Z","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-04-12T20:49:19.916976Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.157:2379"]} {"level":"info","ts":"2026-04-12T20:49:19.91708Z","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.157:2380"],"listen-peer-urls":["https://199.204.45.157:2380"],"advertise-client-urls":["https://199.204.45.157:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.157:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.157: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-04-12T20:49:19.921103Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.694527ms"} {"level":"info","ts":"2026-04-12T20:49:19.928829Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5f170c75a1d97cc","cluster-id":"44a3176ec85feb9"} {"level":"info","ts":"2026-04-12T20:49:19.928935Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc switched to configuration voters=()"} {"level":"info","ts":"2026-04-12T20:49:19.928965Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became follower at term 0"} {"level":"info","ts":"2026-04-12T20:49:19.928976Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5f170c75a1d97cc [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-12T20:49:19.928988Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became follower at term 1"} {"level":"info","ts":"2026-04-12T20:49:19.929031Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc switched to configuration voters=(428247441089599436)"} {"level":"warn","ts":"2026-04-12T20:49:19.934088Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-12T20:49:19.935568Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-12T20:49:19.936914Z","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-04-12T20:49:19.93955Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5f170c75a1d97cc","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-12T20:49:19.939745Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5f170c75a1d97cc","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-12T20:49:19.94005Z","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-04-12T20:49:19.940192Z","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-04-12T20:49:19.940245Z","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-04-12T20:49:19.94229Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc switched to configuration voters=(428247441089599436)"} {"level":"info","ts":"2026-04-12T20:49:19.942428Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"44a3176ec85feb9","local-member-id":"5f170c75a1d97cc","added-peer-id":"5f170c75a1d97cc","added-peer-peer-urls":["https://199.204.45.157:2380"]} {"level":"info","ts":"2026-04-12T20:49:19.945507Z","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-04-12T20:49:19.945711Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.157:2380"} {"level":"info","ts":"2026-04-12T20:49:19.945817Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.157:2380"} {"level":"info","ts":"2026-04-12T20:49:19.946035Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5f170c75a1d97cc","initial-advertise-peer-urls":["https://199.204.45.157:2380"],"listen-peer-urls":["https://199.204.45.157:2380"],"advertise-client-urls":["https://199.204.45.157:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.157:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-12T20:49:19.946137Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-12T20:49:20.229497Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc is starting a new election at term 1"} {"level":"info","ts":"2026-04-12T20:49:20.229558Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became pre-candidate at term 1"} {"level":"info","ts":"2026-04-12T20:49:20.229591Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc received MsgPreVoteResp from 5f170c75a1d97cc at term 1"} {"level":"info","ts":"2026-04-12T20:49:20.229612Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became candidate at term 2"} {"level":"info","ts":"2026-04-12T20:49:20.229628Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc received MsgVoteResp from 5f170c75a1d97cc at term 2"} {"level":"info","ts":"2026-04-12T20:49:20.229649Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became leader at term 2"} {"level":"info","ts":"2026-04-12T20:49:20.229667Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5f170c75a1d97cc elected leader 5f170c75a1d97cc at term 2"} {"level":"info","ts":"2026-04-12T20:49:20.230602Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-12T20:49:20.230584Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-12T20:49:20.230628Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-12T20:49:20.231526Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"44a3176ec85feb9","local-member-id":"5f170c75a1d97cc","cluster-version":"3.5"} {"level":"info","ts":"2026-04-12T20:49:20.231358Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5f170c75a1d97cc","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.157:2379]}","request-path":"/0/members/5f170c75a1d97cc/attributes","cluster-id":"44a3176ec85feb9","publish-timeout":"7s"} {"level":"info","ts":"2026-04-12T20:49:20.231693Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-12T20:49:20.231715Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-12T20:49:20.231729Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-12T20:49:20.231753Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-12T20:49:20.234587Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.157:2379"} {"level":"info","ts":"2026-04-12T20:49:20.234752Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-12T20:49:48.285392Z","caller":"traceutil/trace.go:171","msg":"trace[774240604] transaction","detail":"{read_only:false; response_revision:430; number_of_response:1; }","duration":"107.517407ms","start":"2026-04-12T20:49:48.177835Z","end":"2026-04-12T20:49:48.285353Z","steps":["trace[774240604] 'process raft request' (duration: 107.348984ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T20:49:52.381368Z","caller":"traceutil/trace.go:171","msg":"trace[1163631935] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"182.675921ms","start":"2026-04-12T20:49:52.198666Z","end":"2026-04-12T20:49:52.381342Z","steps":["trace[1163631935] 'process raft request' (duration: 97.931098ms)","trace[1163631935] 'compare' (duration: 84.321155ms)"],"step_count":2} {"level":"warn","ts":"2026-04-12T20:49:57.289151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.399265ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-12T20:49:57.289313Z","caller":"traceutil/trace.go:171","msg":"trace[1915308616] linearizableReadLoop","detail":"{readStateIndex:602; appliedIndex:601; }","duration":"275.839593ms","start":"2026-04-12T20:49:57.013456Z","end":"2026-04-12T20:49:57.289296Z","steps":["trace[1915308616] 'read index received' (duration: 60.780614ms)","trace[1915308616] 'applied index is now lower than readState.Index' (duration: 215.057529ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T20:49:57.289356Z","caller":"traceutil/trace.go:171","msg":"trace[732653977] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"292.957789ms","start":"2026-04-12T20:49:56.996355Z","end":"2026-04-12T20:49:57.289313Z","steps":["trace[732653977] 'process raft request' (duration: 77.926551ms)","trace[732653977] 'compare' (duration: 214.272422ms)"],"step_count":2} {"level":"warn","ts":"2026-04-12T20:49:57.289525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.067688ms","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-04-12T20:49:57.28959Z","caller":"traceutil/trace.go:171","msg":"trace[1663650719] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:576; }","duration":"276.184ms","start":"2026-04-12T20:49:57.01339Z","end":"2026-04-12T20:49:57.289574Z","steps":["trace[1663650719] 'agreement among raft nodes before linearized reading' (duration: 275.954216ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T20:49:57.685573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.916943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-bk4fn\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-12T20:49:57.685795Z","caller":"traceutil/trace.go:171","msg":"trace[706361105] range","detail":"{range_begin:/registry/pods/kube-system/cilium-bk4fn; range_end:; response_count:1; response_revision:577; }","duration":"238.194219ms","start":"2026-04-12T20:49:57.447572Z","end":"2026-04-12T20:49:57.685766Z","steps":["trace[706361105] 'range keys from in-memory index tree' (duration: 237.803862ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T20:49:57.880874Z","caller":"traceutil/trace.go:171","msg":"trace[1803215667] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"169.792455ms","start":"2026-04-12T20:49:57.711046Z","end":"2026-04-12T20:49:57.880838Z","steps":["trace[1803215667] 'process raft request' (duration: 169.095021ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T20:49:57.889273Z","caller":"traceutil/trace.go:171","msg":"trace[827768300] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"170.965379ms","start":"2026-04-12T20:49:57.718274Z","end":"2026-04-12T20:49:57.88924Z","steps":["trace[827768300] 'process raft request' (duration: 170.828267ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T20:50:13.64509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.834405ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-12T20:50:13.645253Z","caller":"traceutil/trace.go:171","msg":"trace[213889882] transaction","detail":"{read_only:false; response_revision:739; number_of_response:1; }","duration":"258.590905ms","start":"2026-04-12T20:50:13.386628Z","end":"2026-04-12T20:50:13.645219Z","steps":["trace[213889882] 'process raft request' (duration: 126.406533ms)","trace[213889882] 'compare' (duration: 131.687482ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T20:50:40.75503Z","caller":"traceutil/trace.go:171","msg":"trace[1670590828] transaction","detail":"{read_only:false; response_revision:1132; number_of_response:1; }","duration":"127.292249ms","start":"2026-04-12T20:50:40.627708Z","end":"2026-04-12T20:50:40.755001Z","steps":["trace[1670590828] 'process raft request' (duration: 127.136736ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T20:51:22.653887Z","caller":"traceutil/trace.go:171","msg":"trace[1278093831] linearizableReadLoop","detail":"{readStateIndex:1846; appliedIndex:1845; }","duration":"153.920323ms","start":"2026-04-12T20:51:22.499901Z","end":"2026-04-12T20:51:22.653821Z","steps":["trace[1278093831] 'read index received' (duration: 153.712119ms)","trace[1278093831] 'applied index is now lower than readState.Index' (duration: 206.564µs)"],"step_count":2} {"level":"info","ts":"2026-04-12T20:51:22.653908Z","caller":"traceutil/trace.go:171","msg":"trace[113304256] transaction","detail":"{read_only:false; response_revision:1774; number_of_response:1; }","duration":"167.121015ms","start":"2026-04-12T20:51:22.486753Z","end":"2026-04-12T20:51:22.653874Z","steps":["trace[113304256] 'process raft request' (duration: 166.89076ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T20:51:22.654406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.165478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-12T20:51:22.654526Z","caller":"traceutil/trace.go:171","msg":"trace[1203874530] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:1774; }","duration":"154.652349ms","start":"2026-04-12T20:51:22.499847Z","end":"2026-04-12T20:51:22.654499Z","steps":["trace[1203874530] 'agreement among raft nodes before linearized reading' (duration: 154.134498ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T20:51:23.057824Z","caller":"traceutil/trace.go:171","msg":"trace[1106432773] transaction","detail":"{read_only:false; response_revision:1776; number_of_response:1; }","duration":"149.171245ms","start":"2026-04-12T20:51:22.908611Z","end":"2026-04-12T20:51:23.057782Z","steps":["trace[1106432773] 'process raft request' (duration: 148.904389ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T20:51:23.126255Z","caller":"traceutil/trace.go:171","msg":"trace[466149603] linearizableReadLoop","detail":"{readStateIndex:1849; appliedIndex:1847; }","duration":"197.499287ms","start":"2026-04-12T20:51:22.928721Z","end":"2026-04-12T20:51:23.12622Z","steps":["trace[466149603] 'read index received' (duration: 128.884158ms)","trace[466149603] 'applied index is now lower than readState.Index' (duration: 68.613899ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T20:51:23.126323Z","caller":"traceutil/trace.go:171","msg":"trace[690595738] transaction","detail":"{read_only:false; response_revision:1777; number_of_response:1; }","duration":"198.778365ms","start":"2026-04-12T20:51:22.927522Z","end":"2026-04-12T20:51:23.1263Z","steps":["trace[690595738] 'process raft request' (duration: 167.613345ms)","trace[690595738] 'compare' (duration: 30.747682ms)"],"step_count":2} {"level":"warn","ts":"2026-04-12T20:51:23.12648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.740643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-12T20:51:23.12717Z","caller":"traceutil/trace.go:171","msg":"trace[383858417] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1777; }","duration":"198.486429ms","start":"2026-04-12T20:51:22.92866Z","end":"2026-04-12T20:51:23.127146Z","steps":["trace[383858417] 'agreement among raft nodes before linearized reading' (duration: 197.713163ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T20:51:23.127165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.896581ms","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-04-12T20:51:23.127316Z","caller":"traceutil/trace.go:171","msg":"trace[484643000] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1777; }","duration":"186.039064ms","start":"2026-04-12T20:51:22.941197Z","end":"2026-04-12T20:51:23.127236Z","steps":["trace[484643000] 'agreement among raft nodes before linearized reading' (duration: 185.784299ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T20:51:38.784452Z","caller":"traceutil/trace.go:171","msg":"trace[704864894] transaction","detail":"{read_only:false; response_revision:1904; number_of_response:1; }","duration":"152.993484ms","start":"2026-04-12T20:51:38.631422Z","end":"2026-04-12T20:51:38.784415Z","steps":["trace[704864894] 'process raft request' (duration: 152.653108ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T20:52:12.624599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.255445ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-12T20:52:12.62472Z","caller":"traceutil/trace.go:171","msg":"trace[1244537366] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2101; }","duration":"188.424019ms","start":"2026-04-12T20:52:12.436271Z","end":"2026-04-12T20:52:12.624695Z","steps":["trace[1244537366] 'range keys from in-memory index tree' (duration: 188.076092ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T20:52:12.749976Z","caller":"traceutil/trace.go:171","msg":"trace[838621306] transaction","detail":"{read_only:false; response_revision:2102; number_of_response:1; }","duration":"121.07006ms","start":"2026-04-12T20:52:12.628888Z","end":"2026-04-12T20:52:12.749958Z","steps":["trace[838621306] 'process raft request' (duration: 120.944018ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T20:53:37.369486Z","caller":"traceutil/trace.go:171","msg":"trace[819281370] transaction","detail":"{read_only:false; response_revision:2749; number_of_response:1; }","duration":"170.38843ms","start":"2026-04-12T20:53:37.199063Z","end":"2026-04-12T20:53:37.369452Z","steps":["trace[819281370] 'process raft request' (duration: 170.183736ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T20:56:13.273256Z","caller":"traceutil/trace.go:171","msg":"trace[2086920056] transaction","detail":"{read_only:false; response_revision:3774; number_of_response:1; }","duration":"115.542664ms","start":"2026-04-12T20:56:13.15768Z","end":"2026-04-12T20:56:13.273223Z","steps":["trace[2086920056] 'process raft request' (duration: 115.32841ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T20:56:13.328851Z","caller":"traceutil/trace.go:171","msg":"trace[976671744] transaction","detail":"{read_only:false; response_revision:3775; number_of_response:1; }","duration":"140.503596ms","start":"2026-04-12T20:56:13.188326Z","end":"2026-04-12T20:56:13.328829Z","steps":["trace[976671744] 'process raft request' (duration: 139.332383ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T20:57:33.122966Z","caller":"traceutil/trace.go:171","msg":"trace[279856906] linearizableReadLoop","detail":"{readStateIndex:5015; appliedIndex:5014; }","duration":"121.086868ms","start":"2026-04-12T20:57:33.001851Z","end":"2026-04-12T20:57:33.122938Z","steps":["trace[279856906] 'read index received' (duration: 80.434166ms)","trace[279856906] 'applied index is now lower than readState.Index' (duration: 40.651812ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T20:57:33.123135Z","caller":"traceutil/trace.go:171","msg":"trace[752940036] transaction","detail":"{read_only:false; response_revision:4827; number_of_response:1; }","duration":"144.038638ms","start":"2026-04-12T20:57:32.979075Z","end":"2026-04-12T20:57:33.123113Z","steps":["trace[752940036] 'process raft request' (duration: 103.236352ms)","trace[752940036] 'compare' (duration: 40.510499ms)"],"step_count":2} {"level":"warn","ts":"2026-04-12T20:57:33.123173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.342674ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1821"} {"level":"info","ts":"2026-04-12T20:57:33.123215Z","caller":"traceutil/trace.go:171","msg":"trace[1027209742] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4827; }","duration":"121.447876ms","start":"2026-04-12T20:57:33.001747Z","end":"2026-04-12T20:57:33.123195Z","steps":["trace[1027209742] 'agreement among raft nodes before linearized reading' (duration: 121.299103ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T20:57:33.327237Z","caller":"traceutil/trace.go:171","msg":"trace[2010748227] transaction","detail":"{read_only:false; response_revision:4829; number_of_response:1; }","duration":"141.474186ms","start":"2026-04-12T20:57:33.185737Z","end":"2026-04-12T20:57:33.327211Z","steps":["trace[2010748227] 'process raft request' (duration: 42.54624ms)","trace[2010748227] 'compare' (duration: 98.813414ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T20:57:36.170605Z","caller":"traceutil/trace.go:171","msg":"trace[1993586487] transaction","detail":"{read_only:false; response_revision:4957; number_of_response:1; }","duration":"167.712079ms","start":"2026-04-12T20:57:36.002857Z","end":"2026-04-12T20:57:36.170569Z","steps":["trace[1993586487] 'process raft request' (duration: 167.517756ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T20:57:55.157245Z","caller":"traceutil/trace.go:171","msg":"trace[1385858995] transaction","detail":"{read_only:false; response_revision:5318; number_of_response:1; }","duration":"114.975476ms","start":"2026-04-12T20:57:55.042233Z","end":"2026-04-12T20:57:55.157208Z","steps":["trace[1385858995] 'process raft request' (duration: 114.740852ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T20:57:55.466073Z","caller":"traceutil/trace.go:171","msg":"trace[726096111] transaction","detail":"{read_only:false; response_revision:5320; number_of_response:1; }","duration":"137.039598ms","start":"2026-04-12T20:57:55.329006Z","end":"2026-04-12T20:57:55.466046Z","steps":["trace[726096111] 'process raft request' (duration: 136.877584ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T20:57:55.663937Z","caller":"traceutil/trace.go:171","msg":"trace[869190006] transaction","detail":"{read_only:false; response_revision:5321; number_of_response:1; }","duration":"158.167501ms","start":"2026-04-12T20:57:55.50574Z","end":"2026-04-12T20:57:55.663908Z","steps":["trace[869190006] 'process raft request' (duration: 149.387126ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T20:59:20.464658Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2989} {"level":"info","ts":"2026-04-12T20:59:20.536988Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2989,"took":"70.70784ms","hash":345693557,"current-db-size-bytes":58736640,"current-db-size":"59 MB","current-db-size-in-use-bytes":33783808,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-04-12T20:59:20.537054Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":345693557,"revision":2989,"compact-revision":-1} {"level":"info","ts":"2026-04-12T21:03:44.087379Z","caller":"traceutil/trace.go:171","msg":"trace[1858898791] transaction","detail":"{read_only:false; response_revision:8100; number_of_response:1; }","duration":"201.376382ms","start":"2026-04-12T21:03:43.885933Z","end":"2026-04-12T21:03:44.087309Z","steps":["trace[1858898791] 'process raft request' (duration: 201.084427ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T21:03:56.04417Z","caller":"traceutil/trace.go:171","msg":"trace[479675828] linearizableReadLoop","detail":"{readStateIndex:8448; appliedIndex:8447; }","duration":"189.123647ms","start":"2026-04-12T21:03:55.855019Z","end":"2026-04-12T21:03:56.044142Z","steps":["trace[479675828] 'read index received' (duration: 188.946023ms)","trace[479675828] 'applied index is now lower than readState.Index' (duration: 176.624µs)"],"step_count":2} {"level":"warn","ts":"2026-04-12T21:03:56.044314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.27624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/queues/\" range_end:\"/registry/rabbitmq.com/queues0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-12T21:03:56.04435Z","caller":"traceutil/trace.go:171","msg":"trace[1283489514] range","detail":"{range_begin:/registry/rabbitmq.com/queues/; range_end:/registry/rabbitmq.com/queues0; response_count:0; response_revision:8160; }","duration":"189.337081ms","start":"2026-04-12T21:03:55.855001Z","end":"2026-04-12T21:03:56.044338Z","steps":["trace[1283489514] 'agreement among raft nodes before linearized reading' (duration: 189.250239ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T21:03:56.044545Z","caller":"traceutil/trace.go:171","msg":"trace[972386725] transaction","detail":"{read_only:false; response_revision:8160; number_of_response:1; }","duration":"244.521976ms","start":"2026-04-12T21:03:55.799988Z","end":"2026-04-12T21:03:56.04451Z","steps":["trace[972386725] 'process raft request' (duration: 243.977774ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T21:03:56.85898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.032172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-04-12T21:03:56.859072Z","caller":"traceutil/trace.go:171","msg":"trace[1964204882] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8164; }","duration":"108.176595ms","start":"2026-04-12T21:03:56.750873Z","end":"2026-04-12T21:03:56.85905Z","steps":["trace[1964204882] 'range keys from in-memory index tree' (duration: 107.830748ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T21:04:20.485181Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6127} {"level":"info","ts":"2026-04-12T21:04:20.583546Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6127,"took":"96.410796ms","hash":3893551457,"current-db-size-bytes":58736640,"current-db-size":"59 MB","current-db-size-in-use-bytes":23232512,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-04-12T21:04:20.583701Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3893551457,"revision":6127,"compact-revision":2989} {"level":"warn","ts":"2026-04-12T21:04:23.75753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.84635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.157\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-12T21:04:23.757605Z","caller":"traceutil/trace.go:171","msg":"trace[955681151] range","detail":"{range_begin:/registry/masterleases/199.204.45.157; range_end:; response_count:1; response_revision:8362; }","duration":"369.964763ms","start":"2026-04-12T21:04:23.387626Z","end":"2026-04-12T21:04:23.757591Z","steps":["trace[955681151] 'range keys from in-memory index tree' (duration: 369.690387ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T21:04:23.757633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T21:04:23.387602Z","time spent":"370.025184ms","remote":"127.0.0.1:43302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.157\" "} {"level":"warn","ts":"2026-04-12T21:04:23.75851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.726931ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-12T21:04:23.758597Z","caller":"traceutil/trace.go:171","msg":"trace[454781373] linearizableReadLoop","detail":"{readStateIndex:8660; appliedIndex:8659; }","duration":"277.27584ms","start":"2026-04-12T21:04:23.481305Z","end":"2026-04-12T21:04:23.758581Z","steps":["trace[454781373] 'read index received' (duration: 95.426146ms)","trace[454781373] 'applied index is now lower than readState.Index' (duration: 181.848084ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T21:04:23.758611Z","caller":"traceutil/trace.go:171","msg":"trace[1225520618] transaction","detail":"{read_only:false; response_revision:8363; number_of_response:1; }","duration":"323.946073ms","start":"2026-04-12T21:04:23.434641Z","end":"2026-04-12T21:04:23.758587Z","steps":["trace[1225520618] 'process raft request' (duration: 142.030238ms)","trace[1225520618] 'compare' (duration: 180.608488ms)"],"step_count":2} {"level":"warn","ts":"2026-04-12T21:04:23.758711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T21:04:23.434608Z","time spent":"324.053846ms","remote":"127.0.0.1:43542","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-12T21:04:23.758743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.432413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-12T21:04:23.758776Z","caller":"traceutil/trace.go:171","msg":"trace[342505512] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8363; }","duration":"277.466194ms","start":"2026-04-12T21:04:23.4813Z","end":"2026-04-12T21:04:23.758767Z","steps":["trace[342505512] 'agreement among raft nodes before linearized reading' (duration: 277.355112ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T21:04:23.758936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.018576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-dgjwm\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-04-12T21:04:23.759001Z","caller":"traceutil/trace.go:171","msg":"trace[193304374] range","detail":"{range_begin:/registry/pods/openstack/keepalived-dgjwm; range_end:; response_count:1; response_revision:8363; }","duration":"262.145639ms","start":"2026-04-12T21:04:23.496841Z","end":"2026-04-12T21:04:23.758987Z","steps":["trace[193304374] 'agreement among raft nodes before linearized reading' (duration: 261.862703ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T21:04:35.773566Z","caller":"traceutil/trace.go:171","msg":"trace[134332155] transaction","detail":"{read_only:false; response_revision:8472; number_of_response:1; }","duration":"157.58203ms","start":"2026-04-12T21:04:35.615956Z","end":"2026-04-12T21:04:35.773538Z","steps":["trace[134332155] 'process raft request' (duration: 157.417897ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T21:04:36.523374Z","caller":"traceutil/trace.go:171","msg":"trace[1153422916] transaction","detail":"{read_only:false; response_revision:8479; number_of_response:1; }","duration":"103.402005ms","start":"2026-04-12T21:04:36.419948Z","end":"2026-04-12T21:04:36.52335Z","steps":["trace[1153422916] 'process raft request' (duration: 103.236432ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T21:05:43.369528Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000024da.wal"} {"level":"info","ts":"2026-04-12T21:05:46.554008Z","caller":"traceutil/trace.go:171","msg":"trace[1694216663] linearizableReadLoop","detail":"{readStateIndex:9451; appliedIndex:9450; }","duration":"231.568387ms","start":"2026-04-12T21:05:46.322413Z","end":"2026-04-12T21:05:46.553981Z","steps":["trace[1694216663] 'read index received' (duration: 166.856004ms)","trace[1694216663] 'applied index is now lower than readState.Index' (duration: 64.710943ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T21:05:46.553991Z","caller":"traceutil/trace.go:171","msg":"trace[274428851] transaction","detail":"{read_only:false; response_revision:9128; number_of_response:1; }","duration":"257.308231ms","start":"2026-04-12T21:05:46.296636Z","end":"2026-04-12T21:05:46.553944Z","steps":["trace[274428851] 'process raft request' (duration: 192.626749ms)","trace[274428851] 'compare' (duration: 64.517859ms)"],"step_count":2} {"level":"warn","ts":"2026-04-12T21:05:46.554347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.915165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-dgjwm\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-04-12T21:05:46.554377Z","caller":"traceutil/trace.go:171","msg":"trace[1794645616] range","detail":"{range_begin:/registry/pods/openstack/keepalived-dgjwm; range_end:; response_count:1; response_revision:9129; }","duration":"232.007776ms","start":"2026-04-12T21:05:46.322361Z","end":"2026-04-12T21:05:46.554368Z","steps":["trace[1794645616] 'agreement among raft nodes before linearized reading' (duration: 231.802412ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T21:05:46.554428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.562217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-12T21:05:46.554517Z","caller":"traceutil/trace.go:171","msg":"trace[211212260] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9129; }","duration":"198.70343ms","start":"2026-04-12T21:05:46.355795Z","end":"2026-04-12T21:05:46.554498Z","steps":["trace[211212260] 'agreement among raft nodes before linearized reading' (duration: 198.528897ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T21:06:47.784447Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"5f170c75a1d97cc","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-12T21:06:47.789794Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-12T21:06:47.789875Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-12T21:09:20.492101Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8346} {"level":"info","ts":"2026-04-12T21:09:20.569696Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8346,"took":"75.147874ms","hash":1619311313,"current-db-size-bytes":58736640,"current-db-size":"59 MB","current-db-size-in-use-bytes":24813568,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-04-12T21:09:20.569755Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1619311313,"revision":8346,"compact-revision":6127} {"level":"info","ts":"2026-04-12T21:14:20.499067Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10736} {"level":"info","ts":"2026-04-12T21:14:20.575447Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10736,"took":"73.96717ms","hash":1807093774,"current-db-size-bytes":58736640,"current-db-size":"59 MB","current-db-size-in-use-bytes":20418560,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-04-12T21:14:20.575506Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1807093774,"revision":10736,"compact-revision":8346}