{"level":"warn","ts":"2026-02-04T05:19:40.752888Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-04T05:19:40.752993Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.115: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.115:2380","--initial-cluster=instance=https://199.204.45.115:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.115:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.115: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-02-04T05:19:40.753073Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-04T05:19:40.753086Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.115:2380"]} {"level":"info","ts":"2026-02-04T05:19:40.753116Z","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-02-04T05:19:40.759817Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.115:2379"]} {"level":"info","ts":"2026-02-04T05:19:40.762205Z","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":2,"max-cpu-available":2,"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.115:2380"],"listen-peer-urls":["https://199.204.45.115:2380"],"advertise-client-urls":["https://199.204.45.115:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.115:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.115: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-02-04T05:19:40.772849Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"10.464935ms"} {"level":"info","ts":"2026-02-04T05:19:40.784122Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e3aaa5c123e150e0","cluster-id":"61ec519698823541"} {"level":"info","ts":"2026-02-04T05:19:40.784173Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 switched to configuration voters=()"} {"level":"info","ts":"2026-02-04T05:19:40.784204Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became follower at term 0"} {"level":"info","ts":"2026-02-04T05:19:40.784212Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e3aaa5c123e150e0 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-04T05:19:40.78422Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became follower at term 1"} {"level":"info","ts":"2026-02-04T05:19:40.784282Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 switched to configuration voters=(16405106841599693024)"} {"level":"warn","ts":"2026-02-04T05:19:40.800651Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-04T05:19:40.811983Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-04T05:19:40.813359Z","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-02-04T05:19:40.815408Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e3aaa5c123e150e0","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-04T05:19:40.817372Z","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-02-04T05:19:40.817557Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e3aaa5c123e150e0","initial-advertise-peer-urls":["https://199.204.45.115:2380"],"listen-peer-urls":["https://199.204.45.115:2380"],"advertise-client-urls":["https://199.204.45.115:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.115:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-04T05:19:40.817578Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-04T05:19:40.817705Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.115:2380"} {"level":"info","ts":"2026-02-04T05:19:40.817723Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.115:2380"} {"level":"info","ts":"2026-02-04T05:19:40.818271Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e3aaa5c123e150e0","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-04T05:19:40.818385Z","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-02-04T05:19:40.818776Z","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-02-04T05:19:40.81879Z","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-02-04T05:19:40.819111Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 switched to configuration voters=(16405106841599693024)"} {"level":"info","ts":"2026-02-04T05:19:40.819198Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"61ec519698823541","local-member-id":"e3aaa5c123e150e0","added-peer-id":"e3aaa5c123e150e0","added-peer-peer-urls":["https://199.204.45.115:2380"]} {"level":"info","ts":"2026-02-04T05:19:41.185279Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 is starting a new election at term 1"} {"level":"info","ts":"2026-02-04T05:19:41.18546Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-04T05:19:41.185572Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 received MsgPreVoteResp from e3aaa5c123e150e0 at term 1"} {"level":"info","ts":"2026-02-04T05:19:41.185711Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became candidate at term 2"} {"level":"info","ts":"2026-02-04T05:19:41.185772Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 received MsgVoteResp from e3aaa5c123e150e0 at term 2"} {"level":"info","ts":"2026-02-04T05:19:41.185811Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became leader at term 2"} {"level":"info","ts":"2026-02-04T05:19:41.185885Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e3aaa5c123e150e0 elected leader e3aaa5c123e150e0 at term 2"} {"level":"info","ts":"2026-02-04T05:19:41.186962Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-04T05:19:41.190985Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e3aaa5c123e150e0","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.115:2379]}","request-path":"/0/members/e3aaa5c123e150e0/attributes","cluster-id":"61ec519698823541","publish-timeout":"7s"} {"level":"info","ts":"2026-02-04T05:19:41.191039Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-04T05:19:41.192576Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.115:2379"} {"level":"info","ts":"2026-02-04T05:19:41.193078Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"61ec519698823541","local-member-id":"e3aaa5c123e150e0","cluster-version":"3.5"} {"level":"info","ts":"2026-02-04T05:19:41.193198Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-04T05:19:41.193777Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-04T05:19:41.193951Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-04T05:19:41.196409Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-04T05:19:41.19774Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-04T05:19:41.197815Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} 2026/02/04 05:19:46 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-02-04T05:19:46.424752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.805959ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-04T05:19:51.976179Z","caller":"traceutil/trace.go:171","msg":"trace[157554391] linearizableReadLoop","detail":"{readStateIndex:347; appliedIndex:346; }","duration":"260.546475ms","start":"2026-02-04T05:19:51.715602Z","end":"2026-02-04T05:19:51.976148Z","steps":["trace[157554391] 'read index received' (duration: 260.444832ms)","trace[157554391] 'applied index is now lower than readState.Index' (duration: 101.083µs)"],"step_count":2} {"level":"info","ts":"2026-02-04T05:19:51.976318Z","caller":"traceutil/trace.go:171","msg":"trace[1691103552] transaction","detail":"{read_only:false; response_revision:337; number_of_response:1; }","duration":"305.245078ms","start":"2026-02-04T05:19:51.671064Z","end":"2026-02-04T05:19:51.97631Z","steps":["trace[1691103552] 'process raft request' (duration: 305.018391ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T05:19:51.976364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T05:19:51.671041Z","time spent":"305.29092ms","remote":"127.0.0.1:34990","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1723,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-04T05:19:51.976494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.888146ms","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-02-04T05:19:51.976512Z","caller":"traceutil/trace.go:171","msg":"trace[1333097518] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:337; }","duration":"260.912367ms","start":"2026-02-04T05:19:51.715594Z","end":"2026-02-04T05:19:51.976506Z","steps":["trace[1333097518] 'agreement among raft nodes before linearized reading' (duration: 260.858525ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T05:19:51.976589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.219473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-02-04T05:19:51.976601Z","caller":"traceutil/trace.go:171","msg":"trace[1606312768] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:337; }","duration":"211.263675ms","start":"2026-02-04T05:19:51.765334Z","end":"2026-02-04T05:19:51.976598Z","steps":["trace[1606312768] 'agreement among raft nodes before linearized reading' (duration: 211.239264ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T05:19:51.976769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.128654ms","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-02-04T05:19:51.976782Z","caller":"traceutil/trace.go:171","msg":"trace[1235839498] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:337; }","duration":"111.174285ms","start":"2026-02-04T05:19:51.865604Z","end":"2026-02-04T05:19:51.976778Z","steps":["trace[1235839498] 'agreement among raft nodes before linearized reading' (duration: 111.152885ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T05:19:51.976842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.267731ms","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-02-04T05:19:51.976855Z","caller":"traceutil/trace.go:171","msg":"trace[1631674679] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:337; }","duration":"161.318523ms","start":"2026-02-04T05:19:51.815533Z","end":"2026-02-04T05:19:51.976852Z","steps":["trace[1631674679] 'agreement among raft nodes before linearized reading' (duration: 161.297502ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T05:19:52.654543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.184551ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-04T05:19:52.654614Z","caller":"traceutil/trace.go:171","msg":"trace[895581624] transaction","detail":"{read_only:false; response_revision:338; number_of_response:1; }","duration":"649.267999ms","start":"2026-02-04T05:19:52.005332Z","end":"2026-02-04T05:19:52.6546Z","steps":["trace[895581624] 'process raft request' (duration: 326.985105ms)","trace[895581624] 'compare' (duration: 321.774318ms)"],"step_count":2} {"level":"warn","ts":"2026-02-04T05:19:52.654648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T05:19:52.005316Z","time spent":"649.318131ms","remote":"127.0.0.1:34990","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1739,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-04T05:19:52.764988Z","caller":"traceutil/trace.go:171","msg":"trace[321012309] transaction","detail":"{read_only:false; response_revision:342; number_of_response:1; }","duration":"106.597418ms","start":"2026-02-04T05:19:52.658377Z","end":"2026-02-04T05:19:52.764975Z","steps":["trace[321012309] 'process raft request' (duration: 106.576878ms)"],"step_count":1} {"level":"info","ts":"2026-02-04T05:19:52.765234Z","caller":"traceutil/trace.go:171","msg":"trace[2139329598] transaction","detail":"{read_only:false; response_revision:341; number_of_response:1; }","duration":"754.281896ms","start":"2026-02-04T05:19:52.010939Z","end":"2026-02-04T05:19:52.765221Z","steps":["trace[2139329598] 'process raft request' (duration: 753.990777ms)"],"step_count":1} {"level":"info","ts":"2026-02-04T05:19:52.765086Z","caller":"traceutil/trace.go:171","msg":"trace[1280997079] transaction","detail":"{read_only:false; response_revision:340; number_of_response:1; }","duration":"756.089015ms","start":"2026-02-04T05:19:52.00896Z","end":"2026-02-04T05:19:52.765049Z","steps":["trace[1280997079] 'process raft request' (duration: 755.93514ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T05:19:52.765296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T05:19:52.01093Z","time spent":"754.322248ms","remote":"127.0.0.1:35376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3620,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-04T05:19:52.765379Z","caller":"traceutil/trace.go:171","msg":"trace[1269233415] linearizableReadLoop","detail":"{readStateIndex:351; appliedIndex:347; }","duration":"750.233707ms","start":"2026-02-04T05:19:52.015124Z","end":"2026-02-04T05:19:52.765358Z","steps":["trace[1269233415] 'read index received' (duration: 317.299915ms)","trace[1269233415] 'applied index is now lower than readState.Index' (duration: 432.932932ms)"],"step_count":2} {"level":"warn","ts":"2026-02-04T05:19:52.765513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"750.382161ms","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-02-04T05:19:52.765531Z","caller":"traceutil/trace.go:171","msg":"trace[1073318113] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:342; }","duration":"750.405012ms","start":"2026-02-04T05:19:52.015121Z","end":"2026-02-04T05:19:52.765526Z","steps":["trace[1073318113] 'agreement among raft nodes before linearized reading' (duration: 750.3497ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T05:19:52.765546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T05:19:52.015099Z","time spent":"750.443614ms","remote":"127.0.0.1:35106","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":216,"request content":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" "} {"level":"warn","ts":"2026-02-04T05:19:52.765624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"699.697206ms","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-02-04T05:19:52.765636Z","caller":"traceutil/trace.go:171","msg":"trace[2091269444] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:342; }","duration":"699.709176ms","start":"2026-02-04T05:19:52.065923Z","end":"2026-02-04T05:19:52.765632Z","steps":["trace[2091269444] 'agreement among raft nodes before linearized reading' (duration: 699.687286ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T05:19:52.765648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T05:19:52.065884Z","time spent":"699.760608ms","remote":"127.0.0.1:35106","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":218,"request content":"key:\"/registry/serviceaccounts/kube-system/node-controller\" "} {"level":"warn","ts":"2026-02-04T05:19:52.765737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"498.9657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-02-04T05:19:52.765752Z","caller":"traceutil/trace.go:171","msg":"trace[1686179757] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:342; }","duration":"498.99601ms","start":"2026-02-04T05:19:52.266752Z","end":"2026-02-04T05:19:52.765748Z","steps":["trace[1686179757] 'agreement among raft nodes before linearized reading' (duration: 498.971809ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T05:19:52.765764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T05:19:52.266741Z","time spent":"499.020392ms","remote":"127.0.0.1:35106","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" "} {"level":"warn","ts":"2026-02-04T05:19:52.765821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"549.593443ms","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-02-04T05:19:52.765833Z","caller":"traceutil/trace.go:171","msg":"trace[2095841616] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:342; }","duration":"549.605594ms","start":"2026-02-04T05:19:52.216223Z","end":"2026-02-04T05:19:52.765829Z","steps":["trace[2095841616] 'agreement among raft nodes before linearized reading' (duration: 549.583593ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T05:19:52.765844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T05:19:52.216183Z","time spent":"549.658435ms","remote":"127.0.0.1:35106","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":237,"request content":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" "} {"level":"warn","ts":"2026-02-04T05:19:52.7659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"599.511294ms","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-02-04T05:19:52.765912Z","caller":"traceutil/trace.go:171","msg":"trace[1634819874] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:342; }","duration":"599.549585ms","start":"2026-02-04T05:19:52.166358Z","end":"2026-02-04T05:19:52.765908Z","steps":["trace[1634819874] 'agreement among raft nodes before linearized reading' (duration: 599.528585ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T05:19:52.765923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T05:19:52.166321Z","time spent":"599.598627ms","remote":"127.0.0.1:35106","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":226,"request content":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" "} {"level":"warn","ts":"2026-02-04T05:19:52.765978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"648.417422ms","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-02-04T05:19:52.76599Z","caller":"traceutil/trace.go:171","msg":"trace[1091280351] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:342; }","duration":"648.469504ms","start":"2026-02-04T05:19:52.117516Z","end":"2026-02-04T05:19:52.765985Z","steps":["trace[1091280351] 'agreement among raft nodes before linearized reading' (duration: 648.447073ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T05:19:52.766002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T05:19:52.117496Z","time spent":"648.503214ms","remote":"127.0.0.1:35106","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":257,"request content":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" "} {"level":"info","ts":"2026-02-04T05:19:52.766262Z","caller":"traceutil/trace.go:171","msg":"trace[622047954] transaction","detail":"{read_only:false; response_revision:339; number_of_response:1; }","duration":"760.120453ms","start":"2026-02-04T05:19:52.006136Z","end":"2026-02-04T05:19:52.766256Z","steps":["trace[622047954] 'process raft request' (duration: 751.651012ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T05:19:52.766287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T05:19:52.006128Z","time spent":"760.145705ms","remote":"127.0.0.1:35106","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":156,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-04T05:19:52.771302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T05:19:52.008948Z","time spent":"756.363513ms","remote":"127.0.0.1:34990","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2163,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-04T05:20:11.617938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.734954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-04T05:20:11.618001Z","caller":"traceutil/trace.go:171","msg":"trace[1596384668] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:498; }","duration":"160.835157ms","start":"2026-02-04T05:20:11.457153Z","end":"2026-02-04T05:20:11.617988Z","steps":["trace[1596384668] 'range keys from in-memory index tree' (duration: 160.62213ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T05:20:11.618214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.751833ms","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-02-04T05:20:11.618235Z","caller":"traceutil/trace.go:171","msg":"trace[702654176] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:498; }","duration":"164.794464ms","start":"2026-02-04T05:20:11.453433Z","end":"2026-02-04T05:20:11.618228Z","steps":["trace[702654176] 'range keys from in-memory index tree' (duration: 164.67018ms)"],"step_count":1} {"level":"info","ts":"2026-02-04T05:20:11.87348Z","caller":"traceutil/trace.go:171","msg":"trace[315831687] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"250.687389ms","start":"2026-02-04T05:20:11.622775Z","end":"2026-02-04T05:20:11.873463Z","steps":["trace[315831687] 'process raft request' (duration: 250.545314ms)"],"step_count":1} {"level":"info","ts":"2026-02-04T05:20:11.909907Z","caller":"traceutil/trace.go:171","msg":"trace[36039698] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"286.626751ms","start":"2026-02-04T05:20:11.623257Z","end":"2026-02-04T05:20:11.909884Z","steps":["trace[36039698] 'process raft request' (duration: 286.517987ms)"],"step_count":1} {"level":"info","ts":"2026-02-04T05:20:34.786945Z","caller":"traceutil/trace.go:171","msg":"trace[514078379] linearizableReadLoop","detail":"{readStateIndex:719; appliedIndex:718; }","duration":"205.991496ms","start":"2026-02-04T05:20:34.580937Z","end":"2026-02-04T05:20:34.786929Z","steps":["trace[514078379] 'read index received' (duration: 205.868452ms)","trace[514078379] 'applied index is now lower than readState.Index' (duration: 122.244µs)"],"step_count":2} {"level":"info","ts":"2026-02-04T05:20:34.787038Z","caller":"traceutil/trace.go:171","msg":"trace[266655406] transaction","detail":"{read_only:false; response_revision:698; number_of_response:1; }","duration":"243.187608ms","start":"2026-02-04T05:20:34.543843Z","end":"2026-02-04T05:20:34.78703Z","steps":["trace[266655406] 'process raft request' (duration: 242.971481ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T05:20:34.787336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.386078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-04T05:20:34.787395Z","caller":"traceutil/trace.go:171","msg":"trace[2099413858] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:698; }","duration":"206.45702ms","start":"2026-02-04T05:20:34.580915Z","end":"2026-02-04T05:20:34.787372Z","steps":["trace[2099413858] 'agreement among raft nodes before linearized reading' (duration: 206.393958ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T05:20:35.278091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.064215ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"info","ts":"2026-02-04T05:20:35.278177Z","caller":"traceutil/trace.go:171","msg":"trace[880105652] linearizableReadLoop","detail":"{readStateIndex:720; appliedIndex:719; }","duration":"489.448764ms","start":"2026-02-04T05:20:34.788712Z","end":"2026-02-04T05:20:35.278161Z","steps":["trace[880105652] 'read index received' (duration: 270.330178ms)","trace[880105652] 'applied index is now lower than readState.Index' (duration: 219.116606ms)"],"step_count":2} {"level":"warn","ts":"2026-02-04T05:20:35.278242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.522176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-04T05:20:35.278268Z","caller":"traceutil/trace.go:171","msg":"trace[365270320] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:698; }","duration":"489.572678ms","start":"2026-02-04T05:20:34.788687Z","end":"2026-02-04T05:20:35.27826Z","steps":["trace[365270320] 'agreement among raft nodes before linearized reading' (duration: 489.515486ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T05:20:35.278302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T05:20:34.788674Z","time spent":"489.619869ms","remote":"127.0.0.1:34888","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-04T05:20:35.278488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T05:20:34.788663Z","time spent":"489.822447ms","remote":"127.0.0.1:34908","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-02-04T05:20:35.55408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.00326ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-04T05:20:35.554168Z","caller":"traceutil/trace.go:171","msg":"trace[1872515530] linearizableReadLoop","detail":"{readStateIndex:722; appliedIndex:721; }","duration":"174.690331ms","start":"2026-02-04T05:20:35.379463Z","end":"2026-02-04T05:20:35.554153Z","steps":["trace[1872515530] 'read index received' (duration: 19.514795ms)","trace[1872515530] 'applied index is now lower than readState.Index' (duration: 155.174526ms)"],"step_count":2} {"level":"warn","ts":"2026-02-04T05:20:35.554334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.839799ms","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-02-04T05:20:35.554361Z","caller":"traceutil/trace.go:171","msg":"trace[2068939617] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:700; }","duration":"146.88276ms","start":"2026-02-04T05:20:35.407469Z","end":"2026-02-04T05:20:35.554352Z","steps":["trace[2068939617] 'agreement among raft nodes before linearized reading' (duration: 146.774906ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T05:20:35.554473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.983652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-04T05:20:35.554544Z","caller":"traceutil/trace.go:171","msg":"trace[1224954979] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:700; }","duration":"175.073244ms","start":"2026-02-04T05:20:35.379453Z","end":"2026-02-04T05:20:35.554526Z","steps":["trace[1224954979] 'agreement among raft nodes before linearized reading' (duration: 174.783555ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T05:20:35.554575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.828847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-02-04T05:20:35.554606Z","caller":"traceutil/trace.go:171","msg":"trace[1118276145] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:700; }","duration":"102.879379ms","start":"2026-02-04T05:20:35.451718Z","end":"2026-02-04T05:20:35.554598Z","steps":["trace[1118276145] 'agreement among raft nodes before linearized reading' (duration: 102.795837ms)"],"step_count":1} {"level":"info","ts":"2026-02-04T05:20:35.554747Z","caller":"traceutil/trace.go:171","msg":"trace[732543191] transaction","detail":"{read_only:false; response_revision:700; number_of_response:1; }","duration":"175.363964ms","start":"2026-02-04T05:20:35.379367Z","end":"2026-02-04T05:20:35.554731Z","steps":["trace[732543191] 'process raft request' (duration: 19.62963ms)","trace[732543191] 'compare' (duration: 154.915457ms)"],"step_count":2} {"level":"info","ts":"2026-02-04T05:20:53.866395Z","caller":"traceutil/trace.go:171","msg":"trace[125253908] linearizableReadLoop","detail":"{readStateIndex:781; appliedIndex:780; }","duration":"170.363873ms","start":"2026-02-04T05:20:53.696016Z","end":"2026-02-04T05:20:53.86638Z","steps":["trace[125253908] 'read index received' (duration: 170.244599ms)","trace[125253908] 'applied index is now lower than readState.Index' (duration: 118.754µs)"],"step_count":2} {"level":"info","ts":"2026-02-04T05:20:53.866571Z","caller":"traceutil/trace.go:171","msg":"trace[523111419] transaction","detail":"{read_only:false; response_revision:755; number_of_response:1; }","duration":"200.612073ms","start":"2026-02-04T05:20:53.665953Z","end":"2026-02-04T05:20:53.866565Z","steps":["trace[523111419] 'process raft request' (duration: 200.349474ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T05:20:53.866725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.695183ms","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-02-04T05:20:53.866744Z","caller":"traceutil/trace.go:171","msg":"trace[491688846] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:755; }","duration":"170.757255ms","start":"2026-02-04T05:20:53.69598Z","end":"2026-02-04T05:20:53.866737Z","steps":["trace[491688846] 'agreement among raft nodes before linearized reading' (duration: 170.680053ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T05:20:53.866851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.676797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-02-04T05:20:53.866866Z","caller":"traceutil/trace.go:171","msg":"trace[1639237415] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:755; }","duration":"162.709187ms","start":"2026-02-04T05:20:53.704151Z","end":"2026-02-04T05:20:53.86686Z","steps":["trace[1639237415] 'agreement among raft nodes before linearized reading' (duration: 162.660826ms)"],"step_count":1} {"level":"info","ts":"2026-02-04T05:20:54.12872Z","caller":"traceutil/trace.go:171","msg":"trace[1851438171] transaction","detail":"{read_only:false; response_revision:756; number_of_response:1; }","duration":"259.366635ms","start":"2026-02-04T05:20:53.869339Z","end":"2026-02-04T05:20:54.128705Z","steps":["trace[1851438171] 'process raft request' (duration: 184.702391ms)","trace[1851438171] 'compare' (duration: 74.042784ms)"],"step_count":2} {"level":"info","ts":"2026-02-04T05:20:54.128836Z","caller":"traceutil/trace.go:171","msg":"trace[328397400] transaction","detail":"{read_only:false; response_revision:757; number_of_response:1; }","duration":"258.544679ms","start":"2026-02-04T05:20:53.870274Z","end":"2026-02-04T05:20:54.128819Z","steps":["trace[328397400] 'process raft request' (duration: 258.047473ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T05:20:54.351014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.592873ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-04T05:20:54.351135Z","caller":"traceutil/trace.go:171","msg":"trace[1174661940] transaction","detail":"{read_only:false; response_revision:759; number_of_response:1; }","duration":"218.193176ms","start":"2026-02-04T05:20:54.13293Z","end":"2026-02-04T05:20:54.351123Z","steps":["trace[1174661940] 'process raft request' (duration: 218.158345ms)"],"step_count":1} {"level":"info","ts":"2026-02-04T05:20:54.351408Z","caller":"traceutil/trace.go:171","msg":"trace[1868697218] transaction","detail":"{read_only:false; response_revision:758; number_of_response:1; }","duration":"218.852507ms","start":"2026-02-04T05:20:54.132522Z","end":"2026-02-04T05:20:54.351374Z","steps":["trace[1868697218] 'process raft request' (duration: 113.83234ms)","trace[1868697218] 'compare' (duration: 104.48794ms)"],"step_count":2} {"level":"info","ts":"2026-02-04T05:20:58.016978Z","caller":"traceutil/trace.go:171","msg":"trace[2085831904] transaction","detail":"{read_only:false; response_revision:767; number_of_response:1; }","duration":"137.413266ms","start":"2026-02-04T05:20:57.879542Z","end":"2026-02-04T05:20:58.016955Z","steps":["trace[2085831904] 'process raft request' (duration: 137.286462ms)"],"step_count":1} {"level":"info","ts":"2026-02-04T05:20:58.249638Z","caller":"traceutil/trace.go:171","msg":"trace[323392179] transaction","detail":"{read_only:false; response_revision:770; number_of_response:1; }","duration":"101.164884ms","start":"2026-02-04T05:20:58.148457Z","end":"2026-02-04T05:20:58.249622Z","steps":["trace[323392179] 'process raft request' (duration: 101.112362ms)"],"step_count":1} {"level":"info","ts":"2026-02-04T05:21:15.591159Z","caller":"traceutil/trace.go:171","msg":"trace[1456144923] transaction","detail":"{read_only:false; response_revision:877; number_of_response:1; }","duration":"262.372402ms","start":"2026-02-04T05:21:15.328772Z","end":"2026-02-04T05:21:15.591145Z","steps":["trace[1456144923] 'process raft request' (duration: 261.99204ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T05:21:28.78746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.620046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-04T05:21:28.787529Z","caller":"traceutil/trace.go:171","msg":"trace[1501893179] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:914; }","duration":"209.726409ms","start":"2026-02-04T05:21:28.57779Z","end":"2026-02-04T05:21:28.787516Z","steps":["trace[1501893179] 'range keys from in-memory index tree' (duration: 209.562944ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T05:21:28.787733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.548355ms","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-02-04T05:21:28.787788Z","caller":"traceutil/trace.go:171","msg":"trace[296909676] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:914; }","duration":"260.648338ms","start":"2026-02-04T05:21:28.527126Z","end":"2026-02-04T05:21:28.787774Z","steps":["trace[296909676] 'range keys from in-memory index tree' (duration: 260.427942ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T05:21:28.787945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.706465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-04T05:21:28.787962Z","caller":"traceutil/trace.go:171","msg":"trace[344261453] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:914; }","duration":"256.747476ms","start":"2026-02-04T05:21:28.531209Z","end":"2026-02-04T05:21:28.787957Z","steps":["trace[344261453] 'range keys from in-memory index tree' (duration: 256.636033ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T05:21:30.091097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.255835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-8j795\" ","response":"range_response_count:1 size:10357"} {"level":"info","ts":"2026-02-04T05:21:30.091159Z","caller":"traceutil/trace.go:171","msg":"trace[1873690653] range","detail":"{range_begin:/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-8j795; range_end:; response_count:1; response_revision:923; }","duration":"146.353478ms","start":"2026-02-04T05:21:29.944792Z","end":"2026-02-04T05:21:30.091146Z","steps":["trace[1873690653] 'range keys from in-memory index tree' (duration: 146.132561ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T05:21:30.359178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.766754ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-04T05:21:30.364911Z","caller":"traceutil/trace.go:171","msg":"trace[948323813] linearizableReadLoop","detail":"{readStateIndex:960; appliedIndex:958; }","duration":"215.851301ms","start":"2026-02-04T05:21:30.14904Z","end":"2026-02-04T05:21:30.364892Z","steps":["trace[948323813] 'read index received' (duration: 101.971994ms)","trace[948323813] 'applied index is now lower than readState.Index' (duration: 113.878097ms)"],"step_count":2} {"level":"info","ts":"2026-02-04T05:21:30.364982Z","caller":"traceutil/trace.go:171","msg":"trace[500825516] transaction","detail":"{read_only:false; response_revision:924; number_of_response:1; }","duration":"225.548806ms","start":"2026-02-04T05:21:30.139426Z","end":"2026-02-04T05:21:30.364975Z","steps":["trace[500825516] 'process raft request' (duration: 219.843637ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T05:21:30.406891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.83544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-02-04T05:21:30.406941Z","caller":"traceutil/trace.go:171","msg":"trace[1344631406] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:924; }","duration":"257.890772ms","start":"2026-02-04T05:21:30.149037Z","end":"2026-02-04T05:21:30.406927Z","steps":["trace[1344631406] 'agreement among raft nodes before linearized reading' (duration: 215.917723ms)","trace[1344631406] 'range keys from in-memory index tree' (duration: 41.851705ms)"],"step_count":2} {"level":"info","ts":"2026-02-04T05:21:30.97345Z","caller":"traceutil/trace.go:171","msg":"trace[1851854296] transaction","detail":"{read_only:false; response_revision:933; number_of_response:1; }","duration":"168.330088ms","start":"2026-02-04T05:21:30.805071Z","end":"2026-02-04T05:21:30.973401Z","steps":["trace[1851854296] 'process raft request' (duration: 168.246655ms)"],"step_count":1} {"level":"info","ts":"2026-02-04T05:21:30.974072Z","caller":"traceutil/trace.go:171","msg":"trace[1660777975] transaction","detail":"{read_only:false; response_revision:932; number_of_response:1; }","duration":"170.9055ms","start":"2026-02-04T05:21:30.803121Z","end":"2026-02-04T05:21:30.974027Z","steps":["trace[1660777975] 'process raft request' (duration: 132.807653ms)","trace[1660777975] 'compare' (duration: 37.236409ms)"],"step_count":2} {"level":"info","ts":"2026-02-04T05:21:30.974785Z","caller":"traceutil/trace.go:171","msg":"trace[800375771] linearizableReadLoop","detail":"{readStateIndex:968; appliedIndex:967; }","duration":"169.824155ms","start":"2026-02-04T05:21:30.804944Z","end":"2026-02-04T05:21:30.974768Z","steps":["trace[800375771] 'read index received' (duration: 130.991455ms)","trace[800375771] 'applied index is now lower than readState.Index' (duration: 38.83044ms)"],"step_count":2} {"level":"warn","ts":"2026-02-04T05:21:30.975014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.047863ms","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-02-04T05:21:30.975194Z","caller":"traceutil/trace.go:171","msg":"trace[2071339320] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:933; }","duration":"170.250589ms","start":"2026-02-04T05:21:30.80493Z","end":"2026-02-04T05:21:30.975181Z","steps":["trace[2071339320] 'agreement among raft nodes before linearized reading' (duration: 169.97752ms)"],"step_count":1} {"level":"info","ts":"2026-02-04T05:21:42.958738Z","caller":"traceutil/trace.go:171","msg":"trace[1426861227] transaction","detail":"{read_only:false; response_revision:1009; number_of_response:1; }","duration":"321.955415ms","start":"2026-02-04T05:21:42.636758Z","end":"2026-02-04T05:21:42.958714Z","steps":["trace[1426861227] 'process raft request' (duration: 321.80085ms)"],"step_count":1} {"level":"info","ts":"2026-02-04T05:21:42.959717Z","caller":"traceutil/trace.go:171","msg":"trace[2145010000] transaction","detail":"{read_only:false; response_revision:1008; number_of_response:1; }","duration":"401.801313ms","start":"2026-02-04T05:21:42.557813Z","end":"2026-02-04T05:21:42.959614Z","steps":["trace[2145010000] 'process raft request' (duration: 398.610723ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T05:21:42.960227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T05:21:42.5578Z","time spent":"402.212707ms","remote":"127.0.0.1:34990","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":606,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-04T05:21:42.959163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T05:21:42.636739Z","time spent":"322.277135ms","remote":"127.0.0.1:35172","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-04T05:21:42.962636Z","caller":"traceutil/trace.go:171","msg":"trace[957791538] linearizableReadLoop","detail":"{readStateIndex:1046; appliedIndex:1045; }","duration":"330.657729ms","start":"2026-02-04T05:21:42.631964Z","end":"2026-02-04T05:21:42.962622Z","steps":["trace[957791538] 'read index received' (duration: 324.467784ms)","trace[957791538] 'applied index is now lower than readState.Index' (duration: 6.188645ms)"],"step_count":2} {"level":"warn","ts":"2026-02-04T05:21:42.963036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.91669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-04T05:21:42.965197Z","caller":"traceutil/trace.go:171","msg":"trace[876201874] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1009; }","duration":"385.087048ms","start":"2026-02-04T05:21:42.580095Z","end":"2026-02-04T05:21:42.965182Z","steps":["trace[876201874] 'agreement among raft nodes before linearized reading' (duration: 382.903939ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T05:21:42.965493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T05:21:42.580087Z","time spent":"385.390067ms","remote":"127.0.0.1:34876","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-04T05:21:42.966984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.887536ms","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-02-04T05:21:42.967023Z","caller":"traceutil/trace.go:171","msg":"trace[1649667792] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1009; }","duration":"408.929738ms","start":"2026-02-04T05:21:42.558084Z","end":"2026-02-04T05:21:42.967013Z","steps":["trace[1649667792] 'agreement among raft nodes before linearized reading' (duration: 407.760251ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T05:21:42.967047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T05:21:42.558064Z","time spent":"408.978209ms","remote":"127.0.0.1:35172","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\" "}