{"level":"warn","ts":"2026-04-27T01:21:05.721852Z","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-27T01:21:05.722035Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.248: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.248:2380","--initial-cluster=instance=https://199.204.45.248:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.248:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.248: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-27T01:21:05.722158Z","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-27T01:21:05.722183Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.248:2380"]} {"level":"info","ts":"2026-04-27T01:21:05.722294Z","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-27T01:21:05.722999Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"]} {"level":"info","ts":"2026-04-27T01:21:05.723079Z","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.248:2380"],"listen-peer-urls":["https://199.204.45.248:2380"],"advertise-client-urls":["https://199.204.45.248:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.248: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-27T01:21:05.728969Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.506307ms"} {"level":"info","ts":"2026-04-27T01:21:05.737358Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"39582465ceaa2f67","cluster-id":"87fd8ddedde3be45"} {"level":"info","ts":"2026-04-27T01:21:05.737626Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=()"} {"level":"info","ts":"2026-04-27T01:21:05.73768Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became follower at term 0"} {"level":"info","ts":"2026-04-27T01:21:05.73779Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 39582465ceaa2f67 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-27T01:21:05.737858Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became follower at term 1"} {"level":"info","ts":"2026-04-27T01:21:05.738033Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=(4132092677789986663)"} {"level":"warn","ts":"2026-04-27T01:21:05.744944Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-27T01:21:05.74626Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-27T01:21:05.747265Z","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-27T01:21:05.749254Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"39582465ceaa2f67","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-27T01:21:05.749911Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"39582465ceaa2f67","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-27T01:21:05.750027Z","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-27T01:21:05.750074Z","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-27T01:21:05.750085Z","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-27T01:21:05.750292Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=(4132092677789986663)"} {"level":"info","ts":"2026-04-27T01:21:05.751501Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"87fd8ddedde3be45","local-member-id":"39582465ceaa2f67","added-peer-id":"39582465ceaa2f67","added-peer-peer-urls":["https://199.204.45.248:2380"]} {"level":"info","ts":"2026-04-27T01:21:05.753808Z","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-27T01:21:05.753941Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.248:2380"} {"level":"info","ts":"2026-04-27T01:21:05.753966Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.248:2380"} {"level":"info","ts":"2026-04-27T01:21:05.754121Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"39582465ceaa2f67","initial-advertise-peer-urls":["https://199.204.45.248:2380"],"listen-peer-urls":["https://199.204.45.248:2380"],"advertise-client-urls":["https://199.204.45.248:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-27T01:21:05.75417Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-27T01:21:06.538471Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 is starting a new election at term 1"} {"level":"info","ts":"2026-04-27T01:21:06.538565Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-27T01:21:06.538605Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 received MsgPreVoteResp from 39582465ceaa2f67 at term 1"} {"level":"info","ts":"2026-04-27T01:21:06.538627Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became candidate at term 2"} {"level":"info","ts":"2026-04-27T01:21:06.538638Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 received MsgVoteResp from 39582465ceaa2f67 at term 2"} {"level":"info","ts":"2026-04-27T01:21:06.538655Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became leader at term 2"} {"level":"info","ts":"2026-04-27T01:21:06.53867Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 39582465ceaa2f67 elected leader 39582465ceaa2f67 at term 2"} {"level":"info","ts":"2026-04-27T01:21:06.539819Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T01:21:06.540614Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-27T01:21:06.540615Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"39582465ceaa2f67","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.248:2379]}","request-path":"/0/members/39582465ceaa2f67/attributes","cluster-id":"87fd8ddedde3be45","publish-timeout":"7s"} {"level":"info","ts":"2026-04-27T01:21:06.540651Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-27T01:21:06.540968Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-27T01:21:06.541008Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-27T01:21:06.541081Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"87fd8ddedde3be45","local-member-id":"39582465ceaa2f67","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T01:21:06.541349Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T01:21:06.541387Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T01:21:06.543238Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-27T01:21:06.545787Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.248:2379"} {"level":"info","ts":"2026-04-27T01:21:36.387445Z","caller":"traceutil/trace.go:171","msg":"trace[1403486417] linearizableReadLoop","detail":"{readStateIndex:489; appliedIndex:488; }","duration":"189.238645ms","start":"2026-04-27T01:21:36.198176Z","end":"2026-04-27T01:21:36.387415Z","steps":["trace[1403486417] 'read index received' (duration: 189.011323ms)","trace[1403486417] 'applied index is now lower than readState.Index' (duration: 226.042µs)"],"step_count":2} {"level":"warn","ts":"2026-04-27T01:21:36.387653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.442487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T01:21:36.387721Z","caller":"traceutil/trace.go:171","msg":"trace[154318326] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:472; }","duration":"189.549457ms","start":"2026-04-27T01:21:36.198159Z","end":"2026-04-27T01:21:36.387708Z","steps":["trace[154318326] 'agreement among raft nodes before linearized reading' (duration: 189.401676ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:21:36.387839Z","caller":"traceutil/trace.go:171","msg":"trace[1881511981] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"189.647008ms","start":"2026-04-27T01:21:36.197939Z","end":"2026-04-27T01:21:36.387586Z","steps":["trace[1881511981] 'process raft request' (duration: 188.665101ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:21:36.404742Z","caller":"traceutil/trace.go:171","msg":"trace[88467740] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"206.057112ms","start":"2026-04-27T01:21:36.198667Z","end":"2026-04-27T01:21:36.404724Z","steps":["trace[88467740] 'process raft request' (duration: 205.81472ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:21:36.405081Z","caller":"traceutil/trace.go:171","msg":"trace[276599858] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"205.025445ms","start":"2026-04-27T01:21:36.200034Z","end":"2026-04-27T01:21:36.405059Z","steps":["trace[276599858] 'process raft request' (duration: 204.613392ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:21:36.405173Z","caller":"traceutil/trace.go:171","msg":"trace[1133791033] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"202.265584ms","start":"2026-04-27T01:21:36.202887Z","end":"2026-04-27T01:21:36.405152Z","steps":["trace[1133791033] 'process raft request' (duration: 202.066351ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:21:36.405206Z","caller":"traceutil/trace.go:171","msg":"trace[1099072502] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"200.68357ms","start":"2026-04-27T01:21:36.204499Z","end":"2026-04-27T01:21:36.405183Z","steps":["trace[1099072502] 'process raft request' (duration: 200.573858ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:21:36.405251Z","caller":"traceutil/trace.go:171","msg":"trace[519109833] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"200.791271ms","start":"2026-04-27T01:21:36.204434Z","end":"2026-04-27T01:21:36.405225Z","steps":["trace[519109833] 'process raft request' (duration: 200.599009ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:21:36.405289Z","caller":"traceutil/trace.go:171","msg":"trace[2048891751] transaction","detail":"{read_only:false; number_of_response:1; response_revision:477; }","duration":"198.124619ms","start":"2026-04-27T01:21:36.2071Z","end":"2026-04-27T01:21:36.405224Z","steps":["trace[2048891751] 'process raft request' (duration: 198.007457ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:21:36.40543Z","caller":"traceutil/trace.go:171","msg":"trace[60829520] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"186.775957ms","start":"2026-04-27T01:21:36.218638Z","end":"2026-04-27T01:21:36.405414Z","steps":["trace[60829520] 'process raft request' (duration: 186.510155ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:21:36.406015Z","caller":"traceutil/trace.go:171","msg":"trace[1050079866] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"186.876607ms","start":"2026-04-27T01:21:36.219123Z","end":"2026-04-27T01:21:36.406Z","steps":["trace[1050079866] 'process raft request' (duration: 186.061911ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:21:36.406082Z","caller":"traceutil/trace.go:171","msg":"trace[1412685516] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"181.905046ms","start":"2026-04-27T01:21:36.224172Z","end":"2026-04-27T01:21:36.406077Z","steps":["trace[1412685516] 'process raft request' (duration: 181.429312ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:21:36.406133Z","caller":"traceutil/trace.go:171","msg":"trace[483235532] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"179.579606ms","start":"2026-04-27T01:21:36.226549Z","end":"2026-04-27T01:21:36.406128Z","steps":["trace[483235532] 'process raft request' (duration: 179.097033ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:21:36.406181Z","caller":"traceutil/trace.go:171","msg":"trace[419998721] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"172.633511ms","start":"2026-04-27T01:21:36.233543Z","end":"2026-04-27T01:21:36.406176Z","steps":["trace[419998721] 'process raft request' (duration: 172.194137ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:21:36.406228Z","caller":"traceutil/trace.go:171","msg":"trace[354404094] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"167.757561ms","start":"2026-04-27T01:21:36.238465Z","end":"2026-04-27T01:21:36.406223Z","steps":["trace[354404094] 'process raft request' (duration: 167.325378ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:21:36.66195Z","caller":"traceutil/trace.go:171","msg":"trace[1519031308] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"126.352532ms","start":"2026-04-27T01:21:36.53557Z","end":"2026-04-27T01:21:36.661922Z","steps":["trace[1519031308] 'process raft request' (duration: 116.151589ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:21:36.662424Z","caller":"traceutil/trace.go:171","msg":"trace[1545003757] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"122.527241ms","start":"2026-04-27T01:21:36.53987Z","end":"2026-04-27T01:21:36.662397Z","steps":["trace[1545003757] 'process raft request' (duration: 121.982506ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:21:40.187763Z","caller":"traceutil/trace.go:171","msg":"trace[1931409735] linearizableReadLoop","detail":"{readStateIndex:580; appliedIndex:579; }","duration":"181.086064ms","start":"2026-04-27T01:21:40.006645Z","end":"2026-04-27T01:21:40.187731Z","steps":["trace[1931409735] 'read index received' (duration: 178.06124ms)","trace[1931409735] 'applied index is now lower than readState.Index' (duration: 3.023184ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T01:21:40.187876Z","caller":"traceutil/trace.go:171","msg":"trace[1705890259] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"336.933299ms","start":"2026-04-27T01:21:39.850915Z","end":"2026-04-27T01:21:40.187848Z","steps":["trace[1705890259] 'process raft request' (duration: 334.809562ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:21:40.188033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.365336ms","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-27T01:21:40.188127Z","caller":"traceutil/trace.go:171","msg":"trace[1769628388] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:556; }","duration":"181.463167ms","start":"2026-04-27T01:21:40.00663Z","end":"2026-04-27T01:21:40.188093Z","steps":["trace[1769628388] 'agreement among raft nodes before linearized reading' (duration: 181.286135ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:21:40.188315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:21:39.850885Z","time spent":"337.052231ms","remote":"127.0.0.1:49562","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036101,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T01:21:42.775765Z","caller":"traceutil/trace.go:171","msg":"trace[1648830427] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"227.33783ms","start":"2026-04-27T01:21:42.548398Z","end":"2026-04-27T01:21:42.775736Z","steps":["trace[1648830427] 'process raft request' (duration: 226.711905ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:21:43.391632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.712151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-cl2fq\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-27T01:21:43.391772Z","caller":"traceutil/trace.go:171","msg":"trace[162582890] range","detail":"{range_begin:/registry/pods/kube-system/cilium-cl2fq; range_end:; response_count:1; response_revision:580; }","duration":"166.901784ms","start":"2026-04-27T01:21:43.224846Z","end":"2026-04-27T01:21:43.391748Z","steps":["trace[162582890] 'range keys from in-memory index tree' (duration: 166.138857ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:21:43.425968Z","caller":"traceutil/trace.go:171","msg":"trace[1136030460] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"195.806613ms","start":"2026-04-27T01:21:43.230122Z","end":"2026-04-27T01:21:43.425929Z","steps":["trace[1136030460] 'process raft request' (duration: 194.853424ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:22:08.898551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.82163ms","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-27T01:22:08.898646Z","caller":"traceutil/trace.go:171","msg":"trace[1730598827] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:771; }","duration":"117.971804ms","start":"2026-04-27T01:22:08.780656Z","end":"2026-04-27T01:22:08.898628Z","steps":["trace[1730598827] 'range keys from in-memory index tree' (duration: 117.672274ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:24:07.426959Z","caller":"traceutil/trace.go:171","msg":"trace[1412471349] linearizableReadLoop","detail":"{readStateIndex:1392; appliedIndex:1391; }","duration":"426.537239ms","start":"2026-04-27T01:24:07.000401Z","end":"2026-04-27T01:24:07.426938Z","steps":["trace[1412471349] 'read index received' (duration: 426.462458ms)","trace[1412471349] 'applied index is now lower than readState.Index' (duration: 73.761µs)"],"step_count":2} {"level":"warn","ts":"2026-04-27T01:24:07.427175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.917237ms","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-27T01:24:07.427203Z","caller":"traceutil/trace.go:171","msg":"trace[1251498347] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1332; }","duration":"420.983358ms","start":"2026-04-27T01:24:07.006211Z","end":"2026-04-27T01:24:07.427195Z","steps":["trace[1251498347] 'agreement among raft nodes before linearized reading' (duration: 420.854536ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:24:07.427232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:24:07.006198Z","time spent":"421.025629ms","remote":"127.0.0.1:49738","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":"warn","ts":"2026-04-27T01:24:07.427276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.744817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-27T01:24:07.427306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.929557ms","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-27T01:24:07.427376Z","caller":"traceutil/trace.go:171","msg":"trace[1996806711] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1332; }","duration":"243.889171ms","start":"2026-04-27T01:24:07.183463Z","end":"2026-04-27T01:24:07.427352Z","steps":["trace[1996806711] 'agreement among raft nodes before linearized reading' (duration: 243.699297ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:24:07.427382Z","caller":"traceutil/trace.go:171","msg":"trace[458205307] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1332; }","duration":"129.049639ms","start":"2026-04-27T01:24:07.298315Z","end":"2026-04-27T01:24:07.427364Z","steps":["trace[458205307] 'agreement among raft nodes before linearized reading' (duration: 128.802985ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:24:07.427183Z","caller":"traceutil/trace.go:171","msg":"trace[605017180] transaction","detail":"{read_only:false; response_revision:1332; number_of_response:1; }","duration":"438.175689ms","start":"2026-04-27T01:24:06.988972Z","end":"2026-04-27T01:24:07.427148Z","steps":["trace[605017180] 'process raft request' (duration: 437.834154ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:24:07.427581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.164359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-27T01:24:07.427676Z","caller":"traceutil/trace.go:171","msg":"trace[649233925] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1332; }","duration":"427.307841ms","start":"2026-04-27T01:24:07.000346Z","end":"2026-04-27T01:24:07.427654Z","steps":["trace[649233925] 'agreement among raft nodes before linearized reading' (duration: 426.709822ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:24:07.427782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:24:06.988956Z","time spent":"438.604526ms","remote":"127.0.0.1:49738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T01:24:07.427983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:24:07.000327Z","time spent":"427.505074ms","remote":"127.0.0.1:49738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-27T01:24:28.008479Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415872344140732923,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-27T01:24:28.175162Z","caller":"traceutil/trace.go:171","msg":"trace[542443180] transaction","detail":"{read_only:false; response_revision:1399; number_of_response:1; }","duration":"667.396116ms","start":"2026-04-27T01:24:27.507738Z","end":"2026-04-27T01:24:28.175135Z","steps":["trace[542443180] 'process raft request' (duration: 667.239454ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:24:28.175395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:24:27.507726Z","time spent":"667.596428ms","remote":"127.0.0.1:49738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T01:24:28.176104Z","caller":"traceutil/trace.go:171","msg":"trace[1292339927] linearizableReadLoop","detail":"{readStateIndex:1464; appliedIndex:1462; }","duration":"668.264748ms","start":"2026-04-27T01:24:27.507829Z","end":"2026-04-27T01:24:28.176094Z","steps":["trace[1292339927] 'read index received' (duration: 667.142383ms)","trace[1292339927] 'applied index is now lower than readState.Index' (duration: 1.121925ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T01:24:28.176154Z","caller":"traceutil/trace.go:171","msg":"trace[1805774359] transaction","detail":"{read_only:false; response_revision:1400; number_of_response:1; }","duration":"312.510216ms","start":"2026-04-27T01:24:27.863629Z","end":"2026-04-27T01:24:28.176139Z","steps":["trace[1805774359] 'process raft request' (duration: 312.407255ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:24:28.176216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:24:27.863598Z","time spent":"312.583707ms","remote":"127.0.0.1:49738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T01:24:28.17644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"658.680588ms","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-27T01:24:28.176831Z","caller":"traceutil/trace.go:171","msg":"trace[1674557580] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1400; }","duration":"659.096294ms","start":"2026-04-27T01:24:27.517721Z","end":"2026-04-27T01:24:28.176817Z","steps":["trace[1674557580] 'agreement among raft nodes before linearized reading' (duration: 658.622807ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:24:28.176941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:24:27.51771Z","time spent":"659.215266ms","remote":"127.0.0.1:49738","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":"warn","ts":"2026-04-27T01:24:28.176569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"649.468082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-04-27T01:24:28.177177Z","caller":"traceutil/trace.go:171","msg":"trace[388349085] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:1400; }","duration":"650.088131ms","start":"2026-04-27T01:24:27.527074Z","end":"2026-04-27T01:24:28.177162Z","steps":["trace[388349085] 'agreement among raft nodes before linearized reading' (duration: 649.411111ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:24:28.177251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:24:27.527066Z","time spent":"650.170622ms","remote":"127.0.0.1:49670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":220,"request content":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" "} {"level":"warn","ts":"2026-04-27T01:24:28.176601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"668.776274ms","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-27T01:24:28.177657Z","caller":"traceutil/trace.go:171","msg":"trace[790778084] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1400; }","duration":"669.853659ms","start":"2026-04-27T01:24:27.507783Z","end":"2026-04-27T01:24:28.177637Z","steps":["trace[790778084] 'agreement among raft nodes before linearized reading' (duration: 668.46926ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:24:28.177805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:24:27.507765Z","time spent":"670.023732ms","remote":"127.0.0.1:49738","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-27T01:24:28.176561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.610976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"warn","ts":"2026-04-27T01:24:28.176633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"498.233423ms","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":"warn","ts":"2026-04-27T01:24:28.176644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"658.81609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-27T01:24:28.177946Z","caller":"traceutil/trace.go:171","msg":"trace[1120781029] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1400; }","duration":"660.127848ms","start":"2026-04-27T01:24:27.517807Z","end":"2026-04-27T01:24:28.177935Z","steps":["trace[1120781029] 'agreement among raft nodes before linearized reading' (duration: 658.750189ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:24:28.177968Z","caller":"traceutil/trace.go:171","msg":"trace[1794660300] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:1400; }","duration":"402.032325ms","start":"2026-04-27T01:24:27.775896Z","end":"2026-04-27T01:24:28.177928Z","steps":["trace[1794660300] 'agreement among raft nodes before linearized reading' (duration: 400.586955ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:24:28.178086Z","caller":"traceutil/trace.go:171","msg":"trace[1730005700] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1400; }","duration":"499.707174ms","start":"2026-04-27T01:24:27.678359Z","end":"2026-04-27T01:24:28.178066Z","steps":["trace[1730005700] 'agreement among raft nodes before linearized reading' (duration: 498.058061ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:24:28.17817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:24:27.678349Z","time spent":"499.809515ms","remote":"127.0.0.1:49738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-27T01:24:28.178225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:24:27.775878Z","time spent":"402.308489ms","remote":"127.0.0.1:49670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":232,"request content":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" "} {"level":"warn","ts":"2026-04-27T01:24:28.178014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:24:27.517803Z","time spent":"660.199869ms","remote":"127.0.0.1:49738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}