{"level":"warn","ts":"2026-05-06T05:02:24.277722Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-06T05:02:24.277808Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.147: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.19.213.147:2380","--initial-cluster=instance=https://199.19.213.147:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.147:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.147: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-05-06T05:02:24.277877Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-06T05:02:24.27789Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.147:2380"]} {"level":"info","ts":"2026-05-06T05:02:24.277906Z","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-05-06T05:02:24.278771Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.147:2379"]} {"level":"info","ts":"2026-05-06T05:02:24.278849Z","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.19.213.147:2380"],"listen-peer-urls":["https://199.19.213.147:2380"],"advertise-client-urls":["https://199.19.213.147:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.147:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.147: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-05-06T05:02:24.282356Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.116215ms"} {"level":"info","ts":"2026-05-06T05:02:24.286954Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"6244e483e416226f","cluster-id":"68a374eab3e2de92"} {"level":"info","ts":"2026-05-06T05:02:24.287035Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f switched to configuration voters=()"} {"level":"info","ts":"2026-05-06T05:02:24.287056Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f became follower at term 0"} {"level":"info","ts":"2026-05-06T05:02:24.287069Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 6244e483e416226f [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-06T05:02:24.287079Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f became follower at term 1"} {"level":"info","ts":"2026-05-06T05:02:24.287118Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f switched to configuration voters=(7081035769251766895)"} {"level":"warn","ts":"2026-05-06T05:02:24.296535Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-06T05:02:24.298188Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-06T05:02:24.3012Z","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-05-06T05:02:24.304106Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"6244e483e416226f","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-06T05:02:24.304932Z","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-05-06T05:02:24.304972Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"6244e483e416226f","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-06T05:02:24.305025Z","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-05-06T05:02:24.305059Z","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-05-06T05:02:24.309969Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f switched to configuration voters=(7081035769251766895)"} {"level":"info","ts":"2026-05-06T05:02:24.310139Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"68a374eab3e2de92","local-member-id":"6244e483e416226f","added-peer-id":"6244e483e416226f","added-peer-peer-urls":["https://199.19.213.147:2380"]} {"level":"info","ts":"2026-05-06T05:02:24.314373Z","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-05-06T05:02:24.314571Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"6244e483e416226f","initial-advertise-peer-urls":["https://199.19.213.147:2380"],"listen-peer-urls":["https://199.19.213.147:2380"],"advertise-client-urls":["https://199.19.213.147:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.147:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-06T05:02:24.314594Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-06T05:02:24.314627Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.147:2380"} {"level":"info","ts":"2026-05-06T05:02:24.314636Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.147:2380"} {"level":"info","ts":"2026-05-06T05:02:24.487981Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f is starting a new election at term 1"} {"level":"info","ts":"2026-05-06T05:02:24.488082Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f became pre-candidate at term 1"} {"level":"info","ts":"2026-05-06T05:02:24.488168Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f received MsgPreVoteResp from 6244e483e416226f at term 1"} {"level":"info","ts":"2026-05-06T05:02:24.488316Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f became candidate at term 2"} {"level":"info","ts":"2026-05-06T05:02:24.488333Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f received MsgVoteResp from 6244e483e416226f at term 2"} {"level":"info","ts":"2026-05-06T05:02:24.488346Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f became leader at term 2"} {"level":"info","ts":"2026-05-06T05:02:24.488399Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 6244e483e416226f elected leader 6244e483e416226f at term 2"} {"level":"info","ts":"2026-05-06T05:02:24.489291Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"6244e483e416226f","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.147:2379]}","request-path":"/0/members/6244e483e416226f/attributes","cluster-id":"68a374eab3e2de92","publish-timeout":"7s"} {"level":"info","ts":"2026-05-06T05:02:24.489403Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-06T05:02:24.490414Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-06T05:02:24.491673Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-06T05:02:24.491839Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-06T05:02:24.492947Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"68a374eab3e2de92","local-member-id":"6244e483e416226f","cluster-version":"3.5"} {"level":"info","ts":"2026-05-06T05:02:24.493041Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-06T05:02:24.493077Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-06T05:02:24.493745Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-06T05:02:24.493813Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-06T05:02:24.497335Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.147:2379"} {"level":"warn","ts":"2026-05-06T05:02:33.911013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.843822ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-06T05:02:33.911146Z","caller":"traceutil/trace.go:171","msg":"trace[1256712472] transaction","detail":"{read_only:false; response_revision:351; number_of_response:1; }","duration":"422.481172ms","start":"2026-05-06T05:02:33.488647Z","end":"2026-05-06T05:02:33.911128Z","steps":["trace[1256712472] 'process raft request' (duration: 204.987026ms)","trace[1256712472] 'compare' (duration: 216.709488ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T05:02:33.911229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:02:33.488624Z","time spent":"422.572164ms","remote":"127.0.0.1:47768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2264,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T05:02:34.090653Z","caller":"traceutil/trace.go:171","msg":"trace[482440999] linearizableReadLoop","detail":"{readStateIndex:363; appliedIndex:361; }","duration":"576.944174ms","start":"2026-05-06T05:02:33.513672Z","end":"2026-05-06T05:02:34.090616Z","steps":["trace[482440999] 'read index received' (duration: 179.923034ms)","trace[482440999] 'applied index is now lower than readState.Index' (duration: 397.02008ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T05:02:34.090718Z","caller":"traceutil/trace.go:171","msg":"trace[1908386231] transaction","detail":"{read_only:false; response_revision:352; number_of_response:1; }","duration":"601.923784ms","start":"2026-05-06T05:02:33.488737Z","end":"2026-05-06T05:02:34.09066Z","steps":["trace[1908386231] 'process raft request' (duration: 541.897202ms)","trace[1908386231] 'compare' (duration: 59.879689ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T05:02:34.090904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:02:33.48871Z","time spent":"602.087827ms","remote":"127.0.0.1:47768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3461,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-06T05:02:34.091077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.845994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"warn","ts":"2026-05-06T05:02:34.091082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"475.462186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"warn","ts":"2026-05-06T05:02:34.091103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.863544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"warn","ts":"2026-05-06T05:02:34.091126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"525.957348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-05-06T05:02:34.091182Z","caller":"traceutil/trace.go:171","msg":"trace[410546933] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:352; }","duration":"475.575418ms","start":"2026-05-06T05:02:33.615556Z","end":"2026-05-06T05:02:34.091131Z","steps":["trace[410546933] 'agreement among raft nodes before linearized reading' (duration: 475.431955ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:02:34.091174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.671754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"warn","ts":"2026-05-06T05:02:34.091226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:02:33.61553Z","time spent":"475.68758ms","remote":"127.0.0.1:47616","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":217,"request content":"key:\"/registry/serviceaccounts/kube-system/node-controller\" "} {"level":"info","ts":"2026-05-06T05:02:34.091241Z","caller":"traceutil/trace.go:171","msg":"trace[1955255131] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:352; }","duration":"275.90161ms","start":"2026-05-06T05:02:33.815323Z","end":"2026-05-06T05:02:34.091225Z","steps":["trace[1955255131] 'agreement among raft nodes before linearized reading' (duration: 275.660124ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:02:34.091268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"577.350884ms","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-05-06T05:02:34.091537Z","caller":"traceutil/trace.go:171","msg":"trace[477494729] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:352; }","duration":"526.355038ms","start":"2026-05-06T05:02:33.564965Z","end":"2026-05-06T05:02:34.09132Z","steps":["trace[477494729] 'agreement among raft nodes before linearized reading' (duration: 525.888087ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:02:34.091604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:02:33.564949Z","time spent":"526.641995ms","remote":"127.0.0.1:47616","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":231,"request content":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" "} {"level":"info","ts":"2026-05-06T05:02:34.091151Z","caller":"traceutil/trace.go:171","msg":"trace[1918432017] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:352; }","duration":"326.936867ms","start":"2026-05-06T05:02:33.764201Z","end":"2026-05-06T05:02:34.091137Z","steps":["trace[1918432017] 'agreement among raft nodes before linearized reading' (duration: 326.857165ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:02:34.091664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:02:33.764185Z","time spent":"327.463249ms","remote":"127.0.0.1:47616","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":229,"request content":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" "} {"level":"warn","ts":"2026-05-06T05:02:34.091667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.817826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-05-06T05:02:34.091759Z","caller":"traceutil/trace.go:171","msg":"trace[1930814400] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:352; }","duration":"427.535863ms","start":"2026-05-06T05:02:33.664199Z","end":"2026-05-06T05:02:34.091735Z","steps":["trace[1930814400] 'agreement among raft nodes before linearized reading' (duration: 426.722523ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:02:34.091328Z","caller":"traceutil/trace.go:171","msg":"trace[459732385] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:352; }","duration":"577.668201ms","start":"2026-05-06T05:02:33.513639Z","end":"2026-05-06T05:02:34.091307Z","steps":["trace[459732385] 'agreement among raft nodes before linearized reading' (duration: 577.123558ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:02:34.091814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:02:33.664133Z","time spent":"427.666046ms","remote":"127.0.0.1:47616","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":225,"request content":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" "} {"level":"warn","ts":"2026-05-06T05:02:34.091884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:02:33.51363Z","time spent":"578.237205ms","remote":"127.0.0.1:47616","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":219,"request content":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" "} {"level":"info","ts":"2026-05-06T05:02:34.091586Z","caller":"traceutil/trace.go:171","msg":"trace[1294139494] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:352; }","duration":"377.114441ms","start":"2026-05-06T05:02:33.714009Z","end":"2026-05-06T05:02:34.091124Z","steps":["trace[1294139494] 'agreement among raft nodes before linearized reading' (duration: 376.853605ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:02:34.092038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:02:33.713995Z","time spent":"378.031353ms","remote":"127.0.0.1:47616","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":236,"request content":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" "} {"level":"info","ts":"2026-05-06T05:02:34.224424Z","caller":"traceutil/trace.go:171","msg":"trace[2116375257] transaction","detail":"{read_only:false; response_revision:354; number_of_response:1; }","duration":"124.40914ms","start":"2026-05-06T05:02:34.099994Z","end":"2026-05-06T05:02:34.224403Z","steps":["trace[2116375257] 'process raft request' (duration: 124.356839ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:02:34.225008Z","caller":"traceutil/trace.go:171","msg":"trace[244979767] transaction","detail":"{read_only:false; response_revision:360; number_of_response:1; }","duration":"123.567169ms","start":"2026-05-06T05:02:34.101432Z","end":"2026-05-06T05:02:34.224999Z","steps":["trace[244979767] 'process raft request' (duration: 123.538178ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:02:34.225041Z","caller":"traceutil/trace.go:171","msg":"trace[2137114911] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"124.719198ms","start":"2026-05-06T05:02:34.100296Z","end":"2026-05-06T05:02:34.225015Z","steps":["trace[2137114911] 'process raft request' (duration: 124.577244ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:02:34.2252Z","caller":"traceutil/trace.go:171","msg":"trace[840595801] transaction","detail":"{read_only:false; response_revision:359; number_of_response:1; }","duration":"124.243736ms","start":"2026-05-06T05:02:34.10094Z","end":"2026-05-06T05:02:34.225183Z","steps":["trace[840595801] 'process raft request' (duration: 123.983999ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:02:34.225183Z","caller":"traceutil/trace.go:171","msg":"trace[1886114749] transaction","detail":"{read_only:false; response_revision:353; number_of_response:1; }","duration":"125.180808ms","start":"2026-05-06T05:02:34.09999Z","end":"2026-05-06T05:02:34.22517Z","steps":["trace[1886114749] 'process raft request' (duration: 115.804473ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:02:34.225301Z","caller":"traceutil/trace.go:171","msg":"trace[247035762] transaction","detail":"{read_only:false; response_revision:355; number_of_response:1; }","duration":"125.185068ms","start":"2026-05-06T05:02:34.100104Z","end":"2026-05-06T05:02:34.225289Z","steps":["trace[247035762] 'process raft request' (duration: 124.651685ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:02:34.225144Z","caller":"traceutil/trace.go:171","msg":"trace[904330428] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"124.370748ms","start":"2026-05-06T05:02:34.100752Z","end":"2026-05-06T05:02:34.225123Z","steps":["trace[904330428] 'process raft request' (duration: 124.147313ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:02:34.225527Z","caller":"traceutil/trace.go:171","msg":"trace[115930145] transaction","detail":"{read_only:false; response_revision:356; number_of_response:1; }","duration":"125.343442ms","start":"2026-05-06T05:02:34.100173Z","end":"2026-05-06T05:02:34.225517Z","steps":["trace[115930145] 'process raft request' (duration: 124.641586ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:03:07.016607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.593719ms","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-05-06T05:03:07.016725Z","caller":"traceutil/trace.go:171","msg":"trace[1085444545] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:630; }","duration":"261.744983ms","start":"2026-05-06T05:03:06.754967Z","end":"2026-05-06T05:03:07.016712Z","steps":["trace[1085444545] 'range keys from in-memory index tree' (duration: 261.441375ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:03:07.016767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.234608ms","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-05-06T05:03:07.016881Z","caller":"traceutil/trace.go:171","msg":"trace[265841668] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:630; }","duration":"265.432353ms","start":"2026-05-06T05:03:06.751428Z","end":"2026-05-06T05:03:07.01686Z","steps":["trace[265841668] 'range keys from in-memory index tree' (duration: 265.017972ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:03:07.267233Z","caller":"traceutil/trace.go:171","msg":"trace[272968670] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"246.44021ms","start":"2026-05-06T05:03:07.020771Z","end":"2026-05-06T05:03:07.267211Z","steps":["trace[272968670] 'process raft request' (duration: 246.283927ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:03:07.267617Z","caller":"traceutil/trace.go:171","msg":"trace[1041537151] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"246.501612ms","start":"2026-05-06T05:03:07.021103Z","end":"2026-05-06T05:03:07.267604Z","steps":["trace[1041537151] 'process raft request' (duration: 246.076061ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:03:07.268063Z","caller":"traceutil/trace.go:171","msg":"trace[1939881691] linearizableReadLoop","detail":"{readStateIndex:656; appliedIndex:653; }","duration":"228.307108ms","start":"2026-05-06T05:03:07.039738Z","end":"2026-05-06T05:03:07.268045Z","steps":["trace[1939881691] 'read index received' (duration: 15.412305ms)","trace[1939881691] 'applied index is now lower than readState.Index' (duration: 212.894123ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T05:03:07.268182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.426401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-t72t5\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-05-06T05:03:07.26821Z","caller":"traceutil/trace.go:171","msg":"trace[853642067] range","detail":"{range_begin:/registry/pods/kube-system/cilium-t72t5; range_end:; response_count:1; response_revision:634; }","duration":"228.470492ms","start":"2026-05-06T05:03:07.039732Z","end":"2026-05-06T05:03:07.268203Z","steps":["trace[853642067] 'agreement among raft nodes before linearized reading' (duration: 228.38366ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:03:07.268373Z","caller":"traceutil/trace.go:171","msg":"trace[687461090] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"218.711865ms","start":"2026-05-06T05:03:07.049646Z","end":"2026-05-06T05:03:07.268358Z","steps":["trace[687461090] 'process raft request' (duration: 217.960637ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:03:07.935842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.760423ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-06T05:03:07.936752Z","caller":"traceutil/trace.go:171","msg":"trace[1072359690] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"605.000609ms","start":"2026-05-06T05:03:07.331724Z","end":"2026-05-06T05:03:07.936725Z","steps":["trace[1072359690] 'process raft request' (duration: 350.79471ms)","trace[1072359690] 'compare' (duration: 252.466796ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T05:03:07.936952Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:03:07.331706Z","time spent":"605.177114ms","remote":"127.0.0.1:47656","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-06T05:03:07.937119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"601.533285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T05:03:07.93729Z","caller":"traceutil/trace.go:171","msg":"trace[1692688382] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:636; }","duration":"601.770591ms","start":"2026-05-06T05:03:07.33549Z","end":"2026-05-06T05:03:07.937261Z","steps":["trace[1692688382] 'agreement among raft nodes before linearized reading' (duration: 601.456073ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:03:07.937359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:03:07.335479Z","time spent":"601.865203ms","remote":"127.0.0.1:47396","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-06T05:03:07.937598Z","caller":"traceutil/trace.go:171","msg":"trace[99623376] linearizableReadLoop","detail":"{readStateIndex:659; appliedIndex:657; }","duration":"601.130815ms","start":"2026-05-06T05:03:07.335524Z","end":"2026-05-06T05:03:07.936655Z","steps":["trace[99623376] 'read index received' (duration: 20.330166ms)","trace[99623376] 'applied index is now lower than readState.Index' (duration: 580.798389ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T05:03:07.937762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.854528ms","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-05-06T05:03:07.937807Z","caller":"traceutil/trace.go:171","msg":"trace[213472515] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:636; }","duration":"425.93925ms","start":"2026-05-06T05:03:07.51186Z","end":"2026-05-06T05:03:07.937799Z","steps":["trace[213472515] 'agreement among raft nodes before linearized reading' (duration: 425.824037ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:03:07.93783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:03:07.511835Z","time spent":"425.98898ms","remote":"127.0.0.1:47686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-06T05:03:23.345544Z","caller":"traceutil/trace.go:171","msg":"trace[904013964] transaction","detail":"{read_only:false; response_revision:796; number_of_response:1; }","duration":"196.622867ms","start":"2026-05-06T05:03:23.148887Z","end":"2026-05-06T05:03:23.34551Z","steps":["trace[904013964] 'process raft request' (duration: 196.444192ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:03:58.340216Z","caller":"traceutil/trace.go:171","msg":"trace[970029833] transaction","detail":"{read_only:false; response_revision:1010; number_of_response:1; }","duration":"113.260239ms","start":"2026-05-06T05:03:58.226934Z","end":"2026-05-06T05:03:58.340194Z","steps":["trace[970029833] 'process raft request' (duration: 113.131186ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:03:58.583959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.047011ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-06T05:03:58.584188Z","caller":"traceutil/trace.go:171","msg":"trace[1512917571] linearizableReadLoop","detail":"{readStateIndex:1049; appliedIndex:1047; }","duration":"248.010218ms","start":"2026-05-06T05:03:58.336162Z","end":"2026-05-06T05:03:58.584172Z","steps":["trace[1512917571] 'read index received' (duration: 4.455577ms)","trace[1512917571] 'applied index is now lower than readState.Index' (duration: 243.553391ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T05:03:58.584213Z","caller":"traceutil/trace.go:171","msg":"trace[586182650] transaction","detail":"{read_only:false; response_revision:1011; number_of_response:1; }","duration":"270.432038ms","start":"2026-05-06T05:03:58.313739Z","end":"2026-05-06T05:03:58.584171Z","steps":["trace[586182650] 'process raft request' (duration: 126.085919ms)","trace[586182650] 'compare' (duration: 143.937729ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T05:03:58.584326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.167061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T05:03:58.584353Z","caller":"traceutil/trace.go:171","msg":"trace[937788275] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1012; }","duration":"248.224463ms","start":"2026-05-06T05:03:58.33612Z","end":"2026-05-06T05:03:58.584345Z","steps":["trace[937788275] 'agreement among raft nodes before linearized reading' (duration: 248.09795ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:03:58.584543Z","caller":"traceutil/trace.go:171","msg":"trace[1865296915] transaction","detail":"{read_only:false; response_revision:1012; number_of_response:1; }","duration":"263.909232ms","start":"2026-05-06T05:03:58.320625Z","end":"2026-05-06T05:03:58.584534Z","steps":["trace[1865296915] 'process raft request' (duration: 263.484701ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:04:22.035213Z","caller":"traceutil/trace.go:171","msg":"trace[1746374028] transaction","detail":"{read_only:false; response_revision:1088; number_of_response:1; }","duration":"100.309888ms","start":"2026-05-06T05:04:21.934882Z","end":"2026-05-06T05:04:22.035192Z","steps":["trace[1746374028] 'process raft request' (duration: 100.165985ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:04:22.5115Z","caller":"traceutil/trace.go:171","msg":"trace[793720922] linearizableReadLoop","detail":"{readStateIndex:1130; appliedIndex:1129; }","duration":"388.235938ms","start":"2026-05-06T05:04:22.123245Z","end":"2026-05-06T05:04:22.511481Z","steps":["trace[793720922] 'read index received' (duration: 388.087625ms)","trace[793720922] 'applied index is now lower than readState.Index' (duration: 147.273µs)"],"step_count":2} {"level":"info","ts":"2026-05-06T05:04:22.511631Z","caller":"traceutil/trace.go:171","msg":"trace[1805638773] transaction","detail":"{read_only:false; response_revision:1089; number_of_response:1; }","duration":"403.29055ms","start":"2026-05-06T05:04:22.108312Z","end":"2026-05-06T05:04:22.511603Z","steps":["trace[1805638773] 'process raft request' (duration: 403.017824ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:04:22.511676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.400352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T05:04:22.511748Z","caller":"traceutil/trace.go:171","msg":"trace[845249802] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:1089; }","duration":"388.513134ms","start":"2026-05-06T05:04:22.123218Z","end":"2026-05-06T05:04:22.511732Z","steps":["trace[845249802] 'agreement among raft nodes before linearized reading' (duration: 388.373871ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:04:22.511775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:04:22.10827Z","time spent":"403.429554ms","remote":"127.0.0.1:47686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-06T05:04:22.511782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:04:22.123207Z","time spent":"388.567776ms","remote":"127.0.0.1:47704","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":0,"response size":27,"request content":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-06T05:04:22.511657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.323056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T05:04:22.511945Z","caller":"traceutil/trace.go:171","msg":"trace[1670771063] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1089; }","duration":"175.627154ms","start":"2026-05-06T05:04:22.336286Z","end":"2026-05-06T05:04:22.511913Z","steps":["trace[1670771063] 'agreement among raft nodes before linearized reading' (duration: 175.325807ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:04:23.12902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.162197ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-05-06T05:04:52.96179Z","caller":"traceutil/trace.go:171","msg":"trace[405471386] transaction","detail":"{read_only:false; response_revision:1240; number_of_response:1; }","duration":"107.389481ms","start":"2026-05-06T05:04:52.854367Z","end":"2026-05-06T05:04:52.961756Z","steps":["trace[405471386] 'process raft request' (duration: 107.166006ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:04:53.096884Z","caller":"traceutil/trace.go:171","msg":"trace[1755803128] linearizableReadLoop","detail":"{readStateIndex:1290; appliedIndex:1289; }","duration":"108.392067ms","start":"2026-05-06T05:04:52.988468Z","end":"2026-05-06T05:04:53.09686Z","steps":["trace[1755803128] 'read index received' (duration: 57.504305ms)","trace[1755803128] 'applied index is now lower than readState.Index' (duration: 50.884892ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T05:04:53.097055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.573411ms","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-05-06T05:04:53.097073Z","caller":"traceutil/trace.go:171","msg":"trace[1678864714] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1241; }","duration":"108.670233ms","start":"2026-05-06T05:04:52.988397Z","end":"2026-05-06T05:04:53.097067Z","steps":["trace[1678864714] 'agreement among raft nodes before linearized reading' (duration: 108.538779ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:04:54.45513Z","caller":"traceutil/trace.go:171","msg":"trace[1285420772] linearizableReadLoop","detail":"{readStateIndex:1296; appliedIndex:1295; }","duration":"118.584995ms","start":"2026-05-06T05:04:54.336517Z","end":"2026-05-06T05:04:54.455102Z","steps":["trace[1285420772] 'read index received' (duration: 118.319398ms)","trace[1285420772] 'applied index is now lower than readState.Index' (duration: 264.687µs)"],"step_count":2} {"level":"info","ts":"2026-05-06T05:04:54.455292Z","caller":"traceutil/trace.go:171","msg":"trace[504134747] transaction","detail":"{read_only:false; response_revision:1246; number_of_response:1; }","duration":"168.663918ms","start":"2026-05-06T05:04:54.286542Z","end":"2026-05-06T05:04:54.455206Z","steps":["trace[504134747] 'process raft request' (duration: 168.36538ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:04:54.455336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.740799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T05:04:54.455511Z","caller":"traceutil/trace.go:171","msg":"trace[131372376] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1246; }","duration":"119.010476ms","start":"2026-05-06T05:04:54.33648Z","end":"2026-05-06T05:04:54.45549Z","steps":["trace[131372376] 'agreement among raft nodes before linearized reading' (duration: 118.736769ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:04:55.315148Z","caller":"traceutil/trace.go:171","msg":"trace[1932518604] transaction","detail":"{read_only:false; response_revision:1250; number_of_response:1; }","duration":"100.162615ms","start":"2026-05-06T05:04:55.214959Z","end":"2026-05-06T05:04:55.315121Z","steps":["trace[1932518604] 'compare' (duration: 92.127848ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:05:08.077029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.013931ms","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-05-06T05:05:08.077087Z","caller":"traceutil/trace.go:171","msg":"trace[702837301] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1356; }","duration":"186.111923ms","start":"2026-05-06T05:05:07.890962Z","end":"2026-05-06T05:05:08.077074Z","steps":["trace[702837301] 'agreement among raft nodes before linearized reading' (duration: 185.911218ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:05:08.076699Z","caller":"traceutil/trace.go:171","msg":"trace[1384397290] linearizableReadLoop","detail":"{readStateIndex:1409; appliedIndex:1408; }","duration":"185.673033ms","start":"2026-05-06T05:05:07.891005Z","end":"2026-05-06T05:05:08.076678Z","steps":["trace[1384397290] 'read index received' (duration: 185.54986ms)","trace[1384397290] 'applied index is now lower than readState.Index' (duration: 121.913µs)"],"step_count":2}