{"level":"warn","ts":"2026-04-17T00:31:50.78694Z","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-17T00:31:50.787033Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.156: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.156:2380","--initial-cluster=instance=https://199.204.45.156:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.156:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.156: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-17T00:31:50.787239Z","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-17T00:31:50.787257Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.156:2380"]} {"level":"info","ts":"2026-04-17T00:31:50.787293Z","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-17T00:31:50.787986Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"]} {"level":"info","ts":"2026-04-17T00:31:50.788136Z","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.156:2380"],"listen-peer-urls":["https://199.204.45.156:2380"],"advertise-client-urls":["https://199.204.45.156:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.156: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-17T00:31:50.792573Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.188305ms"} {"level":"info","ts":"2026-04-17T00:31:50.799125Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5ac240a6daec2148","cluster-id":"62163637a46c33c2"} {"level":"info","ts":"2026-04-17T00:31:50.799233Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=()"} {"level":"info","ts":"2026-04-17T00:31:50.799257Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became follower at term 0"} {"level":"info","ts":"2026-04-17T00:31:50.799267Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5ac240a6daec2148 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-17T00:31:50.799275Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became follower at term 1"} {"level":"info","ts":"2026-04-17T00:31:50.799358Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=(6539860694277038408)"} {"level":"warn","ts":"2026-04-17T00:31:50.805311Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-17T00:31:50.807942Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-17T00:31:50.809713Z","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-17T00:31:50.812664Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5ac240a6daec2148","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-17T00:31:50.812809Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5ac240a6daec2148","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-17T00:31:50.812957Z","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-17T00:31:50.813034Z","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-17T00:31:50.813045Z","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-17T00:31:50.816514Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=(6539860694277038408)"} {"level":"info","ts":"2026-04-17T00:31:50.816781Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"62163637a46c33c2","local-member-id":"5ac240a6daec2148","added-peer-id":"5ac240a6daec2148","added-peer-peer-urls":["https://199.204.45.156:2380"]} {"level":"info","ts":"2026-04-17T00:31:50.820208Z","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-17T00:31:50.820378Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.156:2380"} {"level":"info","ts":"2026-04-17T00:31:50.820416Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.156:2380"} {"level":"info","ts":"2026-04-17T00:31:50.820773Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5ac240a6daec2148","initial-advertise-peer-urls":["https://199.204.45.156:2380"],"listen-peer-urls":["https://199.204.45.156:2380"],"advertise-client-urls":["https://199.204.45.156:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-17T00:31:50.820847Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-17T00:31:50.999848Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 is starting a new election at term 1"} {"level":"info","ts":"2026-04-17T00:31:50.999914Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-17T00:31:50.999944Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 received MsgPreVoteResp from 5ac240a6daec2148 at term 1"} {"level":"info","ts":"2026-04-17T00:31:50.999962Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became candidate at term 2"} {"level":"info","ts":"2026-04-17T00:31:50.99997Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 received MsgVoteResp from 5ac240a6daec2148 at term 2"} {"level":"info","ts":"2026-04-17T00:31:50.999983Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became leader at term 2"} {"level":"info","ts":"2026-04-17T00:31:50.999994Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5ac240a6daec2148 elected leader 5ac240a6daec2148 at term 2"} {"level":"info","ts":"2026-04-17T00:31:51.000756Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-17T00:31:51.000924Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5ac240a6daec2148","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.156:2379]}","request-path":"/0/members/5ac240a6daec2148/attributes","cluster-id":"62163637a46c33c2","publish-timeout":"7s"} {"level":"info","ts":"2026-04-17T00:31:51.000954Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-17T00:31:51.001142Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-17T00:31:51.001226Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-17T00:31:51.001268Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-17T00:31:51.00366Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.156:2379"} {"level":"info","ts":"2026-04-17T00:31:51.005006Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-17T00:31:51.005319Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"62163637a46c33c2","local-member-id":"5ac240a6daec2148","cluster-version":"3.5"} {"level":"info","ts":"2026-04-17T00:31:51.005499Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-17T00:31:51.005576Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-17T00:32:17.06173Z","caller":"traceutil/trace.go:171","msg":"trace[880481053] linearizableReadLoop","detail":"{readStateIndex:482; appliedIndex:481; }","duration":"132.910324ms","start":"2026-04-17T00:32:16.928798Z","end":"2026-04-17T00:32:17.061708Z","steps":["trace[880481053] 'read index received' (duration: 132.738521ms)","trace[880481053] 'applied index is now lower than readState.Index' (duration: 170.913µs)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:32:17.061985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.159409ms","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-17T00:32:17.062065Z","caller":"traceutil/trace.go:171","msg":"trace[947914809] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:466; }","duration":"133.282972ms","start":"2026-04-17T00:32:16.928769Z","end":"2026-04-17T00:32:17.062052Z","steps":["trace[947914809] 'agreement among raft nodes before linearized reading' (duration: 133.063268ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:32:17.06204Z","caller":"traceutil/trace.go:171","msg":"trace[1473325644] transaction","detail":"{read_only:false; response_revision:466; number_of_response:1; }","duration":"218.437729ms","start":"2026-04-17T00:32:16.84356Z","end":"2026-04-17T00:32:17.061997Z","steps":["trace[1473325644] 'process raft request' (duration: 218.033391ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:32:27.859405Z","caller":"traceutil/trace.go:171","msg":"trace[253223554] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"233.173568ms","start":"2026-04-17T00:32:27.626172Z","end":"2026-04-17T00:32:27.859346Z","steps":["trace[253223554] 'process raft request' (duration: 232.557945ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:32:28.304421Z","caller":"traceutil/trace.go:171","msg":"trace[58830153] linearizableReadLoop","detail":"{readStateIndex:638; appliedIndex:637; }","duration":"192.116038ms","start":"2026-04-17T00:32:28.112285Z","end":"2026-04-17T00:32:28.304401Z","steps":["trace[58830153] 'read index received' (duration: 192.032026ms)","trace[58830153] 'applied index is now lower than readState.Index' (duration: 83.332µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:32:28.304531Z","caller":"traceutil/trace.go:171","msg":"trace[1211376660] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"386.891078ms","start":"2026-04-17T00:32:27.917601Z","end":"2026-04-17T00:32:28.304493Z","steps":["trace[1211376660] 'process raft request' (duration: 386.692684ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:32:28.304649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.347302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-7zzxc\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-17T00:32:28.304709Z","caller":"traceutil/trace.go:171","msg":"trace[1217621002] range","detail":"{range_begin:/registry/pods/kube-system/cilium-7zzxc; range_end:; response_count:1; response_revision:617; }","duration":"192.463624ms","start":"2026-04-17T00:32:28.112228Z","end":"2026-04-17T00:32:28.304692Z","steps":["trace[1217621002] 'agreement among raft nodes before linearized reading' (duration: 192.25508ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:32:28.305124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:32:27.917572Z","time spent":"387.047601ms","remote":"127.0.0.1:44720","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-17T00:32:44.871174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.537727ms","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-17T00:32:44.871309Z","caller":"traceutil/trace.go:171","msg":"trace[80137193] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:785; }","duration":"128.68811ms","start":"2026-04-17T00:32:44.742602Z","end":"2026-04-17T00:32:44.87129Z","steps":["trace[80137193] 'range keys from in-memory index tree' (duration: 128.349644ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:33:11.216565Z","caller":"traceutil/trace.go:171","msg":"trace[394037787] transaction","detail":"{read_only:false; response_revision:1172; number_of_response:1; }","duration":"200.685008ms","start":"2026-04-17T00:33:11.015848Z","end":"2026-04-17T00:33:11.216533Z","steps":["trace[394037787] 'process raft request' (duration: 199.887133ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:33:11.218147Z","caller":"traceutil/trace.go:171","msg":"trace[361112765] transaction","detail":"{read_only:false; response_revision:1173; number_of_response:1; }","duration":"202.212699ms","start":"2026-04-17T00:33:11.015902Z","end":"2026-04-17T00:33:11.218115Z","steps":["trace[361112765] 'process raft request' (duration: 201.2215ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:33:58.432164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.254504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-17T00:33:58.432284Z","caller":"traceutil/trace.go:171","msg":"trace[30521621] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1851; }","duration":"186.448758ms","start":"2026-04-17T00:33:58.245808Z","end":"2026-04-17T00:33:58.432257Z","steps":["trace[30521621] 'range keys from in-memory index tree' (duration: 185.992859ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:33:58.499355Z","caller":"traceutil/trace.go:171","msg":"trace[855248983] linearizableReadLoop","detail":"{readStateIndex:1919; appliedIndex:1918; }","duration":"169.24433ms","start":"2026-04-17T00:33:58.330079Z","end":"2026-04-17T00:33:58.499324Z","steps":["trace[855248983] 'read index received' (duration: 169.159888ms)","trace[855248983] 'applied index is now lower than readState.Index' (duration: 82.472µs)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:33:58.499676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.537015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T00:33:58.499734Z","caller":"traceutil/trace.go:171","msg":"trace[451705054] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1852; }","duration":"169.691159ms","start":"2026-04-17T00:33:58.330026Z","end":"2026-04-17T00:33:58.499717Z","steps":["trace[451705054] 'agreement among raft nodes before linearized reading' (duration: 169.491566ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:33:58.499919Z","caller":"traceutil/trace.go:171","msg":"trace[351473611] transaction","detail":"{read_only:false; response_revision:1852; number_of_response:1; }","duration":"228.310438ms","start":"2026-04-17T00:33:58.271565Z","end":"2026-04-17T00:33:58.499876Z","steps":["trace[351473611] 'process raft request' (duration: 227.539134ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:33:58.509453Z","caller":"traceutil/trace.go:171","msg":"trace[1182950299] transaction","detail":"{read_only:false; response_revision:1853; number_of_response:1; }","duration":"177.3669ms","start":"2026-04-17T00:33:58.33205Z","end":"2026-04-17T00:33:58.509417Z","steps":["trace[1182950299] 'process raft request' (duration: 177.188656ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:34:48.069922Z","caller":"traceutil/trace.go:171","msg":"trace[1502339620] linearizableReadLoop","detail":"{readStateIndex:2249; appliedIndex:2248; }","duration":"136.235677ms","start":"2026-04-17T00:34:47.93366Z","end":"2026-04-17T00:34:48.069896Z","steps":["trace[1502339620] 'read index received' (duration: 75.894018ms)","trace[1502339620] 'applied index is now lower than readState.Index' (duration: 60.340369ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:34:48.069957Z","caller":"traceutil/trace.go:171","msg":"trace[307782373] transaction","detail":"{read_only:false; response_revision:2171; number_of_response:1; }","duration":"152.088889ms","start":"2026-04-17T00:34:47.917835Z","end":"2026-04-17T00:34:48.069924Z","steps":["trace[307782373] 'process raft request' (duration: 91.77756ms)","trace[307782373] 'compare' (duration: 60.152996ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:34:48.070211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.528993ms","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-04-17T00:34:48.07025Z","caller":"traceutil/trace.go:171","msg":"trace[651727482] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2171; }","duration":"136.655835ms","start":"2026-04-17T00:34:47.933583Z","end":"2026-04-17T00:34:48.070239Z","steps":["trace[651727482] 'agreement among raft nodes before linearized reading' (duration: 136.41831ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:34:48.849728Z","caller":"traceutil/trace.go:171","msg":"trace[189803818] transaction","detail":"{read_only:false; response_revision:2174; number_of_response:1; }","duration":"162.542946ms","start":"2026-04-17T00:34:48.68709Z","end":"2026-04-17T00:34:48.849633Z","steps":["trace[189803818] 'process raft request' (duration: 123.149749ms)","trace[189803818] 'compare' (duration: 38.764895ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:36:17.895931Z","caller":"traceutil/trace.go:171","msg":"trace[393097029] transaction","detail":"{read_only:false; response_revision:2847; number_of_response:1; }","duration":"175.629952ms","start":"2026-04-17T00:36:17.720266Z","end":"2026-04-17T00:36:17.895896Z","steps":["trace[393097029] 'process raft request' (duration: 111.110498ms)","trace[393097029] 'compare' (duration: 64.382671ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:36:18.22588Z","caller":"traceutil/trace.go:171","msg":"trace[1746773356] transaction","detail":"{read_only:false; response_revision:2848; number_of_response:1; }","duration":"131.686151ms","start":"2026-04-17T00:36:18.094161Z","end":"2026-04-17T00:36:18.225848Z","steps":["trace[1746773356] 'process raft request' (duration: 131.488397ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:36:18.396117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.217576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-17T00:36:18.396235Z","caller":"traceutil/trace.go:171","msg":"trace[294642009] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2848; }","duration":"143.38953ms","start":"2026-04-17T00:36:18.252823Z","end":"2026-04-17T00:36:18.396213Z","steps":["trace[294642009] 'range keys from in-memory index tree' (duration: 143.010222ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:36:18.396175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.104194ms","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-17T00:36:18.396401Z","caller":"traceutil/trace.go:171","msg":"trace[1300742049] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2848; }","duration":"143.376429ms","start":"2026-04-17T00:36:18.252973Z","end":"2026-04-17T00:36:18.39635Z","steps":["trace[1300742049] 'range keys from in-memory index tree' (duration: 142.90125ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:40:11.793387Z","caller":"traceutil/trace.go:171","msg":"trace[509331617] linearizableReadLoop","detail":"{readStateIndex:5057; appliedIndex:5055; }","duration":"120.092103ms","start":"2026-04-17T00:40:11.673269Z","end":"2026-04-17T00:40:11.793361Z","steps":["trace[509331617] 'read index received' (duration: 30.208857ms)","trace[509331617] 'applied index is now lower than readState.Index' (duration: 89.882346ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:40:11.793441Z","caller":"traceutil/trace.go:171","msg":"trace[1227974879] transaction","detail":"{read_only:false; response_revision:4872; number_of_response:1; }","duration":"121.390589ms","start":"2026-04-17T00:40:11.672014Z","end":"2026-04-17T00:40:11.793404Z","steps":["trace[1227974879] 'process raft request' (duration: 120.877299ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:40:11.7936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.309897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-17T00:40:11.793656Z","caller":"traceutil/trace.go:171","msg":"trace[565836137] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4872; }","duration":"120.400539ms","start":"2026-04-17T00:40:11.673248Z","end":"2026-04-17T00:40:11.793648Z","steps":["trace[565836137] 'agreement among raft nodes before linearized reading' (duration: 120.240946ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:40:11.793782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.622702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-17T00:40:11.793828Z","caller":"traceutil/trace.go:171","msg":"trace[2052447132] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4872; }","duration":"107.701254ms","start":"2026-04-17T00:40:11.686115Z","end":"2026-04-17T00:40:11.793817Z","steps":["trace[2052447132] 'agreement among raft nodes before linearized reading' (duration: 107.542111ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:40:15.110931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.835924ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T00:40:15.111107Z","caller":"traceutil/trace.go:171","msg":"trace[1202588462] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:5011; }","duration":"186.034628ms","start":"2026-04-17T00:40:14.925051Z","end":"2026-04-17T00:40:15.111085Z","steps":["trace[1202588462] 'range keys from in-memory index tree' (duration: 185.816334ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:40:15.111517Z","caller":"traceutil/trace.go:171","msg":"trace[1881681245] transaction","detail":"{read_only:false; response_revision:5012; number_of_response:1; }","duration":"232.551402ms","start":"2026-04-17T00:40:14.878937Z","end":"2026-04-17T00:40:15.111488Z","steps":["trace[1881681245] 'process raft request' (duration: 208.983658ms)","trace[1881681245] 'compare' (duration: 22.968512ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:40:15.111743Z","caller":"traceutil/trace.go:171","msg":"trace[807273814] linearizableReadLoop","detail":"{readStateIndex:5201; appliedIndex:5200; }","duration":"155.712099ms","start":"2026-04-17T00:40:14.955715Z","end":"2026-04-17T00:40:15.111427Z","steps":["trace[807273814] 'read index received' (duration: 132.275207ms)","trace[807273814] 'applied index is now lower than readState.Index' (duration: 23.435042ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:40:15.111745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.014515ms","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-17T00:40:15.111809Z","caller":"traceutil/trace.go:171","msg":"trace[556318142] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:5012; }","duration":"156.076196ms","start":"2026-04-17T00:40:14.955707Z","end":"2026-04-17T00:40:15.111783Z","steps":["trace[556318142] 'agreement among raft nodes before linearized reading' (duration: 155.872112ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:40:26.999889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.512018ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-17T00:40:27.000327Z","caller":"traceutil/trace.go:171","msg":"trace[1053956891] transaction","detail":"{read_only:false; response_revision:5247; number_of_response:1; }","duration":"106.882117ms","start":"2026-04-17T00:40:26.893418Z","end":"2026-04-17T00:40:27.0003Z","steps":["trace[1053956891] 'process raft request' (duration: 106.745494ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:40:27.000672Z","caller":"traceutil/trace.go:171","msg":"trace[1186879233] transaction","detail":"{read_only:false; response_revision:5245; number_of_response:1; }","duration":"115.195873ms","start":"2026-04-17T00:40:26.885456Z","end":"2026-04-17T00:40:27.000652Z","steps":["trace[1186879233] 'process raft request' (duration: 13.520191ms)","trace[1186879233] 'compare' (duration: 100.143691ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:40:27.000828Z","caller":"traceutil/trace.go:171","msg":"trace[118598066] transaction","detail":"{read_only:false; response_revision:5246; number_of_response:1; }","duration":"114.889497ms","start":"2026-04-17T00:40:26.885863Z","end":"2026-04-17T00:40:27.000753Z","steps":["trace[118598066] 'process raft request' (duration: 114.171473ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:40:27.389494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.118373ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T00:40:27.390151Z","caller":"traceutil/trace.go:171","msg":"trace[555204802] transaction","detail":"{read_only:false; response_revision:5253; number_of_response:1; }","duration":"236.39746ms","start":"2026-04-17T00:40:27.15372Z","end":"2026-04-17T00:40:27.390117Z","steps":["trace[555204802] 'process raft request' (duration: 120.294687ms)","trace[555204802] 'compare' (duration: 114.96206ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:40:27.390423Z","caller":"traceutil/trace.go:171","msg":"trace[744765375] transaction","detail":"{read_only:false; response_revision:5254; number_of_response:1; }","duration":"199.445247ms","start":"2026-04-17T00:40:27.190935Z","end":"2026-04-17T00:40:27.39038Z","steps":["trace[744765375] 'process raft request' (duration: 198.734672ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:40:53.693966Z","caller":"traceutil/trace.go:171","msg":"trace[291703610] transaction","detail":"{read_only:false; response_revision:5624; number_of_response:1; }","duration":"120.631593ms","start":"2026-04-17T00:40:53.573292Z","end":"2026-04-17T00:40:53.693924Z","steps":["trace[291703610] 'process raft request' (duration: 66.432435ms)","trace[291703610] 'compare' (duration: 53.963404ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:41:51.087298Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3030} {"level":"info","ts":"2026-04-17T00:41:51.173305Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3030,"took":"84.579172ms","hash":469208035,"current-db-size-bytes":58228736,"current-db-size":"58 MB","current-db-size-in-use-bytes":31498240,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-04-17T00:41:51.17343Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":469208035,"revision":3030,"compact-revision":-1} {"level":"info","ts":"2026-04-17T00:44:00.043088Z","caller":"traceutil/trace.go:171","msg":"trace[439520925] linearizableReadLoop","detail":"{readStateIndex:7135; appliedIndex:7134; }","duration":"170.220337ms","start":"2026-04-17T00:43:59.872836Z","end":"2026-04-17T00:44:00.043056Z","steps":["trace[439520925] 'read index received' (duration: 152.88594ms)","trace[439520925] 'applied index is now lower than readState.Index' (duration: 17.333077ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:44:00.043253Z","caller":"traceutil/trace.go:171","msg":"trace[1173151641] transaction","detail":"{read_only:false; response_revision:6886; number_of_response:1; }","duration":"257.603183ms","start":"2026-04-17T00:43:59.785634Z","end":"2026-04-17T00:44:00.043237Z","steps":["trace[1173151641] 'process raft request' (duration: 240.022111ms)","trace[1173151641] 'compare' (duration: 17.065302ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:44:00.043754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.882921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-cj647\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-04-17T00:44:00.044226Z","caller":"traceutil/trace.go:171","msg":"trace[1559776468] range","detail":"{range_begin:/registry/pods/openstack/keepalived-cj647; range_end:; response_count:1; response_revision:6886; }","duration":"171.408522ms","start":"2026-04-17T00:43:59.872795Z","end":"2026-04-17T00:44:00.044204Z","steps":["trace[1559776468] 'agreement among raft nodes before linearized reading' (duration: 170.705827ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:44:15.412806Z","caller":"traceutil/trace.go:171","msg":"trace[1331012718] linearizableReadLoop","detail":"{readStateIndex:7256; appliedIndex:7253; }","duration":"194.354836ms","start":"2026-04-17T00:44:15.218418Z","end":"2026-04-17T00:44:15.412773Z","steps":["trace[1331012718] 'read index received' (duration: 34.595726ms)","trace[1331012718] 'applied index is now lower than readState.Index' (duration: 159.75758ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:44:15.412844Z","caller":"traceutil/trace.go:171","msg":"trace[1845910100] transaction","detail":"{read_only:false; response_revision:7000; number_of_response:1; }","duration":"227.94619ms","start":"2026-04-17T00:44:15.184854Z","end":"2026-04-17T00:44:15.4128Z","steps":["trace[1845910100] 'process raft request' (duration: 206.820515ms)","trace[1845910100] 'compare' (duration: 20.8473ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:44:15.412862Z","caller":"traceutil/trace.go:171","msg":"trace[1599354429] transaction","detail":"{read_only:false; response_revision:7001; number_of_response:1; }","duration":"225.438019ms","start":"2026-04-17T00:44:15.187373Z","end":"2026-04-17T00:44:15.412811Z","steps":["trace[1599354429] 'process raft request' (duration: 225.336517ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:44:15.413526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.042719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" ","response":"range_response_count:1 size:414319"} {"level":"info","ts":"2026-04-17T00:44:15.413658Z","caller":"traceutil/trace.go:171","msg":"trace[1640383885] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance; range_end:; response_count:1; response_revision:7001; }","duration":"195.274863ms","start":"2026-04-17T00:44:15.218353Z","end":"2026-04-17T00:44:15.413628Z","steps":["trace[1640383885] 'agreement among raft nodes before linearized reading' (duration: 194.568349ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:46:51.095432Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6100} {"level":"info","ts":"2026-04-17T00:46:51.213611Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6100,"took":"115.588118ms","hash":2287830931,"current-db-size-bytes":58228736,"current-db-size":"58 MB","current-db-size-in-use-bytes":21753856,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-04-17T00:46:51.213729Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2287830931,"revision":6100,"compact-revision":3030} {"level":"info","ts":"2026-04-17T00:47:09.3092Z","caller":"traceutil/trace.go:171","msg":"trace[882496610] transaction","detail":"{read_only:false; response_revision:8399; number_of_response:1; }","duration":"152.47317ms","start":"2026-04-17T00:47:09.15668Z","end":"2026-04-17T00:47:09.309154Z","steps":["trace[882496610] 'process raft request' (duration: 152.263486ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:47:10.359462Z","caller":"traceutil/trace.go:171","msg":"trace[773570663] transaction","detail":"{read_only:false; response_revision:8401; number_of_response:1; }","duration":"133.711592ms","start":"2026-04-17T00:47:10.225727Z","end":"2026-04-17T00:47:10.359438Z","steps":["trace[773570663] 'process raft request' (duration: 133.547458ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:47:50.810136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.30769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-04-17T00:47:50.81023Z","caller":"traceutil/trace.go:171","msg":"trace[948549255] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:8717; }","duration":"104.447213ms","start":"2026-04-17T00:47:50.705762Z","end":"2026-04-17T00:47:50.81021Z","steps":["trace[948549255] 'range keys from in-memory index tree' (duration: 104.134626ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:47:50.856787Z","caller":"traceutil/trace.go:171","msg":"trace[78515914] transaction","detail":"{read_only:false; response_revision:8718; number_of_response:1; }","duration":"110.532176ms","start":"2026-04-17T00:47:50.746233Z","end":"2026-04-17T00:47:50.856765Z","steps":["trace[78515914] 'process raft request' (duration: 110.376183ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:47:50.987872Z","caller":"traceutil/trace.go:171","msg":"trace[2118763652] transaction","detail":"{read_only:false; response_revision:8720; number_of_response:1; }","duration":"170.690607ms","start":"2026-04-17T00:47:50.817156Z","end":"2026-04-17T00:47:50.987847Z","steps":["trace[2118763652] 'process raft request' (duration: 170.621746ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:47:50.987955Z","caller":"traceutil/trace.go:171","msg":"trace[1866005545] transaction","detail":"{read_only:false; response_revision:8719; number_of_response:1; }","duration":"172.676107ms","start":"2026-04-17T00:47:50.815225Z","end":"2026-04-17T00:47:50.987901Z","steps":["trace[1866005545] 'process raft request' (duration: 172.36553ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:48:15.654468Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002462.wal"} {"level":"info","ts":"2026-04-17T00:49:33.808848Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"5ac240a6daec2148","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-17T00:49:33.816795Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-17T00:49:33.816898Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-17T00:51:51.100786Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8174} {"level":"info","ts":"2026-04-17T00:51:51.168999Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8174,"took":"65.825525ms","hash":2091565867,"current-db-size-bytes":58228736,"current-db-size":"58 MB","current-db-size-in-use-bytes":28069888,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-04-17T00:51:51.169052Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2091565867,"revision":8174,"compact-revision":6100} {"level":"info","ts":"2026-04-17T00:53:22.388847Z","caller":"traceutil/trace.go:171","msg":"trace[288391263] transaction","detail":"{read_only:false; response_revision:11109; number_of_response:1; }","duration":"100.42585ms","start":"2026-04-17T00:53:22.28837Z","end":"2026-04-17T00:53:22.388796Z","steps":["trace[288391263] 'process raft request' (duration: 66.61626ms)","trace[288391263] 'compare' (duration: 33.388832ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:56:51.106696Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10531} {"level":"info","ts":"2026-04-17T00:56:51.187363Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10531,"took":"77.864336ms","hash":1110105991,"current-db-size-bytes":58228736,"current-db-size":"58 MB","current-db-size-in-use-bytes":21635072,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-04-17T00:56:51.187434Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1110105991,"revision":10531,"compact-revision":8174}