{"level":"warn","ts":"2026-04-24T01:22:06.872933Z","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-24T01:22:06.873027Z","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-24T01:22:06.873097Z","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-24T01:22:06.873111Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.223:2380"]} {"level":"info","ts":"2026-04-24T01:22:06.873126Z","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-24T01:22:06.873826Z","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-24T01:22:06.8739Z","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-24T01:22:06.877817Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.711501ms"} {"level":"info","ts":"2026-04-24T01:22:06.885377Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"11f26225a5bb9fe3","cluster-id":"75c25101f01fd4c6"} {"level":"info","ts":"2026-04-24T01:22:06.885541Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 switched to configuration voters=()"} {"level":"info","ts":"2026-04-24T01:22:06.885663Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became follower at term 0"} {"level":"info","ts":"2026-04-24T01:22:06.885726Z","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-24T01:22:06.885781Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became follower at term 1"} {"level":"info","ts":"2026-04-24T01:22:06.885849Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 switched to configuration voters=(1293203956842602467)"} {"level":"warn","ts":"2026-04-24T01:22:06.892351Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-24T01:22:06.89356Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-24T01:22:06.894463Z","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-24T01:22:06.896372Z","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-24T01:22:06.900621Z","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-24T01:22:06.900526Z","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-24T01:22:06.900753Z","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-24T01:22:06.900766Z","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-24T01:22:06.901101Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 switched to configuration voters=(1293203956842602467)"} {"level":"info","ts":"2026-04-24T01:22:06.902056Z","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-24T01:22:06.902609Z","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-24T01:22:06.902802Z","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-24T01:22:06.90284Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-24T01:22:06.902948Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.223:2380"} {"level":"info","ts":"2026-04-24T01:22:06.902965Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.223:2380"} {"level":"info","ts":"2026-04-24T01:22:07.586687Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 is starting a new election at term 1"} {"level":"info","ts":"2026-04-24T01:22:07.58675Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-24T01:22:07.586804Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 received MsgPreVoteResp from 11f26225a5bb9fe3 at term 1"} {"level":"info","ts":"2026-04-24T01:22:07.58684Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became candidate at term 2"} {"level":"info","ts":"2026-04-24T01:22:07.586857Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 received MsgVoteResp from 11f26225a5bb9fe3 at term 2"} {"level":"info","ts":"2026-04-24T01:22:07.586888Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became leader at term 2"} {"level":"info","ts":"2026-04-24T01:22:07.586906Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 11f26225a5bb9fe3 elected leader 11f26225a5bb9fe3 at term 2"} {"level":"info","ts":"2026-04-24T01:22:07.587715Z","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-24T01:22:07.587933Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-24T01:22:07.587977Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-24T01:22:07.588014Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-24T01:22:07.588323Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-24T01:22:07.588342Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-24T01:22:07.58869Z","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-24T01:22:07.58877Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-24T01:22:07.588793Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-24T01:22:07.592367Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-24T01:22:07.59252Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.223:2379"} {"level":"info","ts":"2026-04-24T01:22:13.202163Z","caller":"traceutil/trace.go:171","msg":"trace[1402369576] transaction","detail":"{read_only:false; response_revision:281; number_of_response:1; }","duration":"116.722308ms","start":"2026-04-24T01:22:13.085411Z","end":"2026-04-24T01:22:13.202133Z","steps":["trace[1402369576] 'process raft request' (duration: 78.576797ms)","trace[1402369576] 'compare' (duration: 37.864338ms)"],"step_count":2} {"level":"info","ts":"2026-04-24T01:22:13.331085Z","caller":"traceutil/trace.go:171","msg":"trace[2049293714] transaction","detail":"{read_only:false; response_revision:283; number_of_response:1; }","duration":"102.350613ms","start":"2026-04-24T01:22:13.228682Z","end":"2026-04-24T01:22:13.331033Z","steps":["trace[2049293714] 'process raft request' (duration: 73.759495ms)","trace[2049293714] 'compare' (duration: 28.451596ms)"],"step_count":2} {"level":"info","ts":"2026-04-24T01:22:38.008123Z","caller":"traceutil/trace.go:171","msg":"trace[705780127] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"287.704494ms","start":"2026-04-24T01:22:37.720377Z","end":"2026-04-24T01:22:38.008081Z","steps":["trace[705780127] 'process raft request' (duration: 284.86377ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T01:26:10.054957Z","caller":"traceutil/trace.go:171","msg":"trace[367064878] transaction","detail":"{read_only:false; response_revision:1472; number_of_response:1; }","duration":"106.321727ms","start":"2026-04-24T01:26:09.948597Z","end":"2026-04-24T01:26:10.054919Z","steps":["trace[367064878] 'process raft request' (duration: 105.981019ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T01:26:10.314883Z","caller":"traceutil/trace.go:171","msg":"trace[397492471] transaction","detail":"{read_only:false; response_revision:1473; number_of_response:1; }","duration":"252.249712ms","start":"2026-04-24T01:26:10.062605Z","end":"2026-04-24T01:26:10.314855Z","steps":["trace[397492471] 'process raft request' (duration: 163.545162ms)","trace[397492471] 'compare' (duration: 88.477554ms)"],"step_count":2} {"level":"warn","ts":"2026-04-24T01:26:10.588729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.312305ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-24T01:26:10.588894Z","caller":"traceutil/trace.go:171","msg":"trace[701988286] transaction","detail":"{read_only:false; response_revision:1474; number_of_response:1; }","duration":"269.565243ms","start":"2026-04-24T01:26:10.319302Z","end":"2026-04-24T01:26:10.588867Z","steps":["trace[701988286] 'process raft request' (duration: 140.239062ms)","trace[701988286] 'compare' (duration: 128.134921ms)"],"step_count":2} {"level":"info","ts":"2026-04-24T01:26:10.589517Z","caller":"traceutil/trace.go:171","msg":"trace[578007111] linearizableReadLoop","detail":"{readStateIndex:1538; appliedIndex:1536; }","duration":"207.656751ms","start":"2026-04-24T01:26:10.381818Z","end":"2026-04-24T01:26:10.589475Z","steps":["trace[578007111] 'read index received' (duration: 77.815288ms)","trace[578007111] 'applied index is now lower than readState.Index' (duration: 129.839993ms)"],"step_count":2} {"level":"info","ts":"2026-04-24T01:26:10.589734Z","caller":"traceutil/trace.go:171","msg":"trace[1711825060] transaction","detail":"{read_only:false; response_revision:1475; number_of_response:1; }","duration":"269.201524ms","start":"2026-04-24T01:26:10.320466Z","end":"2026-04-24T01:26:10.589668Z","steps":["trace[1711825060] 'process raft request' (duration: 268.846085ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T01:26:10.589893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.138962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-24T01:26:10.590125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.115561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.223\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-24T01:26:10.590174Z","caller":"traceutil/trace.go:171","msg":"trace[1870315066] range","detail":"{range_begin:/registry/masterleases/199.204.45.223; range_end:; response_count:1; response_revision:1475; }","duration":"114.44608ms","start":"2026-04-24T01:26:10.475713Z","end":"2026-04-24T01:26:10.590159Z","steps":["trace[1870315066] 'agreement among raft nodes before linearized reading' (duration: 114.057701ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T01:26:10.590172Z","caller":"traceutil/trace.go:171","msg":"trace[1722742160] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1475; }","duration":"112.480751ms","start":"2026-04-24T01:26:10.477667Z","end":"2026-04-24T01:26:10.590147Z","steps":["trace[1722742160] 'agreement among raft nodes before linearized reading' (duration: 112.097862ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T01:26:10.590221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.408729ms","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-24T01:26:10.590275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.671867ms","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-24T01:26:10.590364Z","caller":"traceutil/trace.go:171","msg":"trace[1020305295] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1475; }","duration":"208.605524ms","start":"2026-04-24T01:26:10.381745Z","end":"2026-04-24T01:26:10.59035Z","steps":["trace[1020305295] 'agreement among raft nodes before linearized reading' (duration: 207.984329ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T01:26:10.590395Z","caller":"traceutil/trace.go:171","msg":"trace[1597738541] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1475; }","duration":"200.836351ms","start":"2026-04-24T01:26:10.389528Z","end":"2026-04-24T01:26:10.590365Z","steps":["trace[1597738541] 'agreement among raft nodes before linearized reading' (duration: 200.322229ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T01:26:36.399942Z","caller":"traceutil/trace.go:171","msg":"trace[1643539544] transaction","detail":"{read_only:false; response_revision:1558; number_of_response:1; }","duration":"182.349911ms","start":"2026-04-24T01:26:36.217564Z","end":"2026-04-24T01:26:36.399914Z","steps":["trace[1643539544] 'process raft request' (duration: 182.153306ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T01:26:36.997141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.306113ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-24T01:26:36.997796Z","caller":"traceutil/trace.go:171","msg":"trace[86454419] linearizableReadLoop","detail":"{readStateIndex:1628; appliedIndex:1627; }","duration":"255.73387ms","start":"2026-04-24T01:26:36.741498Z","end":"2026-04-24T01:26:36.997232Z","steps":["trace[86454419] 'read index received' (duration: 60.20637ms)","trace[86454419] 'applied index is now lower than readState.Index' (duration: 195.52615ms)"],"step_count":2} {"level":"info","ts":"2026-04-24T01:26:36.997795Z","caller":"traceutil/trace.go:171","msg":"trace[1904824294] transaction","detail":"{read_only:false; response_revision:1559; number_of_response:1; }","duration":"533.698371ms","start":"2026-04-24T01:26:36.464003Z","end":"2026-04-24T01:26:36.997701Z","steps":["trace[1904824294] 'process raft request' (duration: 337.728961ms)","trace[1904824294] 'compare' (duration: 194.997585ms)"],"step_count":2} {"level":"warn","ts":"2026-04-24T01:26:36.99795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T01:26:36.463977Z","time spent":"533.891705ms","remote":"127.0.0.1:48556","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-24T01:26:36.998095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.529307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-24T01:26:36.998129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.903374ms","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-24T01:26:36.998173Z","caller":"traceutil/trace.go:171","msg":"trace[1398178844] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1559; }","duration":"243.991946ms","start":"2026-04-24T01:26:36.754171Z","end":"2026-04-24T01:26:36.998163Z","steps":["trace[1398178844] 'agreement among raft nodes before linearized reading' (duration: 243.829122ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T01:26:36.998175Z","caller":"traceutil/trace.go:171","msg":"trace[1380695074] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:1559; }","duration":"121.685201ms","start":"2026-04-24T01:26:36.876472Z","end":"2026-04-24T01:26:36.998158Z","steps":["trace[1380695074] 'agreement among raft nodes before linearized reading' (duration: 121.538988ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T01:26:36.998288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.674942ms","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-24T01:26:36.998396Z","caller":"traceutil/trace.go:171","msg":"trace[1524165769] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1559; }","duration":"256.96595ms","start":"2026-04-24T01:26:36.741416Z","end":"2026-04-24T01:26:36.998382Z","steps":["trace[1524165769] 'agreement among raft nodes before linearized reading' (duration: 256.526399ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T01:26:36.998277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.900023ms","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-24T01:26:36.998658Z","caller":"traceutil/trace.go:171","msg":"trace[1359627493] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1559; }","duration":"199.343714ms","start":"2026-04-24T01:26:36.799286Z","end":"2026-04-24T01:26:36.99863Z","steps":["trace[1359627493] 'agreement among raft nodes before linearized reading' (duration: 198.722039ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T01:26:36.998825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.594801ms","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-24T01:26:36.998871Z","caller":"traceutil/trace.go:171","msg":"trace[591348419] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1559; }","duration":"189.663323ms","start":"2026-04-24T01:26:36.809198Z","end":"2026-04-24T01:26:36.998861Z","steps":["trace[591348419] 'agreement among raft nodes before linearized reading' (duration: 189.551731ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T01:26:37.1146Z","caller":"traceutil/trace.go:171","msg":"trace[506084427] transaction","detail":"{read_only:false; response_revision:1562; number_of_response:1; }","duration":"110.814339ms","start":"2026-04-24T01:26:37.003761Z","end":"2026-04-24T01:26:37.114576Z","steps":["trace[506084427] 'process raft request' (duration: 110.760197ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T01:26:37.114621Z","caller":"traceutil/trace.go:171","msg":"trace[199110242] transaction","detail":"{read_only:false; response_revision:1561; number_of_response:1; }","duration":"111.095176ms","start":"2026-04-24T01:26:37.003479Z","end":"2026-04-24T01:26:37.114575Z","steps":["trace[199110242] 'process raft request' (duration: 110.906211ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T01:26:37.115324Z","caller":"traceutil/trace.go:171","msg":"trace[1167871471] transaction","detail":"{read_only:false; response_revision:1563; number_of_response:1; }","duration":"111.351974ms","start":"2026-04-24T01:26:37.00396Z","end":"2026-04-24T01:26:37.115312Z","steps":["trace[1167871471] 'process raft request' (duration: 110.590694ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T01:26:37.806409Z","caller":"traceutil/trace.go:171","msg":"trace[581405863] transaction","detail":"{read_only:false; response_revision:1564; number_of_response:1; }","duration":"274.838394ms","start":"2026-04-24T01:26:37.531536Z","end":"2026-04-24T01:26:37.806375Z","steps":["trace[581405863] 'process raft request' (duration: 274.6737ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T01:26:38.530751Z","caller":"traceutil/trace.go:171","msg":"trace[656671278] transaction","detail":"{read_only:false; response_revision:1565; number_of_response:1; }","duration":"120.978943ms","start":"2026-04-24T01:26:38.409746Z","end":"2026-04-24T01:26:38.530725Z","steps":["trace[656671278] 'process raft request' (duration: 120.746107ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T01:26:39.299316Z","caller":"traceutil/trace.go:171","msg":"trace[1829334860] linearizableReadLoop","detail":"{readStateIndex:1635; appliedIndex:1634; }","duration":"231.212797ms","start":"2026-04-24T01:26:39.068076Z","end":"2026-04-24T01:26:39.299289Z","steps":["trace[1829334860] 'read index received' (duration: 230.91277ms)","trace[1829334860] 'applied index is now lower than readState.Index' (duration: 299.027µs)"],"step_count":2} {"level":"info","ts":"2026-04-24T01:26:39.299489Z","caller":"traceutil/trace.go:171","msg":"trace[2007614596] transaction","detail":"{read_only:false; response_revision:1566; number_of_response:1; }","duration":"294.393841ms","start":"2026-04-24T01:26:39.005034Z","end":"2026-04-24T01:26:39.299428Z","steps":["trace[2007614596] 'process raft request' (duration: 294.018692ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T01:26:39.299701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.536205ms","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-24T01:26:39.299756Z","caller":"traceutil/trace.go:171","msg":"trace[1218988468] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1566; }","duration":"180.651898ms","start":"2026-04-24T01:26:39.119091Z","end":"2026-04-24T01:26:39.299743Z","steps":["trace[1218988468] 'agreement among raft nodes before linearized reading' (duration: 180.435143ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T01:26:39.299872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.777402ms","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-24T01:26:39.300066Z","caller":"traceutil/trace.go:171","msg":"trace[1069012345] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1566; }","duration":"232.044258ms","start":"2026-04-24T01:26:39.068003Z","end":"2026-04-24T01:26:39.300047Z","steps":["trace[1069012345] 'agreement among raft nodes before linearized reading' (duration: 231.599477ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T01:26:39.299918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.152531ms","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-24T01:26:39.300197Z","caller":"traceutil/trace.go:171","msg":"trace[2042763804] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1566; }","duration":"179.473439ms","start":"2026-04-24T01:26:39.120708Z","end":"2026-04-24T01:26:39.300181Z","steps":["trace[2042763804] 'agreement among raft nodes before linearized reading' (duration: 178.925454ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T01:26:39.300062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.977133ms","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-24T01:26:39.300335Z","caller":"traceutil/trace.go:171","msg":"trace[1193198091] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1566; }","duration":"180.27035ms","start":"2026-04-24T01:26:39.120035Z","end":"2026-04-24T01:26:39.300305Z","steps":["trace[1193198091] 'agreement among raft nodes before linearized reading' (duration: 179.758086ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T01:26:39.479779Z","caller":"traceutil/trace.go:171","msg":"trace[1256107712] transaction","detail":"{read_only:false; response_revision:1567; number_of_response:1; }","duration":"173.813698ms","start":"2026-04-24T01:26:39.305928Z","end":"2026-04-24T01:26:39.479741Z","steps":["trace[1256107712] 'process raft request' (duration: 100.203914ms)","trace[1256107712] 'compare' (duration: 73.471311ms)"],"step_count":2} {"level":"info","ts":"2026-04-24T01:26:39.500056Z","caller":"traceutil/trace.go:171","msg":"trace[1247104622] transaction","detail":"{read_only:false; response_revision:1568; number_of_response:1; }","duration":"193.899689ms","start":"2026-04-24T01:26:39.306121Z","end":"2026-04-24T01:26:39.50002Z","steps":["trace[1247104622] 'process raft request' (duration: 193.597122ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T01:26:39.500096Z","caller":"traceutil/trace.go:171","msg":"trace[1739074062] transaction","detail":"{read_only:false; response_revision:1570; number_of_response:1; }","duration":"193.640202ms","start":"2026-04-24T01:26:39.306417Z","end":"2026-04-24T01:26:39.500057Z","steps":["trace[1739074062] 'process raft request' (duration: 193.56892ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T01:26:39.500167Z","caller":"traceutil/trace.go:171","msg":"trace[769525015] transaction","detail":"{read_only:false; response_revision:1569; number_of_response:1; }","duration":"193.98565ms","start":"2026-04-24T01:26:39.306128Z","end":"2026-04-24T01:26:39.500114Z","steps":["trace[769525015] 'process raft request' (duration: 193.803706ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T01:26:54.83488Z","caller":"traceutil/trace.go:171","msg":"trace[963032687] linearizableReadLoop","detail":"{readStateIndex:1743; appliedIndex:1742; }","duration":"113.196944ms","start":"2026-04-24T01:26:54.721662Z","end":"2026-04-24T01:26:54.834859Z","steps":["trace[963032687] 'read index received' (duration: 113.04768ms)","trace[963032687] 'applied index is now lower than readState.Index' (duration: 148.714µs)"],"step_count":2} {"level":"info","ts":"2026-04-24T01:26:54.835033Z","caller":"traceutil/trace.go:171","msg":"trace[1821021032] transaction","detail":"{read_only:false; response_revision:1669; number_of_response:1; }","duration":"191.878914ms","start":"2026-04-24T01:26:54.643106Z","end":"2026-04-24T01:26:54.834985Z","steps":["trace[1821021032] 'process raft request' (duration: 191.649438ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T01:26:54.835074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.397278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-24T01:26:54.835128Z","caller":"traceutil/trace.go:171","msg":"trace[132325739] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1669; }","duration":"113.550112ms","start":"2026-04-24T01:26:54.721569Z","end":"2026-04-24T01:26:54.835119Z","steps":["trace[132325739] 'agreement among raft nodes before linearized reading' (duration: 113.374938ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T01:26:55.101233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.86837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-24T01:26:55.101353Z","caller":"traceutil/trace.go:171","msg":"trace[1426268973] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1670; }","duration":"160.047435ms","start":"2026-04-24T01:26:54.941281Z","end":"2026-04-24T01:26:55.101328Z","steps":["trace[1426268973] 'range keys from in-memory index tree' (duration: 159.777249ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T01:27:11.540717Z","caller":"traceutil/trace.go:171","msg":"trace[738390600] transaction","detail":"{read_only:false; response_revision:1752; number_of_response:1; }","duration":"102.183088ms","start":"2026-04-24T01:27:11.438473Z","end":"2026-04-24T01:27:11.540656Z","steps":["trace[738390600] 'process raft request' (duration: 101.988033ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T01:27:11.89708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.895476ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-24T01:27:11.897184Z","caller":"traceutil/trace.go:171","msg":"trace[1302430914] linearizableReadLoop","detail":"{readStateIndex:1831; appliedIndex:1830; }","duration":"352.459462ms","start":"2026-04-24T01:27:11.544709Z","end":"2026-04-24T01:27:11.897168Z","steps":["trace[1302430914] 'read index received' (duration: 249.317871ms)","trace[1302430914] 'applied index is now lower than readState.Index' (duration: 103.140461ms)"],"step_count":2} {"level":"warn","ts":"2026-04-24T01:27:11.897434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.13583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-24T01:27:11.897412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.691158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/persistent-volume-binder\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-04-24T01:27:11.89747Z","caller":"traceutil/trace.go:171","msg":"trace[814559631] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:1753; }","duration":"233.176661ms","start":"2026-04-24T01:27:11.664283Z","end":"2026-04-24T01:27:11.89746Z","steps":["trace[814559631] 'agreement among raft nodes before linearized reading' (duration: 233.115479ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T01:27:11.897505Z","caller":"traceutil/trace.go:171","msg":"trace[749030977] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/persistent-volume-binder; range_end:; response_count:1; response_revision:1753; }","duration":"352.833701ms","start":"2026-04-24T01:27:11.544651Z","end":"2026-04-24T01:27:11.897484Z","steps":["trace[749030977] 'agreement among raft nodes before linearized reading' (duration: 352.661707ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T01:27:11.89755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T01:27:11.544629Z","time spent":"352.911923ms","remote":"127.0.0.1:48494","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":236,"request content":"key:\"/registry/serviceaccounts/kube-system/persistent-volume-binder\" "} {"level":"warn","ts":"2026-04-24T01:27:11.897778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.024762ms","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-24T01:27:11.897807Z","caller":"traceutil/trace.go:171","msg":"trace[2001705108] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1753; }","duration":"181.091654ms","start":"2026-04-24T01:27:11.716707Z","end":"2026-04-24T01:27:11.897798Z","steps":["trace[2001705108] 'agreement among raft nodes before linearized reading' (duration: 180.984971ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T01:27:11.897821Z","caller":"traceutil/trace.go:171","msg":"trace[587646897] transaction","detail":"{read_only:false; response_revision:1753; number_of_response:1; }","duration":"391.858304ms","start":"2026-04-24T01:27:11.505948Z","end":"2026-04-24T01:27:11.897806Z","steps":["trace[587646897] 'process raft request' (duration: 288.116449ms)","trace[587646897] 'compare' (duration: 102.800023ms)"],"step_count":2} {"level":"warn","ts":"2026-04-24T01:27:11.897921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T01:27:11.505922Z","time spent":"391.933136ms","remote":"127.0.0.1:48556","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-24T01:27:11.89798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.295899ms","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-24T01:27:11.898007Z","caller":"traceutil/trace.go:171","msg":"trace[1480763897] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1753; }","duration":"181.35824ms","start":"2026-04-24T01:27:11.716641Z","end":"2026-04-24T01:27:11.897999Z","steps":["trace[1480763897] 'agreement among raft nodes before linearized reading' (duration: 181.281198ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T01:27:11.898155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.133052ms","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-24T01:27:11.898178Z","caller":"traceutil/trace.go:171","msg":"trace[556390748] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1753; }","duration":"183.188124ms","start":"2026-04-24T01:27:11.714983Z","end":"2026-04-24T01:27:11.898171Z","steps":["trace[556390748] 'agreement among raft nodes before linearized reading' (duration: 183.122822ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T01:27:11.898425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.943187ms","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-24T01:27:11.898461Z","caller":"traceutil/trace.go:171","msg":"trace[1369045587] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1753; }","duration":"214.010038ms","start":"2026-04-24T01:27:11.68444Z","end":"2026-04-24T01:27:11.89845Z","steps":["trace[1369045587] 'agreement among raft nodes before linearized reading' (duration: 213.865565ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T01:27:12.562085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.438133ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-24T01:27:12.562169Z","caller":"traceutil/trace.go:171","msg":"trace[801494743] transaction","detail":"{read_only:false; response_revision:1764; number_of_response:1; }","duration":"338.981317ms","start":"2026-04-24T01:27:12.223174Z","end":"2026-04-24T01:27:12.562155Z","steps":["trace[801494743] 'process raft request' (duration: 181.414962ms)","trace[801494743] 'compare' (duration: 157.219907ms)"],"step_count":2} {"level":"warn","ts":"2026-04-24T01:27:12.562208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T01:27:12.223155Z","time spent":"339.036118ms","remote":"127.0.0.1:48466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1933,"response count":0,"response size":38,"request content":"compare: success:> failure: >"}