{"level":"warn","ts":"2026-03-04T01:17:30.037681Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-04T01:17:30.037763Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.95: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.95:2380","--initial-cluster=instance=https://199.204.45.95:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.95:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.95: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-03-04T01:17:30.037834Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-04T01:17:30.037841Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.95:2380"]} {"level":"info","ts":"2026-03-04T01:17:30.037939Z","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-03-04T01:17:30.041623Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.95:2379"]} {"level":"info","ts":"2026-03-04T01:17:30.041724Z","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.95:2380"],"listen-peer-urls":["https://199.204.45.95:2380"],"advertise-client-urls":["https://199.204.45.95:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.95:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.95: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-03-04T01:17:30.047441Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.052226ms"} {"level":"info","ts":"2026-03-04T01:17:30.062314Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"be773dfc027af3eb","cluster-id":"9ba5fbd7288fd5af"} {"level":"info","ts":"2026-03-04T01:17:30.062387Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb switched to configuration voters=()"} {"level":"info","ts":"2026-03-04T01:17:30.062407Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb became follower at term 0"} {"level":"info","ts":"2026-03-04T01:17:30.062417Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft be773dfc027af3eb [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-03-04T01:17:30.062425Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb became follower at term 1"} {"level":"info","ts":"2026-03-04T01:17:30.062468Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb switched to configuration voters=(13724506542017541099)"} {"level":"warn","ts":"2026-03-04T01:17:30.072503Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-03-04T01:17:30.073724Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-03-04T01:17:30.078221Z","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-03-04T01:17:30.080019Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"be773dfc027af3eb","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-03-04T01:17:30.080982Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"be773dfc027af3eb","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-03-04T01:17:30.081685Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb switched to configuration voters=(13724506542017541099)"} {"level":"info","ts":"2026-03-04T01:17:30.081623Z","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-03-04T01:17:30.084494Z","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-03-04T01:17:30.084563Z","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-03-04T01:17:30.08644Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9ba5fbd7288fd5af","local-member-id":"be773dfc027af3eb","added-peer-id":"be773dfc027af3eb","added-peer-peer-urls":["https://199.204.45.95:2380"]} {"level":"info","ts":"2026-03-04T01:17:30.087075Z","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-03-04T01:17:30.087247Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.95:2380"} {"level":"info","ts":"2026-03-04T01:17:30.088236Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.95:2380"} {"level":"info","ts":"2026-03-04T01:17:30.087423Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"be773dfc027af3eb","initial-advertise-peer-urls":["https://199.204.45.95:2380"],"listen-peer-urls":["https://199.204.45.95:2380"],"advertise-client-urls":["https://199.204.45.95:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.95:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-03-04T01:17:30.087462Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-03-04T01:17:30.763092Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb is starting a new election at term 1"} {"level":"info","ts":"2026-03-04T01:17:30.76318Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb became pre-candidate at term 1"} {"level":"info","ts":"2026-03-04T01:17:30.763431Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb received MsgPreVoteResp from be773dfc027af3eb at term 1"} {"level":"info","ts":"2026-03-04T01:17:30.763473Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb became candidate at term 2"} {"level":"info","ts":"2026-03-04T01:17:30.763606Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb received MsgVoteResp from be773dfc027af3eb at term 2"} {"level":"info","ts":"2026-03-04T01:17:30.763712Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb became leader at term 2"} {"level":"info","ts":"2026-03-04T01:17:30.763744Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: be773dfc027af3eb elected leader be773dfc027af3eb at term 2"} {"level":"info","ts":"2026-03-04T01:17:30.765416Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-03-04T01:17:30.765836Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"be773dfc027af3eb","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.95:2379]}","request-path":"/0/members/be773dfc027af3eb/attributes","cluster-id":"9ba5fbd7288fd5af","publish-timeout":"7s"} {"level":"info","ts":"2026-03-04T01:17:30.765863Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-04T01:17:30.766037Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-04T01:17:30.766519Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-03-04T01:17:30.766618Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-03-04T01:17:30.766648Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9ba5fbd7288fd5af","local-member-id":"be773dfc027af3eb","cluster-version":"3.5"} {"level":"info","ts":"2026-03-04T01:17:30.766702Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-03-04T01:17:30.766717Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-03-04T01:17:30.768253Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.95:2379"} {"level":"info","ts":"2026-03-04T01:17:30.770032Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-03-04T01:17:33.881394Z","caller":"traceutil/trace.go:171","msg":"trace[76165629] transaction","detail":"{read_only:false; response_revision:201; number_of_response:1; }","duration":"301.904139ms","start":"2026-03-04T01:17:33.579464Z","end":"2026-03-04T01:17:33.881368Z","steps":["trace[76165629] 'process raft request' (duration: 293.091679ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:17:33.882033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:17:33.57945Z","time spent":"302.03446ms","remote":"127.0.0.1:51594","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":716,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-04T01:17:41.223367Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17576314278051598612,"retry-timeout":"500ms"} {"level":"info","ts":"2026-03-04T01:17:41.641627Z","caller":"traceutil/trace.go:171","msg":"trace[1067253883] transaction","detail":"{read_only:false; response_revision:340; number_of_response:1; }","duration":"959.280363ms","start":"2026-03-04T01:17:40.682323Z","end":"2026-03-04T01:17:41.641603Z","steps":["trace[1067253883] 'process raft request' (duration: 959.145602ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:17:41.641753Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:17:40.6823Z","time spent":"959.399333ms","remote":"127.0.0.1:51720","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3642,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-04T01:17:41.641932Z","caller":"traceutil/trace.go:171","msg":"trace[1817050047] linearizableReadLoop","detail":"{readStateIndex:352; appliedIndex:352; }","duration":"919.56ms","start":"2026-03-04T01:17:40.722355Z","end":"2026-03-04T01:17:41.641915Z","steps":["trace[1817050047] 'read index received' (duration: 919.54957ms)","trace[1817050047] 'applied index is now lower than readState.Index' (duration: 8.18µs)"],"step_count":2} {"level":"warn","ts":"2026-03-04T01:17:41.642214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"718.96759ms","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-03-04T01:17:41.642257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"670.57645ms","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-03-04T01:17:41.642518Z","caller":"traceutil/trace.go:171","msg":"trace[896208990] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:340; }","duration":"670.896961ms","start":"2026-03-04T01:17:40.9716Z","end":"2026-03-04T01:17:41.642497Z","steps":["trace[896208990] 'agreement among raft nodes before linearized reading' (duration: 670.526889ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:17:41.642667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:17:40.971582Z","time spent":"670.977032ms","remote":"127.0.0.1:51428","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":227,"request content":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" "} {"level":"info","ts":"2026-03-04T01:17:41.642299Z","caller":"traceutil/trace.go:171","msg":"trace[275454177] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:340; }","duration":"719.099961ms","start":"2026-03-04T01:17:40.923189Z","end":"2026-03-04T01:17:41.642289Z","steps":["trace[275454177] 'agreement among raft nodes before linearized reading' (duration: 718.98738ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:17:41.642855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:17:40.92313Z","time spent":"719.710845ms","remote":"127.0.0.1:51428","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":231,"request content":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" "} {"level":"warn","ts":"2026-03-04T01:17:41.642293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"869.71515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"info","ts":"2026-03-04T01:17:41.642966Z","caller":"traceutil/trace.go:171","msg":"trace[1700885707] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:340; }","duration":"870.443864ms","start":"2026-03-04T01:17:40.772508Z","end":"2026-03-04T01:17:41.642952Z","steps":["trace[1700885707] 'agreement among raft nodes before linearized reading' (duration: 869.606819ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:17:41.643005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:17:40.772487Z","time spent":"870.507194ms","remote":"127.0.0.1:51428","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":219,"request content":"key:\"/registry/serviceaccounts/kube-system/node-controller\" "} {"level":"warn","ts":"2026-03-04T01:17:41.64236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"770.032969ms","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-03-04T01:17:41.643088Z","caller":"traceutil/trace.go:171","msg":"trace[1650841330] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:340; }","duration":"770.798703ms","start":"2026-03-04T01:17:40.872279Z","end":"2026-03-04T01:17:41.643078Z","steps":["trace[1650841330] 'agreement among raft nodes before linearized reading' (duration: 770.054558ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:17:41.643123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:17:40.872255Z","time spent":"770.861293ms","remote":"127.0.0.1:51428","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":233,"request content":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" "} {"level":"warn","ts":"2026-03-04T01:17:41.64241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"619.162399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-03-04T01:17:41.643199Z","caller":"traceutil/trace.go:171","msg":"trace[1288858114] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:340; }","duration":"619.988614ms","start":"2026-03-04T01:17:41.023203Z","end":"2026-03-04T01:17:41.643192Z","steps":["trace[1288858114] 'agreement among raft nodes before linearized reading' (duration: 619.185939ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:17:41.643244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:17:41.023178Z","time spent":"620.059944ms","remote":"127.0.0.1:51428","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":217,"request content":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" "} {"level":"warn","ts":"2026-03-04T01:17:41.642399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"717.838313ms","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-03-04T01:17:41.643321Z","caller":"traceutil/trace.go:171","msg":"trace[1002474294] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:340; }","duration":"718.828839ms","start":"2026-03-04T01:17:40.924484Z","end":"2026-03-04T01:17:41.643313Z","steps":["trace[1002474294] 'agreement among raft nodes before linearized reading' (duration: 717.754503ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:17:41.64335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:17:40.924461Z","time spent":"718.88218ms","remote":"127.0.0.1:51496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-03-04T01:17:41.642408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"820.207391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-03-04T01:17:41.643505Z","caller":"traceutil/trace.go:171","msg":"trace[178620902] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:340; }","duration":"821.298648ms","start":"2026-03-04T01:17:40.822191Z","end":"2026-03-04T01:17:41.643489Z","steps":["trace[178620902] 'agreement among raft nodes before linearized reading' (duration: 820.15353ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:17:41.643545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:17:40.822156Z","time spent":"821.379249ms","remote":"127.0.0.1:51428","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":238,"request content":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" "} {"level":"warn","ts":"2026-03-04T01:17:41.642399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"569.691422ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-03-04T01:17:41.643628Z","caller":"traceutil/trace.go:171","msg":"trace[1130164000] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:340; }","duration":"570.96264ms","start":"2026-03-04T01:17:41.072657Z","end":"2026-03-04T01:17:41.643619Z","steps":["trace[1130164000] 'agreement among raft nodes before linearized reading' (duration: 569.703713ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:17:41.643662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:17:41.072641Z","time spent":"571.014851ms","remote":"127.0.0.1:51428","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":233,"request content":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" "} {"level":"warn","ts":"2026-03-04T01:17:41.642456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"919.763652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"info","ts":"2026-03-04T01:17:41.643733Z","caller":"traceutil/trace.go:171","msg":"trace[1336005525] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:340; }","duration":"921.424722ms","start":"2026-03-04T01:17:40.722302Z","end":"2026-03-04T01:17:41.643726Z","steps":["trace[1336005525] 'agreement among raft nodes before linearized reading' (duration: 919.699521ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:17:41.643763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:17:40.722279Z","time spent":"921.474712ms","remote":"127.0.0.1:51428","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":1,"response size":242,"request content":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" "} {"level":"warn","ts":"2026-03-04T01:17:41.644403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"520.005204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"info","ts":"2026-03-04T01:17:41.646079Z","caller":"traceutil/trace.go:171","msg":"trace[1498317917] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:340; }","duration":"523.072574ms","start":"2026-03-04T01:17:41.122459Z","end":"2026-03-04T01:17:41.645532Z","steps":["trace[1498317917] 'agreement among raft nodes before linearized reading' (duration: 519.941584ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:17:41.646123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:17:41.122438Z","time spent":"523.673478ms","remote":"127.0.0.1:51428","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":258,"request content":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" "} {"level":"warn","ts":"2026-03-04T01:17:42.149177Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17576314278051598615,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-04T01:17:42.650028Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17576314278051598615,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-04T01:17:42.862691Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.214160764s","expected-duration":"1s"} {"level":"warn","ts":"2026-03-04T01:17:43.723259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"859.954975ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-04T01:17:43.723737Z","caller":"traceutil/trace.go:171","msg":"trace[1530159642] transaction","detail":"{read_only:false; response_revision:344; number_of_response:1; }","duration":"2.071452423s","start":"2026-03-04T01:17:41.652242Z","end":"2026-03-04T01:17:43.723695Z","steps":["trace[1530159642] 'process raft request' (duration: 2.071222911s)"],"step_count":1} {"level":"info","ts":"2026-03-04T01:17:43.723825Z","caller":"traceutil/trace.go:171","msg":"trace[1240623817] linearizableReadLoop","detail":"{readStateIndex:362; appliedIndex:352; }","duration":"2.074678814s","start":"2026-03-04T01:17:41.649122Z","end":"2026-03-04T01:17:43.723801Z","steps":["trace[1240623817] 'read index received' (duration: 1.213917452s)","trace[1240623817] 'applied index is now lower than readState.Index' (duration: 860.760092ms)"],"step_count":2} {"level":"info","ts":"2026-03-04T01:17:43.723883Z","caller":"traceutil/trace.go:171","msg":"trace[270562668] transaction","detail":"{read_only:false; response_revision:346; number_of_response:1; }","duration":"2.069985233s","start":"2026-03-04T01:17:41.653884Z","end":"2026-03-04T01:17:43.72387Z","steps":["trace[270562668] 'process raft request' (duration: 2.069650381s)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:17:43.723894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:17:41.652222Z","time spent":"2.071603894s","remote":"127.0.0.1:51724","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2150,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-04T01:17:43.723955Z","caller":"traceutil/trace.go:171","msg":"trace[780682195] transaction","detail":"{read_only:false; response_revision:349; number_of_response:1; }","duration":"2.068891895s","start":"2026-03-04T01:17:41.655051Z","end":"2026-03-04T01:17:43.723943Z","steps":["trace[780682195] 'process raft request' (duration: 2.068631074s)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:17:43.723977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:17:41.653869Z","time spent":"2.070044783s","remote":"127.0.0.1:51488","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1251,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-04T01:17:43.724005Z","caller":"traceutil/trace.go:171","msg":"trace[284042824] transaction","detail":"{read_only:false; response_revision:341; number_of_response:1; }","duration":"2.07558929s","start":"2026-03-04T01:17:41.648405Z","end":"2026-03-04T01:17:43.723994Z","steps":["trace[284042824] 'process raft request' (duration: 1.214460316s)","trace[284042824] 'compare' (duration: 859.438052ms)"],"step_count":2} {"level":"warn","ts":"2026-03-04T01:17:43.724044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:17:41.648377Z","time spent":"2.07564476s","remote":"127.0.0.1:51496","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-04T01:17:43.724039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:17:41.655044Z","time spent":"2.068944846s","remote":"127.0.0.1:51582","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2094,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-04T01:17:43.724151Z","caller":"traceutil/trace.go:171","msg":"trace[122000162] transaction","detail":"{read_only:false; response_revision:343; number_of_response:1; }","duration":"2.074420542s","start":"2026-03-04T01:17:41.649724Z","end":"2026-03-04T01:17:43.724144Z","steps":["trace[122000162] 'process raft request' (duration: 2.073695587s)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:17:43.724192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:17:41.649716Z","time spent":"2.074456812s","remote":"127.0.0.1:51700","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3691,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-04T01:17:43.724206Z","caller":"traceutil/trace.go:171","msg":"trace[1854985496] transaction","detail":"{read_only:false; response_revision:342; number_of_response:1; }","duration":"2.074632333s","start":"2026-03-04T01:17:41.649556Z","end":"2026-03-04T01:17:43.724189Z","steps":["trace[1854985496] 'process raft request' (duration: 2.073803018s)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:17:43.724279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:17:41.649544Z","time spent":"2.074697324s","remote":"127.0.0.1:51308","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":680,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-04T01:17:43.72437Z","caller":"traceutil/trace.go:171","msg":"trace[769646099] transaction","detail":"{read_only:false; response_revision:350; number_of_response:1; }","duration":"1.50384002s","start":"2026-03-04T01:17:42.220517Z","end":"2026-03-04T01:17:43.724357Z","steps":["trace[769646099] 'process raft request' (duration: 1.503213886s)"],"step_count":1} {"level":"info","ts":"2026-03-04T01:17:43.72437Z","caller":"traceutil/trace.go:171","msg":"trace[277445975] transaction","detail":"{read_only:false; response_revision:347; number_of_response:1; }","duration":"2.070264804s","start":"2026-03-04T01:17:41.654077Z","end":"2026-03-04T01:17:43.724342Z","steps":["trace[277445975] 'process raft request' (duration: 2.069501029s)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:17:43.724439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:17:42.2205Z","time spent":"1.50390038s","remote":"127.0.0.1:51496","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-04T01:17:43.724507Z","caller":"traceutil/trace.go:171","msg":"trace[688277546] transaction","detail":"{read_only:false; response_revision:345; number_of_response:1; }","duration":"2.07121366s","start":"2026-03-04T01:17:41.653278Z","end":"2026-03-04T01:17:43.724492Z","steps":["trace[688277546] 'process raft request' (duration: 2.070219504s)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:17:43.72451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:17:41.654068Z","time spent":"2.070370705s","remote":"127.0.0.1:51582","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":899,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-04T01:17:43.724547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:17:41.653268Z","time spent":"2.07125908s","remote":"127.0.0.1:51406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4354,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-04T01:17:43.724605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.075434168s","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-03-04T01:17:43.724644Z","caller":"traceutil/trace.go:171","msg":"trace[716752048] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:350; }","duration":"2.075478359s","start":"2026-03-04T01:17:41.649152Z","end":"2026-03-04T01:17:43.72463Z","steps":["trace[716752048] 'agreement among raft nodes before linearized reading' (duration: 2.075414578s)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:17:43.724673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:17:41.649148Z","time spent":"2.075518229s","remote":"127.0.0.1:51428","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":233,"request content":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" "} {"level":"info","ts":"2026-03-04T01:17:43.723832Z","caller":"traceutil/trace.go:171","msg":"trace[585722770] transaction","detail":"{read_only:false; response_revision:348; number_of_response:1; }","duration":"2.069099107s","start":"2026-03-04T01:17:41.654711Z","end":"2026-03-04T01:17:43.72381Z","steps":["trace[585722770] 'process raft request' (duration: 2.068923126s)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:17:43.724813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.573726699s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"warn","ts":"2026-03-04T01:17:43.724844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:17:41.654704Z","time spent":"2.070106383s","remote":"127.0.0.1:51582","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2191,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-04T01:17:43.724862Z","caller":"traceutil/trace.go:171","msg":"trace[2001172379] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:350; }","duration":"1.57381044s","start":"2026-03-04T01:17:42.151038Z","end":"2026-03-04T01:17:43.724848Z","steps":["trace[2001172379] 'agreement among raft nodes before linearized reading' (duration: 1.573712779s)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:17:43.724856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.047388ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-04T01:17:43.7249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:17:42.150993Z","time spent":"1.57389792s","remote":"127.0.0.1:51496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-03-04T01:17:43.724909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.89540704s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-03-04T01:17:43.724926Z","caller":"traceutil/trace.go:171","msg":"trace[358530342] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:350; }","duration":"244.119118ms","start":"2026-03-04T01:17:43.480797Z","end":"2026-03-04T01:17:43.724917Z","steps":["trace[358530342] 'agreement among raft nodes before linearized reading' (duration: 244.015038ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T01:17:43.72495Z","caller":"traceutil/trace.go:171","msg":"trace[1786497544] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:350; }","duration":"1.895507171s","start":"2026-03-04T01:17:41.829431Z","end":"2026-03-04T01:17:43.724939Z","steps":["trace[1786497544] 'agreement among raft nodes before linearized reading' (duration: 1.8954347s)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:17:43.724968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.075839341s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-03-04T01:17:43.725014Z","caller":"traceutil/trace.go:171","msg":"trace[152722106] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:350; }","duration":"2.075905411s","start":"2026-03-04T01:17:41.649093Z","end":"2026-03-04T01:17:43.724999Z","steps":["trace[152722106] 'agreement among raft nodes before linearized reading' (duration: 2.07581901s)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:17:43.725022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.074431051s","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-03-04T01:17:43.725047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:17:41.64908Z","time spent":"2.075959561s","remote":"127.0.0.1:51428","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":231,"request content":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" "} {"level":"warn","ts":"2026-03-04T01:17:43.72498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:17:41.829411Z","time spent":"1.895561751s","remote":"127.0.0.1:51496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-03-04T01:17:43.725093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.075909562s","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-03-04T01:17:43.725119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.075153377s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"info","ts":"2026-03-04T01:17:43.725145Z","caller":"traceutil/trace.go:171","msg":"trace[916048831] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:350; }","duration":"2.075184357s","start":"2026-03-04T01:17:41.649954Z","end":"2026-03-04T01:17:43.725138Z","steps":["trace[916048831] 'agreement among raft nodes before linearized reading' (duration: 2.075147387s)"],"step_count":1} {"level":"info","ts":"2026-03-04T01:17:43.725049Z","caller":"traceutil/trace.go:171","msg":"trace[1164255402] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:350; }","duration":"2.074456641s","start":"2026-03-04T01:17:41.650585Z","end":"2026-03-04T01:17:43.725042Z","steps":["trace[1164255402] 'agreement among raft nodes before linearized reading' (duration: 2.074411931s)"],"step_count":1} {"level":"info","ts":"2026-03-04T01:17:43.72515Z","caller":"traceutil/trace.go:171","msg":"trace[776845976] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:350; }","duration":"2.075967912s","start":"2026-03-04T01:17:41.649168Z","end":"2026-03-04T01:17:43.725136Z","steps":["trace[776845976] 'agreement among raft nodes before linearized reading' (duration: 2.075897071s)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:17:43.725165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:17:41.649951Z","time spent":"2.075210087s","remote":"127.0.0.1:51428","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":1,"response size":242,"request content":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" "} {"level":"warn","ts":"2026-03-04T01:17:43.725087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.075153526s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"warn","ts":"2026-03-04T01:17:43.725181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:17:41.650567Z","time spent":"2.074606002s","remote":"127.0.0.1:51428","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":219,"request content":"key:\"/registry/serviceaccounts/kube-system/node-controller\" "} {"level":"warn","ts":"2026-03-04T01:17:43.725196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:17:41.649165Z","time spent":"2.076016272s","remote":"127.0.0.1:51428","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":238,"request content":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" "} {"level":"info","ts":"2026-03-04T01:17:43.725206Z","caller":"traceutil/trace.go:171","msg":"trace[457348953] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:350; }","duration":"2.075270847s","start":"2026-03-04T01:17:41.649918Z","end":"2026-03-04T01:17:43.725189Z","steps":["trace[457348953] 'agreement among raft nodes before linearized reading' (duration: 2.075140966s)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:17:43.725259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:17:41.649913Z","time spent":"2.075332268s","remote":"127.0.0.1:51428","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":227,"request content":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" "} {"level":"warn","ts":"2026-03-04T01:17:43.725357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.106527707s","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-03-04T01:17:43.7256Z","caller":"traceutil/trace.go:171","msg":"trace[2058180509] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:350; }","duration":"1.106840179s","start":"2026-03-04T01:17:42.618735Z","end":"2026-03-04T01:17:43.725575Z","steps":["trace[2058180509] 'agreement among raft nodes before linearized reading' (duration: 1.106503876s)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:17:43.725827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:17:42.618713Z","time spent":"1.10709371s","remote":"127.0.0.1:51496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-03-04T01:18:03.559822Z","caller":"traceutil/trace.go:171","msg":"trace[1868130372] linearizableReadLoop","detail":"{readStateIndex:526; appliedIndex:525; }","duration":"409.144135ms","start":"2026-03-04T01:18:03.15065Z","end":"2026-03-04T01:18:03.559794Z","steps":["trace[1868130372] 'read index received' (duration: 408.900055ms)","trace[1868130372] 'applied index is now lower than readState.Index' (duration: 243.22µs)"],"step_count":2} {"level":"warn","ts":"2026-03-04T01:18:03.559964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.308321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-04T01:18:03.559997Z","caller":"traceutil/trace.go:171","msg":"trace[149714138] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:507; }","duration":"409.399744ms","start":"2026-03-04T01:18:03.150586Z","end":"2026-03-04T01:18:03.559986Z","steps":["trace[149714138] 'agreement among raft nodes before linearized reading' (duration: 409.309631ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:18:03.560037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:18:03.150559Z","time spent":"409.470697ms","remote":"127.0.0.1:51220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-03-04T01:18:03.560128Z","caller":"traceutil/trace.go:171","msg":"trace[431674608] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"493.846104ms","start":"2026-03-04T01:18:03.066224Z","end":"2026-03-04T01:18:03.56007Z","steps":["trace[431674608] 'process raft request' (duration: 493.391297ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:18:03.560299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:18:03.066205Z","time spent":"494.005762ms","remote":"127.0.0.1:51406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4566,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-04T01:18:10.075072Z","caller":"traceutil/trace.go:171","msg":"trace[1005530713] linearizableReadLoop","detail":"{readStateIndex:569; appliedIndex:568; }","duration":"189.696612ms","start":"2026-03-04T01:18:09.88535Z","end":"2026-03-04T01:18:10.075047Z","steps":["trace[1005530713] 'read index received' (duration: 189.546956ms)","trace[1005530713] 'applied index is now lower than readState.Index' (duration: 148.796µs)"],"step_count":2} {"level":"info","ts":"2026-03-04T01:18:10.075106Z","caller":"traceutil/trace.go:171","msg":"trace[1052671414] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"191.210176ms","start":"2026-03-04T01:18:09.88387Z","end":"2026-03-04T01:18:10.075081Z","steps":["trace[1052671414] 'process raft request' (duration: 190.903265ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:18:10.075357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.980131ms","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-03-04T01:18:10.075436Z","caller":"traceutil/trace.go:171","msg":"trace[1412633600] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:548; }","duration":"190.101697ms","start":"2026-03-04T01:18:09.885313Z","end":"2026-03-04T01:18:10.075415Z","steps":["trace[1412633600] 'agreement among raft nodes before linearized reading' (duration: 189.871839ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T01:18:10.328463Z","caller":"traceutil/trace.go:171","msg":"trace[1500182576] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"442.999066ms","start":"2026-03-04T01:18:09.885444Z","end":"2026-03-04T01:18:10.328443Z","steps":["trace[1500182576] 'process raft request' (duration: 442.866731ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:18:10.328588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:18:09.885425Z","time spent":"443.10105ms","remote":"127.0.0.1:51496","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-04T01:18:10.329126Z","caller":"traceutil/trace.go:171","msg":"trace[357412420] linearizableReadLoop","detail":"{readStateIndex:570; appliedIndex:570; }","duration":"253.937127ms","start":"2026-03-04T01:18:10.075145Z","end":"2026-03-04T01:18:10.329082Z","steps":["trace[357412420] 'read index received' (duration: 253.932747ms)","trace[357412420] 'applied index is now lower than readState.Index' (duration: 3.71µs)"],"step_count":2} {"level":"warn","ts":"2026-03-04T01:18:10.329293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.098697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-03-04T01:18:10.329281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.10028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-8rgl4\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-03-04T01:18:10.329385Z","caller":"traceutil/trace.go:171","msg":"trace[1791562397] range","detail":"{range_begin:/registry/pods/kube-system/cilium-8rgl4; range_end:; response_count:1; response_revision:549; }","duration":"304.322168ms","start":"2026-03-04T01:18:10.025048Z","end":"2026-03-04T01:18:10.32937Z","steps":["trace[1791562397] 'agreement among raft nodes before linearized reading' (duration: 304.053788ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:18:10.329477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:18:10.025006Z","time spent":"304.462302ms","remote":"127.0.0.1:51410","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16985,"request content":"key:\"/registry/pods/kube-system/cilium-8rgl4\" "} {"level":"info","ts":"2026-03-04T01:18:10.329323Z","caller":"traceutil/trace.go:171","msg":"trace[1846056263] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:549; }","duration":"436.18649ms","start":"2026-03-04T01:18:09.89313Z","end":"2026-03-04T01:18:10.329316Z","steps":["trace[1846056263] 'agreement among raft nodes before linearized reading' (duration: 436.056485ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:18:10.329684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:18:09.893096Z","time spent":"436.578925ms","remote":"127.0.0.1:51496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-03-04T01:18:10.338778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.773393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-04T01:18:10.338843Z","caller":"traceutil/trace.go:171","msg":"trace[1629711355] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"260.050413ms","start":"2026-03-04T01:18:10.078776Z","end":"2026-03-04T01:18:10.338826Z","steps":["trace[1629711355] 'process raft request' (duration: 259.796054ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T01:18:10.338856Z","caller":"traceutil/trace.go:171","msg":"trace[1814461646] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:550; }","duration":"194.901607ms","start":"2026-03-04T01:18:10.143936Z","end":"2026-03-04T01:18:10.338838Z","steps":["trace[1814461646] 'agreement among raft nodes before linearized reading' (duration: 194.748571ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:18:12.24428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.781407471s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-04T01:18:12.244369Z","caller":"traceutil/trace.go:171","msg":"trace[1095184460] linearizableReadLoop","detail":"{readStateIndex:573; appliedIndex:572; }","duration":"1.07514246s","start":"2026-03-04T01:18:11.169211Z","end":"2026-03-04T01:18:12.244353Z","steps":["trace[1095184460] 'read index received' (duration: 25.781µs)","trace[1095184460] 'applied index is now lower than readState.Index' (duration: 1.075115629s)"],"step_count":2} {"level":"warn","ts":"2026-03-04T01:18:12.244529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.075316875s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-04T01:18:12.244482Z","caller":"traceutil/trace.go:171","msg":"trace[961768886] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"1.902668452s","start":"2026-03-04T01:18:10.34178Z","end":"2026-03-04T01:18:12.244448Z","steps":["trace[961768886] 'process raft request' (duration: 121.021702ms)","trace[961768886] 'compare' (duration: 1.781248556s)"],"step_count":2} {"level":"info","ts":"2026-03-04T01:18:12.244592Z","caller":"traceutil/trace.go:171","msg":"trace[2142404171] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:552; }","duration":"1.0754043s","start":"2026-03-04T01:18:11.169178Z","end":"2026-03-04T01:18:12.244583Z","steps":["trace[2142404171] 'agreement among raft nodes before linearized reading' (duration: 1.075257124s)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:18:12.244634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:18:11.169166Z","time spent":"1.075461531s","remote":"127.0.0.1:51220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-03-04T01:18:12.244718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:18:10.341764Z","time spent":"1.902860739s","remote":"127.0.0.1:51410","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-04T01:18:12.244766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.586292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-03-04T01:18:12.244836Z","caller":"traceutil/trace.go:171","msg":"trace[9703169] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:552; }","duration":"166.712466ms","start":"2026-03-04T01:18:12.078104Z","end":"2026-03-04T01:18:12.244816Z","steps":["trace[9703169] 'agreement among raft nodes before linearized reading' (duration: 166.514919ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T01:18:12.523195Z","caller":"traceutil/trace.go:171","msg":"trace[281598787] linearizableReadLoop","detail":"{readStateIndex:574; appliedIndex:573; }","duration":"266.096531ms","start":"2026-03-04T01:18:12.25705Z","end":"2026-03-04T01:18:12.523147Z","steps":["trace[281598787] 'read index received' (duration: 228.349748ms)","trace[281598787] 'applied index is now lower than readState.Index' (duration: 37.744993ms)"],"step_count":2} {"level":"info","ts":"2026-03-04T01:18:12.523235Z","caller":"traceutil/trace.go:171","msg":"trace[1062362559] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"269.213479ms","start":"2026-03-04T01:18:12.253983Z","end":"2026-03-04T01:18:12.523197Z","steps":["trace[1062362559] 'process raft request' (duration: 231.377643ms)","trace[1062362559] 'compare' (duration: 37.640819ms)"],"step_count":2} {"level":"warn","ts":"2026-03-04T01:18:12.523363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.292287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-04T01:18:12.523469Z","caller":"traceutil/trace.go:171","msg":"trace[412667251] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:553; }","duration":"266.421062ms","start":"2026-03-04T01:18:12.257022Z","end":"2026-03-04T01:18:12.523443Z","steps":["trace[412667251] 'agreement among raft nodes before linearized reading' (duration: 266.265187ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:18:12.523818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.784638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-03-04T01:18:12.523914Z","caller":"traceutil/trace.go:171","msg":"trace[402178761] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:553; }","duration":"189.925233ms","start":"2026-03-04T01:18:12.333973Z","end":"2026-03-04T01:18:12.523898Z","steps":["trace[402178761] 'agreement among raft nodes before linearized reading' (duration: 189.710805ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:18:12.524143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.854889ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-03-04T01:18:12.524167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.572719ms","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-03-04T01:18:12.524203Z","caller":"traceutil/trace.go:171","msg":"trace[679573982] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:553; }","duration":"172.948812ms","start":"2026-03-04T01:18:12.351239Z","end":"2026-03-04T01:18:12.524187Z","steps":["trace[679573982] 'agreement among raft nodes before linearized reading' (duration: 172.774316ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T01:18:12.524221Z","caller":"traceutil/trace.go:171","msg":"trace[1906216718] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:553; }","duration":"172.654021ms","start":"2026-03-04T01:18:12.351553Z","end":"2026-03-04T01:18:12.524207Z","steps":["trace[1906216718] 'agreement among raft nodes before linearized reading' (duration: 172.414913ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T01:18:14.568595Z","caller":"traceutil/trace.go:171","msg":"trace[491546743] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"237.121484ms","start":"2026-03-04T01:18:14.331445Z","end":"2026-03-04T01:18:14.568567Z","steps":["trace[491546743] 'process raft request' (duration: 236.969129ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T01:18:14.574217Z","caller":"traceutil/trace.go:171","msg":"trace[1828741995] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"111.4308ms","start":"2026-03-04T01:18:14.462774Z","end":"2026-03-04T01:18:14.574205Z","steps":["trace[1828741995] 'process raft request' (duration: 111.018406ms)"],"step_count":1}