{"level":"warn","ts":"2026-04-21T15:30:07.309493Z","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-21T15:30:07.309601Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.162: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.162:2380","--initial-cluster=instance=https://199.204.45.162:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.162:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.162: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-21T15:30:07.309732Z","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-21T15:30:07.309757Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.162:2380"]} {"level":"info","ts":"2026-04-21T15:30:07.309797Z","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-21T15:30:07.310702Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.162:2379"]} {"level":"info","ts":"2026-04-21T15:30:07.310839Z","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.162:2380"],"listen-peer-urls":["https://199.204.45.162:2380"],"advertise-client-urls":["https://199.204.45.162:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.162:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.162: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-21T15:30:07.325686Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"14.534994ms"} {"level":"info","ts":"2026-04-21T15:30:07.335597Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"2d372260bb4c37a","cluster-id":"52bb6ec15e8722ff"} {"level":"info","ts":"2026-04-21T15:30:07.335717Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a switched to configuration voters=()"} {"level":"info","ts":"2026-04-21T15:30:07.335751Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became follower at term 0"} {"level":"info","ts":"2026-04-21T15:30:07.335772Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 2d372260bb4c37a [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-21T15:30:07.335784Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became follower at term 1"} {"level":"info","ts":"2026-04-21T15:30:07.335928Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a switched to configuration voters=(203631915892523898)"} {"level":"warn","ts":"2026-04-21T15:30:07.342326Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-21T15:30:07.343709Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-21T15:30:07.34446Z","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-21T15:30:07.346182Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"2d372260bb4c37a","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-21T15:30:07.346419Z","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-21T15:30:07.346381Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"2d372260bb4c37a","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-21T15:30:07.348182Z","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-21T15:30:07.348295Z","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-21T15:30:07.348726Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a switched to configuration voters=(203631915892523898)"} {"level":"info","ts":"2026-04-21T15:30:07.348862Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"52bb6ec15e8722ff","local-member-id":"2d372260bb4c37a","added-peer-id":"2d372260bb4c37a","added-peer-peer-urls":["https://199.204.45.162:2380"]} {"level":"info","ts":"2026-04-21T15:30:07.351994Z","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-21T15:30:07.352211Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"2d372260bb4c37a","initial-advertise-peer-urls":["https://199.204.45.162:2380"],"listen-peer-urls":["https://199.204.45.162:2380"],"advertise-client-urls":["https://199.204.45.162:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.162:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-21T15:30:07.352249Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-21T15:30:07.352316Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.162:2380"} {"level":"info","ts":"2026-04-21T15:30:07.352328Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.162:2380"} {"level":"info","ts":"2026-04-21T15:30:07.437122Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a is starting a new election at term 1"} {"level":"info","ts":"2026-04-21T15:30:07.437208Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became pre-candidate at term 1"} {"level":"info","ts":"2026-04-21T15:30:07.437239Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a received MsgPreVoteResp from 2d372260bb4c37a at term 1"} {"level":"info","ts":"2026-04-21T15:30:07.437267Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became candidate at term 2"} {"level":"info","ts":"2026-04-21T15:30:07.437291Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a received MsgVoteResp from 2d372260bb4c37a at term 2"} {"level":"info","ts":"2026-04-21T15:30:07.437313Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became leader at term 2"} {"level":"info","ts":"2026-04-21T15:30:07.437371Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 2d372260bb4c37a elected leader 2d372260bb4c37a at term 2"} {"level":"info","ts":"2026-04-21T15:30:07.440563Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"2d372260bb4c37a","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.162:2379]}","request-path":"/0/members/2d372260bb4c37a/attributes","cluster-id":"52bb6ec15e8722ff","publish-timeout":"7s"} {"level":"info","ts":"2026-04-21T15:30:07.440606Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-21T15:30:07.440705Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T15:30:07.442586Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"52bb6ec15e8722ff","local-member-id":"2d372260bb4c37a","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T15:30:07.442697Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T15:30:07.442732Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T15:30:07.442944Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-21T15:30:07.444249Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.162:2379"} {"level":"info","ts":"2026-04-21T15:30:07.444653Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-21T15:30:07.444719Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-21T15:30:07.448882Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-21T15:30:37.585686Z","caller":"traceutil/trace.go:171","msg":"trace[683124524] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"145.638487ms","start":"2026-04-21T15:30:37.440024Z","end":"2026-04-21T15:30:37.585662Z","steps":["trace[683124524] 'process raft request' (duration: 145.511206ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:30:37.591873Z","caller":"traceutil/trace.go:171","msg":"trace[118020406] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"151.505971ms","start":"2026-04-21T15:30:37.440348Z","end":"2026-04-21T15:30:37.591854Z","steps":["trace[118020406] 'process raft request' (duration: 151.39041ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:30:37.592107Z","caller":"traceutil/trace.go:171","msg":"trace[1431320791] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"107.418011ms","start":"2026-04-21T15:30:37.48468Z","end":"2026-04-21T15:30:37.592098Z","steps":["trace[1431320791] 'process raft request' (duration: 107.36847ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:30:37.592109Z","caller":"traceutil/trace.go:171","msg":"trace[765588373] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"138.583891ms","start":"2026-04-21T15:30:37.453501Z","end":"2026-04-21T15:30:37.592085Z","steps":["trace[765588373] 'process raft request' (duration: 138.368078ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:30:37.592202Z","caller":"traceutil/trace.go:171","msg":"trace[16818715] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"133.025909ms","start":"2026-04-21T15:30:37.459172Z","end":"2026-04-21T15:30:37.592198Z","steps":["trace[16818715] 'process raft request' (duration: 132.751786ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:30:37.592278Z","caller":"traceutil/trace.go:171","msg":"trace[2022979195] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"131.054219ms","start":"2026-04-21T15:30:37.461218Z","end":"2026-04-21T15:30:37.592272Z","steps":["trace[2022979195] 'process raft request' (duration: 130.729975ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:30:37.592333Z","caller":"traceutil/trace.go:171","msg":"trace[104048135] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"122.270162ms","start":"2026-04-21T15:30:37.470058Z","end":"2026-04-21T15:30:37.592328Z","steps":["trace[104048135] 'process raft request' (duration: 121.936359ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:30:37.592395Z","caller":"traceutil/trace.go:171","msg":"trace[1740608002] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"151.990596ms","start":"2026-04-21T15:30:37.4404Z","end":"2026-04-21T15:30:37.592391Z","steps":["trace[1740608002] 'process raft request' (duration: 151.381699ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:30:37.592431Z","caller":"traceutil/trace.go:171","msg":"trace[1572573463] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"139.912975ms","start":"2026-04-21T15:30:37.452514Z","end":"2026-04-21T15:30:37.592427Z","steps":["trace[1572573463] 'process raft request' (duration: 139.312619ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:30:37.592186Z","caller":"traceutil/trace.go:171","msg":"trace[1274422340] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"138.626231ms","start":"2026-04-21T15:30:37.453554Z","end":"2026-04-21T15:30:37.592181Z","steps":["trace[1274422340] 'process raft request' (duration: 138.347668ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:30:37.592451Z","caller":"traceutil/trace.go:171","msg":"trace[995449060] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"140.165428ms","start":"2026-04-21T15:30:37.452226Z","end":"2026-04-21T15:30:37.592392Z","steps":["trace[995449060] 'process raft request' (duration: 139.579072ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:30:41.846932Z","caller":"traceutil/trace.go:171","msg":"trace[603516655] linearizableReadLoop","detail":"{readStateIndex:626; appliedIndex:625; }","duration":"156.621831ms","start":"2026-04-21T15:30:41.690291Z","end":"2026-04-21T15:30:41.846913Z","steps":["trace[603516655] 'read index received' (duration: 156.383849ms)","trace[603516655] 'applied index is now lower than readState.Index' (duration: 237.132µs)"],"step_count":2} {"level":"info","ts":"2026-04-21T15:30:41.847003Z","caller":"traceutil/trace.go:171","msg":"trace[2055394451] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"196.874008ms","start":"2026-04-21T15:30:41.650108Z","end":"2026-04-21T15:30:41.846982Z","steps":["trace[2055394451] 'process raft request' (duration: 196.654086ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:30:41.847085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.778733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T15:30:41.847145Z","caller":"traceutil/trace.go:171","msg":"trace[416569895] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:601; }","duration":"156.883624ms","start":"2026-04-21T15:30:41.690253Z","end":"2026-04-21T15:30:41.847137Z","steps":["trace[416569895] 'agreement among raft nodes before linearized reading' (duration: 156.774533ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:30:44.010265Z","caller":"traceutil/trace.go:171","msg":"trace[1892160795] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"275.960768ms","start":"2026-04-21T15:30:43.73427Z","end":"2026-04-21T15:30:44.010231Z","steps":["trace[1892160795] 'process raft request' (duration: 275.689705ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:30:44.010407Z","caller":"traceutil/trace.go:171","msg":"trace[1951884717] linearizableReadLoop","detail":"{readStateIndex:642; appliedIndex:642; }","duration":"153.825024ms","start":"2026-04-21T15:30:43.856555Z","end":"2026-04-21T15:30:44.01038Z","steps":["trace[1951884717] 'read index received' (duration: 153.811634ms)","trace[1951884717] 'applied index is now lower than readState.Index' (duration: 10.82µs)"],"step_count":2} {"level":"warn","ts":"2026-04-21T15:30:44.010606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.031356ms","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-21T15:30:44.010636Z","caller":"traceutil/trace.go:171","msg":"trace[1659962334] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:617; }","duration":"154.113457ms","start":"2026-04-21T15:30:43.856515Z","end":"2026-04-21T15:30:44.010628Z","steps":["trace[1659962334] 'agreement among raft nodes before linearized reading' (duration: 153.972905ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:30:44.173917Z","caller":"traceutil/trace.go:171","msg":"trace[2111845149] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"289.233863ms","start":"2026-04-21T15:30:43.884668Z","end":"2026-04-21T15:30:44.173901Z","steps":["trace[2111845149] 'process raft request' (duration: 284.574217ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:30:44.173917Z","caller":"traceutil/trace.go:171","msg":"trace[1595017679] linearizableReadLoop","detail":"{readStateIndex:643; appliedIndex:642; }","duration":"163.438282ms","start":"2026-04-21T15:30:44.010459Z","end":"2026-04-21T15:30:44.173897Z","steps":["trace[1595017679] 'read index received' (duration: 158.632374ms)","trace[1595017679] 'applied index is now lower than readState.Index' (duration: 4.804948ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T15:30:44.174179Z","caller":"traceutil/trace.go:171","msg":"trace[2083240928] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"159.879126ms","start":"2026-04-21T15:30:44.014282Z","end":"2026-04-21T15:30:44.174162Z","steps":["trace[2083240928] 'process raft request' (duration: 159.571542ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:30:44.174408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.6ms","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-21T15:30:44.174453Z","caller":"traceutil/trace.go:171","msg":"trace[288357190] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:619; }","duration":"317.682811ms","start":"2026-04-21T15:30:43.856757Z","end":"2026-04-21T15:30:44.17444Z","steps":["trace[288357190] 'agreement among raft nodes before linearized reading' (duration: 317.194116ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:30:44.174573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T15:30:43.856751Z","time spent":"317.777922ms","remote":"127.0.0.1:45038","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-21T15:32:14.969407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.748565ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-21T15:32:14.969617Z","caller":"traceutil/trace.go:171","msg":"trace[35553679] transaction","detail":"{read_only:false; response_revision:1846; number_of_response:1; }","duration":"272.107951ms","start":"2026-04-21T15:32:14.697492Z","end":"2026-04-21T15:32:14.9696Z","steps":["trace[35553679] 'process raft request' (duration: 272.037929ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:32:14.969702Z","caller":"traceutil/trace.go:171","msg":"trace[128431715] linearizableReadLoop","detail":"{readStateIndex:1918; appliedIndex:1917; }","duration":"279.460606ms","start":"2026-04-21T15:32:14.69021Z","end":"2026-04-21T15:32:14.969671Z","steps":["trace[128431715] 'read index received' (duration: 37.011µs)","trace[128431715] 'applied index is now lower than readState.Index' (duration: 279.421285ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T15:32:14.969844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.63141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T15:32:14.969874Z","caller":"traceutil/trace.go:171","msg":"trace[737149451] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1846; }","duration":"279.711911ms","start":"2026-04-21T15:32:14.690153Z","end":"2026-04-21T15:32:14.969865Z","steps":["trace[737149451] 'agreement among raft nodes before linearized reading' (duration: 279.64101ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:32:14.969905Z","caller":"traceutil/trace.go:171","msg":"trace[491202915] transaction","detail":"{read_only:false; response_revision:1845; number_of_response:1; }","duration":"307.879132ms","start":"2026-04-21T15:32:14.661995Z","end":"2026-04-21T15:32:14.969874Z","steps":["trace[491202915] 'compare' (duration: 297.598191ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:32:14.970093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T15:32:14.661969Z","time spent":"308.002605ms","remote":"127.0.0.1:45038","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-21T15:32:14.988123Z","caller":"traceutil/trace.go:171","msg":"trace[1395092559] transaction","detail":"{read_only:false; response_revision:1848; number_of_response:1; }","duration":"231.109063ms","start":"2026-04-21T15:32:14.756991Z","end":"2026-04-21T15:32:14.9881Z","steps":["trace[1395092559] 'process raft request' (duration: 230.993931ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:32:14.98831Z","caller":"traceutil/trace.go:171","msg":"trace[1408904753] transaction","detail":"{read_only:false; response_revision:1847; number_of_response:1; }","duration":"281.426069ms","start":"2026-04-21T15:32:14.706863Z","end":"2026-04-21T15:32:14.988289Z","steps":["trace[1408904753] 'process raft request' (duration: 280.98316ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:32:14.988447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.023403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2690b4cd-0476-4711-8176-59e2d554c0da\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-04-21T15:32:14.988513Z","caller":"traceutil/trace.go:171","msg":"trace[1438972653] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2690b4cd-0476-4711-8176-59e2d554c0da; range_end:; response_count:1; response_revision:1848; }","duration":"190.133546ms","start":"2026-04-21T15:32:14.798364Z","end":"2026-04-21T15:32:14.988498Z","steps":["trace[1438972653] 'agreement among raft nodes before linearized reading' (duration: 189.966671ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:32:15.129567Z","caller":"traceutil/trace.go:171","msg":"trace[1064552248] linearizableReadLoop","detail":"{readStateIndex:1923; appliedIndex:1922; }","duration":"123.921929ms","start":"2026-04-21T15:32:15.005619Z","end":"2026-04-21T15:32:15.12954Z","steps":["trace[1064552248] 'read index received' (duration: 96.715515ms)","trace[1064552248] 'applied index is now lower than readState.Index' (duration: 27.205204ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T15:32:15.129858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.216405ms","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-21T15:32:15.129905Z","caller":"traceutil/trace.go:171","msg":"trace[1239577680] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1850; }","duration":"124.306867ms","start":"2026-04-21T15:32:15.005586Z","end":"2026-04-21T15:32:15.129893Z","steps":["trace[1239577680] 'agreement among raft nodes before linearized reading' (duration: 124.097703ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:32:15.129602Z","caller":"traceutil/trace.go:171","msg":"trace[623804875] transaction","detail":"{read_only:false; response_revision:1850; number_of_response:1; }","duration":"130.902155ms","start":"2026-04-21T15:32:14.99867Z","end":"2026-04-21T15:32:15.129572Z","steps":["trace[623804875] 'process raft request' (duration: 103.686802ms)","trace[623804875] 'compare' (duration: 27.05549ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T15:32:15.410642Z","caller":"traceutil/trace.go:171","msg":"trace[1324758536] transaction","detail":"{read_only:false; response_revision:1851; number_of_response:1; }","duration":"221.935553ms","start":"2026-04-21T15:32:15.188677Z","end":"2026-04-21T15:32:15.410612Z","steps":["trace[1324758536] 'process raft request' (duration: 221.091354ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:32:15.410675Z","caller":"traceutil/trace.go:171","msg":"trace[143321104] linearizableReadLoop","detail":"{readStateIndex:1924; appliedIndex:1923; }","duration":"156.686426ms","start":"2026-04-21T15:32:15.253954Z","end":"2026-04-21T15:32:15.410641Z","steps":["trace[143321104] 'read index received' (duration: 155.795567ms)","trace[143321104] 'applied index is now lower than readState.Index' (duration: 889.399µs)"],"step_count":2} {"level":"warn","ts":"2026-04-21T15:32:15.411145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.164296ms","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-21T15:32:15.411207Z","caller":"traceutil/trace.go:171","msg":"trace[1255744178] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:1852; }","duration":"157.285859ms","start":"2026-04-21T15:32:15.253905Z","end":"2026-04-21T15:32:15.411191Z","steps":["trace[1255744178] 'agreement among raft nodes before linearized reading' (duration: 156.84168ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:32:50.333703Z","caller":"traceutil/trace.go:171","msg":"trace[1854512296] transaction","detail":"{read_only:false; response_revision:2092; number_of_response:1; }","duration":"112.662735ms","start":"2026-04-21T15:32:50.221003Z","end":"2026-04-21T15:32:50.333666Z","steps":["trace[1854512296] 'process raft request' (duration: 87.877048ms)","trace[1854512296] 'compare' (duration: 24.638224ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T15:34:17.640459Z","caller":"traceutil/trace.go:171","msg":"trace[945200766] transaction","detail":"{read_only:false; response_revision:2674; number_of_response:1; }","duration":"107.745854ms","start":"2026-04-21T15:34:17.532689Z","end":"2026-04-21T15:34:17.640435Z","steps":["trace[945200766] 'process raft request' (duration: 107.610813ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:34:17.648999Z","caller":"traceutil/trace.go:171","msg":"trace[54606867] transaction","detail":"{read_only:false; response_revision:2675; number_of_response:1; }","duration":"110.342934ms","start":"2026-04-21T15:34:17.538633Z","end":"2026-04-21T15:34:17.648976Z","steps":["trace[54606867] 'process raft request' (duration: 110.111902ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:34:18.105353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.033977ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-21T15:34:18.105443Z","caller":"traceutil/trace.go:171","msg":"trace[383191749] linearizableReadLoop","detail":"{readStateIndex:2777; appliedIndex:2776; }","duration":"305.117064ms","start":"2026-04-21T15:34:17.800311Z","end":"2026-04-21T15:34:18.105428Z","steps":["trace[383191749] 'read index received' (duration: 92.828625ms)","trace[383191749] 'applied index is now lower than readState.Index' (duration: 212.287189ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T15:34:18.105652Z","caller":"traceutil/trace.go:171","msg":"trace[1262727604] transaction","detail":"{read_only:false; response_revision:2676; number_of_response:1; }","duration":"383.554425ms","start":"2026-04-21T15:34:17.722085Z","end":"2026-04-21T15:34:18.10564Z","steps":["trace[1262727604] 'process raft request' (duration: 171.139004ms)","trace[1262727604] 'compare' (duration: 211.593971ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T15:34:18.105715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T15:34:17.72207Z","time spent":"383.614336ms","remote":"127.0.0.1:44928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9269,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T15:34:18.106118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.806921ms","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-21T15:34:18.10616Z","caller":"traceutil/trace.go:171","msg":"trace[1567182513] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2676; }","duration":"305.887932ms","start":"2026-04-21T15:34:17.800262Z","end":"2026-04-21T15:34:18.10615Z","steps":["trace[1567182513] 'agreement among raft nodes before linearized reading' (duration: 305.76328ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:34:18.106189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T15:34:17.800236Z","time spent":"305.946323ms","remote":"127.0.0.1:45038","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-21T15:34:18.241592Z","caller":"traceutil/trace.go:171","msg":"trace[1782115053] transaction","detail":"{read_only:false; response_revision:2678; number_of_response:1; }","duration":"130.6319ms","start":"2026-04-21T15:34:18.110936Z","end":"2026-04-21T15:34:18.241567Z","steps":["trace[1782115053] 'process raft request' (duration: 120.531236ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:38:05.470956Z","caller":"traceutil/trace.go:171","msg":"trace[1872928039] linearizableReadLoop","detail":"{readStateIndex:4822; appliedIndex:4821; }","duration":"124.65777ms","start":"2026-04-21T15:38:05.346273Z","end":"2026-04-21T15:38:05.470931Z","steps":["trace[1872928039] 'read index received' (duration: 97.961946ms)","trace[1872928039] 'applied index is now lower than readState.Index' (duration: 26.694414ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T15:38:05.471027Z","caller":"traceutil/trace.go:171","msg":"trace[480617525] transaction","detail":"{read_only:false; response_revision:4646; number_of_response:1; }","duration":"152.552522ms","start":"2026-04-21T15:38:05.318416Z","end":"2026-04-21T15:38:05.470968Z","steps":["trace[480617525] 'process raft request' (duration: 125.805926ms)","trace[480617525] 'compare' (duration: 26.277445ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T15:38:05.471383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.089469ms","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-21T15:38:05.471434Z","caller":"traceutil/trace.go:171","msg":"trace[33529597] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4646; }","duration":"125.153701ms","start":"2026-04-21T15:38:05.346268Z","end":"2026-04-21T15:38:05.471421Z","steps":["trace[33529597] 'agreement among raft nodes before linearized reading' (duration: 124.802093ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:38:05.643748Z","caller":"traceutil/trace.go:171","msg":"trace[1379080642] linearizableReadLoop","detail":"{readStateIndex:4823; appliedIndex:4822; }","duration":"172.697707ms","start":"2026-04-21T15:38:05.471025Z","end":"2026-04-21T15:38:05.643722Z","steps":["trace[1379080642] 'read index received' (duration: 132.012756ms)","trace[1379080642] 'applied index is now lower than readState.Index' (duration: 40.684071ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T15:38:05.643863Z","caller":"traceutil/trace.go:171","msg":"trace[950126601] transaction","detail":"{read_only:false; response_revision:4647; number_of_response:1; }","duration":"226.470732ms","start":"2026-04-21T15:38:05.417363Z","end":"2026-04-21T15:38:05.643834Z","steps":["trace[950126601] 'process raft request' (duration: 185.660039ms)","trace[950126601] 'compare' (duration: 40.491835ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T15:38:05.643997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.943571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-21T15:38:05.644043Z","caller":"traceutil/trace.go:171","msg":"trace[1166538447] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:4648; }","duration":"272.012113ms","start":"2026-04-21T15:38:05.372018Z","end":"2026-04-21T15:38:05.64403Z","steps":["trace[1166538447] 'agreement among raft nodes before linearized reading' (duration: 271.849029ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:38:05.644058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.538756ms","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-21T15:38:05.644167Z","caller":"traceutil/trace.go:171","msg":"trace[759388636] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4648; }","duration":"200.69681ms","start":"2026-04-21T15:38:05.443446Z","end":"2026-04-21T15:38:05.644143Z","steps":["trace[759388636] 'agreement among raft nodes before linearized reading' (duration: 200.391093ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:38:05.644539Z","caller":"traceutil/trace.go:171","msg":"trace[468355508] transaction","detail":"{read_only:false; response_revision:4648; number_of_response:1; }","duration":"168.938992ms","start":"2026-04-21T15:38:05.475588Z","end":"2026-04-21T15:38:05.644527Z","steps":["trace[468355508] 'process raft request' (duration: 168.090172ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:38:05.644874Z","caller":"traceutil/trace.go:171","msg":"trace[1027694578] transaction","detail":"{read_only:false; response_revision:4649; number_of_response:1; }","duration":"168.040371ms","start":"2026-04-21T15:38:05.476817Z","end":"2026-04-21T15:38:05.644857Z","steps":["trace[1027694578] 'process raft request' (duration: 167.182032ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:38:05.952568Z","caller":"traceutil/trace.go:171","msg":"trace[1254174366] transaction","detail":"{read_only:false; response_revision:4652; number_of_response:1; }","duration":"110.203893ms","start":"2026-04-21T15:38:05.842337Z","end":"2026-04-21T15:38:05.952541Z","steps":["trace[1254174366] 'process raft request' (duration: 110.04197ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:38:06.004957Z","caller":"traceutil/trace.go:171","msg":"trace[1731032824] transaction","detail":"{read_only:false; response_revision:4653; number_of_response:1; }","duration":"160.961911ms","start":"2026-04-21T15:38:05.843933Z","end":"2026-04-21T15:38:06.004895Z","steps":["trace[1731032824] 'process raft request' (duration: 160.781717ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:38:06.164195Z","caller":"traceutil/trace.go:171","msg":"trace[555438170] transaction","detail":"{read_only:false; response_revision:4658; number_of_response:1; }","duration":"106.945471ms","start":"2026-04-21T15:38:06.057224Z","end":"2026-04-21T15:38:06.164169Z","steps":["trace[555438170] 'process raft request' (duration: 106.88105ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:38:06.164256Z","caller":"traceutil/trace.go:171","msg":"trace[1991608263] transaction","detail":"{read_only:false; response_revision:4657; number_of_response:1; }","duration":"107.35873ms","start":"2026-04-21T15:38:06.056859Z","end":"2026-04-21T15:38:06.164218Z","steps":["trace[1991608263] 'process raft request' (duration: 107.193856ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:38:06.164233Z","caller":"traceutil/trace.go:171","msg":"trace[213847101] transaction","detail":"{read_only:false; response_revision:4656; number_of_response:1; }","duration":"107.948323ms","start":"2026-04-21T15:38:06.056264Z","end":"2026-04-21T15:38:06.164212Z","steps":["trace[213847101] 'process raft request' (duration: 86.063009ms)","trace[213847101] 'compare' (duration: 21.584807ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T15:38:18.205614Z","caller":"traceutil/trace.go:171","msg":"trace[847222665] transaction","detail":"{read_only:false; response_revision:4825; number_of_response:1; }","duration":"211.650662ms","start":"2026-04-21T15:38:17.993935Z","end":"2026-04-21T15:38:18.205585Z","steps":["trace[847222665] 'process raft request' (duration: 136.923401ms)","trace[847222665] 'compare' (duration: 74.525377ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T15:40:07.942788Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2940} {"level":"info","ts":"2026-04-21T15:40:08.017717Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2940,"took":"71.440703ms","hash":3817492095,"current-db-size-bytes":54689792,"current-db-size":"55 MB","current-db-size-in-use-bytes":29614080,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-04-21T15:40:08.017796Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3817492095,"revision":2940,"compact-revision":-1} {"level":"info","ts":"2026-04-21T15:45:07.947948Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5663} {"level":"info","ts":"2026-04-21T15:45:08.043599Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5663,"took":"94.343009ms","hash":74904140,"current-db-size-bytes":54689792,"current-db-size":"55 MB","current-db-size-in-use-bytes":18042880,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-04-21T15:45:08.043655Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":74904140,"revision":5663,"compact-revision":2940}