{"level":"warn","ts":"2026-04-18T03:24:42.253232Z","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-18T03:24:42.253336Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.223: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.223:2380","--initial-cluster=instance=https://199.204.45.223:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.223:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.223: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-18T03:24:42.253415Z","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-18T03:24:42.253431Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.223:2380"]} {"level":"info","ts":"2026-04-18T03:24:42.253454Z","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-18T03:24:42.25439Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.223:2379"]} {"level":"info","ts":"2026-04-18T03:24:42.254485Z","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.223:2380"],"listen-peer-urls":["https://199.204.45.223:2380"],"advertise-client-urls":["https://199.204.45.223:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.223:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.223: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-18T03:24:42.259337Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.603315ms"} {"level":"info","ts":"2026-04-18T03:24:42.26647Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"11f26225a5bb9fe3","cluster-id":"75c25101f01fd4c6"} {"level":"info","ts":"2026-04-18T03:24:42.26654Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 switched to configuration voters=()"} {"level":"info","ts":"2026-04-18T03:24:42.26656Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became follower at term 0"} {"level":"info","ts":"2026-04-18T03:24:42.266583Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 11f26225a5bb9fe3 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-18T03:24:42.266592Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became follower at term 1"} {"level":"info","ts":"2026-04-18T03:24:42.266634Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 switched to configuration voters=(1293203956842602467)"} {"level":"warn","ts":"2026-04-18T03:24:42.27238Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-18T03:24:42.276554Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-18T03:24:42.277761Z","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-18T03:24:42.280198Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"11f26225a5bb9fe3","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-18T03:24:42.280325Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"11f26225a5bb9fe3","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-18T03:24:42.280763Z","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-18T03:24:42.280847Z","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-18T03:24:42.280858Z","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-18T03:24:42.283083Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 switched to configuration voters=(1293203956842602467)"} {"level":"info","ts":"2026-04-18T03:24:42.283274Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"75c25101f01fd4c6","local-member-id":"11f26225a5bb9fe3","added-peer-id":"11f26225a5bb9fe3","added-peer-peer-urls":["https://199.204.45.223:2380"]} {"level":"info","ts":"2026-04-18T03:24:42.28527Z","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-18T03:24:42.287739Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-18T03:24:42.285787Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"11f26225a5bb9fe3","initial-advertise-peer-urls":["https://199.204.45.223:2380"],"listen-peer-urls":["https://199.204.45.223:2380"],"advertise-client-urls":["https://199.204.45.223:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.223:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-18T03:24:42.285803Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.223:2380"} {"level":"info","ts":"2026-04-18T03:24:42.289088Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.223:2380"} {"level":"info","ts":"2026-04-18T03:24:42.467579Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 is starting a new election at term 1"} {"level":"info","ts":"2026-04-18T03:24:42.467629Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-18T03:24:42.467646Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 received MsgPreVoteResp from 11f26225a5bb9fe3 at term 1"} {"level":"info","ts":"2026-04-18T03:24:42.46766Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became candidate at term 2"} {"level":"info","ts":"2026-04-18T03:24:42.467668Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 received MsgVoteResp from 11f26225a5bb9fe3 at term 2"} {"level":"info","ts":"2026-04-18T03:24:42.467679Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became leader at term 2"} {"level":"info","ts":"2026-04-18T03:24:42.467692Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 11f26225a5bb9fe3 elected leader 11f26225a5bb9fe3 at term 2"} {"level":"info","ts":"2026-04-18T03:24:42.469821Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-18T03:24:42.476794Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"11f26225a5bb9fe3","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.223:2379]}","request-path":"/0/members/11f26225a5bb9fe3/attributes","cluster-id":"75c25101f01fd4c6","publish-timeout":"7s"} {"level":"info","ts":"2026-04-18T03:24:42.476847Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-18T03:24:42.476942Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-18T03:24:42.479061Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.223:2379"} {"level":"info","ts":"2026-04-18T03:24:42.479474Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-18T03:24:42.479495Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-18T03:24:42.47951Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-18T03:24:42.479653Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"75c25101f01fd4c6","local-member-id":"11f26225a5bb9fe3","cluster-version":"3.5"} {"level":"info","ts":"2026-04-18T03:24:42.479742Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-18T03:24:42.479787Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-18T03:25:11.07584Z","caller":"traceutil/trace.go:171","msg":"trace[977473869] transaction","detail":"{read_only:false; response_revision:464; number_of_response:1; }","duration":"142.712746ms","start":"2026-04-18T03:25:10.933106Z","end":"2026-04-18T03:25:11.075819Z","steps":["trace[977473869] 'process raft request' (duration: 142.505076ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T03:25:11.096323Z","caller":"traceutil/trace.go:171","msg":"trace[2029871796] transaction","detail":"{read_only:false; response_revision:465; number_of_response:1; }","duration":"155.363924ms","start":"2026-04-18T03:25:10.940925Z","end":"2026-04-18T03:25:11.096289Z","steps":["trace[2029871796] 'process raft request' (duration: 155.138062ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T03:25:11.096436Z","caller":"traceutil/trace.go:171","msg":"trace[394270092] transaction","detail":"{read_only:false; response_revision:466; number_of_response:1; }","duration":"155.432657ms","start":"2026-04-18T03:25:10.940973Z","end":"2026-04-18T03:25:11.096406Z","steps":["trace[394270092] 'process raft request' (duration: 155.202856ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T03:25:11.097013Z","caller":"traceutil/trace.go:171","msg":"trace[660012770] transaction","detail":"{read_only:false; response_revision:467; number_of_response:1; }","duration":"151.51935ms","start":"2026-04-18T03:25:10.945481Z","end":"2026-04-18T03:25:11.097Z","steps":["trace[660012770] 'process raft request' (duration: 150.766903ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T03:25:11.097104Z","caller":"traceutil/trace.go:171","msg":"trace[1065506328] transaction","detail":"{read_only:false; response_revision:468; number_of_response:1; }","duration":"151.378362ms","start":"2026-04-18T03:25:10.945711Z","end":"2026-04-18T03:25:11.09709Z","steps":["trace[1065506328] 'process raft request' (duration: 151.225045ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T03:25:11.097468Z","caller":"traceutil/trace.go:171","msg":"trace[1155320799] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"148.670395ms","start":"2026-04-18T03:25:10.948786Z","end":"2026-04-18T03:25:11.097456Z","steps":["trace[1155320799] 'process raft request' (duration: 148.346238ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T03:25:11.097558Z","caller":"traceutil/trace.go:171","msg":"trace[340386246] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"147.317355ms","start":"2026-04-18T03:25:10.950215Z","end":"2026-04-18T03:25:11.097532Z","steps":["trace[340386246] 'process raft request' (duration: 147.173008ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T03:25:11.097842Z","caller":"traceutil/trace.go:171","msg":"trace[1294213658] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"143.791048ms","start":"2026-04-18T03:25:10.954041Z","end":"2026-04-18T03:25:11.097832Z","steps":["trace[1294213658] 'process raft request' (duration: 143.577738ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T03:25:11.097923Z","caller":"traceutil/trace.go:171","msg":"trace[1676582915] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"131.442523ms","start":"2026-04-18T03:25:10.966475Z","end":"2026-04-18T03:25:11.097917Z","steps":["trace[1676582915] 'process raft request' (duration: 131.344098ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T03:25:11.097933Z","caller":"traceutil/trace.go:171","msg":"trace[1766495851] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"136.893088ms","start":"2026-04-18T03:25:10.961019Z","end":"2026-04-18T03:25:11.097912Z","steps":["trace[1766495851] 'process raft request' (duration: 136.750231ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T03:25:11.097983Z","caller":"traceutil/trace.go:171","msg":"trace[387224615] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"100.536037ms","start":"2026-04-18T03:25:10.997431Z","end":"2026-04-18T03:25:11.097967Z","steps":["trace[387224615] 'process raft request' (duration: 100.438192ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T03:25:12.195356Z","caller":"traceutil/trace.go:171","msg":"trace[565781029] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"102.517674ms","start":"2026-04-18T03:25:12.092811Z","end":"2026-04-18T03:25:12.195328Z","steps":["trace[565781029] 'process raft request' (duration: 51.258337ms)","trace[565781029] 'compare' (duration: 51.133461ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T03:25:12.199944Z","caller":"traceutil/trace.go:171","msg":"trace[457654425] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"107.099101ms","start":"2026-04-18T03:25:12.092831Z","end":"2026-04-18T03:25:12.19993Z","steps":["trace[457654425] 'process raft request' (duration: 106.740954ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T03:25:15.931882Z","caller":"traceutil/trace.go:171","msg":"trace[1596853800] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"181.729418ms","start":"2026-04-18T03:25:15.75013Z","end":"2026-04-18T03:25:15.931859Z","steps":["trace[1596853800] 'process raft request' (duration: 181.156491ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T03:25:15.99495Z","caller":"traceutil/trace.go:171","msg":"trace[239996960] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"102.862953ms","start":"2026-04-18T03:25:15.892065Z","end":"2026-04-18T03:25:15.994928Z","steps":["trace[239996960] 'process raft request' (duration: 102.341807ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T03:25:17.289388Z","caller":"traceutil/trace.go:171","msg":"trace[1550557545] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"249.456767ms","start":"2026-04-18T03:25:17.039886Z","end":"2026-04-18T03:25:17.289343Z","steps":["trace[1550557545] 'process raft request' (duration: 152.351941ms)","trace[1550557545] 'compare' (duration: 96.791091ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T03:25:17.586802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.683548ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T03:25:17.586959Z","caller":"traceutil/trace.go:171","msg":"trace[656785004] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"117.483339ms","start":"2026-04-18T03:25:17.469463Z","end":"2026-04-18T03:25:17.586947Z","steps":["trace[656785004] 'process raft request' (duration: 117.425516ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T03:25:17.587127Z","caller":"traceutil/trace.go:171","msg":"trace[1728139746] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"284.242485ms","start":"2026-04-18T03:25:17.302876Z","end":"2026-04-18T03:25:17.587118Z","steps":["trace[1728139746] 'process raft request' (duration: 121.540359ms)","trace[1728139746] 'compare' (duration: 161.543992ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T03:25:18.088421Z","caller":"traceutil/trace.go:171","msg":"trace[1625555106] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"413.628388ms","start":"2026-04-18T03:25:17.674771Z","end":"2026-04-18T03:25:18.0884Z","steps":["trace[1625555106] 'process raft request' (duration: 412.39032ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T03:25:18.088571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T03:25:17.674743Z","time spent":"413.760415ms","remote":"127.0.0.1:54840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T03:25:18.094194Z","caller":"traceutil/trace.go:171","msg":"trace[327043476] linearizableReadLoop","detail":"{readStateIndex:598; appliedIndex:596; }","duration":"157.304696ms","start":"2026-04-18T03:25:17.936856Z","end":"2026-04-18T03:25:18.09416Z","steps":["trace[327043476] 'read index received' (duration: 150.115383ms)","trace[327043476] 'applied index is now lower than readState.Index' (duration: 7.188323ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T03:25:18.094839Z","caller":"traceutil/trace.go:171","msg":"trace[1632397992] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"159.379274ms","start":"2026-04-18T03:25:17.935374Z","end":"2026-04-18T03:25:18.094753Z","steps":["trace[1632397992] 'process raft request' (duration: 158.557366ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T03:25:18.095259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.383857ms","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-18T03:25:18.095314Z","caller":"traceutil/trace.go:171","msg":"trace[1401008463] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:575; }","duration":"158.488621ms","start":"2026-04-18T03:25:17.936813Z","end":"2026-04-18T03:25:18.095302Z","steps":["trace[1401008463] 'agreement among raft nodes before linearized reading' (duration: 157.6027ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T03:25:32.352271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.858176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T03:25:32.352716Z","caller":"traceutil/trace.go:171","msg":"trace[468024102] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:732; }","duration":"175.370847ms","start":"2026-04-18T03:25:32.17732Z","end":"2026-04-18T03:25:32.35269Z","steps":["trace[468024102] 'range keys from in-memory index tree' (duration: 174.751872ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T03:25:32.352722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.552644ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-18T03:25:32.352823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.353795ms","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-18T03:25:32.352835Z","caller":"traceutil/trace.go:171","msg":"trace[683914685] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:732; }","duration":"181.72283ms","start":"2026-04-18T03:25:32.171083Z","end":"2026-04-18T03:25:32.352806Z","steps":["trace[683914685] 'range keys from in-memory index tree' (duration: 181.264181ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T03:25:32.352911Z","caller":"traceutil/trace.go:171","msg":"trace[680987690] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:732; }","duration":"183.473941ms","start":"2026-04-18T03:25:32.16942Z","end":"2026-04-18T03:25:32.352894Z","steps":["trace[680987690] 'range keys from in-memory index tree' (duration: 183.169628ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T03:25:32.353078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.983301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-18T03:25:32.353158Z","caller":"traceutil/trace.go:171","msg":"trace[898227801] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:732; }","duration":"181.942868ms","start":"2026-04-18T03:25:32.171193Z","end":"2026-04-18T03:25:32.353136Z","steps":["trace[898227801] 'range keys from in-memory index tree' (duration: 180.647478ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T03:26:05.650171Z","caller":"traceutil/trace.go:171","msg":"trace[936482015] linearizableReadLoop","detail":"{readStateIndex:1181; appliedIndex:1180; }","duration":"107.911401ms","start":"2026-04-18T03:26:05.542233Z","end":"2026-04-18T03:26:05.650145Z","steps":["trace[936482015] 'read index received' (duration: 107.737236ms)","trace[936482015] 'applied index is now lower than readState.Index' (duration: 173.105µs)"],"step_count":2} {"level":"info","ts":"2026-04-18T03:26:05.650329Z","caller":"traceutil/trace.go:171","msg":"trace[693879470] transaction","detail":"{read_only:false; response_revision:1145; number_of_response:1; }","duration":"158.564289ms","start":"2026-04-18T03:26:05.491752Z","end":"2026-04-18T03:26:05.650316Z","steps":["trace[693879470] 'process raft request' (duration: 158.224619ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T03:26:05.654164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.895368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-18T03:26:05.65427Z","caller":"traceutil/trace.go:171","msg":"trace[1820940792] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1145; }","duration":"112.065183ms","start":"2026-04-18T03:26:05.54218Z","end":"2026-04-18T03:26:05.654245Z","steps":["trace[1820940792] 'agreement among raft nodes before linearized reading' (duration: 108.434717ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T03:27:00.092121Z","caller":"traceutil/trace.go:171","msg":"trace[425917591] transaction","detail":"{read_only:false; response_revision:1896; number_of_response:1; }","duration":"107.585012ms","start":"2026-04-18T03:26:59.984499Z","end":"2026-04-18T03:27:00.092084Z","steps":["trace[425917591] 'process raft request' (duration: 77.963336ms)","trace[425917591] 'compare' (duration: 29.473413ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T03:27:26.347105Z","caller":"traceutil/trace.go:171","msg":"trace[2077597253] linearizableReadLoop","detail":"{readStateIndex:2143; appliedIndex:2142; }","duration":"110.55522ms","start":"2026-04-18T03:27:26.236526Z","end":"2026-04-18T03:27:26.347081Z","steps":["trace[2077597253] 'read index received' (duration: 110.309296ms)","trace[2077597253] 'applied index is now lower than readState.Index' (duration: 244.844µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T03:27:26.34734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.784014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-04-18T03:27:26.347383Z","caller":"traceutil/trace.go:171","msg":"trace[1348262585] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2063; }","duration":"110.878925ms","start":"2026-04-18T03:27:26.236492Z","end":"2026-04-18T03:27:26.347371Z","steps":["trace[1348262585] 'agreement among raft nodes before linearized reading' (duration: 110.693362ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T03:27:26.347488Z","caller":"traceutil/trace.go:171","msg":"trace[1790374483] transaction","detail":"{read_only:false; response_revision:2063; number_of_response:1; }","duration":"112.847601ms","start":"2026-04-18T03:27:26.23461Z","end":"2026-04-18T03:27:26.347457Z","steps":["trace[1790374483] 'process raft request' (duration: 112.287891ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T03:28:33.571405Z","caller":"traceutil/trace.go:171","msg":"trace[1057125962] transaction","detail":"{read_only:false; response_revision:2525; number_of_response:1; }","duration":"145.348127ms","start":"2026-04-18T03:28:33.426032Z","end":"2026-04-18T03:28:33.57138Z","steps":["trace[1057125962] 'process raft request' (duration: 143.965575ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T03:29:11.914087Z","caller":"traceutil/trace.go:171","msg":"trace[2013023914] linearizableReadLoop","detail":"{readStateIndex:2837; appliedIndex:2836; }","duration":"147.766815ms","start":"2026-04-18T03:29:11.766294Z","end":"2026-04-18T03:29:11.91406Z","steps":["trace[2013023914] 'read index received' (duration: 147.522591ms)","trace[2013023914] 'applied index is now lower than readState.Index' (duration: 243.324µs)"],"step_count":2} {"level":"info","ts":"2026-04-18T03:29:11.914568Z","caller":"traceutil/trace.go:171","msg":"trace[147891468] transaction","detail":"{read_only:false; response_revision:2734; number_of_response:1; }","duration":"149.675332ms","start":"2026-04-18T03:29:11.764877Z","end":"2026-04-18T03:29:11.914552Z","steps":["trace[147891468] 'process raft request' (duration: 148.979892ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T03:29:11.914991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.381003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-18T03:29:11.915193Z","caller":"traceutil/trace.go:171","msg":"trace[533338498] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2734; }","duration":"148.563406ms","start":"2026-04-18T03:29:11.766573Z","end":"2026-04-18T03:29:11.915136Z","steps":["trace[533338498] 'agreement among raft nodes before linearized reading' (duration: 148.320002ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T03:29:11.915396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.655198ms","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-18T03:29:11.915488Z","caller":"traceutil/trace.go:171","msg":"trace[1387253454] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2734; }","duration":"149.190266ms","start":"2026-04-18T03:29:11.766277Z","end":"2026-04-18T03:29:11.915467Z","steps":["trace[1387253454] 'agreement among raft nodes before linearized reading' (duration: 148.579036ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T03:29:11.915784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.467945ms","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-18T03:29:11.915941Z","caller":"traceutil/trace.go:171","msg":"trace[299475455] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2734; }","duration":"148.631717ms","start":"2026-04-18T03:29:11.767249Z","end":"2026-04-18T03:29:11.91588Z","steps":["trace[299475455] 'agreement among raft nodes before linearized reading' (duration: 147.970968ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T03:33:00.26196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.367976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-18T03:33:00.262056Z","caller":"traceutil/trace.go:171","msg":"trace[120467436] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4841; }","duration":"126.52235ms","start":"2026-04-18T03:33:00.135514Z","end":"2026-04-18T03:33:00.262036Z","steps":["trace[120467436] 'range keys from in-memory index tree' (duration: 126.179173ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T03:33:00.778588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.515962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T03:33:00.778693Z","caller":"traceutil/trace.go:171","msg":"trace[1778676940] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:4843; }","duration":"105.706046ms","start":"2026-04-18T03:33:00.672958Z","end":"2026-04-18T03:33:00.778664Z","steps":["trace[1778676940] 'count revisions from in-memory index tree' (duration: 105.42922ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T03:34:42.626303Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2897} {"level":"info","ts":"2026-04-18T03:34:42.765663Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2897,"took":"137.984121ms","hash":1160713902,"current-db-size-bytes":53366784,"current-db-size":"53 MB","current-db-size-in-use-bytes":29437952,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-04-18T03:34:42.765743Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1160713902,"revision":2897,"compact-revision":-1} {"level":"warn","ts":"2026-04-18T03:36:42.276763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.108865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T03:36:42.276873Z","caller":"traceutil/trace.go:171","msg":"trace[1892946402] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6440; }","duration":"100.273937ms","start":"2026-04-18T03:36:42.176571Z","end":"2026-04-18T03:36:42.276845Z","steps":["trace[1892946402] 'agreement among raft nodes before linearized reading' (duration: 100.062313ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T03:36:42.277131Z","caller":"traceutil/trace.go:171","msg":"trace[122963257] transaction","detail":"{read_only:false; response_revision:6440; number_of_response:1; }","duration":"144.473174ms","start":"2026-04-18T03:36:42.132629Z","end":"2026-04-18T03:36:42.277102Z","steps":["trace[122963257] 'process raft request' (duration: 143.531347ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T03:37:00.731066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.411592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T03:37:00.731161Z","caller":"traceutil/trace.go:171","msg":"trace[1338835192] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:6592; }","duration":"119.557934ms","start":"2026-04-18T03:37:00.611583Z","end":"2026-04-18T03:37:00.731141Z","steps":["trace[1338835192] 'count revisions from in-memory index tree' (duration: 119.349521ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T03:39:42.633165Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5635} {"level":"info","ts":"2026-04-18T03:39:42.706719Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5635,"took":"71.919589ms","hash":1814690525,"current-db-size-bytes":53366784,"current-db-size":"53 MB","current-db-size-in-use-bytes":18137088,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-04-18T03:39:42.706776Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1814690525,"revision":5635,"compact-revision":2897}