{"level":"warn","ts":"2026-04-20T04:45:55.330882Z","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-20T04:45:55.330969Z","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-20T04:45:55.331024Z","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-20T04:45:55.331031Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.157:2380"]} {"level":"info","ts":"2026-04-20T04:45:55.331048Z","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-20T04:45:55.331998Z","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-20T04:45:55.332128Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.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-20T04:45:55.336337Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.813103ms"} {"level":"info","ts":"2026-04-20T04:45:55.343234Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5f170c75a1d97cc","cluster-id":"44a3176ec85feb9"} {"level":"info","ts":"2026-04-20T04:45:55.343323Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc switched to configuration voters=()"} {"level":"info","ts":"2026-04-20T04:45:55.343358Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became follower at term 0"} {"level":"info","ts":"2026-04-20T04:45:55.34337Z","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-20T04:45:55.343379Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became follower at term 1"} {"level":"info","ts":"2026-04-20T04:45:55.344448Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc switched to configuration voters=(428247441089599436)"} {"level":"warn","ts":"2026-04-20T04:45:55.3514Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-20T04:45:55.353044Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-20T04:45:55.353906Z","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-20T04:45:55.362225Z","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-20T04:45:55.362331Z","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-20T04:45:55.36258Z","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-20T04:45:55.362656Z","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-20T04:45:55.362678Z","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-20T04:45:55.363744Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc switched to configuration voters=(428247441089599436)"} {"level":"info","ts":"2026-04-20T04:45:55.365365Z","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-20T04:45:55.373118Z","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-20T04:45:55.373347Z","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-20T04:45:55.373393Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-20T04:45:55.373363Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.157:2380"} {"level":"info","ts":"2026-04-20T04:45:55.373447Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.157:2380"} {"level":"info","ts":"2026-04-20T04:45:55.645605Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc is starting a new election at term 1"} {"level":"info","ts":"2026-04-20T04:45:55.645698Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became pre-candidate at term 1"} {"level":"info","ts":"2026-04-20T04:45:55.646123Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc received MsgPreVoteResp from 5f170c75a1d97cc at term 1"} {"level":"info","ts":"2026-04-20T04:45:55.646187Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became candidate at term 2"} {"level":"info","ts":"2026-04-20T04:45:55.646203Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc received MsgVoteResp from 5f170c75a1d97cc at term 2"} {"level":"info","ts":"2026-04-20T04:45:55.646219Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became leader at term 2"} {"level":"info","ts":"2026-04-20T04:45:55.646362Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5f170c75a1d97cc elected leader 5f170c75a1d97cc at term 2"} {"level":"info","ts":"2026-04-20T04:45:55.647247Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T04:45:55.648023Z","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-20T04:45:55.648254Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T04:45:55.648337Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T04:45:55.648524Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-20T04:45:55.648583Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-20T04:45:55.649797Z","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-20T04:45:55.650862Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T04:45:55.650927Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T04:45:55.651646Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-20T04:45:55.651982Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.157:2379"} {"level":"info","ts":"2026-04-20T04:46:27.131379Z","caller":"traceutil/trace.go:171","msg":"trace[345841449] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"169.758664ms","start":"2026-04-20T04:46:26.961586Z","end":"2026-04-20T04:46:27.131345Z","steps":["trace[345841449] 'process raft request' (duration: 169.572332ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:46:27.164819Z","caller":"traceutil/trace.go:171","msg":"trace[1029554799] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"197.184981ms","start":"2026-04-20T04:46:26.967606Z","end":"2026-04-20T04:46:27.164791Z","steps":["trace[1029554799] 'process raft request' (duration: 196.811917ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:46:27.164832Z","caller":"traceutil/trace.go:171","msg":"trace[1581942912] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"196.738996ms","start":"2026-04-20T04:46:26.96806Z","end":"2026-04-20T04:46:27.164799Z","steps":["trace[1581942912] 'process raft request' (duration: 196.472923ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:46:27.164919Z","caller":"traceutil/trace.go:171","msg":"trace[157712967] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"188.555893ms","start":"2026-04-20T04:46:26.976339Z","end":"2026-04-20T04:46:27.164895Z","steps":["trace[157712967] 'process raft request' (duration: 188.390871ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:46:27.165029Z","caller":"traceutil/trace.go:171","msg":"trace[667774470] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"188.868397ms","start":"2026-04-20T04:46:26.976125Z","end":"2026-04-20T04:46:27.164993Z","steps":["trace[667774470] 'process raft request' (duration: 188.567263ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:46:27.165067Z","caller":"traceutil/trace.go:171","msg":"trace[2087172771] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"184.468602ms","start":"2026-04-20T04:46:26.980587Z","end":"2026-04-20T04:46:27.165056Z","steps":["trace[2087172771] 'process raft request' (duration: 184.221739ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:46:27.165094Z","caller":"traceutil/trace.go:171","msg":"trace[977467697] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"173.00707ms","start":"2026-04-20T04:46:26.992075Z","end":"2026-04-20T04:46:27.165082Z","steps":["trace[977467697] 'process raft request' (duration: 172.773277ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:46:27.165096Z","caller":"traceutil/trace.go:171","msg":"trace[1754479712] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"136.582408ms","start":"2026-04-20T04:46:27.028486Z","end":"2026-04-20T04:46:27.165068Z","steps":["trace[1754479712] 'process raft request' (duration: 136.529557ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:46:27.165124Z","caller":"traceutil/trace.go:171","msg":"trace[310855859] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"150.847424ms","start":"2026-04-20T04:46:27.014238Z","end":"2026-04-20T04:46:27.165085Z","steps":["trace[310855859] 'process raft request' (duration: 150.669742ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:46:27.165161Z","caller":"traceutil/trace.go:171","msg":"trace[1674930186] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"185.166791ms","start":"2026-04-20T04:46:26.979978Z","end":"2026-04-20T04:46:27.165145Z","steps":["trace[1674930186] 'process raft request' (duration: 184.792727ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:46:27.165172Z","caller":"traceutil/trace.go:171","msg":"trace[61160063] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"148.687517ms","start":"2026-04-20T04:46:27.016477Z","end":"2026-04-20T04:46:27.165164Z","steps":["trace[61160063] 'process raft request' (duration: 148.486234ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:46:27.363317Z","caller":"traceutil/trace.go:171","msg":"trace[1329359046] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"175.404307ms","start":"2026-04-20T04:46:27.187885Z","end":"2026-04-20T04:46:27.363289Z","steps":["trace[1329359046] 'process raft request' (duration: 161.256872ms)","trace[1329359046] 'compare' (duration: 13.891562ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T04:46:27.363498Z","caller":"traceutil/trace.go:171","msg":"trace[1019638300] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"173.860447ms","start":"2026-04-20T04:46:27.189594Z","end":"2026-04-20T04:46:27.363455Z","steps":["trace[1019638300] 'process raft request' (duration: 173.700675ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:46:27.363579Z","caller":"traceutil/trace.go:171","msg":"trace[559805174] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"168.822325ms","start":"2026-04-20T04:46:27.194716Z","end":"2026-04-20T04:46:27.363538Z","steps":["trace[559805174] 'process raft request' (duration: 168.658273ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:46:27.363529Z","caller":"traceutil/trace.go:171","msg":"trace[756597080] linearizableReadLoop","detail":"{readStateIndex:565; appliedIndex:559; }","duration":"149.045931ms","start":"2026-04-20T04:46:27.214433Z","end":"2026-04-20T04:46:27.363479Z","steps":["trace[756597080] 'read index received' (duration: 134.610962ms)","trace[756597080] 'applied index is now lower than readState.Index' (duration: 14.434139ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T04:46:27.363644Z","caller":"traceutil/trace.go:171","msg":"trace[1849206528] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"159.011994ms","start":"2026-04-20T04:46:27.204624Z","end":"2026-04-20T04:46:27.363636Z","steps":["trace[1849206528] 'process raft request' (duration: 158.809572ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:46:27.36365Z","caller":"traceutil/trace.go:171","msg":"trace[689426028] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"175.704951ms","start":"2026-04-20T04:46:27.187935Z","end":"2026-04-20T04:46:27.36364Z","steps":["trace[689426028] 'process raft request' (duration: 175.215745ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:46:27.363655Z","caller":"traceutil/trace.go:171","msg":"trace[1585178740] transaction","detail":"{read_only:false; number_of_response:0; response_revision:541; }","duration":"173.554073ms","start":"2026-04-20T04:46:27.190079Z","end":"2026-04-20T04:46:27.363633Z","steps":["trace[1585178740] 'process raft request' (duration: 173.26848ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:46:27.363754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.249053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/v1beta1.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:1010"} {"level":"info","ts":"2026-04-20T04:46:27.363839Z","caller":"traceutil/trace.go:171","msg":"trace[1350076143] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/v1beta1.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:543; }","duration":"149.424465ms","start":"2026-04-20T04:46:27.2144Z","end":"2026-04-20T04:46:27.363825Z","steps":["trace[1350076143] 'agreement among raft nodes before linearized reading' (duration: 149.160232ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:46:27.36397Z","caller":"traceutil/trace.go:171","msg":"trace[1039755536] transaction","detail":"{read_only:false; number_of_response:0; response_revision:543; }","duration":"148.624225ms","start":"2026-04-20T04:46:27.215337Z","end":"2026-04-20T04:46:27.363961Z","steps":["trace[1039755536] 'process raft request' (duration: 148.488284ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:46:27.364093Z","caller":"traceutil/trace.go:171","msg":"trace[169004034] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"128.076002ms","start":"2026-04-20T04:46:27.236005Z","end":"2026-04-20T04:46:27.364081Z","steps":["trace[169004034] 'process raft request' (duration: 128.036341ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:46:27.364145Z","caller":"traceutil/trace.go:171","msg":"trace[1591912113] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"136.136251ms","start":"2026-04-20T04:46:27.227996Z","end":"2026-04-20T04:46:27.364132Z","steps":["trace[1591912113] 'process raft request' (duration: 135.874768ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:46:27.364156Z","caller":"traceutil/trace.go:171","msg":"trace[1950133445] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"128.899332ms","start":"2026-04-20T04:46:27.23524Z","end":"2026-04-20T04:46:27.36414Z","steps":["trace[1950133445] 'process raft request' (duration: 128.73518ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:46:33.410822Z","caller":"traceutil/trace.go:171","msg":"trace[1324572097] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"241.566274ms","start":"2026-04-20T04:46:33.169218Z","end":"2026-04-20T04:46:33.410784Z","steps":["trace[1324572097] 'process raft request' (duration: 235.415982ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:46:34.087083Z","caller":"traceutil/trace.go:171","msg":"trace[1044502377] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"374.350841ms","start":"2026-04-20T04:46:33.712705Z","end":"2026-04-20T04:46:34.087056Z","steps":["trace[1044502377] 'process raft request' (duration: 354.77444ms)","trace[1044502377] 'compare' (duration: 19.277778ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T04:46:34.087823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T04:46:33.712686Z","time spent":"374.471502ms","remote":"127.0.0.1:52616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T04:46:34.08853Z","caller":"traceutil/trace.go:171","msg":"trace[683764266] linearizableReadLoop","detail":"{readStateIndex:656; appliedIndex:654; }","duration":"257.501624ms","start":"2026-04-20T04:46:33.831008Z","end":"2026-04-20T04:46:34.088509Z","steps":["trace[683764266] 'read index received' (duration: 236.520536ms)","trace[683764266] 'applied index is now lower than readState.Index' (duration: 20.980198ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T04:46:34.089184Z","caller":"traceutil/trace.go:171","msg":"trace[193403323] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"274.440857ms","start":"2026-04-20T04:46:33.814727Z","end":"2026-04-20T04:46:34.089168Z","steps":["trace[193403323] 'process raft request' (duration: 273.046121ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:46:34.089294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.270322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-20T04:46:34.08935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.784308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-z5ssg\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-20T04:46:34.089403Z","caller":"traceutil/trace.go:171","msg":"trace[675174041] range","detail":"{range_begin:/registry/pods/kube-system/cilium-z5ssg; range_end:; response_count:1; response_revision:631; }","duration":"237.855819ms","start":"2026-04-20T04:46:33.851529Z","end":"2026-04-20T04:46:34.089384Z","steps":["trace[675174041] 'agreement among raft nodes before linearized reading' (duration: 237.732938ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:46:34.089406Z","caller":"traceutil/trace.go:171","msg":"trace[601321255] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:631; }","duration":"258.418353ms","start":"2026-04-20T04:46:33.830957Z","end":"2026-04-20T04:46:34.089375Z","steps":["trace[601321255] 'agreement among raft nodes before linearized reading' (duration: 258.173991ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:48:08.832923Z","caller":"traceutil/trace.go:171","msg":"trace[1760278743] linearizableReadLoop","detail":"{readStateIndex:1941; appliedIndex:1940; }","duration":"240.594973ms","start":"2026-04-20T04:48:08.592296Z","end":"2026-04-20T04:48:08.832891Z","steps":["trace[1760278743] 'read index received' (duration: 240.318089ms)","trace[1760278743] 'applied index is now lower than readState.Index' (duration: 275.844µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T04:48:08.832955Z","caller":"traceutil/trace.go:171","msg":"trace[1991241650] transaction","detail":"{read_only:false; response_revision:1865; number_of_response:1; }","duration":"246.89258ms","start":"2026-04-20T04:48:08.586029Z","end":"2026-04-20T04:48:08.832922Z","steps":["trace[1991241650] 'process raft request' (duration: 246.690627ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:48:08.833188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.871439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-20T04:48:08.833226Z","caller":"traceutil/trace.go:171","msg":"trace[719820878] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1865; }","duration":"240.980471ms","start":"2026-04-20T04:48:08.592232Z","end":"2026-04-20T04:48:08.833213Z","steps":["trace[719820878] 'agreement among raft nodes before linearized reading' (duration: 240.814028ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:48:08.83323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.712596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-20T04:48:08.833235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.894863ms","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-04-20T04:48:08.833272Z","caller":"traceutil/trace.go:171","msg":"trace[1648012606] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1865; }","duration":"209.793087ms","start":"2026-04-20T04:48:08.623464Z","end":"2026-04-20T04:48:08.833257Z","steps":["trace[1648012606] 'agreement among raft nodes before linearized reading' (duration: 209.654255ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:48:08.833295Z","caller":"traceutil/trace.go:171","msg":"trace[1565823130] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1865; }","duration":"240.025805ms","start":"2026-04-20T04:48:08.593256Z","end":"2026-04-20T04:48:08.833282Z","steps":["trace[1565823130] 'agreement among raft nodes before linearized reading' (duration: 239.819241ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:48:42.685264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.144353ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-20T04:48:42.685377Z","caller":"traceutil/trace.go:171","msg":"trace[452203642] linearizableReadLoop","detail":"{readStateIndex:2191; appliedIndex:2190; }","duration":"157.447657ms","start":"2026-04-20T04:48:42.527909Z","end":"2026-04-20T04:48:42.685356Z","steps":["trace[452203642] 'read index received' (duration: 43.081µs)","trace[452203642] 'applied index is now lower than readState.Index' (duration: 157.402906ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T04:48:42.685572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.660449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-20T04:48:42.685602Z","caller":"traceutil/trace.go:171","msg":"trace[1523907322] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2107; }","duration":"157.7325ms","start":"2026-04-20T04:48:42.52786Z","end":"2026-04-20T04:48:42.685593Z","steps":["trace[1523907322] 'agreement among raft nodes before linearized reading' (duration: 157.553697ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:48:42.685713Z","caller":"traceutil/trace.go:171","msg":"trace[1443043666] transaction","detail":"{read_only:false; response_revision:2107; number_of_response:1; }","duration":"204.051969ms","start":"2026-04-20T04:48:42.481631Z","end":"2026-04-20T04:48:42.685683Z","steps":["trace[1443043666] 'process raft request' (duration: 29.297218ms)","trace[1443043666] 'compare' (duration: 173.775738ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T04:53:10.441782Z","caller":"traceutil/trace.go:171","msg":"trace[1982969694] linearizableReadLoop","detail":"{readStateIndex:3932; appliedIndex:3931; }","duration":"134.246019ms","start":"2026-04-20T04:53:10.307503Z","end":"2026-04-20T04:53:10.441749Z","steps":["trace[1982969694] 'read index received' (duration: 53.355988ms)","trace[1982969694] 'applied index is now lower than readState.Index' (duration: 80.888691ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T04:53:10.441891Z","caller":"traceutil/trace.go:171","msg":"trace[1006925106] transaction","detail":"{read_only:false; response_revision:3783; number_of_response:1; }","duration":"139.068535ms","start":"2026-04-20T04:53:10.302783Z","end":"2026-04-20T04:53:10.441851Z","steps":["trace[1006925106] 'process raft request' (duration: 58.290646ms)","trace[1006925106] 'compare' (duration: 80.32618ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T04:53:10.442027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.402023ms","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-04-20T04:53:10.442098Z","caller":"traceutil/trace.go:171","msg":"trace[1621507837] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretimports/; range_end:/registry/secretgen.carvel.dev/secretimports0; response_count:0; response_revision:3783; }","duration":"134.625617ms","start":"2026-04-20T04:53:10.307457Z","end":"2026-04-20T04:53:10.442082Z","steps":["trace[1621507837] 'agreement among raft nodes before linearized reading' (duration: 134.403553ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:53:10.443796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.544039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/prometheusrules.monitoring.coreos.com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T04:53:10.443853Z","caller":"traceutil/trace.go:171","msg":"trace[1541780630] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/prometheusrules.monitoring.coreos.com; range_end:; response_count:0; response_revision:3784; }","duration":"135.638011ms","start":"2026-04-20T04:53:10.3082Z","end":"2026-04-20T04:53:10.443838Z","steps":["trace[1541780630] 'agreement among raft nodes before linearized reading' (duration: 135.486998ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:54:05.492591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.260133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1285"} {"level":"info","ts":"2026-04-20T04:54:05.492871Z","caller":"traceutil/trace.go:171","msg":"trace[1608980954] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:4676; }","duration":"114.558048ms","start":"2026-04-20T04:54:05.378287Z","end":"2026-04-20T04:54:05.492845Z","steps":["trace[1608980954] 'agreement among raft nodes before linearized reading' (duration: 114.149401ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:54:06.176594Z","caller":"traceutil/trace.go:171","msg":"trace[936131863] transaction","detail":"{read_only:false; response_revision:4693; number_of_response:1; }","duration":"120.02064ms","start":"2026-04-20T04:54:06.056531Z","end":"2026-04-20T04:54:06.176552Z","steps":["trace[936131863] 'process raft request' (duration: 119.837067ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:54:06.456881Z","caller":"traceutil/trace.go:171","msg":"trace[1827724689] transaction","detail":"{read_only:false; response_revision:4701; number_of_response:1; }","duration":"140.925135ms","start":"2026-04-20T04:54:06.315931Z","end":"2026-04-20T04:54:06.456856Z","steps":["trace[1827724689] 'process raft request' (duration: 140.623858ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:54:06.599871Z","caller":"traceutil/trace.go:171","msg":"trace[1639977512] transaction","detail":"{read_only:false; response_revision:4702; number_of_response:1; }","duration":"138.992499ms","start":"2026-04-20T04:54:06.460848Z","end":"2026-04-20T04:54:06.599841Z","steps":["trace[1639977512] 'process raft request' (duration: 79.39891ms)","trace[1639977512] 'compare' (duration: 59.473547ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T04:54:06.747254Z","caller":"traceutil/trace.go:171","msg":"trace[490271675] transaction","detail":"{read_only:false; response_revision:4706; number_of_response:1; }","duration":"126.408618ms","start":"2026-04-20T04:54:06.620819Z","end":"2026-04-20T04:54:06.747227Z","steps":["trace[490271675] 'process raft request' (duration: 126.253576ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:54:17.527418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.291028ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-20T04:54:17.527791Z","caller":"traceutil/trace.go:171","msg":"trace[287183631] linearizableReadLoop","detail":"{readStateIndex:5049; appliedIndex:5047; }","duration":"292.186686ms","start":"2026-04-20T04:54:17.235572Z","end":"2026-04-20T04:54:17.527759Z","steps":["trace[287183631] 'read index received' (duration: 117.493922ms)","trace[287183631] 'applied index is now lower than readState.Index' (duration: 174.691674ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T04:54:17.52787Z","caller":"traceutil/trace.go:171","msg":"trace[1579846898] transaction","detail":"{read_only:false; response_revision:4863; number_of_response:1; }","duration":"315.615242ms","start":"2026-04-20T04:54:17.212244Z","end":"2026-04-20T04:54:17.527859Z","steps":["trace[1579846898] 'process raft request' (duration: 315.308166ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:54:17.528093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T04:54:17.212222Z","time spent":"315.673433ms","remote":"127.0.0.1:52616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T04:54:17.528088Z","caller":"traceutil/trace.go:171","msg":"trace[1129439780] transaction","detail":"{read_only:false; response_revision:4862; number_of_response:1; }","duration":"346.266975ms","start":"2026-04-20T04:54:17.181774Z","end":"2026-04-20T04:54:17.528041Z","steps":["trace[1129439780] 'process raft request' (duration: 171.277304ms)","trace[1129439780] 'compare' (duration: 173.748109ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T04:54:17.528282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T04:54:17.181757Z","time spent":"346.436878ms","remote":"127.0.0.1:52458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":794,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T04:54:17.528455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.850809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-04-20T04:54:17.528564Z","caller":"traceutil/trace.go:171","msg":"trace[98485792] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4864; }","duration":"293.008212ms","start":"2026-04-20T04:54:17.235528Z","end":"2026-04-20T04:54:17.528536Z","steps":["trace[98485792] 'agreement among raft nodes before linearized reading' (duration: 292.30822ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:55:56.116987Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2930} {"level":"info","ts":"2026-04-20T04:55:56.184284Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2930,"took":"66.073645ms","hash":3279709937,"current-db-size-bytes":54292480,"current-db-size":"54 MB","current-db-size-in-use-bytes":29499392,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-04-20T04:55:56.18466Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3279709937,"revision":2930,"compact-revision":-1} {"level":"info","ts":"2026-04-20T05:00:56.14396Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5649} {"level":"info","ts":"2026-04-20T05:00:56.267577Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5649,"took":"121.984464ms","hash":2898889318,"current-db-size-bytes":54292480,"current-db-size":"54 MB","current-db-size-in-use-bytes":18182144,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-04-20T05:00:56.267643Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2898889318,"revision":5649,"compact-revision":2930}