{"level":"warn","ts":"2026-02-18T02:42:13.272193Z","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-18T02:42:13.272318Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.21:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.21:2380","--initial-cluster=instance=https://199.19.213.21:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.21:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.21: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-18T02:42:13.27241Z","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-18T02:42:13.272424Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.21:2380"]} {"level":"info","ts":"2026-02-18T02:42:13.2725Z","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-18T02:42:13.2732Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.21:2379"]} {"level":"info","ts":"2026-02-18T02:42:13.273449Z","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.19.213.21:2380"],"listen-peer-urls":["https://199.19.213.21:2380"],"advertise-client-urls":["https://199.19.213.21:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.21:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.21: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-18T02:42:13.366035Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"92.220462ms"} {"level":"info","ts":"2026-02-18T02:42:13.454417Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c39f03fd9ad57fdc","cluster-id":"3c95a04d00bbaaa4"} {"level":"info","ts":"2026-02-18T02:42:13.454741Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c39f03fd9ad57fdc switched to configuration voters=()"} {"level":"info","ts":"2026-02-18T02:42:13.454832Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c39f03fd9ad57fdc became follower at term 0"} {"level":"info","ts":"2026-02-18T02:42:13.454907Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c39f03fd9ad57fdc [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-18T02:42:13.454943Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c39f03fd9ad57fdc became follower at term 1"} {"level":"info","ts":"2026-02-18T02:42:13.455033Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c39f03fd9ad57fdc switched to configuration voters=(14095989746452234204)"} {"level":"warn","ts":"2026-02-18T02:42:13.484606Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-18T02:42:13.486343Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-18T02:42:13.487474Z","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-18T02:42:13.490445Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c39f03fd9ad57fdc","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-18T02:42:13.491153Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c39f03fd9ad57fdc","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-18T02:42:13.491412Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c39f03fd9ad57fdc switched to configuration voters=(14095989746452234204)"} {"level":"info","ts":"2026-02-18T02:42:13.491496Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"3c95a04d00bbaaa4","local-member-id":"c39f03fd9ad57fdc","added-peer-id":"c39f03fd9ad57fdc","added-peer-peer-urls":["https://199.19.213.21:2380"]} {"level":"info","ts":"2026-02-18T02:42:13.491573Z","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-18T02:42:13.491625Z","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-18T02:42:13.491654Z","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-18T02:42:13.50038Z","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-18T02:42:13.500543Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.21:2380"} {"level":"info","ts":"2026-02-18T02:42:13.500593Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.21:2380"} {"level":"info","ts":"2026-02-18T02:42:13.501796Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c39f03fd9ad57fdc","initial-advertise-peer-urls":["https://199.19.213.21:2380"],"listen-peer-urls":["https://199.19.213.21:2380"],"advertise-client-urls":["https://199.19.213.21:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.21:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-18T02:42:13.501842Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-18T02:42:13.955701Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c39f03fd9ad57fdc is starting a new election at term 1"} {"level":"info","ts":"2026-02-18T02:42:13.955774Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c39f03fd9ad57fdc became pre-candidate at term 1"} {"level":"info","ts":"2026-02-18T02:42:13.955803Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c39f03fd9ad57fdc received MsgPreVoteResp from c39f03fd9ad57fdc at term 1"} {"level":"info","ts":"2026-02-18T02:42:13.955954Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c39f03fd9ad57fdc became candidate at term 2"} {"level":"info","ts":"2026-02-18T02:42:13.95597Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c39f03fd9ad57fdc received MsgVoteResp from c39f03fd9ad57fdc at term 2"} {"level":"info","ts":"2026-02-18T02:42:13.956025Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c39f03fd9ad57fdc became leader at term 2"} {"level":"info","ts":"2026-02-18T02:42:13.956042Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c39f03fd9ad57fdc elected leader c39f03fd9ad57fdc at term 2"} {"level":"info","ts":"2026-02-18T02:42:13.958604Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c39f03fd9ad57fdc","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.21:2379]}","request-path":"/0/members/c39f03fd9ad57fdc/attributes","cluster-id":"3c95a04d00bbaaa4","publish-timeout":"7s"} {"level":"info","ts":"2026-02-18T02:42:13.958635Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-18T02:42:13.959059Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-18T02:42:13.965136Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-18T02:42:13.966503Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-18T02:42:13.967791Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.21:2379"} {"level":"info","ts":"2026-02-18T02:42:13.973575Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"3c95a04d00bbaaa4","local-member-id":"c39f03fd9ad57fdc","cluster-version":"3.5"} {"level":"info","ts":"2026-02-18T02:42:13.973606Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-18T02:42:13.973702Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-18T02:42:13.976934Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-18T02:42:13.977056Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-18T02:42:17.831836Z","caller":"traceutil/trace.go:171","msg":"trace[1308940727] transaction","detail":"{read_only:false; response_revision:135; number_of_response:1; }","duration":"142.872168ms","start":"2026-02-18T02:42:17.688917Z","end":"2026-02-18T02:42:17.831789Z","steps":["trace[1308940727] 'process raft request' (duration: 122.231141ms)","trace[1308940727] 'compare' (duration: 20.428523ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T02:42:22.713954Z","caller":"traceutil/trace.go:171","msg":"trace[724300918] transaction","detail":"{read_only:false; response_revision:297; number_of_response:1; }","duration":"107.115873ms","start":"2026-02-18T02:42:22.606809Z","end":"2026-02-18T02:42:22.713925Z","steps":["trace[724300918] 'process raft request' (duration: 106.878409ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:42:24.207004Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9213410936645046770,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-18T02:42:24.378054Z","caller":"traceutil/trace.go:171","msg":"trace[859251628] linearizableReadLoop","detail":"{readStateIndex:328; appliedIndex:327; }","duration":"671.520052ms","start":"2026-02-18T02:42:23.70651Z","end":"2026-02-18T02:42:24.37803Z","steps":["trace[859251628] 'read index received' (duration: 661.856963ms)","trace[859251628] 'applied index is now lower than readState.Index' (duration: 9.661769ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T02:42:24.378437Z","caller":"traceutil/trace.go:171","msg":"trace[1432182749] transaction","detail":"{read_only:false; response_revision:317; number_of_response:1; }","duration":"679.43133ms","start":"2026-02-18T02:42:23.698995Z","end":"2026-02-18T02:42:24.378427Z","steps":["trace[1432182749] 'process raft request' (duration: 669.477435ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:42:24.37905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T02:42:23.698973Z","time spent":"679.699924ms","remote":"127.0.0.1:60238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3980,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-18T02:42:24.379379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"672.865115ms","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-18T02:42:24.379427Z","caller":"traceutil/trace.go:171","msg":"trace[620911260] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:317; }","duration":"672.961055ms","start":"2026-02-18T02:42:23.706454Z","end":"2026-02-18T02:42:24.379415Z","steps":["trace[620911260] 'agreement among raft nodes before linearized reading' (duration: 672.884754ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:42:24.379687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T02:42:23.706433Z","time spent":"673.244771ms","remote":"127.0.0.1:59946","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":"warn","ts":"2026-02-18T02:42:24.379984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"624.001333ms","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-02-18T02:42:24.38001Z","caller":"traceutil/trace.go:171","msg":"trace[2105092561] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:317; }","duration":"624.065183ms","start":"2026-02-18T02:42:23.755937Z","end":"2026-02-18T02:42:24.380002Z","steps":["trace[2105092561] 'agreement among raft nodes before linearized reading' (duration: 624.012902ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:42:24.380029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T02:42:23.755919Z","time spent":"624.106155ms","remote":"127.0.0.1:59946","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":232,"request content":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" "} {"level":"warn","ts":"2026-02-18T02:42:24.380246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.983146ms","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-02-18T02:42:24.380275Z","caller":"traceutil/trace.go:171","msg":"trace[597298077] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:317; }","duration":"325.035118ms","start":"2026-02-18T02:42:24.055232Z","end":"2026-02-18T02:42:24.380267Z","steps":["trace[597298077] 'agreement among raft nodes before linearized reading' (duration: 324.982636ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:42:24.380298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T02:42:24.055219Z","time spent":"325.072948ms","remote":"127.0.0.1:59946","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" "} {"level":"warn","ts":"2026-02-18T02:42:24.380364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.018491ms","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-18T02:42:24.380382Z","caller":"traceutil/trace.go:171","msg":"trace[1183967639] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:317; }","duration":"374.066163ms","start":"2026-02-18T02:42:24.006308Z","end":"2026-02-18T02:42:24.380374Z","steps":["trace[1183967639] 'agreement among raft nodes before linearized reading' (duration: 374.031492ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:42:24.380402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T02:42:24.006295Z","time spent":"374.101883ms","remote":"127.0.0.1:59946","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-18T02:42:24.380466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.999372ms","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-18T02:42:24.380485Z","caller":"traceutil/trace.go:171","msg":"trace[1943666240] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:317; }","duration":"424.059503ms","start":"2026-02-18T02:42:23.95642Z","end":"2026-02-18T02:42:24.38048Z","steps":["trace[1943666240] 'agreement among raft nodes before linearized reading' (duration: 424.027402ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:42:24.380509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T02:42:23.956401Z","time spent":"424.104684ms","remote":"127.0.0.1:59946","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-18T02:42:24.380563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.189688ms","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-18T02:42:24.380578Z","caller":"traceutil/trace.go:171","msg":"trace[1096611319] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:317; }","duration":"473.248109ms","start":"2026-02-18T02:42:23.907325Z","end":"2026-02-18T02:42:24.380573Z","steps":["trace[1096611319] 'agreement among raft nodes before linearized reading' (duration: 473.222349ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:42:24.380596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T02:42:23.907304Z","time spent":"473.287539ms","remote":"127.0.0.1:59946","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":220,"request content":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" "} {"level":"warn","ts":"2026-02-18T02:42:24.381188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"573.585175ms","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-18T02:42:24.38121Z","caller":"traceutil/trace.go:171","msg":"trace[1434728761] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:317; }","duration":"573.660397ms","start":"2026-02-18T02:42:23.807544Z","end":"2026-02-18T02:42:24.381204Z","steps":["trace[1434728761] 'agreement among raft nodes before linearized reading' (duration: 573.616506ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:42:24.381228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T02:42:23.807521Z","time spent":"573.702968ms","remote":"127.0.0.1:59946","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-18T02:42:24.381315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.308201ms","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-18T02:42:24.381333Z","caller":"traceutil/trace.go:171","msg":"trace[105305454] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:317; }","duration":"523.364862ms","start":"2026-02-18T02:42:23.857962Z","end":"2026-02-18T02:42:24.381326Z","steps":["trace[105305454] 'agreement among raft nodes before linearized reading' (duration: 523.333561ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:42:24.381355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T02:42:23.857944Z","time spent":"523.405822ms","remote":"127.0.0.1:59946","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-18T02:42:25.614653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.292662ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-18T02:42:25.61537Z","caller":"traceutil/trace.go:171","msg":"trace[1081722917] transaction","detail":"{read_only:false; response_revision:359; number_of_response:1; }","duration":"175.830108ms","start":"2026-02-18T02:42:25.439523Z","end":"2026-02-18T02:42:25.615353Z","steps":["trace[1081722917] 'process raft request' (duration: 67.60335ms)","trace[1081722917] 'compare' (duration: 107.063329ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T02:42:25.615836Z","caller":"traceutil/trace.go:171","msg":"trace[768419467] transaction","detail":"{read_only:false; response_revision:360; number_of_response:1; }","duration":"165.343306ms","start":"2026-02-18T02:42:25.450486Z","end":"2026-02-18T02:42:25.615829Z","steps":["trace[768419467] 'process raft request' (duration: 165.288855ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:42:29.393342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.316924ms","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-18T02:42:29.393429Z","caller":"traceutil/trace.go:171","msg":"trace[2095330884] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:369; }","duration":"349.466296ms","start":"2026-02-18T02:42:29.04394Z","end":"2026-02-18T02:42:29.393407Z","steps":["trace[2095330884] 'range keys from in-memory index tree' (duration: 349.203512ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:42:29.393467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T02:42:29.043919Z","time spent":"349.541557ms","remote":"127.0.0.1:60026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-18T02:42:29.758521Z","caller":"traceutil/trace.go:171","msg":"trace[1402017040] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"360.634421ms","start":"2026-02-18T02:42:29.397866Z","end":"2026-02-18T02:42:29.7585Z","steps":["trace[1402017040] 'process raft request' (duration: 360.192253ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:42:29.75882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T02:42:29.397844Z","time spent":"360.900685ms","remote":"127.0.0.1:60026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-18T02:42:30.029652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.484399ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T02:42:30.029826Z","caller":"traceutil/trace.go:171","msg":"trace[1380140542] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:370; }","duration":"170.686893ms","start":"2026-02-18T02:42:29.859111Z","end":"2026-02-18T02:42:30.029798Z","steps":["trace[1380140542] 'range keys from in-memory index tree' (duration: 170.411518ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T02:42:30.326794Z","caller":"traceutil/trace.go:171","msg":"trace[1652602985] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"286.365555ms","start":"2026-02-18T02:42:30.040399Z","end":"2026-02-18T02:42:30.326765Z","steps":["trace[1652602985] 'process raft request' (duration: 286.233863ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T02:42:30.500186Z","caller":"traceutil/trace.go:171","msg":"trace[647902217] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"133.633295ms","start":"2026-02-18T02:42:30.366527Z","end":"2026-02-18T02:42:30.500161Z","steps":["trace[647902217] 'process raft request' (duration: 133.496423ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T02:42:30.500774Z","caller":"traceutil/trace.go:171","msg":"trace[707124978] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"117.159365ms","start":"2026-02-18T02:42:30.383605Z","end":"2026-02-18T02:42:30.500764Z","steps":["trace[707124978] 'process raft request' (duration: 117.088034ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T02:42:35.994289Z","caller":"traceutil/trace.go:171","msg":"trace[1376204253] transaction","detail":"{read_only:false; response_revision:420; number_of_response:1; }","duration":"209.095234ms","start":"2026-02-18T02:42:35.784942Z","end":"2026-02-18T02:42:35.994038Z","steps":["trace[1376204253] 'process raft request' (duration: 208.901031ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T02:42:39.072047Z","caller":"traceutil/trace.go:171","msg":"trace[77237491] transaction","detail":"{read_only:false; response_revision:429; number_of_response:1; }","duration":"138.699511ms","start":"2026-02-18T02:42:38.933328Z","end":"2026-02-18T02:42:39.072028Z","steps":["trace[77237491] 'process raft request' (duration: 138.605739ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T02:42:46.258355Z","caller":"traceutil/trace.go:171","msg":"trace[1456077047] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"193.457376ms","start":"2026-02-18T02:42:46.064882Z","end":"2026-02-18T02:42:46.258339Z","steps":["trace[1456077047] 'process raft request' (duration: 193.324323ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T02:42:47.046272Z","caller":"traceutil/trace.go:171","msg":"trace[1463557810] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"313.111412ms","start":"2026-02-18T02:42:46.73314Z","end":"2026-02-18T02:42:47.046252Z","steps":["trace[1463557810] 'process raft request' (duration: 312.99321ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:42:47.046404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T02:42:46.733093Z","time spent":"313.243504ms","remote":"127.0.0.1:60026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T02:42:47.047336Z","caller":"traceutil/trace.go:171","msg":"trace[1274634591] linearizableReadLoop","detail":"{readStateIndex:497; appliedIndex:497; }","duration":"300.974175ms","start":"2026-02-18T02:42:46.746349Z","end":"2026-02-18T02:42:47.047323Z","steps":["trace[1274634591] 'read index received' (duration: 300.968985ms)","trace[1274634591] 'applied index is now lower than readState.Index' (duration: 4.13µs)"],"step_count":2} {"level":"warn","ts":"2026-02-18T02:42:47.047412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.058658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-02-18T02:42:47.047441Z","caller":"traceutil/trace.go:171","msg":"trace[1029891217] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:480; }","duration":"301.116188ms","start":"2026-02-18T02:42:46.746316Z","end":"2026-02-18T02:42:47.047432Z","steps":["trace[1029891217] 'agreement among raft nodes before linearized reading' (duration: 301.052667ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:42:47.04747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T02:42:46.746301Z","time spent":"301.16246ms","remote":"127.0.0.1:60026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-18T02:42:47.59689Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9213410936645047081,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-18T02:42:48.097938Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9213410936645047081,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-18T02:42:48.704824Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9213410936645047081,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-18T02:42:49.205446Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9213410936645047081,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-18T02:42:49.25062Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.204626671s","expected-duration":"1s"} {"level":"warn","ts":"2026-02-18T02:42:49.69553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000450271s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-02-18T02:42:49.695644Z","caller":"traceutil/trace.go:171","msg":"trace[1126970541] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000622155s","start":"2026-02-18T02:42:47.69499Z","end":"2026-02-18T02:42:49.695612Z","steps":["trace[1126970541] 'agreement among raft nodes before linearized reading' (duration: 2.000480012s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:42:49.695705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T02:42:47.694971Z","time spent":"2.000723046s","remote":"127.0.0.1:59734","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/02/18 02:42:49 WARNING: [core] [Server #6] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-02-18T02:42:50.294552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T02:42:48.140262Z","time spent":"2.154284108s","remote":"127.0.0.1:42160","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-02-18T02:42:50.294889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.044014175s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-18T02:42:50.295047Z","caller":"traceutil/trace.go:171","msg":"trace[2084337244] linearizableReadLoop","detail":"{readStateIndex:499; appliedIndex:497; }","duration":"3.198355492s","start":"2026-02-18T02:42:47.096677Z","end":"2026-02-18T02:42:50.295032Z","steps":["trace[2084337244] 'read index received' (duration: 2.154128553s)","trace[2084337244] 'applied index is now lower than readState.Index' (duration: 1.044225248s)"],"step_count":2} {"level":"info","ts":"2026-02-18T02:42:50.295142Z","caller":"traceutil/trace.go:171","msg":"trace[153911458] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"3.244067325s","start":"2026-02-18T02:42:47.051066Z","end":"2026-02-18T02:42:50.295134Z","steps":["trace[153911458] 'process raft request' (duration: 3.243910223s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:42:50.295213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.03464768s","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-18T02:42:50.295245Z","caller":"traceutil/trace.go:171","msg":"trace[393803630] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:482; }","duration":"2.034704331s","start":"2026-02-18T02:42:48.260531Z","end":"2026-02-18T02:42:50.295235Z","steps":["trace[393803630] 'agreement among raft nodes before linearized reading' (duration: 2.03464776s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:42:50.295265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.023131573s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-18T02:42:50.295273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T02:42:48.260518Z","time spent":"2.034748723s","remote":"127.0.0.1:60026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-18T02:42:50.295293Z","caller":"traceutil/trace.go:171","msg":"trace[884976388] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:0; response_revision:482; }","duration":"1.023186024s","start":"2026-02-18T02:42:49.272097Z","end":"2026-02-18T02:42:50.295283Z","steps":["trace[884976388] 'agreement among raft nodes before linearized reading' (duration: 1.023143243s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:42:50.295319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T02:42:49.272084Z","time spent":"1.023229455s","remote":"127.0.0.1:59848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":28,"request content":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" "} {"level":"warn","ts":"2026-02-18T02:42:50.295403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.244344929s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-18T02:42:50.29543Z","caller":"traceutil/trace.go:171","msg":"trace[556787657] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:482; }","duration":"1.244370159s","start":"2026-02-18T02:42:49.051051Z","end":"2026-02-18T02:42:50.295421Z","steps":["trace[556787657] 'agreement among raft nodes before linearized reading' (duration: 1.244324898s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:42:50.295455Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T02:42:49.051006Z","time spent":"1.244442531s","remote":"127.0.0.1:60026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-18T02:42:50.295533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.198861771s","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-18T02:42:50.295574Z","caller":"traceutil/trace.go:171","msg":"trace[1623667131] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:482; }","duration":"3.198941192s","start":"2026-02-18T02:42:47.096621Z","end":"2026-02-18T02:42:50.295562Z","steps":["trace[1623667131] 'agreement among raft nodes before linearized reading' (duration: 3.19883836s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:42:50.295608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.589305981s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.21\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-02-18T02:42:50.295617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T02:42:47.096601Z","time spent":"3.199001823s","remote":"127.0.0.1:60026","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":"info","ts":"2026-02-18T02:42:50.295634Z","caller":"traceutil/trace.go:171","msg":"trace[1466942118] range","detail":"{range_begin:/registry/masterleases/199.19.213.21; range_end:; response_count:1; response_revision:482; }","duration":"1.589354383s","start":"2026-02-18T02:42:48.706271Z","end":"2026-02-18T02:42:50.295626Z","steps":["trace[1466942118] 'agreement among raft nodes before linearized reading' (duration: 1.589306201s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:42:50.295658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T02:42:48.70626Z","time spent":"1.589393153s","remote":"127.0.0.1:59774","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.19.213.21\" "} {"level":"warn","ts":"2026-02-18T02:42:50.29521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T02:42:47.051049Z","time spent":"3.244126436s","remote":"127.0.0.1:60026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T02:42:50.295135Z","caller":"traceutil/trace.go:171","msg":"trace[1268805739] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"3.270540465s","start":"2026-02-18T02:42:47.024578Z","end":"2026-02-18T02:42:50.295119Z","steps":["trace[1268805739] 'process raft request' (duration: 2.226220085s)","trace[1268805739] 'compare' (duration: 1.043861952s)"],"step_count":2} {"level":"warn","ts":"2026-02-18T02:42:50.296003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T02:42:47.024553Z","time spent":"3.271414311s","remote":"127.0.0.1:60026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-18T02:42:50.295781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"599.712512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T02:42:50.296112Z","caller":"traceutil/trace.go:171","msg":"trace[210282403] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:482; }","duration":"600.083728ms","start":"2026-02-18T02:42:49.696017Z","end":"2026-02-18T02:42:50.2961Z","steps":["trace[210282403] 'agreement among raft nodes before linearized reading' (duration: 599.736512ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:42:50.296139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T02:42:49.695998Z","time spent":"600.13418ms","remote":"127.0.0.1:59750","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-18T02:42:50.759517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.458282ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"info","ts":"2026-02-18T02:42:50.760192Z","caller":"traceutil/trace.go:171","msg":"trace[596588890] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"447.841491ms","start":"2026-02-18T02:42:50.312326Z","end":"2026-02-18T02:42:50.760168Z","steps":["trace[596588890] 'process raft request' (duration: 447.753139ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:42:50.760319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T02:42:50.31232Z","time spent":"447.921752ms","remote":"127.0.0.1:60026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T02:42:50.760738Z","caller":"traceutil/trace.go:171","msg":"trace[1290187271] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"448.728527ms","start":"2026-02-18T02:42:50.311972Z","end":"2026-02-18T02:42:50.760701Z","steps":["trace[1290187271] 'process raft request' (duration: 447.670548ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T02:42:50.760786Z","caller":"traceutil/trace.go:171","msg":"trace[264094742] linearizableReadLoop","detail":"{readStateIndex:504; appliedIndex:499; }","duration":"442.21214ms","start":"2026-02-18T02:42:50.318555Z","end":"2026-02-18T02:42:50.760767Z","steps":["trace[264094742] 'read index received' (duration: 124.591997ms)","trace[264094742] 'applied index is now lower than readState.Index' (duration: 317.619143ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T02:42:50.760932Z","caller":"traceutil/trace.go:171","msg":"trace[999790928] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"443.064116ms","start":"2026-02-18T02:42:50.317857Z","end":"2026-02-18T02:42:50.760922Z","steps":["trace[999790928] 'process raft request' (duration: 442.272171ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:42:50.760945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T02:42:50.311954Z","time spent":"448.85942ms","remote":"127.0.0.1:60026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-18T02:42:50.760997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T02:42:50.317845Z","time spent":"443.118067ms","remote":"127.0.0.1:59824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-18T02:42:50.76114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T02:42:50.300725Z","time spent":"460.413385ms","remote":"127.0.0.1:59774","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-02-18T02:42:50.761175Z","caller":"traceutil/trace.go:171","msg":"trace[1276525783] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"443.261799ms","start":"2026-02-18T02:42:50.317903Z","end":"2026-02-18T02:42:50.761165Z","steps":["trace[1276525783] 'process raft request' (duration: 442.796551ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:42:50.761237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T02:42:50.317899Z","time spent":"443.305671ms","remote":"127.0.0.1:60026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-18T02:42:50.761415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.863031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T02:42:50.761454Z","caller":"traceutil/trace.go:171","msg":"trace[1471257203] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:486; }","duration":"442.919143ms","start":"2026-02-18T02:42:50.318523Z","end":"2026-02-18T02:42:50.761442Z","steps":["trace[1471257203] 'agreement among raft nodes before linearized reading' (duration: 442.847462ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:42:50.761534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T02:42:50.318517Z","time spent":"442.967504ms","remote":"127.0.0.1:59734","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-18T02:42:50.767622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.92226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T02:42:50.767657Z","caller":"traceutil/trace.go:171","msg":"trace[529170399] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:0; response_revision:487; }","duration":"362.984591ms","start":"2026-02-18T02:42:50.404664Z","end":"2026-02-18T02:42:50.767649Z","steps":["trace[529170399] 'agreement among raft nodes before linearized reading' (duration: 362.931291ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:42:50.767677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T02:42:50.40465Z","time spent":"363.022412ms","remote":"127.0.0.1:59848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":28,"request content":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" "} {"level":"warn","ts":"2026-02-18T02:42:52.096727Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.02706699s","expected-duration":"1s"} {"level":"info","ts":"2026-02-18T02:42:52.102962Z","caller":"traceutil/trace.go:171","msg":"trace[632222794] linearizableReadLoop","detail":"{readStateIndex:510; appliedIndex:508; }","duration":"408.050527ms","start":"2026-02-18T02:42:51.694889Z","end":"2026-02-18T02:42:52.102939Z","steps":["trace[632222794] 'read index received' (duration: 401.955108ms)","trace[632222794] 'applied index is now lower than readState.Index' (duration: 6.094489ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T02:42:52.10307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.163949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T02:42:52.103109Z","caller":"traceutil/trace.go:171","msg":"trace[153386093] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:492; }","duration":"408.23568ms","start":"2026-02-18T02:42:51.694864Z","end":"2026-02-18T02:42:52.103099Z","steps":["trace[153386093] 'agreement among raft nodes before linearized reading' (duration: 408.146318ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:42:52.103148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T02:42:51.694851Z","time spent":"408.288402ms","remote":"127.0.0.1:59734","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-18T02:42:52.103391Z","caller":"traceutil/trace.go:171","msg":"trace[1223331664] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"1.103956089s","start":"2026-02-18T02:42:50.999423Z","end":"2026-02-18T02:42:52.10338Z","steps":["trace[1223331664] 'process raft request' (duration: 1.097461472s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:42:52.103469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T02:42:50.999418Z","time spent":"1.10400842s","remote":"127.0.0.1:59946","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":178,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-18T02:42:52.103664Z","caller":"traceutil/trace.go:171","msg":"trace[1224643319] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"1.098989851s","start":"2026-02-18T02:42:51.004664Z","end":"2026-02-18T02:42:52.103654Z","steps":["trace[1224643319] 'process raft request' (duration: 1.098187667s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:42:52.103721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T02:42:51.004658Z","time spent":"1.099040311s","remote":"127.0.0.1:59848","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12737,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-18T02:42:57.194744Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9213410936645047156,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-18T02:42:57.694967Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9213410936645047156,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-18T02:42:57.792161Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.45925107s","expected-duration":"1s"} {"level":"info","ts":"2026-02-18T02:42:57.792424Z","caller":"traceutil/trace.go:171","msg":"trace[857661297] linearizableReadLoop","detail":"{readStateIndex:538; appliedIndex:537; }","duration":"1.098637635s","start":"2026-02-18T02:42:56.693769Z","end":"2026-02-18T02:42:57.792407Z","steps":["trace[857661297] 'read index received' (duration: 1.098465262s)","trace[857661297] 'applied index is now lower than readState.Index' (duration: 171.573µs)"],"step_count":2} {"level":"info","ts":"2026-02-18T02:42:57.792512Z","caller":"traceutil/trace.go:171","msg":"trace[1468608389] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"1.459649528s","start":"2026-02-18T02:42:56.332853Z","end":"2026-02-18T02:42:57.792503Z","steps":["trace[1468608389] 'process raft request' (duration: 1.459445824s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:42:57.792587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T02:42:56.332844Z","time spent":"1.459686528s","remote":"127.0.0.1:60026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-18T02:42:57.792643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"994.624648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-18T02:42:57.79267Z","caller":"traceutil/trace.go:171","msg":"trace[1122333260] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:519; }","duration":"994.699439ms","start":"2026-02-18T02:42:56.79796Z","end":"2026-02-18T02:42:57.79266Z","steps":["trace[1122333260] 'agreement among raft nodes before linearized reading' (duration: 994.644478ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:42:57.792691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T02:42:56.797937Z","time spent":"994.7496ms","remote":"127.0.0.1:60026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-18T02:42:57.792768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.098999361s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T02:42:57.792779Z","caller":"traceutil/trace.go:171","msg":"trace[836957272] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:519; }","duration":"1.099032271s","start":"2026-02-18T02:42:56.693743Z","end":"2026-02-18T02:42:57.792775Z","steps":["trace[836957272] 'agreement among raft nodes before linearized reading' (duration: 1.099014541s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:42:57.792789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T02:42:56.69373Z","time spent":"1.099057463s","remote":"127.0.0.1:59734","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-18T02:42:57.792911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"938.295153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-18T02:42:57.792929Z","caller":"traceutil/trace.go:171","msg":"trace[1939449526] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:519; }","duration":"938.369784ms","start":"2026-02-18T02:42:56.854554Z","end":"2026-02-18T02:42:57.792924Z","steps":["trace[1939449526] 'agreement among raft nodes before linearized reading' (duration: 938.332393ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:42:57.792943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T02:42:56.854534Z","time spent":"938.405834ms","remote":"127.0.0.1:60026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-18T02:42:57.792987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"975.863604ms","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-02-18T02:42:57.793015Z","caller":"traceutil/trace.go:171","msg":"trace[1489962155] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:519; }","duration":"975.910504ms","start":"2026-02-18T02:42:56.817097Z","end":"2026-02-18T02:42:57.793007Z","steps":["trace[1489962155] 'agreement among raft nodes before linearized reading' (duration: 975.856043ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:42:57.793036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T02:42:56.817089Z","time spent":"975.942365ms","remote":"127.0.0.1:60026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-18T02:42:58.258483Z","caller":"traceutil/trace.go:171","msg":"trace[883404803] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"461.927476ms","start":"2026-02-18T02:42:57.796538Z","end":"2026-02-18T02:42:58.258466Z","steps":["trace[883404803] 'process raft request' (duration: 410.558466ms)","trace[883404803] 'compare' (duration: 51.302298ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T02:42:58.258587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T02:42:57.796528Z","time spent":"462.002388ms","remote":"127.0.0.1:60026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T02:42:58.261297Z","caller":"traceutil/trace.go:171","msg":"trace[548621196] linearizableReadLoop","detail":"{readStateIndex:540; appliedIndex:538; }","duration":"456.924275ms","start":"2026-02-18T02:42:57.804358Z","end":"2026-02-18T02:42:58.261282Z","steps":["trace[548621196] 'read index received' (duration: 402.748296ms)","trace[548621196] 'applied index is now lower than readState.Index' (duration: 54.175489ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T02:42:58.261375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.001817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T02:42:58.261392Z","caller":"traceutil/trace.go:171","msg":"trace[2103453786] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:522; }","duration":"457.047378ms","start":"2026-02-18T02:42:57.804339Z","end":"2026-02-18T02:42:58.261387Z","steps":["trace[2103453786] 'agreement among raft nodes before linearized reading' (duration: 456.996107ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:42:58.261411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T02:42:57.804333Z","time spent":"457.07327ms","remote":"127.0.0.1:59734","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-18T02:42:58.261582Z","caller":"traceutil/trace.go:171","msg":"trace[120527741] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"463.768321ms","start":"2026-02-18T02:42:57.797807Z","end":"2026-02-18T02:42:58.261576Z","steps":["trace[120527741] 'process raft request' (duration: 463.385539ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:42:58.261635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T02:42:57.7978Z","time spent":"463.796642ms","remote":"127.0.0.1:60026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T02:42:58.261737Z","caller":"traceutil/trace.go:171","msg":"trace[771766693] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"426.352395ms","start":"2026-02-18T02:42:57.835377Z","end":"2026-02-18T02:42:58.261729Z","steps":["trace[771766693] 'process raft request' (duration: 425.88394ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:42:58.261767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T02:42:57.835356Z","time spent":"426.394837ms","remote":"127.0.0.1:60026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-18T02:43:00.296704Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9213410936645047179,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-18T02:43:00.797435Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9213410936645047179,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-18T02:43:01.297938Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9213410936645047179,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-18T02:43:01.79845Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9213410936645047179,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-18T02:43:02.177847Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.408601245s","expected-duration":"1s"} {"level":"info","ts":"2026-02-18T02:43:02.17812Z","caller":"traceutil/trace.go:171","msg":"trace[769364227] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"2.408960766s","start":"2026-02-18T02:42:59.769143Z","end":"2026-02-18T02:43:02.178103Z","steps":["trace[769364227] 'process raft request' (duration: 2.408863583s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:43:02.1782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T02:42:59.769125Z","time spent":"2.409019949s","remote":"127.0.0.1:59930","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16799,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T02:43:02.639249Z","caller":"traceutil/trace.go:171","msg":"trace[1458732424] linearizableReadLoop","detail":"{readStateIndex:549; appliedIndex:547; }","duration":"2.84335714s","start":"2026-02-18T02:42:59.795877Z","end":"2026-02-18T02:43:02.639234Z","steps":["trace[1458732424] 'read index received' (duration: 2.382263309s)","trace[1458732424] 'applied index is now lower than readState.Index' (duration: 461.093301ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T02:43:02.639319Z","caller":"traceutil/trace.go:171","msg":"trace[10017579] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"1.971565677s","start":"2026-02-18T02:43:00.667749Z","end":"2026-02-18T02:43:02.639315Z","steps":["trace[10017579] 'process raft request' (duration: 1.967380057s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:43:02.639381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T02:43:00.667731Z","time spent":"1.971601348s","remote":"127.0.0.1:60026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-18T02:43:02.639494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.377808684s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-18T02:43:02.639509Z","caller":"traceutil/trace.go:171","msg":"trace[241664732] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:529; }","duration":"2.377869266s","start":"2026-02-18T02:43:00.261636Z","end":"2026-02-18T02:43:02.639505Z","steps":["trace[241664732] 'agreement among raft nodes before linearized reading' (duration: 2.377837175s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:43:02.63949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.843600259s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-02-18T02:43:02.639538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T02:43:00.261612Z","time spent":"2.377923228s","remote":"127.0.0.1:60026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-18T02:43:02.639552Z","caller":"traceutil/trace.go:171","msg":"trace[657109224] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:529; }","duration":"2.843694422s","start":"2026-02-18T02:42:59.795841Z","end":"2026-02-18T02:43:02.639535Z","steps":["trace[657109224] 'agreement among raft nodes before linearized reading' (duration: 2.843594449s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:43:02.639589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T02:42:59.795804Z","time spent":"2.843777314s","remote":"127.0.0.1:60026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-18T02:43:02.639651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.623057ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-zbh2d\" ","response":"range_response_count:1 size:16814"} {"level":"info","ts":"2026-02-18T02:43:02.639667Z","caller":"traceutil/trace.go:171","msg":"trace[1870796835] range","detail":"{range_begin:/registry/pods/kube-system/cilium-zbh2d; range_end:; response_count:1; response_revision:529; }","duration":"435.672349ms","start":"2026-02-18T02:43:02.203991Z","end":"2026-02-18T02:43:02.639663Z","steps":["trace[1870796835] 'agreement among raft nodes before linearized reading' (duration: 435.610297ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:43:02.639679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T02:43:02.203975Z","time spent":"435.701549ms","remote":"127.0.0.1:59930","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16837,"request content":"key:\"/registry/pods/kube-system/cilium-zbh2d\" "} {"level":"warn","ts":"2026-02-18T02:43:02.639752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.945721831s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T02:43:02.639763Z","caller":"traceutil/trace.go:171","msg":"trace[1537775632] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:529; }","duration":"1.945774472s","start":"2026-02-18T02:43:00.693985Z","end":"2026-02-18T02:43:02.63976Z","steps":["trace[1537775632] 'agreement among raft nodes before linearized reading' (duration: 1.945754612s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:43:02.639776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T02:43:00.693965Z","time spent":"1.945806444s","remote":"127.0.0.1:59734","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-18T02:43:02.639797Z","caller":"traceutil/trace.go:171","msg":"trace[1782629021] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"1.755153149s","start":"2026-02-18T02:43:00.88463Z","end":"2026-02-18T02:43:02.639783Z","steps":["trace[1782629021] 'process raft request' (duration: 1.754556641s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:43:02.639866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.374517192s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-18T02:43:02.639881Z","caller":"traceutil/trace.go:171","msg":"trace[1307715628] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:529; }","duration":"2.374558463s","start":"2026-02-18T02:43:00.265318Z","end":"2026-02-18T02:43:02.639876Z","steps":["trace[1307715628] 'agreement among raft nodes before linearized reading' (duration: 2.374533622s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:43:02.639875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T02:43:00.884579Z","time spent":"1.755246451s","remote":"127.0.0.1:60026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-18T02:43:02.639903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T02:43:00.26531Z","time spent":"2.374591114s","remote":"127.0.0.1:60026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-18T02:43:02.64002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.375339817s","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-02-18T02:43:02.640049Z","caller":"traceutil/trace.go:171","msg":"trace[998981676] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:529; }","duration":"2.375402039s","start":"2026-02-18T02:43:00.264637Z","end":"2026-02-18T02:43:02.640039Z","steps":["trace[998981676] 'agreement among raft nodes before linearized reading' (duration: 2.375351447s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:43:02.640076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T02:43:00.264614Z","time spent":"2.37545534s","remote":"127.0.0.1:60026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-18T02:43:06.09585Z","caller":"traceutil/trace.go:171","msg":"trace[1143297803] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"130.983082ms","start":"2026-02-18T02:43:05.964847Z","end":"2026-02-18T02:43:06.09583Z","steps":["trace[1143297803] 'process raft request' (duration: 127.644841ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T02:43:06.149476Z","caller":"traceutil/trace.go:171","msg":"trace[718019894] linearizableReadLoop","detail":"{readStateIndex:593; appliedIndex:591; }","duration":"151.507756ms","start":"2026-02-18T02:43:05.997938Z","end":"2026-02-18T02:43:06.149446Z","steps":["trace[718019894] 'read index received' (duration: 94.652161ms)","trace[718019894] 'applied index is now lower than readState.Index' (duration: 56.855065ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T02:43:06.14964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.684371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-7fcd8d6ffd-wfz9s\" ","response":"range_response_count:1 size:4818"} {"level":"info","ts":"2026-02-18T02:43:06.149666Z","caller":"traceutil/trace.go:171","msg":"trace[548164637] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-7fcd8d6ffd-wfz9s; range_end:; response_count:1; response_revision:572; }","duration":"151.743503ms","start":"2026-02-18T02:43:05.997917Z","end":"2026-02-18T02:43:06.14966Z","steps":["trace[548164637] 'agreement among raft nodes before linearized reading' (duration: 151.62424ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T02:43:06.149944Z","caller":"traceutil/trace.go:171","msg":"trace[232434895] transaction","detail":"{read_only:false; number_of_response:0; response_revision:571; }","duration":"152.159196ms","start":"2026-02-18T02:43:05.997778Z","end":"2026-02-18T02:43:06.149937Z","steps":["trace[232434895] 'process raft request' (duration: 151.512976ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T02:43:06.430392Z","caller":"traceutil/trace.go:171","msg":"trace[1526641688] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"264.122927ms","start":"2026-02-18T02:43:06.166251Z","end":"2026-02-18T02:43:06.430374Z","steps":["trace[1526641688] 'process raft request' (duration: 258.465256ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T02:43:06.488738Z","caller":"traceutil/trace.go:171","msg":"trace[1460596774] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"132.778741ms","start":"2026-02-18T02:43:06.355937Z","end":"2026-02-18T02:43:06.488715Z","steps":["trace[1460596774] 'process raft request' (duration: 132.7372ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T02:43:06.489208Z","caller":"traceutil/trace.go:171","msg":"trace[457937579] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"322.755486ms","start":"2026-02-18T02:43:06.16644Z","end":"2026-02-18T02:43:06.489196Z","steps":["trace[457937579] 'process raft request' (duration: 322.053605ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:43:06.489428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T02:43:06.166232Z","time spent":"323.112166ms","remote":"127.0.0.1:59930","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4609,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T02:43:06.489988Z","caller":"traceutil/trace.go:171","msg":"trace[928576912] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"213.667599ms","start":"2026-02-18T02:43:06.276304Z","end":"2026-02-18T02:43:06.489971Z","steps":["trace[928576912] 'process raft request' (duration: 212.307609ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:43:06.674406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.433247ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-18T02:43:06.67481Z","caller":"traceutil/trace.go:171","msg":"trace[1635917260] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"166.216419ms","start":"2026-02-18T02:43:06.508582Z","end":"2026-02-18T02:43:06.674798Z","steps":["trace[1635917260] 'process raft request' (duration: 63.337599ms)","trace[1635917260] 'compare' (duration: 102.367875ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T02:43:06.674903Z","caller":"traceutil/trace.go:171","msg":"trace[1172247766] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"164.60382ms","start":"2026-02-18T02:43:06.510293Z","end":"2026-02-18T02:43:06.674897Z","steps":["trace[1172247766] 'process raft request' (duration: 164.178757ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T02:43:06.675071Z","caller":"traceutil/trace.go:171","msg":"trace[542735235] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"164.632671ms","start":"2026-02-18T02:43:06.51043Z","end":"2026-02-18T02:43:06.675062Z","steps":["trace[542735235] 'process raft request' (duration: 164.130946ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:43:07.123889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.462607ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-18T02:43:07.12421Z","caller":"traceutil/trace.go:171","msg":"trace[646344155] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"437.6529ms","start":"2026-02-18T02:43:06.686533Z","end":"2026-02-18T02:43:07.124186Z","steps":["trace[646344155] 'process raft request' (duration: 131.780592ms)","trace[646344155] 'compare' (duration: 305.210658ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T02:43:07.124267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T02:43:06.686528Z","time spent":"437.709861ms","remote":"127.0.0.1:59788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":13214,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T02:43:07.124378Z","caller":"traceutil/trace.go:171","msg":"trace[566856435] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"268.329647ms","start":"2026-02-18T02:43:06.856034Z","end":"2026-02-18T02:43:07.124363Z","steps":["trace[566856435] 'process raft request' (duration: 268.188443ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T02:43:07.124499Z","caller":"traceutil/trace.go:171","msg":"trace[491649492] linearizableReadLoop","detail":"{readStateIndex:606; appliedIndex:603; }","duration":"433.307039ms","start":"2026-02-18T02:43:06.691187Z","end":"2026-02-18T02:43:07.124494Z","steps":["trace[491649492] 'read index received' (duration: 67.724601ms)","trace[491649492] 'applied index is now lower than readState.Index' (duration: 365.581898ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T02:43:07.124578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.388121ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-18T02:43:07.124595Z","caller":"traceutil/trace.go:171","msg":"trace[2051146301] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:585; }","duration":"433.407182ms","start":"2026-02-18T02:43:06.691183Z","end":"2026-02-18T02:43:07.12459Z","steps":["trace[2051146301] 'agreement among raft nodes before linearized reading' (duration: 433.34163ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:43:07.124609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T02:43:06.691163Z","time spent":"433.442493ms","remote":"127.0.0.1:60026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-18T02:43:07.124404Z","caller":"traceutil/trace.go:171","msg":"trace[1120532680] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"433.905077ms","start":"2026-02-18T02:43:06.690493Z","end":"2026-02-18T02:43:07.124399Z","steps":["trace[1120532680] 'process raft request' (duration: 433.622969ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:43:07.124717Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T02:43:06.690485Z","time spent":"434.190715ms","remote":"127.0.0.1:60238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T02:43:07.125147Z","caller":"traceutil/trace.go:171","msg":"trace[431866312] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"250.787788ms","start":"2026-02-18T02:43:06.874352Z","end":"2026-02-18T02:43:07.12514Z","steps":["trace[431866312] 'process raft request' (duration: 250.763087ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:43:07.147836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.07367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T02:43:07.147887Z","caller":"traceutil/trace.go:171","msg":"trace[1360551352] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:587; }","duration":"450.157811ms","start":"2026-02-18T02:43:06.697718Z","end":"2026-02-18T02:43:07.147876Z","steps":["trace[1360551352] 'agreement among raft nodes before linearized reading' (duration: 450.059268ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:43:07.147913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T02:43:06.69771Z","time spent":"450.197753ms","remote":"127.0.0.1:59734","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-18T02:43:07.148188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.247064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-zbh2d\" ","response":"range_response_count:1 size:17666"} {"level":"info","ts":"2026-02-18T02:43:07.148212Z","caller":"traceutil/trace.go:171","msg":"trace[1953357804] range","detail":"{range_begin:/registry/pods/kube-system/cilium-zbh2d; range_end:; response_count:1; response_revision:587; }","duration":"293.304955ms","start":"2026-02-18T02:43:06.854902Z","end":"2026-02-18T02:43:07.148207Z","steps":["trace[1953357804] 'agreement among raft nodes before linearized reading' (duration: 293.224953ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:43:07.148309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.691841ms","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-02-18T02:43:07.148327Z","caller":"traceutil/trace.go:171","msg":"trace[1223808851] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:587; }","duration":"398.740083ms","start":"2026-02-18T02:43:06.749583Z","end":"2026-02-18T02:43:07.148323Z","steps":["trace[1223808851] 'agreement among raft nodes before linearized reading' (duration: 398.693581ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:43:07.14834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T02:43:06.74955Z","time spent":"398.786174ms","remote":"127.0.0.1:60026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-18T02:43:07.148433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.59789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-02-18T02:43:07.148451Z","caller":"traceutil/trace.go:171","msg":"trace[1487558401] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:587; }","duration":"406.62963ms","start":"2026-02-18T02:43:06.741817Z","end":"2026-02-18T02:43:07.148447Z","steps":["trace[1487558401] 'agreement among raft nodes before linearized reading' (duration: 406.585549ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:43:07.148465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T02:43:06.741812Z","time spent":"406.647941ms","remote":"127.0.0.1:60026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-18T02:43:07.148538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.737944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-18T02:43:07.148554Z","caller":"traceutil/trace.go:171","msg":"trace[1911489286] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:587; }","duration":"406.782225ms","start":"2026-02-18T02:43:06.741768Z","end":"2026-02-18T02:43:07.148551Z","steps":["trace[1911489286] 'agreement among raft nodes before linearized reading' (duration: 406.744774ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:43:07.148587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T02:43:06.741753Z","time spent":"406.830536ms","remote":"127.0.0.1:60026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-18T02:43:07.513032Z","caller":"traceutil/trace.go:171","msg":"trace[757686052] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"103.832243ms","start":"2026-02-18T02:43:07.409178Z","end":"2026-02-18T02:43:07.51301Z","steps":["trace[757686052] 'process raft request' (duration: 44.918988ms)","trace[757686052] 'compare' (duration: 58.491522ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T02:43:13.797422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.538866ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T02:43:13.797479Z","caller":"traceutil/trace.go:171","msg":"trace[62325796] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:659; }","duration":"103.625689ms","start":"2026-02-18T02:43:13.693842Z","end":"2026-02-18T02:43:13.797468Z","steps":["trace[62325796] 'range keys from in-memory index tree' (duration: 103.478475ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T02:43:15.267059Z","caller":"traceutil/trace.go:171","msg":"trace[1815820990] transaction","detail":"{read_only:false; response_revision:670; number_of_response:1; }","duration":"267.216001ms","start":"2026-02-18T02:43:14.999813Z","end":"2026-02-18T02:43:15.267029Z","steps":["trace[1815820990] 'process raft request' (duration: 267.046816ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T02:43:15.328339Z","caller":"traceutil/trace.go:171","msg":"trace[419729497] linearizableReadLoop","detail":"{readStateIndex:696; appliedIndex:695; }","duration":"107.315305ms","start":"2026-02-18T02:43:15.221005Z","end":"2026-02-18T02:43:15.328321Z","steps":["trace[419729497] 'read index received' (duration: 46.700733ms)","trace[419729497] 'applied index is now lower than readState.Index' (duration: 60.613881ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T02:43:15.328427Z","caller":"traceutil/trace.go:171","msg":"trace[1264488596] transaction","detail":"{read_only:false; response_revision:671; number_of_response:1; }","duration":"328.351727ms","start":"2026-02-18T02:43:15.000068Z","end":"2026-02-18T02:43:15.32842Z","steps":["trace[1264488596] 'process raft request' (duration: 328.149962ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:43:15.328508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T02:43:15.000062Z","time spent":"328.384049ms","remote":"127.0.0.1:60042","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1291,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-18T02:43:15.328997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.997064ms","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-18T02:43:15.329027Z","caller":"traceutil/trace.go:171","msg":"trace[323655494] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:671; }","duration":"108.050236ms","start":"2026-02-18T02:43:15.220965Z","end":"2026-02-18T02:43:15.329015Z","steps":["trace[323655494] 'agreement among raft nodes before linearized reading' (duration: 107.988294ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T02:43:15.527916Z","caller":"traceutil/trace.go:171","msg":"trace[1298765711] transaction","detail":"{read_only:false; response_revision:675; number_of_response:1; }","duration":"167.999719ms","start":"2026-02-18T02:43:15.359877Z","end":"2026-02-18T02:43:15.527877Z","steps":["trace[1298765711] 'process raft request' (duration: 167.969558ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T02:43:15.528277Z","caller":"traceutil/trace.go:171","msg":"trace[534114151] transaction","detail":"{read_only:false; response_revision:672; number_of_response:1; }","duration":"169.643656ms","start":"2026-02-18T02:43:15.3586Z","end":"2026-02-18T02:43:15.528243Z","steps":["trace[534114151] 'process raft request' (duration: 76.427536ms)","trace[534114151] 'compare' (duration: 92.377075ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T02:43:15.528397Z","caller":"traceutil/trace.go:171","msg":"trace[1926035499] transaction","detail":"{read_only:false; response_revision:673; number_of_response:1; }","duration":"169.78582ms","start":"2026-02-18T02:43:15.358606Z","end":"2026-02-18T02:43:15.528392Z","steps":["trace[1926035499] 'process raft request' (duration: 169.149892ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T02:43:15.528657Z","caller":"traceutil/trace.go:171","msg":"trace[628496564] transaction","detail":"{read_only:false; response_revision:674; number_of_response:1; }","duration":"169.997626ms","start":"2026-02-18T02:43:15.35865Z","end":"2026-02-18T02:43:15.528648Z","steps":["trace[628496564] 'process raft request' (duration: 169.169023ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T02:43:15.594566Z","caller":"traceutil/trace.go:171","msg":"trace[1005021423] transaction","detail":"{read_only:false; response_revision:676; number_of_response:1; }","duration":"151.555386ms","start":"2026-02-18T02:43:15.442997Z","end":"2026-02-18T02:43:15.594552Z","steps":["trace[1005021423] 'process raft request' (duration: 151.295549ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T02:43:17.173997Z","caller":"traceutil/trace.go:171","msg":"trace[1963928418] transaction","detail":"{read_only:false; response_revision:701; number_of_response:1; }","duration":"209.257382ms","start":"2026-02-18T02:43:16.964723Z","end":"2026-02-18T02:43:17.173981Z","steps":["trace[1963928418] 'process raft request' (duration: 209.161139ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:43:23.479238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.161722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-18T02:43:23.479368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.415488ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T02:43:23.479402Z","caller":"traceutil/trace.go:171","msg":"trace[1998106301] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:731; }","duration":"317.417828ms","start":"2026-02-18T02:43:23.161957Z","end":"2026-02-18T02:43:23.479375Z","steps":["trace[1998106301] 'count revisions from in-memory index tree' (duration: 317.086559ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T02:43:23.479426Z","caller":"traceutil/trace.go:171","msg":"trace[1943244580] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:731; }","duration":"317.50149ms","start":"2026-02-18T02:43:23.16191Z","end":"2026-02-18T02:43:23.479411Z","steps":["trace[1943244580] 'range keys from in-memory index tree' (duration: 317.377767ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:43:23.47991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T02:43:23.161907Z","time spent":"317.993814ms","remote":"127.0.0.1:56684","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" limit:10000 "} {"level":"warn","ts":"2026-02-18T02:43:23.479885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T02:43:23.161954Z","time spent":"317.879781ms","remote":"127.0.0.1:56684","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true "} {"level":"warn","ts":"2026-02-18T02:43:23.479458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.590734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T02:43:23.48004Z","caller":"traceutil/trace.go:171","msg":"trace[1026489371] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:731; }","duration":"318.191999ms","start":"2026-02-18T02:43:23.161842Z","end":"2026-02-18T02:43:23.480034Z","steps":["trace[1026489371] 'range keys from in-memory index tree' (duration: 317.479701ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:43:23.480058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T02:43:23.161828Z","time spent":"318.223361ms","remote":"127.0.0.1:56684","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" limit:500 "} {"level":"info","ts":"2026-02-18T02:43:33.09609Z","caller":"traceutil/trace.go:171","msg":"trace[965035859] transaction","detail":"{read_only:false; response_revision:763; number_of_response:1; }","duration":"101.059417ms","start":"2026-02-18T02:43:32.994997Z","end":"2026-02-18T02:43:33.096056Z","steps":["trace[965035859] 'process raft request' (duration: 100.774209ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T02:44:16.817826Z","caller":"traceutil/trace.go:171","msg":"trace[1799389652] transaction","detail":"{read_only:false; response_revision:893; number_of_response:1; }","duration":"142.588092ms","start":"2026-02-18T02:44:16.675215Z","end":"2026-02-18T02:44:16.817803Z","steps":["trace[1799389652] 'process raft request' (duration: 53.265099ms)","trace[1799389652] 'compare' (duration: 89.003935ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T02:44:16.818077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.683097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/local-path-storage/\" range_end:\"/registry/resourcequotas/local-path-storage0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T02:44:16.818267Z","caller":"traceutil/trace.go:171","msg":"trace[573183528] range","detail":"{range_begin:/registry/resourcequotas/local-path-storage/; range_end:/registry/resourcequotas/local-path-storage0; response_count:0; response_revision:893; }","duration":"141.073017ms","start":"2026-02-18T02:44:16.67718Z","end":"2026-02-18T02:44:16.818253Z","steps":["trace[573183528] 'agreement among raft nodes before linearized reading' (duration: 140.650047ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T02:44:16.817826Z","caller":"traceutil/trace.go:171","msg":"trace[1202985996] linearizableReadLoop","detail":"{readStateIndex:931; appliedIndex:930; }","duration":"140.611146ms","start":"2026-02-18T02:44:16.677191Z","end":"2026-02-18T02:44:16.817802Z","steps":["trace[1202985996] 'read index received' (duration: 51.282653ms)","trace[1202985996] 'applied index is now lower than readState.Index' (duration: 89.327253ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T02:44:16.818856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.338717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T02:44:16.818969Z","caller":"traceutil/trace.go:171","msg":"trace[1597674263] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:893; }","duration":"123.498481ms","start":"2026-02-18T02:44:16.695456Z","end":"2026-02-18T02:44:16.818955Z","steps":["trace[1597674263] 'agreement among raft nodes before linearized reading' (duration: 123.368458ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T02:44:22.142117Z","caller":"traceutil/trace.go:171","msg":"trace[480228225] transaction","detail":"{read_only:false; response_revision:918; number_of_response:1; }","duration":"126.639354ms","start":"2026-02-18T02:44:22.015462Z","end":"2026-02-18T02:44:22.142102Z","steps":["trace[480228225] 'process raft request' (duration: 36.420019ms)","trace[480228225] 'compare' (duration: 89.872798ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T02:44:22.313986Z","caller":"traceutil/trace.go:171","msg":"trace[1313778660] transaction","detail":"{read_only:false; response_revision:919; number_of_response:1; }","duration":"165.60086ms","start":"2026-02-18T02:44:22.148365Z","end":"2026-02-18T02:44:22.313966Z","steps":["trace[1313778660] 'process raft request' (duration: 157.339292ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T02:44:22.314436Z","caller":"traceutil/trace.go:171","msg":"trace[440745709] linearizableReadLoop","detail":"{readStateIndex:959; appliedIndex:957; }","duration":"101.44992ms","start":"2026-02-18T02:44:22.212959Z","end":"2026-02-18T02:44:22.314409Z","steps":["trace[440745709] 'read index received' (duration: 92.757252ms)","trace[440745709] 'applied index is now lower than readState.Index' (duration: 8.691278ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T02:44:22.314938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.961281ms","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-18T02:44:22.315048Z","caller":"traceutil/trace.go:171","msg":"trace[1594161105] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:919; }","duration":"102.081674ms","start":"2026-02-18T02:44:22.212953Z","end":"2026-02-18T02:44:22.315035Z","steps":["trace[1594161105] 'agreement among raft nodes before linearized reading' (duration: 101.859029ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T02:44:22.469158Z","caller":"traceutil/trace.go:171","msg":"trace[1221036885] transaction","detail":"{read_only:false; response_revision:924; number_of_response:1; }","duration":"116.41062ms","start":"2026-02-18T02:44:22.352722Z","end":"2026-02-18T02:44:22.469133Z","steps":["trace[1221036885] 'process raft request' (duration: 116.360679ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T02:44:22.4696Z","caller":"traceutil/trace.go:171","msg":"trace[261972108] transaction","detail":"{read_only:false; response_revision:922; number_of_response:1; }","duration":"148.357898ms","start":"2026-02-18T02:44:22.321227Z","end":"2026-02-18T02:44:22.469585Z","steps":["trace[261972108] 'process raft request' (duration: 147.752873ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T02:44:22.47037Z","caller":"traceutil/trace.go:171","msg":"trace[208235434] transaction","detail":"{read_only:false; response_revision:921; number_of_response:1; }","duration":"150.218211ms","start":"2026-02-18T02:44:22.320128Z","end":"2026-02-18T02:44:22.470346Z","steps":["trace[208235434] 'process raft request' (duration: 123.026852ms)","trace[208235434] 'compare' (duration: 25.725615ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T02:44:22.47214Z","caller":"traceutil/trace.go:171","msg":"trace[828789244] transaction","detail":"{read_only:false; response_revision:923; number_of_response:1; }","duration":"149.489664ms","start":"2026-02-18T02:44:22.322638Z","end":"2026-02-18T02:44:22.472128Z","steps":["trace[828789244] 'process raft request' (duration: 146.406374ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T02:44:22.479157Z","caller":"traceutil/trace.go:171","msg":"trace[1461069972] transaction","detail":"{read_only:false; response_revision:925; number_of_response:1; }","duration":"121.981927ms","start":"2026-02-18T02:44:22.357168Z","end":"2026-02-18T02:44:22.47915Z","steps":["trace[1461069972] 'process raft request' (duration: 121.749482ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T02:44:22.479004Z","caller":"traceutil/trace.go:171","msg":"trace[1559972301] linearizableReadLoop","detail":"{readStateIndex:965; appliedIndex:960; }","duration":"110.928686ms","start":"2026-02-18T02:44:22.368066Z","end":"2026-02-18T02:44:22.478995Z","steps":["trace[1559972301] 'read index received' (duration: 75.0936ms)","trace[1559972301] 'applied index is now lower than readState.Index' (duration: 35.834506ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T02:44:22.480582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.555353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-02-18T02:44:22.480616Z","caller":"traceutil/trace.go:171","msg":"trace[630799521] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:925; }","duration":"105.614784ms","start":"2026-02-18T02:44:22.374994Z","end":"2026-02-18T02:44:22.480608Z","steps":["trace[630799521] 'agreement among raft nodes before linearized reading' (duration: 105.507892ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:44:22.481881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.811771ms","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-18T02:44:22.481914Z","caller":"traceutil/trace.go:171","msg":"trace[1509507842] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:925; }","duration":"113.867393ms","start":"2026-02-18T02:44:22.36804Z","end":"2026-02-18T02:44:22.481907Z","steps":["trace[1509507842] 'agreement among raft nodes before linearized reading' (duration: 113.794241ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:44:22.483258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.18273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-18T02:44:22.483291Z","caller":"traceutil/trace.go:171","msg":"trace[1273964761] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:925; }","duration":"107.227801ms","start":"2026-02-18T02:44:22.376056Z","end":"2026-02-18T02:44:22.483283Z","steps":["trace[1273964761] 'agreement among raft nodes before linearized reading' (duration: 107.160739ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T02:44:30.642137Z","caller":"traceutil/trace.go:171","msg":"trace[1210829082] linearizableReadLoop","detail":"{readStateIndex:999; appliedIndex:998; }","duration":"112.774605ms","start":"2026-02-18T02:44:30.529345Z","end":"2026-02-18T02:44:30.642119Z","steps":["trace[1210829082] 'read index received' (duration: 112.54282ms)","trace[1210829082] 'applied index is now lower than readState.Index' (duration: 230.665µs)"],"step_count":2} {"level":"info","ts":"2026-02-18T02:44:30.642579Z","caller":"traceutil/trace.go:171","msg":"trace[1995095009] transaction","detail":"{read_only:false; response_revision:957; number_of_response:1; }","duration":"116.960579ms","start":"2026-02-18T02:44:30.525583Z","end":"2026-02-18T02:44:30.642544Z","steps":["trace[1995095009] 'process raft request' (duration: 116.318475ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:44:30.642817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.302826ms","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-18T02:44:30.643072Z","caller":"traceutil/trace.go:171","msg":"trace[94314074] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:957; }","duration":"113.719515ms","start":"2026-02-18T02:44:30.529326Z","end":"2026-02-18T02:44:30.643046Z","steps":["trace[94314074] 'agreement among raft nodes before linearized reading' (duration: 113.238364ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T02:44:32.814489Z","caller":"traceutil/trace.go:171","msg":"trace[1550488903] transaction","detail":"{read_only:false; response_revision:965; number_of_response:1; }","duration":"105.87181ms","start":"2026-02-18T02:44:32.7086Z","end":"2026-02-18T02:44:32.814471Z","steps":["trace[1550488903] 'process raft request' (duration: 105.777048ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T02:44:32.820558Z","caller":"traceutil/trace.go:171","msg":"trace[619562500] transaction","detail":"{read_only:false; response_revision:968; number_of_response:1; }","duration":"106.153167ms","start":"2026-02-18T02:44:32.714394Z","end":"2026-02-18T02:44:32.820547Z","steps":["trace[619562500] 'process raft request' (duration: 106.135917ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T02:44:32.820681Z","caller":"traceutil/trace.go:171","msg":"trace[198429916] transaction","detail":"{read_only:false; response_revision:967; number_of_response:1; }","duration":"107.077909ms","start":"2026-02-18T02:44:32.713595Z","end":"2026-02-18T02:44:32.820673Z","steps":["trace[198429916] 'process raft request' (duration: 106.913635ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T02:44:32.820921Z","caller":"traceutil/trace.go:171","msg":"trace[57556975] transaction","detail":"{read_only:false; response_revision:966; number_of_response:1; }","duration":"111.833114ms","start":"2026-02-18T02:44:32.708744Z","end":"2026-02-18T02:44:32.820577Z","steps":["trace[57556975] 'process raft request' (duration: 111.713911ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T02:44:34.396727Z","caller":"traceutil/trace.go:171","msg":"trace[1416866860] transaction","detail":"{read_only:false; response_revision:972; number_of_response:1; }","duration":"155.158367ms","start":"2026-02-18T02:44:34.241542Z","end":"2026-02-18T02:44:34.3967Z","steps":["trace[1416866860] 'process raft request' (duration: 154.997424ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T02:44:34.985777Z","caller":"traceutil/trace.go:171","msg":"trace[784405948] transaction","detail":"{read_only:false; response_revision:977; number_of_response:1; }","duration":"124.944505ms","start":"2026-02-18T02:44:34.860809Z","end":"2026-02-18T02:44:34.985753Z","steps":["trace[784405948] 'process raft request' (duration: 85.452018ms)","trace[784405948] 'compare' (duration: 39.312533ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T02:44:34.98619Z","caller":"traceutil/trace.go:171","msg":"trace[794083950] transaction","detail":"{read_only:false; response_revision:978; number_of_response:1; }","duration":"123.545296ms","start":"2026-02-18T02:44:34.862636Z","end":"2026-02-18T02:44:34.986181Z","steps":["trace[794083950] 'process raft request' (duration: 123.073304ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T02:44:34.986431Z","caller":"traceutil/trace.go:171","msg":"trace[926632106] transaction","detail":"{read_only:false; response_revision:979; number_of_response:1; }","duration":"108.777357ms","start":"2026-02-18T02:44:34.877599Z","end":"2026-02-18T02:44:34.986377Z","steps":["trace[926632106] 'process raft request' (duration: 108.520641ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:44:57.277095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.083767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/local-path-storage/\" range_end:\"/registry/persistentvolumeclaims/local-path-storage0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T02:44:57.277172Z","caller":"traceutil/trace.go:171","msg":"trace[695834934] range","detail":"{range_begin:/registry/persistentvolumeclaims/local-path-storage/; range_end:/registry/persistentvolumeclaims/local-path-storage0; response_count:0; response_revision:1039; }","duration":"109.214879ms","start":"2026-02-18T02:44:57.167943Z","end":"2026-02-18T02:44:57.277158Z","steps":["trace[695834934] 'range keys from in-memory index tree' (duration: 108.996345ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:44:57.277641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.166824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-02-18T02:44:57.27771Z","caller":"traceutil/trace.go:171","msg":"trace[929399129] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1039; }","duration":"141.43315ms","start":"2026-02-18T02:44:57.136264Z","end":"2026-02-18T02:44:57.277697Z","steps":["trace[929399129] 'range keys from in-memory index tree' (duration: 141.036982ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T02:45:01.087761Z","caller":"traceutil/trace.go:171","msg":"trace[272152381] linearizableReadLoop","detail":"{readStateIndex:1096; appliedIndex:1095; }","duration":"118.603446ms","start":"2026-02-18T02:45:00.969138Z","end":"2026-02-18T02:45:01.087741Z","steps":["trace[272152381] 'read index received' (duration: 118.415572ms)","trace[272152381] 'applied index is now lower than readState.Index' (duration: 187.104µs)"],"step_count":2} {"level":"info","ts":"2026-02-18T02:45:01.088186Z","caller":"traceutil/trace.go:171","msg":"trace[1379822324] transaction","detail":"{read_only:false; response_revision:1048; number_of_response:1; }","duration":"135.819973ms","start":"2026-02-18T02:45:00.952353Z","end":"2026-02-18T02:45:01.088173Z","steps":["trace[1379822324] 'process raft request' (duration: 135.246131ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:45:01.088492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.343322ms","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-18T02:45:01.088625Z","caller":"traceutil/trace.go:171","msg":"trace[1257392841] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:1048; }","duration":"119.515086ms","start":"2026-02-18T02:45:00.969097Z","end":"2026-02-18T02:45:01.088612Z","steps":["trace[1257392841] 'agreement among raft nodes before linearized reading' (duration: 119.343862ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:45:01.088951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.001493ms","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-02-18T02:45:01.089083Z","caller":"traceutil/trace.go:171","msg":"trace[1473391364] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:1048; }","duration":"103.163286ms","start":"2026-02-18T02:45:00.985907Z","end":"2026-02-18T02:45:01.08907Z","steps":["trace[1473391364] 'agreement among raft nodes before linearized reading' (duration: 102.963352ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T02:45:03.353089Z","caller":"traceutil/trace.go:171","msg":"trace[784364199] linearizableReadLoop","detail":"{readStateIndex:1102; appliedIndex:1101; }","duration":"200.359948ms","start":"2026-02-18T02:45:03.152708Z","end":"2026-02-18T02:45:03.353068Z","steps":["trace[784364199] 'read index received' (duration: 200.209855ms)","trace[784364199] 'applied index is now lower than readState.Index' (duration: 149.113µs)"],"step_count":2} {"level":"info","ts":"2026-02-18T02:45:03.353224Z","caller":"traceutil/trace.go:171","msg":"trace[809213698] transaction","detail":"{read_only:false; response_revision:1054; number_of_response:1; }","duration":"215.372547ms","start":"2026-02-18T02:45:03.13784Z","end":"2026-02-18T02:45:03.353213Z","steps":["trace[809213698] 'process raft request' (duration: 215.087701ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:45:03.353588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.855448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-02-18T02:45:03.353633Z","caller":"traceutil/trace.go:171","msg":"trace[1584756900] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1054; }","duration":"200.921459ms","start":"2026-02-18T02:45:03.1527Z","end":"2026-02-18T02:45:03.353622Z","steps":["trace[1584756900] 'agreement among raft nodes before linearized reading' (duration: 200.745756ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:45:03.353818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.956502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" ","response":"range_response_count:1 size:185"} {"level":"info","ts":"2026-02-18T02:45:03.353854Z","caller":"traceutil/trace.go:171","msg":"trace[784383830] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/kube-proxy; range_end:; response_count:1; response_revision:1054; }","duration":"171.036144ms","start":"2026-02-18T02:45:03.182809Z","end":"2026-02-18T02:45:03.353845Z","steps":["trace[784383830] 'agreement among raft nodes before linearized reading' (duration: 170.973253ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T02:45:03.354124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.57256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-02-18T02:45:03.354164Z","caller":"traceutil/trace.go:171","msg":"trace[1097327017] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:1054; }","duration":"134.6372ms","start":"2026-02-18T02:45:03.219516Z","end":"2026-02-18T02:45:03.354153Z","steps":["trace[1097327017] 'agreement among raft nodes before linearized reading' (duration: 134.580179ms)"],"step_count":1}