{"level":"warn","ts":"2026-02-17T18:16:37.355718Z","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-17T18:16:37.355956Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.27: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.27:2380","--initial-cluster=instance=https://199.19.213.27:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.27:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.27: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-17T18:16:37.356115Z","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-17T18:16:37.356182Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.27:2380"]} {"level":"info","ts":"2026-02-17T18:16:37.356264Z","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-17T18:16:37.357003Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.27:2379"]} {"level":"info","ts":"2026-02-17T18:16:37.35717Z","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.27:2380"],"listen-peer-urls":["https://199.19.213.27:2380"],"advertise-client-urls":["https://199.19.213.27:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.27:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.27: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-17T18:16:37.379254Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"21.510703ms"} {"level":"info","ts":"2026-02-17T18:16:37.38582Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d0494904b1be7692","cluster-id":"7c10a1b21fbd6dff"} {"level":"info","ts":"2026-02-17T18:16:37.385868Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0494904b1be7692 switched to configuration voters=()"} {"level":"info","ts":"2026-02-17T18:16:37.385884Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0494904b1be7692 became follower at term 0"} {"level":"info","ts":"2026-02-17T18:16:37.385893Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d0494904b1be7692 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-17T18:16:37.38592Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0494904b1be7692 became follower at term 1"} {"level":"info","ts":"2026-02-17T18:16:37.385948Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0494904b1be7692 switched to configuration voters=(15008607517699634834)"} {"level":"warn","ts":"2026-02-17T18:16:37.396721Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-17T18:16:37.401077Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-17T18:16:37.40604Z","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-17T18:16:37.41106Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d0494904b1be7692","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-17T18:16:37.412148Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d0494904b1be7692","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-17T18:16:37.412363Z","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-17T18:16:37.412445Z","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-17T18:16:37.412506Z","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-17T18:16:37.415651Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0494904b1be7692 switched to configuration voters=(15008607517699634834)"} {"level":"info","ts":"2026-02-17T18:16:37.423677Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"7c10a1b21fbd6dff","local-member-id":"d0494904b1be7692","added-peer-id":"d0494904b1be7692","added-peer-peer-urls":["https://199.19.213.27:2380"]} {"level":"info","ts":"2026-02-17T18:16:37.43193Z","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-17T18:16:37.432028Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.27:2380"} {"level":"info","ts":"2026-02-17T18:16:37.432047Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.27:2380"} {"level":"info","ts":"2026-02-17T18:16:37.43225Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d0494904b1be7692","initial-advertise-peer-urls":["https://199.19.213.27:2380"],"listen-peer-urls":["https://199.19.213.27:2380"],"advertise-client-urls":["https://199.19.213.27:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.27:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-17T18:16:37.432322Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-17T18:16:37.789364Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0494904b1be7692 is starting a new election at term 1"} {"level":"info","ts":"2026-02-17T18:16:37.789481Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0494904b1be7692 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-17T18:16:37.78958Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0494904b1be7692 received MsgPreVoteResp from d0494904b1be7692 at term 1"} {"level":"info","ts":"2026-02-17T18:16:37.789597Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0494904b1be7692 became candidate at term 2"} {"level":"info","ts":"2026-02-17T18:16:37.789634Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0494904b1be7692 received MsgVoteResp from d0494904b1be7692 at term 2"} {"level":"info","ts":"2026-02-17T18:16:37.789647Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0494904b1be7692 became leader at term 2"} {"level":"info","ts":"2026-02-17T18:16:37.789688Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d0494904b1be7692 elected leader d0494904b1be7692 at term 2"} {"level":"info","ts":"2026-02-17T18:16:37.790681Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T18:16:37.79168Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d0494904b1be7692","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.27:2379]}","request-path":"/0/members/d0494904b1be7692/attributes","cluster-id":"7c10a1b21fbd6dff","publish-timeout":"7s"} {"level":"info","ts":"2026-02-17T18:16:37.791835Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-17T18:16:37.792149Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-17T18:16:37.805945Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-17T18:16:37.807112Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"7c10a1b21fbd6dff","local-member-id":"d0494904b1be7692","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T18:16:37.809087Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T18:16:37.80911Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T18:16:37.811871Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.27:2379"} {"level":"info","ts":"2026-02-17T18:16:37.813147Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-17T18:16:37.813179Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-17T18:16:43.122092Z","caller":"traceutil/trace.go:171","msg":"trace[1143054839] transaction","detail":"{read_only:false; response_revision:236; number_of_response:1; }","duration":"149.262507ms","start":"2026-02-17T18:16:42.972805Z","end":"2026-02-17T18:16:43.122068Z","steps":["trace[1143054839] 'process raft request' (duration: 149.212985ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T18:16:43.122681Z","caller":"traceutil/trace.go:171","msg":"trace[2046913279] transaction","detail":"{read_only:false; response_revision:235; number_of_response:1; }","duration":"168.647273ms","start":"2026-02-17T18:16:42.954022Z","end":"2026-02-17T18:16:43.122669Z","steps":["trace[2046913279] 'process raft request' (duration: 159.608616ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T18:16:43.123046Z","caller":"traceutil/trace.go:171","msg":"trace[788389964] linearizableReadLoop","detail":"{readStateIndex:241; appliedIndex:240; }","duration":"156.454501ms","start":"2026-02-17T18:16:42.966564Z","end":"2026-02-17T18:16:43.123018Z","steps":["trace[788389964] 'read index received' (duration: 147.087911ms)","trace[788389964] 'applied index is now lower than readState.Index' (duration: 9.365459ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T18:16:43.123456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.663184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-02-17T18:16:43.124274Z","caller":"traceutil/trace.go:171","msg":"trace[1552885120] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:236; }","duration":"197.495548ms","start":"2026-02-17T18:16:42.926752Z","end":"2026-02-17T18:16:43.124248Z","steps":["trace[1552885120] 'agreement among raft nodes before linearized reading' (duration: 196.600082ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T18:16:43.306478Z","caller":"traceutil/trace.go:171","msg":"trace[1598075999] linearizableReadLoop","detail":"{readStateIndex:244; appliedIndex:243; }","duration":"141.299864ms","start":"2026-02-17T18:16:43.16515Z","end":"2026-02-17T18:16:43.30645Z","steps":["trace[1598075999] 'read index received' (duration: 72.91192ms)","trace[1598075999] 'applied index is now lower than readState.Index' (duration: 68.385844ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T18:16:43.306907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.726782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T18:16:43.306971Z","caller":"traceutil/trace.go:171","msg":"trace[470639660] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:0; response_revision:238; }","duration":"141.833706ms","start":"2026-02-17T18:16:43.165124Z","end":"2026-02-17T18:16:43.306958Z","steps":["trace[470639660] 'agreement among raft nodes before linearized reading' (duration: 141.523734ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T18:16:43.308149Z","caller":"traceutil/trace.go:171","msg":"trace[1604236936] transaction","detail":"{read_only:false; response_revision:238; number_of_response:1; }","duration":"178.172791ms","start":"2026-02-17T18:16:43.129955Z","end":"2026-02-17T18:16:43.308128Z","steps":["trace[1604236936] 'process raft request' (duration: 108.058166ms)","trace[1604236936] 'compare' (duration: 68.174316ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T18:16:51.903848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.939069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T18:16:51.904005Z","caller":"traceutil/trace.go:171","msg":"trace[910823695] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:367; }","duration":"179.141966ms","start":"2026-02-17T18:16:51.724814Z","end":"2026-02-17T18:16:51.903956Z","steps":["trace[910823695] 'range keys from in-memory index tree' (duration: 178.851456ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T18:16:51.904211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.009895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6894"} {"level":"info","ts":"2026-02-17T18:16:51.904443Z","caller":"traceutil/trace.go:171","msg":"trace[288950742] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:367; }","duration":"145.293956ms","start":"2026-02-17T18:16:51.759131Z","end":"2026-02-17T18:16:51.904425Z","steps":["trace[288950742] 'range keys from in-memory index tree' (duration: 144.834709ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T18:17:11.401009Z","caller":"traceutil/trace.go:171","msg":"trace[610810515] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"161.67063ms","start":"2026-02-17T18:17:11.239301Z","end":"2026-02-17T18:17:11.400972Z","steps":["trace[610810515] 'process raft request' (duration: 161.281308ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T18:17:11.770211Z","caller":"traceutil/trace.go:171","msg":"trace[427383100] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"317.735257ms","start":"2026-02-17T18:17:11.45239Z","end":"2026-02-17T18:17:11.770126Z","steps":["trace[427383100] 'process raft request' (duration: 314.527705ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T18:17:11.772232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T18:17:11.452375Z","time spent":"317.880531ms","remote":"127.0.0.1:38544","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4309,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T18:17:11.773Z","caller":"traceutil/trace.go:171","msg":"trace[1199701285] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"315.015889ms","start":"2026-02-17T18:17:11.457975Z","end":"2026-02-17T18:17:11.772991Z","steps":["trace[1199701285] 'process raft request' (duration: 314.899916ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T18:17:11.77308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T18:17:11.457964Z","time spent":"315.090371ms","remote":"127.0.0.1:38544","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":24229,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T18:17:11.769964Z","caller":"traceutil/trace.go:171","msg":"trace[485798009] linearizableReadLoop","detail":"{readStateIndex:540; appliedIndex:539; }","duration":"314.270567ms","start":"2026-02-17T18:17:11.455678Z","end":"2026-02-17T18:17:11.769949Z","steps":["trace[485798009] 'read index received' (duration: 311.24806ms)","trace[485798009] 'applied index is now lower than readState.Index' (duration: 3.021887ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T18:17:11.792444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.627461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T18:17:11.792485Z","caller":"traceutil/trace.go:171","msg":"trace[1878267011] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:523; }","duration":"191.701273ms","start":"2026-02-17T18:17:11.600772Z","end":"2026-02-17T18:17:11.792473Z","steps":["trace[1878267011] 'agreement among raft nodes before linearized reading' (duration: 191.630891ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T18:17:11.792718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.038531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-02-17T18:17:11.792741Z","caller":"traceutil/trace.go:171","msg":"trace[1615340895] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:523; }","duration":"337.081893ms","start":"2026-02-17T18:17:11.455653Z","end":"2026-02-17T18:17:11.792735Z","steps":["trace[1615340895] 'agreement among raft nodes before linearized reading' (duration: 336.647001ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T18:17:11.792759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T18:17:11.455643Z","time spent":"337.111233ms","remote":"127.0.0.1:38534","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" "} {"level":"info","ts":"2026-02-17T18:17:15.09795Z","caller":"traceutil/trace.go:171","msg":"trace[1655651121] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"444.352851ms","start":"2026-02-17T18:17:14.653582Z","end":"2026-02-17T18:17:15.097935Z","steps":["trace[1655651121] 'process raft request' (duration: 444.105694ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T18:17:15.098208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T18:17:14.653566Z","time spent":"444.432523ms","remote":"127.0.0.1:38544","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":188480,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T18:17:15.098548Z","caller":"traceutil/trace.go:171","msg":"trace[1128672904] linearizableReadLoop","detail":"{readStateIndex:582; appliedIndex:582; }","duration":"140.331778ms","start":"2026-02-17T18:17:14.958209Z","end":"2026-02-17T18:17:15.09854Z","steps":["trace[1128672904] 'read index received' (duration: 140.329268ms)","trace[1128672904] 'applied index is now lower than readState.Index' (duration: 2.04µs)"],"step_count":2} {"level":"warn","ts":"2026-02-17T18:17:15.101677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.473254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" ","response":"range_response_count:1 size:188495"} {"level":"info","ts":"2026-02-17T18:17:15.101713Z","caller":"traceutil/trace.go:171","msg":"trace[1671148159] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:1; response_revision:564; }","duration":"143.570217ms","start":"2026-02-17T18:17:14.958131Z","end":"2026-02-17T18:17:15.101701Z","steps":["trace[1671148159] 'agreement among raft nodes before linearized reading' (duration: 140.438201ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T18:17:20.790641Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8544063434261073920,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T18:17:21.291395Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8544063434261073920,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T18:17:21.79197Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8544063434261073920,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T18:17:22.292802Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8544063434261073920,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T18:17:22.793109Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8544063434261073920,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T18:17:23.002415Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.810219528s","expected-duration":"1s"} {"level":"info","ts":"2026-02-17T18:17:23.002788Z","caller":"traceutil/trace.go:171","msg":"trace[2032933270] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"2.810651319s","start":"2026-02-17T18:17:20.192116Z","end":"2026-02-17T18:17:23.002767Z","steps":["trace[2032933270] 'process raft request' (duration: 2.810536376s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T18:17:23.00289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T18:17:20.192105Z","time spent":"2.81071985s","remote":"127.0.0.1:38776","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T18:17:23.138688Z","caller":"traceutil/trace.go:171","msg":"trace[2060652870] linearizableReadLoop","detail":"{readStateIndex:600; appliedIndex:599; }","duration":"2.848254518s","start":"2026-02-17T18:17:20.290412Z","end":"2026-02-17T18:17:23.138666Z","steps":["trace[2060652870] 'read index received' (duration: 2.712882382s)","trace[2060652870] 'applied index is now lower than readState.Index' (duration: 135.371406ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T18:17:23.1388Z","caller":"traceutil/trace.go:171","msg":"trace[1347938553] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"1.989305291s","start":"2026-02-17T18:17:21.149484Z","end":"2026-02-17T18:17:23.13879Z","steps":["trace[1347938553] 'process raft request' (duration: 1.923805168s)","trace[1347938553] 'compare' (duration: 65.225586ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T18:17:23.13891Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T18:17:21.149467Z","time spent":"1.989358852s","remote":"127.0.0.1:38776","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-17T18:17:23.139003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.560563186s","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-17T18:17:23.139046Z","caller":"traceutil/trace.go:171","msg":"trace[64676080] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:581; }","duration":"2.560645828s","start":"2026-02-17T18:17:20.578389Z","end":"2026-02-17T18:17:23.139035Z","steps":["trace[64676080] 'agreement among raft nodes before linearized reading' (duration: 2.560527305s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T18:17:23.139068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T18:17:20.578373Z","time spent":"2.560689869s","remote":"127.0.0.1:38776","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":"warn","ts":"2026-02-17T18:17:23.139165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.84875707s","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-17T18:17:23.139181Z","caller":"traceutil/trace.go:171","msg":"trace[209309527] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:581; }","duration":"2.848831941s","start":"2026-02-17T18:17:20.290343Z","end":"2026-02-17T18:17:23.139175Z","steps":["trace[209309527] 'agreement among raft nodes before linearized reading' (duration: 2.84879108s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T18:17:23.139195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T18:17:20.290327Z","time spent":"2.848864563s","remote":"127.0.0.1:38776","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-17T18:17:23.139334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.558821049s","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-17T18:17:23.139364Z","caller":"traceutil/trace.go:171","msg":"trace[107498603] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:581; }","duration":"2.558866871s","start":"2026-02-17T18:17:20.58049Z","end":"2026-02-17T18:17:23.139357Z","steps":["trace[107498603] 'agreement among raft nodes before linearized reading' (duration: 2.558769518s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T18:17:23.139403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T18:17:20.580484Z","time spent":"2.558914032s","remote":"127.0.0.1:38776","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-17T18:17:23.139455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.814577519s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.27\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-02-17T18:17:23.139472Z","caller":"traceutil/trace.go:171","msg":"trace[2061125282] range","detail":"{range_begin:/registry/masterleases/199.19.213.27; range_end:; response_count:1; response_revision:581; }","duration":"1.81461774s","start":"2026-02-17T18:17:21.324849Z","end":"2026-02-17T18:17:23.139466Z","steps":["trace[2061125282] 'agreement among raft nodes before linearized reading' (duration: 1.814574569s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T18:17:23.139341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.560255726s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-02-17T18:17:23.139485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T18:17:21.324836Z","time spent":"1.814645851s","remote":"127.0.0.1:38534","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.27\" "} {"level":"info","ts":"2026-02-17T18:17:23.139494Z","caller":"traceutil/trace.go:171","msg":"trace[1001230767] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:581; }","duration":"2.560418831s","start":"2026-02-17T18:17:20.579069Z","end":"2026-02-17T18:17:23.139487Z","steps":["trace[1001230767] 'agreement among raft nodes before linearized reading' (duration: 2.560233466s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T18:17:23.139512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T18:17:20.579062Z","time spent":"2.560444801s","remote":"127.0.0.1:38776","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-17T18:17:23.139581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.322056007s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T18:17:23.139596Z","caller":"traceutil/trace.go:171","msg":"trace[1774932249] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:581; }","duration":"1.322087288s","start":"2026-02-17T18:17:21.817503Z","end":"2026-02-17T18:17:23.13959Z","steps":["trace[1774932249] 'agreement among raft nodes before linearized reading' (duration: 1.322064098s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T18:17:23.139613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T18:17:21.817491Z","time spent":"1.322119969s","remote":"127.0.0.1:38496","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-17T18:17:23.359761Z","caller":"traceutil/trace.go:171","msg":"trace[1614156431] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"213.686161ms","start":"2026-02-17T18:17:23.146052Z","end":"2026-02-17T18:17:23.359739Z","steps":["trace[1614156431] 'process raft request' (duration: 213.623579ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T18:17:23.360948Z","caller":"traceutil/trace.go:171","msg":"trace[869048671] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"217.377764ms","start":"2026-02-17T18:17:23.14356Z","end":"2026-02-17T18:17:23.360937Z","steps":["trace[869048671] 'process raft request' (duration: 215.870556ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T18:17:23.361056Z","caller":"traceutil/trace.go:171","msg":"trace[532005059] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"217.405833ms","start":"2026-02-17T18:17:23.143644Z","end":"2026-02-17T18:17:23.36105Z","steps":["trace[532005059] 'process raft request' (duration: 215.938597ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T18:17:23.361127Z","caller":"traceutil/trace.go:171","msg":"trace[1055770742] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"215.170497ms","start":"2026-02-17T18:17:23.145952Z","end":"2026-02-17T18:17:23.361122Z","steps":["trace[1055770742] 'process raft request' (duration: 213.69426ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T18:17:23.362703Z","caller":"traceutil/trace.go:171","msg":"trace[441822997] linearizableReadLoop","detail":"{readStateIndex:606; appliedIndex:605; }","duration":"180.811405ms","start":"2026-02-17T18:17:23.181871Z","end":"2026-02-17T18:17:23.362682Z","steps":["trace[441822997] 'read index received' (duration: 179.536713ms)","trace[441822997] 'applied index is now lower than readState.Index' (duration: 1.273932ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T18:17:23.362807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.907467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T18:17:23.362838Z","caller":"traceutil/trace.go:171","msg":"trace[1135088364] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:586; }","duration":"180.98392ms","start":"2026-02-17T18:17:23.181848Z","end":"2026-02-17T18:17:23.362832Z","steps":["trace[1135088364] 'agreement among raft nodes before linearized reading' (duration: 180.893108ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T18:17:23.363006Z","caller":"traceutil/trace.go:171","msg":"trace[1430509308] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"185.687438ms","start":"2026-02-17T18:17:23.177313Z","end":"2026-02-17T18:17:23.363Z","steps":["trace[1430509308] 'process raft request' (duration: 185.277718ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T18:17:43.597983Z","caller":"traceutil/trace.go:171","msg":"trace[1590251565] linearizableReadLoop","detail":"{readStateIndex:764; appliedIndex:763; }","duration":"146.358142ms","start":"2026-02-17T18:17:43.451583Z","end":"2026-02-17T18:17:43.597941Z","steps":["trace[1590251565] 'read index received' (duration: 146.104807ms)","trace[1590251565] 'applied index is now lower than readState.Index' (duration: 252.535µs)"],"step_count":2} {"level":"warn","ts":"2026-02-17T18:17:43.598471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.869663ms","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-17T18:17:43.598516Z","caller":"traceutil/trace.go:171","msg":"trace[288470806] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:739; }","duration":"146.934364ms","start":"2026-02-17T18:17:43.451569Z","end":"2026-02-17T18:17:43.598504Z","steps":["trace[288470806] 'agreement among raft nodes before linearized reading' (duration: 146.833532ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T18:17:43.598636Z","caller":"traceutil/trace.go:171","msg":"trace[176647082] transaction","detail":"{read_only:false; response_revision:739; number_of_response:1; }","duration":"153.05138ms","start":"2026-02-17T18:17:43.445566Z","end":"2026-02-17T18:17:43.598618Z","steps":["trace[176647082] 'process raft request' (duration: 152.211222ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T18:17:43.599008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.396264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-17T18:17:43.599048Z","caller":"traceutil/trace.go:171","msg":"trace[1595139470] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:739; }","duration":"116.458035ms","start":"2026-02-17T18:17:43.482581Z","end":"2026-02-17T18:17:43.599039Z","steps":["trace[1595139470] 'agreement among raft nodes before linearized reading' (duration: 116.367233ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T18:17:43.599877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.450418ms","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-17T18:17:43.599912Z","caller":"traceutil/trace.go:171","msg":"trace[757274330] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:739; }","duration":"123.50763ms","start":"2026-02-17T18:17:43.476396Z","end":"2026-02-17T18:17:43.599903Z","steps":["trace[757274330] 'agreement among raft nodes before linearized reading' (duration: 121.928717ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T18:18:46.622568Z","caller":"traceutil/trace.go:171","msg":"trace[1066379011] transaction","detail":"{read_only:false; response_revision:963; number_of_response:1; }","duration":"118.0035ms","start":"2026-02-17T18:18:46.504537Z","end":"2026-02-17T18:18:46.622541Z","steps":["trace[1066379011] 'process raft request' (duration: 117.821708ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T18:18:46.863916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.91233ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-17T18:18:46.863997Z","caller":"traceutil/trace.go:171","msg":"trace[1932393062] linearizableReadLoop","detail":"{readStateIndex:1003; appliedIndex:1002; }","duration":"117.005627ms","start":"2026-02-17T18:18:46.746978Z","end":"2026-02-17T18:18:46.863984Z","steps":["trace[1932393062] 'read index received' (duration: 28.02µs)","trace[1932393062] 'applied index is now lower than readState.Index' (duration: 116.976477ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T18:18:46.864182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.194399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T18:18:46.864206Z","caller":"traceutil/trace.go:171","msg":"trace[112435328] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:963; }","duration":"117.251431ms","start":"2026-02-17T18:18:46.746948Z","end":"2026-02-17T18:18:46.8642Z","steps":["trace[112435328] 'agreement among raft nodes before linearized reading' (duration: 117.067219ms)"],"step_count":1}