{"level":"warn","ts":"2026-02-19T05:53:34.603512Z","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-19T05:53:34.603593Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.65:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.65:2380","--initial-cluster=instance=https://199.204.45.65:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.65:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.65: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-19T05:53:34.603654Z","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-19T05:53:34.603661Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.65:2380"]} {"level":"info","ts":"2026-02-19T05:53:34.603677Z","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-19T05:53:34.604269Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.65:2379"]} {"level":"info","ts":"2026-02-19T05:53:34.604396Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.65:2380"],"listen-peer-urls":["https://199.204.45.65:2380"],"advertise-client-urls":["https://199.204.45.65:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.65:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.65: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-19T05:53:34.637169Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"32.536338ms"} {"level":"info","ts":"2026-02-19T05:53:34.758133Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"cf8c3a138c9a77a2","cluster-id":"c278183e1f634dff"} {"level":"info","ts":"2026-02-19T05:53:34.75825Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 switched to configuration voters=()"} {"level":"info","ts":"2026-02-19T05:53:34.758273Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became follower at term 0"} {"level":"info","ts":"2026-02-19T05:53:34.758286Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft cf8c3a138c9a77a2 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-19T05:53:34.758296Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became follower at term 1"} {"level":"info","ts":"2026-02-19T05:53:34.758331Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 switched to configuration voters=(14955392318228297634)"} {"level":"warn","ts":"2026-02-19T05:53:34.838792Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-19T05:53:34.842458Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-19T05:53:34.912544Z","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-19T05:53:34.990047Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"cf8c3a138c9a77a2","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-19T05:53:34.990371Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"cf8c3a138c9a77a2","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-19T05:53:34.990397Z","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-19T05:53:34.990617Z","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-19T05:53:34.990658Z","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-19T05:53:34.996026Z","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-19T05:53:34.996165Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.65:2380"} {"level":"info","ts":"2026-02-19T05:53:34.996288Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.65:2380"} {"level":"info","ts":"2026-02-19T05:53:34.997806Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-19T05:53:34.997781Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"cf8c3a138c9a77a2","initial-advertise-peer-urls":["https://199.204.45.65:2380"],"listen-peer-urls":["https://199.204.45.65:2380"],"advertise-client-urls":["https://199.204.45.65:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.65:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-19T05:53:35.017127Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 switched to configuration voters=(14955392318228297634)"} {"level":"info","ts":"2026-02-19T05:53:35.017385Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c278183e1f634dff","local-member-id":"cf8c3a138c9a77a2","added-peer-id":"cf8c3a138c9a77a2","added-peer-peer-urls":["https://199.204.45.65:2380"]} {"level":"info","ts":"2026-02-19T05:53:35.759223Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 is starting a new election at term 1"} {"level":"info","ts":"2026-02-19T05:53:35.759294Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-19T05:53:35.759323Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 received MsgPreVoteResp from cf8c3a138c9a77a2 at term 1"} {"level":"info","ts":"2026-02-19T05:53:35.759337Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became candidate at term 2"} {"level":"info","ts":"2026-02-19T05:53:35.759345Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 received MsgVoteResp from cf8c3a138c9a77a2 at term 2"} {"level":"info","ts":"2026-02-19T05:53:35.759361Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became leader at term 2"} {"level":"info","ts":"2026-02-19T05:53:35.759373Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: cf8c3a138c9a77a2 elected leader cf8c3a138c9a77a2 at term 2"} {"level":"info","ts":"2026-02-19T05:53:35.763274Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-19T05:53:35.763268Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-19T05:53:35.763399Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-19T05:53:35.763607Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-19T05:53:35.763744Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-19T05:53:35.764229Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c278183e1f634dff","local-member-id":"cf8c3a138c9a77a2","cluster-version":"3.5"} {"level":"info","ts":"2026-02-19T05:53:35.764356Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-19T05:53:35.76441Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-19T05:53:35.765606Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.65:2379"} {"level":"info","ts":"2026-02-19T05:53:35.766224Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-19T05:53:35.771939Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"cf8c3a138c9a77a2","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.65:2379]}","request-path":"/0/members/cf8c3a138c9a77a2/attributes","cluster-id":"c278183e1f634dff","publish-timeout":"7s"} {"level":"warn","ts":"2026-02-19T05:54:03.343493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.322833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cilium\" ","response":"range_response_count:1 size:520"} {"level":"info","ts":"2026-02-19T05:54:03.343623Z","caller":"traceutil/trace.go:171","msg":"trace[604507769] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cilium; range_end:; response_count:1; response_revision:459; }","duration":"106.527335ms","start":"2026-02-19T05:54:03.237074Z","end":"2026-02-19T05:54:03.343601Z","steps":["trace[604507769] 'range keys from in-memory index tree' (duration: 106.174242ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:54:03.343766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.00441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cilium-operator\" ","response":"range_response_count:1 size:538"} {"level":"warn","ts":"2026-02-19T05:54:03.343845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.91517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:4 size:329932"} {"level":"info","ts":"2026-02-19T05:54:03.343891Z","caller":"traceutil/trace.go:171","msg":"trace[1782680466] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cilium-operator; range_end:; response_count:1; response_revision:459; }","duration":"107.197452ms","start":"2026-02-19T05:54:03.23667Z","end":"2026-02-19T05:54:03.343868Z","steps":["trace[1782680466] 'range keys from in-memory index tree' (duration: 106.716927ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:54:03.343946Z","caller":"traceutil/trace.go:171","msg":"trace[812134303] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:459; }","duration":"189.074282ms","start":"2026-02-19T05:54:03.154846Z","end":"2026-02-19T05:54:03.34392Z","steps":["trace[812134303] 'range keys from in-memory index tree' (duration: 188.394025ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:54:06.019548Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8620624660750019097,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-19T05:54:06.095489Z","caller":"traceutil/trace.go:171","msg":"trace[902190141] linearizableReadLoop","detail":"{readStateIndex:485; appliedIndex:484; }","duration":"576.585243ms","start":"2026-02-19T05:54:05.518873Z","end":"2026-02-19T05:54:06.095458Z","steps":["trace[902190141] 'read index received' (duration: 576.368551ms)","trace[902190141] 'applied index is now lower than readState.Index' (duration: 215.332µs)"],"step_count":2} {"level":"info","ts":"2026-02-19T05:54:06.095585Z","caller":"traceutil/trace.go:171","msg":"trace[196499031] transaction","detail":"{read_only:false; response_revision:466; number_of_response:1; }","duration":"621.81654ms","start":"2026-02-19T05:54:05.473737Z","end":"2026-02-19T05:54:06.095554Z","steps":["trace[196499031] 'process raft request' (duration: 621.541668ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:54:06.09567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"576.791974ms","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-19T05:54:06.095714Z","caller":"traceutil/trace.go:171","msg":"trace[241332469] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:466; }","duration":"576.911796ms","start":"2026-02-19T05:54:05.51879Z","end":"2026-02-19T05:54:06.095701Z","steps":["trace[241332469] 'agreement among raft nodes before linearized reading' (duration: 576.815955ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:54:06.095756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:54:05.518757Z","time spent":"576.991246ms","remote":"127.0.0.1:34530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-19T05:54:06.095841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.904726ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T05:54:06.095894Z","caller":"traceutil/trace.go:171","msg":"trace[1172459541] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:466; }","duration":"183.993747ms","start":"2026-02-19T05:54:05.911877Z","end":"2026-02-19T05:54:06.095871Z","steps":["trace[1172459541] 'agreement among raft nodes before linearized reading' (duration: 183.922937ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:54:06.095899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.954243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-02-19T05:54:06.095956Z","caller":"traceutil/trace.go:171","msg":"trace[581263904] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:466; }","duration":"156.063764ms","start":"2026-02-19T05:54:05.939877Z","end":"2026-02-19T05:54:06.09594Z","steps":["trace[581263904] 'agreement among raft nodes before linearized reading' (duration: 155.954203ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:54:06.095944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"461.440103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-19T05:54:06.09604Z","caller":"traceutil/trace.go:171","msg":"trace[218370032] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:466; }","duration":"461.595264ms","start":"2026-02-19T05:54:05.634423Z","end":"2026-02-19T05:54:06.096018Z","steps":["trace[218370032] 'agreement among raft nodes before linearized reading' (duration: 461.394342ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:54:06.096083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:54:05.634398Z","time spent":"461.677245ms","remote":"127.0.0.1:34530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-19T05:54:06.096285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:54:05.473721Z","time spent":"621.949133ms","remote":"127.0.0.1:34454","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4212,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T05:54:06.09618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"513.23851ms","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-19T05:54:06.09783Z","caller":"traceutil/trace.go:171","msg":"trace[1415803544] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:466; }","duration":"514.991617ms","start":"2026-02-19T05:54:05.582814Z","end":"2026-02-19T05:54:06.097805Z","steps":["trace[1415803544] 'agreement among raft nodes before linearized reading' (duration: 512.984529ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:54:06.098497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:54:05.582784Z","time spent":"515.696483ms","remote":"127.0.0.1:34530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-19T05:54:06.259061Z","caller":"traceutil/trace.go:171","msg":"trace[1778702900] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"156.0907ms","start":"2026-02-19T05:54:06.102945Z","end":"2026-02-19T05:54:06.259035Z","steps":["trace[1778702900] 'process raft request' (duration: 156.04901ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:54:06.259082Z","caller":"traceutil/trace.go:171","msg":"trace[415405170] transaction","detail":"{read_only:false; response_revision:468; number_of_response:1; }","duration":"158.608273ms","start":"2026-02-19T05:54:06.100438Z","end":"2026-02-19T05:54:06.259047Z","steps":["trace[415405170] 'process raft request' (duration: 158.407842ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:54:06.259363Z","caller":"traceutil/trace.go:171","msg":"trace[227651829] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"157.868126ms","start":"2026-02-19T05:54:06.101484Z","end":"2026-02-19T05:54:06.259352Z","steps":["trace[227651829] 'process raft request' (duration: 157.469623ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:54:08.464202Z","caller":"traceutil/trace.go:171","msg":"trace[1960802349] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"197.998084ms","start":"2026-02-19T05:54:08.26617Z","end":"2026-02-19T05:54:08.464168Z","steps":["trace[1960802349] 'process raft request' (duration: 197.845523ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:54:08.464734Z","caller":"traceutil/trace.go:171","msg":"trace[176074020] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"197.308008ms","start":"2026-02-19T05:54:08.267393Z","end":"2026-02-19T05:54:08.464701Z","steps":["trace[176074020] 'process raft request' (duration: 197.270508ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:54:08.465031Z","caller":"traceutil/trace.go:171","msg":"trace[1864416850] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"198.105565ms","start":"2026-02-19T05:54:08.266919Z","end":"2026-02-19T05:54:08.465025Z","steps":["trace[1864416850] 'process raft request' (duration: 197.652411ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:54:12.814302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.486354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-02-19T05:54:12.814447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.254762ms","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-19T05:54:12.814487Z","caller":"traceutil/trace.go:171","msg":"trace[655669014] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:504; }","duration":"326.732747ms","start":"2026-02-19T05:54:12.487733Z","end":"2026-02-19T05:54:12.814466Z","steps":["trace[655669014] 'range keys from in-memory index tree' (duration: 326.372104ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:54:12.814519Z","caller":"traceutil/trace.go:171","msg":"trace[698299801] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:504; }","duration":"327.370453ms","start":"2026-02-19T05:54:12.487127Z","end":"2026-02-19T05:54:12.814497Z","steps":["trace[698299801] 'range keys from in-memory index tree' (duration: 327.07711ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:54:12.814538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:54:12.487714Z","time spent":"326.812748ms","remote":"127.0.0.1:34530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-19T05:54:12.81456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:54:12.487107Z","time spent":"327.444483ms","remote":"127.0.0.1:34530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-19T05:54:12.814315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.045618ms","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-19T05:54:12.814724Z","caller":"traceutil/trace.go:171","msg":"trace[1999568342] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:504; }","duration":"329.499081ms","start":"2026-02-19T05:54:12.485202Z","end":"2026-02-19T05:54:12.814701Z","steps":["trace[1999568342] 'range keys from in-memory index tree' (duration: 328.924026ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:54:12.81496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:54:12.485185Z","time spent":"329.591202ms","remote":"127.0.0.1:34530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-19T05:54:13.585986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.4203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-2sm7z\" ","response":"range_response_count:1 size:16652"} {"level":"info","ts":"2026-02-19T05:54:13.586093Z","caller":"traceutil/trace.go:171","msg":"trace[462694241] range","detail":"{range_begin:/registry/pods/kube-system/cilium-2sm7z; range_end:; response_count:1; response_revision:510; }","duration":"289.587932ms","start":"2026-02-19T05:54:13.296478Z","end":"2026-02-19T05:54:13.586066Z","steps":["trace[462694241] 'range keys from in-memory index tree' (duration: 289.207789ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:54:14.158228Z","caller":"traceutil/trace.go:171","msg":"trace[2118602424] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"556.218498ms","start":"2026-02-19T05:54:13.601985Z","end":"2026-02-19T05:54:14.158203Z","steps":["trace[2118602424] 'process raft request' (duration: 556.025866ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:54:14.158401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:54:13.601958Z","time spent":"556.33539ms","remote":"127.0.0.1:34466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16799,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T05:54:14.904869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"734.282253ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-02-19T05:54:14.904959Z","caller":"traceutil/trace.go:171","msg":"trace[869626065] linearizableReadLoop","detail":"{readStateIndex:532; appliedIndex:531; }","duration":"684.529537ms","start":"2026-02-19T05:54:14.220413Z","end":"2026-02-19T05:54:14.904943Z","steps":["trace[869626065] 'read index received' (duration: 53.8µs)","trace[869626065] 'applied index is now lower than readState.Index' (duration: 684.474357ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T05:54:14.905087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"684.675389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-19T05:54:14.905114Z","caller":"traceutil/trace.go:171","msg":"trace[394008041] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:511; }","duration":"684.740709ms","start":"2026-02-19T05:54:14.220366Z","end":"2026-02-19T05:54:14.905106Z","steps":["trace[394008041] 'agreement among raft nodes before linearized reading' (duration: 684.663838ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:54:14.905144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:54:14.220349Z","time spent":"684.788229ms","remote":"127.0.0.1:34530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-19T05:54:15.111864Z","caller":"traceutil/trace.go:171","msg":"trace[1641830768] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"202.70527ms","start":"2026-02-19T05:54:14.909116Z","end":"2026-02-19T05:54:15.111821Z","steps":["trace[1641830768] 'process raft request' (duration: 202.523719ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:54:15.408647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.697557ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-19T05:54:15.408845Z","caller":"traceutil/trace.go:171","msg":"trace[1421037812] linearizableReadLoop","detail":"{readStateIndex:536; appliedIndex:532; }","duration":"496.804044ms","start":"2026-02-19T05:54:14.912025Z","end":"2026-02-19T05:54:15.408829Z","steps":["trace[1421037812] 'read index received' (duration: 199.714875ms)","trace[1421037812] 'applied index is now lower than readState.Index' (duration: 297.088149ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T05:54:15.408924Z","caller":"traceutil/trace.go:171","msg":"trace[187055774] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"499.665738ms","start":"2026-02-19T05:54:14.909244Z","end":"2026-02-19T05:54:15.408909Z","steps":["trace[187055774] 'process raft request' (duration: 384.612638ms)","trace[187055774] 'compare' (duration: 114.589506ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T05:54:15.408945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"496.915835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T05:54:15.408912Z","caller":"traceutil/trace.go:171","msg":"trace[1993921225] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"499.452367ms","start":"2026-02-19T05:54:14.909439Z","end":"2026-02-19T05:54:15.408891Z","steps":["trace[1993921225] 'process raft request' (duration: 499.345636ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:54:15.408976Z","caller":"traceutil/trace.go:171","msg":"trace[455165845] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:515; }","duration":"496.970595ms","start":"2026-02-19T05:54:14.911995Z","end":"2026-02-19T05:54:15.408966Z","steps":["trace[455165845] 'agreement among raft nodes before linearized reading' (duration: 496.890165ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:54:15.409038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:54:14.909231Z","time spent":"499.733559ms","remote":"127.0.0.1:34530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T05:54:15.409071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:54:14.909431Z","time spent":"499.543227ms","remote":"127.0.0.1:34530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T05:54:15.409054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:54:14.911985Z","time spent":"497.016796ms","remote":"127.0.0.1:34260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-19T05:54:15.409147Z","caller":"traceutil/trace.go:171","msg":"trace[218004840] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"499.83572ms","start":"2026-02-19T05:54:14.9093Z","end":"2026-02-19T05:54:15.409136Z","steps":["trace[218004840] 'process raft request' (duration: 499.437766ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:54:15.409226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:54:14.909294Z","time spent":"499.87398ms","remote":"127.0.0.1:34530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T05:54:17.297876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.384081605s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T05:54:17.297961Z","caller":"traceutil/trace.go:171","msg":"trace[896055183] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:515; }","duration":"1.384223656s","start":"2026-02-19T05:54:15.91372Z","end":"2026-02-19T05:54:17.297943Z","steps":["trace[896055183] 'range keys from in-memory index tree' (duration: 1.383971354s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:54:17.298007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:54:15.9137Z","time spent":"1.384298457s","remote":"127.0.0.1:34260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-19T05:54:17.298686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.795871ms","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-19T05:54:17.298722Z","caller":"traceutil/trace.go:171","msg":"trace[43536216] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:515; }","duration":"182.864272ms","start":"2026-02-19T05:54:17.115848Z","end":"2026-02-19T05:54:17.298712Z","steps":["trace[43536216] 'range keys from in-memory index tree' (duration: 181.734172ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:54:19.895912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.892126ms","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-19T05:54:19.895991Z","caller":"traceutil/trace.go:171","msg":"trace[700438928] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:530; }","duration":"420.015476ms","start":"2026-02-19T05:54:19.475957Z","end":"2026-02-19T05:54:19.895972Z","steps":["trace[700438928] 'range keys from in-memory index tree' (duration: 419.787924ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:54:19.896031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:54:19.475936Z","time spent":"420.085737ms","remote":"127.0.0.1:34530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-19T05:54:19.896021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.735999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-02-19T05:54:19.896089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.942621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-02-19T05:54:19.896158Z","caller":"traceutil/trace.go:171","msg":"trace[1106827568] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:530; }","duration":"416.955641ms","start":"2026-02-19T05:54:19.479177Z","end":"2026-02-19T05:54:19.896132Z","steps":["trace[1106827568] 'range keys from in-memory index tree' (duration: 416.584558ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:54:19.896172Z","caller":"traceutil/trace.go:171","msg":"trace[1555088507] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:530; }","duration":"417.053222ms","start":"2026-02-19T05:54:19.479098Z","end":"2026-02-19T05:54:19.896152Z","steps":["trace[1555088507] 'range keys from in-memory index tree' (duration: 416.760169ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:54:19.89623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:54:19.479088Z","time spent":"417.122702ms","remote":"127.0.0.1:34530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-19T05:54:19.896229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:54:19.479155Z","time spent":"417.058181ms","remote":"127.0.0.1:34530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-19T05:55:40.856678Z","caller":"traceutil/trace.go:171","msg":"trace[367525913] transaction","detail":"{read_only:false; response_revision:937; number_of_response:1; }","duration":"130.522147ms","start":"2026-02-19T05:55:40.726127Z","end":"2026-02-19T05:55:40.856649Z","steps":["trace[367525913] 'process raft request' (duration: 130.357864ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:55:42.310675Z","caller":"traceutil/trace.go:171","msg":"trace[2005860129] linearizableReadLoop","detail":"{readStateIndex:980; appliedIndex:979; }","duration":"396.795995ms","start":"2026-02-19T05:55:41.913854Z","end":"2026-02-19T05:55:42.31065Z","steps":["trace[2005860129] 'read index received' (duration: 396.731474ms)","trace[2005860129] 'applied index is now lower than readState.Index' (duration: 63.401µs)"],"step_count":2} {"level":"info","ts":"2026-02-19T05:55:42.310784Z","caller":"traceutil/trace.go:171","msg":"trace[666832083] transaction","detail":"{read_only:false; response_revision:938; number_of_response:1; }","duration":"498.182463ms","start":"2026-02-19T05:55:41.812567Z","end":"2026-02-19T05:55:42.31075Z","steps":["trace[666832083] 'process raft request' (duration: 497.917269ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:55:42.310815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.940048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T05:55:42.310869Z","caller":"traceutil/trace.go:171","msg":"trace[1499880672] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:938; }","duration":"397.041839ms","start":"2026-02-19T05:55:41.913813Z","end":"2026-02-19T05:55:42.310855Z","steps":["trace[1499880672] 'agreement among raft nodes before linearized reading' (duration: 396.945057ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:55:42.310905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:55:41.812541Z","time spent":"498.301275ms","remote":"127.0.0.1:34530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T05:55:42.310914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:55:41.913765Z","time spent":"397.137621ms","remote":"127.0.0.1:34260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-19T05:55:42.418899Z","caller":"traceutil/trace.go:171","msg":"trace[1390497953] transaction","detail":"{read_only:false; response_revision:939; number_of_response:1; }","duration":"200.009613ms","start":"2026-02-19T05:55:42.218847Z","end":"2026-02-19T05:55:42.418857Z","steps":["trace[1390497953] 'process raft request' (duration: 193.36987ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:55:42.419327Z","caller":"traceutil/trace.go:171","msg":"trace[1511056324] linearizableReadLoop","detail":"{readStateIndex:982; appliedIndex:980; }","duration":"107.368641ms","start":"2026-02-19T05:55:42.311946Z","end":"2026-02-19T05:55:42.419315Z","steps":["trace[1511056324] 'read index received' (duration: 100.1943ms)","trace[1511056324] 'applied index is now lower than readState.Index' (duration: 7.173121ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T05:55:42.419482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.527044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T05:55:42.419519Z","caller":"traceutil/trace.go:171","msg":"trace[1115372718] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:940; }","duration":"107.591255ms","start":"2026-02-19T05:55:42.311918Z","end":"2026-02-19T05:55:42.419509Z","steps":["trace[1115372718] 'agreement among raft nodes before linearized reading' (duration: 107.455992ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:55:42.41951Z","caller":"traceutil/trace.go:171","msg":"trace[1634590483] transaction","detail":"{read_only:false; response_revision:940; number_of_response:1; }","duration":"141.881828ms","start":"2026-02-19T05:55:42.277595Z","end":"2026-02-19T05:55:42.419477Z","steps":["trace[1634590483] 'process raft request' (duration: 141.197497ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:55:58.795547Z","caller":"traceutil/trace.go:171","msg":"trace[1032867718] linearizableReadLoop","detail":"{readStateIndex:1034; appliedIndex:1033; }","duration":"141.751008ms","start":"2026-02-19T05:55:58.65377Z","end":"2026-02-19T05:55:58.79552Z","steps":["trace[1032867718] 'read index received' (duration: 141.619766ms)","trace[1032867718] 'applied index is now lower than readState.Index' (duration: 129.902µs)"],"step_count":2} {"level":"warn","ts":"2026-02-19T05:55:58.795839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.271734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/kube-public/\" range_end:\"/registry/cronjobs/kube-public0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T05:55:58.795893Z","caller":"traceutil/trace.go:171","msg":"trace[1173557850] range","detail":"{range_begin:/registry/cronjobs/kube-public/; range_end:/registry/cronjobs/kube-public0; response_count:0; response_revision:987; }","duration":"118.362935ms","start":"2026-02-19T05:55:58.677517Z","end":"2026-02-19T05:55:58.79588Z","steps":["trace[1173557850] 'agreement among raft nodes before linearized reading' (duration: 118.265054ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:55:58.795869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.709612ms","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-19T05:55:58.795959Z","caller":"traceutil/trace.go:171","msg":"trace[1102958572] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:987; }","duration":"128.843534ms","start":"2026-02-19T05:55:58.667092Z","end":"2026-02-19T05:55:58.795936Z","steps":["trace[1102958572] 'agreement among raft nodes before linearized reading' (duration: 128.59057ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:55:58.796054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.601991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-02-19T05:55:58.796096Z","caller":"traceutil/trace.go:171","msg":"trace[413989779] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:987; }","duration":"121.687102ms","start":"2026-02-19T05:55:58.674395Z","end":"2026-02-19T05:55:58.796082Z","steps":["trace[413989779] 'agreement among raft nodes before linearized reading' (duration: 121.55705ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:55:58.796227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.165379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-02-19T05:55:58.796247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.482968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/default/kubernetes\" ","response":"range_response_count:1 size:704"} {"level":"info","ts":"2026-02-19T05:55:58.796254Z","caller":"traceutil/trace.go:171","msg":"trace[105036864] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:987; }","duration":"122.223599ms","start":"2026-02-19T05:55:58.674023Z","end":"2026-02-19T05:55:58.796247Z","steps":["trace[105036864] 'agreement among raft nodes before linearized reading' (duration: 122.146658ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:55:58.796269Z","caller":"traceutil/trace.go:171","msg":"trace[1405602365] range","detail":"{range_begin:/registry/services/specs/default/kubernetes; range_end:; response_count:1; response_revision:987; }","duration":"142.53404ms","start":"2026-02-19T05:55:58.653729Z","end":"2026-02-19T05:55:58.796263Z","steps":["trace[1405602365] 'agreement among raft nodes before linearized reading' (duration: 141.926241ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:55:58.906164Z","caller":"traceutil/trace.go:171","msg":"trace[5751418] transaction","detail":"{read_only:false; response_revision:988; number_of_response:1; }","duration":"109.695162ms","start":"2026-02-19T05:55:58.796446Z","end":"2026-02-19T05:55:58.906141Z","steps":["trace[5751418] 'process raft request' (duration: 73.01485ms)","trace[5751418] 'compare' (duration: 36.56812ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T05:55:58.945972Z","caller":"traceutil/trace.go:171","msg":"trace[503573301] transaction","detail":"{read_only:false; response_revision:989; number_of_response:1; }","duration":"146.404275ms","start":"2026-02-19T05:55:58.799548Z","end":"2026-02-19T05:55:58.945952Z","steps":["trace[503573301] 'process raft request' (duration: 146.202502ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:55:58.945984Z","caller":"traceutil/trace.go:171","msg":"trace[1825603454] transaction","detail":"{read_only:false; response_revision:990; number_of_response:1; }","duration":"146.07891ms","start":"2026-02-19T05:55:58.799886Z","end":"2026-02-19T05:55:58.945965Z","steps":["trace[1825603454] 'process raft request' (duration: 145.994099ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:55:58.94613Z","caller":"traceutil/trace.go:171","msg":"trace[1452405272] transaction","detail":"{read_only:false; response_revision:991; number_of_response:1; }","duration":"145.683214ms","start":"2026-02-19T05:55:58.800441Z","end":"2026-02-19T05:55:58.946124Z","steps":["trace[1452405272] 'process raft request' (duration: 145.465701ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:55:59.511909Z","caller":"traceutil/trace.go:171","msg":"trace[1885300432] linearizableReadLoop","detail":"{readStateIndex:1040; appliedIndex:1039; }","duration":"158.286322ms","start":"2026-02-19T05:55:59.353597Z","end":"2026-02-19T05:55:59.511883Z","steps":["trace[1885300432] 'read index received' (duration: 158.16088ms)","trace[1885300432] 'applied index is now lower than readState.Index' (duration: 124.522µs)"],"step_count":2} {"level":"warn","ts":"2026-02-19T05:55:59.512144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.530116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/coredns\" ","response":"range_response_count:1 size:612"} {"level":"info","ts":"2026-02-19T05:55:59.512182Z","caller":"traceutil/trace.go:171","msg":"trace[330152775] range","detail":"{range_begin:/registry/configmaps/kube-system/coredns; range_end:; response_count:1; response_revision:993; }","duration":"158.613487ms","start":"2026-02-19T05:55:59.353558Z","end":"2026-02-19T05:55:59.512171Z","steps":["trace[330152775] 'agreement among raft nodes before linearized reading' (duration: 158.454654ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:55:59.512163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.244869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-public/\" range_end:\"/registry/pods/kube-public0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-19T05:55:59.512204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.798844ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" ","response":"range_response_count:1 size:3017"} {"level":"info","ts":"2026-02-19T05:55:59.512244Z","caller":"traceutil/trace.go:171","msg":"trace[655579713] range","detail":"{range_begin:/registry/pods/kube-public/; range_end:/registry/pods/kube-public0; response_count:0; response_revision:993; }","duration":"155.35561ms","start":"2026-02-19T05:55:59.356869Z","end":"2026-02-19T05:55:59.512225Z","steps":["trace[655579713] 'agreement among raft nodes before linearized reading' (duration: 155.176718ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:55:59.512292Z","caller":"traceutil/trace.go:171","msg":"trace[755662857] range","detail":"{range_begin:/registry/configmaps/kube-system/extension-apiserver-authentication; range_end:; response_count:1; response_revision:993; }","duration":"123.899685ms","start":"2026-02-19T05:55:59.388363Z","end":"2026-02-19T05:55:59.512262Z","steps":["trace[755662857] 'agreement among raft nodes before linearized reading' (duration: 123.742523ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:55:59.511951Z","caller":"traceutil/trace.go:171","msg":"trace[1734716288] transaction","detail":"{read_only:false; response_revision:993; number_of_response:1; }","duration":"185.892933ms","start":"2026-02-19T05:55:59.326026Z","end":"2026-02-19T05:55:59.511919Z","steps":["trace[1734716288] 'process raft request' (duration: 185.69971ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:55:59.512406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.833576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/\" range_end:\"/registry/deployments/kube-system0\" limit:500 ","response":"range_response_count:2 size:8877"} {"level":"info","ts":"2026-02-19T05:55:59.512505Z","caller":"traceutil/trace.go:171","msg":"trace[1551393346] range","detail":"{range_begin:/registry/deployments/kube-system/; range_end:/registry/deployments/kube-system0; response_count:2; response_revision:993; }","duration":"150.952608ms","start":"2026-02-19T05:55:59.361522Z","end":"2026-02-19T05:55:59.512475Z","steps":["trace[1551393346] 'agreement among raft nodes before linearized reading' (duration: 150.671254ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:56:00.982299Z","caller":"traceutil/trace.go:171","msg":"trace[2127665095] linearizableReadLoop","detail":"{readStateIndex:1041; appliedIndex:1040; }","duration":"449.024339ms","start":"2026-02-19T05:56:00.533251Z","end":"2026-02-19T05:56:00.982276Z","steps":["trace[2127665095] 'read index received' (duration: 448.812076ms)","trace[2127665095] 'applied index is now lower than readState.Index' (duration: 211.292µs)"],"step_count":2} {"level":"info","ts":"2026-02-19T05:56:00.98235Z","caller":"traceutil/trace.go:171","msg":"trace[1956205218] transaction","detail":"{read_only:false; response_revision:994; number_of_response:1; }","duration":"457.959644ms","start":"2026-02-19T05:56:00.524361Z","end":"2026-02-19T05:56:00.982321Z","steps":["trace[1956205218] 'process raft request' (duration: 457.774242ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:56:00.982479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:56:00.524352Z","time spent":"458.057355ms","remote":"127.0.0.1:34530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T05:56:00.982584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.71871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-02-19T05:56:00.982582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.543138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-public/system:controller:bootstrap-signer\" ","response":"range_response_count:1 size:741"} {"level":"info","ts":"2026-02-19T05:56:00.982646Z","caller":"traceutil/trace.go:171","msg":"trace[1557768909] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:994; }","duration":"171.818431ms","start":"2026-02-19T05:56:00.810812Z","end":"2026-02-19T05:56:00.98263Z","steps":["trace[1557768909] 'agreement among raft nodes before linearized reading' (duration: 171.70364ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:56:00.98269Z","caller":"traceutil/trace.go:171","msg":"trace[48012105] range","detail":"{range_begin:/registry/rolebindings/kube-public/system:controller:bootstrap-signer; range_end:; response_count:1; response_revision:994; }","duration":"396.66075ms","start":"2026-02-19T05:56:00.586012Z","end":"2026-02-19T05:56:00.982673Z","steps":["trace[48012105] 'agreement among raft nodes before linearized reading' (duration: 396.498078ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:56:00.982711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.431404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/\" range_end:\"/registry/serviceaccounts/kube-system0\" limit:500 ","response":"range_response_count:37 size:8042"} {"level":"warn","ts":"2026-02-19T05:56:00.982725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:56:00.585966Z","time spent":"396.751062ms","remote":"127.0.0.1:34628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":765,"request content":"key:\"/registry/rolebindings/kube-public/system:controller:bootstrap-signer\" "} {"level":"info","ts":"2026-02-19T05:56:00.982767Z","caller":"traceutil/trace.go:171","msg":"trace[978516855] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/; range_end:/registry/serviceaccounts/kube-system0; response_count:37; response_revision:994; }","duration":"449.529035ms","start":"2026-02-19T05:56:00.533222Z","end":"2026-02-19T05:56:00.982751Z","steps":["trace[978516855] 'agreement among raft nodes before linearized reading' (duration: 449.17236ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:56:00.982843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.534096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-public/kubeadm:bootstrap-signer-clusterinfo\" ","response":"range_response_count:1 size:496"} {"level":"warn","ts":"2026-02-19T05:56:00.982858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:56:00.533208Z","time spent":"449.632186ms","remote":"127.0.0.1:34488","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":37,"response size":8066,"request content":"key:\"/registry/serviceaccounts/kube-system/\" range_end:\"/registry/serviceaccounts/kube-system0\" limit:500 "} {"level":"info","ts":"2026-02-19T05:56:00.982906Z","caller":"traceutil/trace.go:171","msg":"trace[1008949874] range","detail":"{range_begin:/registry/rolebindings/kube-public/kubeadm:bootstrap-signer-clusterinfo; range_end:; response_count:1; response_revision:994; }","duration":"415.630087ms","start":"2026-02-19T05:56:00.567262Z","end":"2026-02-19T05:56:00.982892Z","steps":["trace[1008949874] 'agreement among raft nodes before linearized reading' (duration: 415.544386ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:56:00.982931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:56:00.567244Z","time spent":"415.680519ms","remote":"127.0.0.1:34628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":1,"response size":520,"request content":"key:\"/registry/rolebindings/kube-public/kubeadm:bootstrap-signer-clusterinfo\" "} {"level":"warn","ts":"2026-02-19T05:56:00.983303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.997964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/kube-system/\" range_end:\"/registry/services/specs/kube-system0\" limit:500 ","response":"range_response_count:1 size:1211"} {"level":"info","ts":"2026-02-19T05:56:00.983332Z","caller":"traceutil/trace.go:171","msg":"trace[581718075] range","detail":"{range_begin:/registry/services/specs/kube-system/; range_end:/registry/services/specs/kube-system0; response_count:1; response_revision:994; }","duration":"431.060175ms","start":"2026-02-19T05:56:00.552262Z","end":"2026-02-19T05:56:00.983322Z","steps":["trace[581718075] 'agreement among raft nodes before linearized reading' (duration: 430.192563ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:56:00.983355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:56:00.552243Z","time spent":"431.103336ms","remote":"127.0.0.1:34476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":1,"response size":1235,"request content":"key:\"/registry/services/specs/kube-system/\" range_end:\"/registry/services/specs/kube-system0\" limit:500 "}