{"level":"warn","ts":"2026-02-18T19:49:12.174521Z","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-18T19:49:12.174625Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.209: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://162.253.55.209:2380","--initial-cluster=instance=https://162.253.55.209:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.209:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.209: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-18T19:49:12.174712Z","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-18T19:49:12.174724Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.209:2380"]} {"level":"info","ts":"2026-02-18T19:49:12.174742Z","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-18T19:49:12.175393Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.209:2379"]} {"level":"info","ts":"2026-02-18T19:49:12.175476Z","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://162.253.55.209:2380"],"listen-peer-urls":["https://162.253.55.209:2380"],"advertise-client-urls":["https://162.253.55.209:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.209:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.209: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-18T19:49:12.180949Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.219539ms"} {"level":"info","ts":"2026-02-18T19:49:12.189202Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"53de2bdd9aa7b793","cluster-id":"385802231390d48c"} {"level":"info","ts":"2026-02-18T19:49:12.189264Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 switched to configuration voters=()"} {"level":"info","ts":"2026-02-18T19:49:12.189289Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 became follower at term 0"} {"level":"info","ts":"2026-02-18T19:49:12.189306Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 53de2bdd9aa7b793 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-18T19:49:12.189318Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 became follower at term 1"} {"level":"info","ts":"2026-02-18T19:49:12.189355Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 switched to configuration voters=(6043315980760233875)"} {"level":"warn","ts":"2026-02-18T19:49:12.198796Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-18T19:49:12.208746Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-18T19:49:12.217435Z","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-18T19:49:12.231229Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"53de2bdd9aa7b793","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-18T19:49:12.231608Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"53de2bdd9aa7b793","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-18T19:49:12.231721Z","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-18T19:49:12.23175Z","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-18T19:49:12.231757Z","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-18T19:49:12.232569Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 switched to configuration voters=(6043315980760233875)"} {"level":"info","ts":"2026-02-18T19:49:12.232773Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"385802231390d48c","local-member-id":"53de2bdd9aa7b793","added-peer-id":"53de2bdd9aa7b793","added-peer-peer-urls":["https://162.253.55.209:2380"]} {"level":"info","ts":"2026-02-18T19:49:12.244386Z","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-18T19:49:12.244565Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"53de2bdd9aa7b793","initial-advertise-peer-urls":["https://162.253.55.209:2380"],"listen-peer-urls":["https://162.253.55.209:2380"],"advertise-client-urls":["https://162.253.55.209:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.209:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-18T19:49:12.244587Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-18T19:49:12.244675Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.209:2380"} {"level":"info","ts":"2026-02-18T19:49:12.244685Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.209:2380"} {"level":"info","ts":"2026-02-18T19:49:12.889605Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 is starting a new election at term 1"} {"level":"info","ts":"2026-02-18T19:49:12.889641Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-18T19:49:12.889664Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 received MsgPreVoteResp from 53de2bdd9aa7b793 at term 1"} {"level":"info","ts":"2026-02-18T19:49:12.889676Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 became candidate at term 2"} {"level":"info","ts":"2026-02-18T19:49:12.889681Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 received MsgVoteResp from 53de2bdd9aa7b793 at term 2"} {"level":"info","ts":"2026-02-18T19:49:12.889689Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 became leader at term 2"} {"level":"info","ts":"2026-02-18T19:49:12.889696Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 53de2bdd9aa7b793 elected leader 53de2bdd9aa7b793 at term 2"} {"level":"info","ts":"2026-02-18T19:49:12.891992Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-18T19:49:12.894522Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"53de2bdd9aa7b793","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.209:2379]}","request-path":"/0/members/53de2bdd9aa7b793/attributes","cluster-id":"385802231390d48c","publish-timeout":"7s"} {"level":"info","ts":"2026-02-18T19:49:12.895006Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-18T19:49:12.895282Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"385802231390d48c","local-member-id":"53de2bdd9aa7b793","cluster-version":"3.5"} {"level":"info","ts":"2026-02-18T19:49:12.895335Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-18T19:49:12.895352Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-18T19:49:12.896074Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-18T19:49:12.896085Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-18T19:49:12.896091Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-18T19:49:12.896829Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.209:2379"} {"level":"info","ts":"2026-02-18T19:49:12.907064Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-18T19:49:42.408079Z","caller":"traceutil/trace.go:171","msg":"trace[1465022356] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"177.730481ms","start":"2026-02-18T19:49:42.230326Z","end":"2026-02-18T19:49:42.408056Z","steps":["trace[1465022356] 'process raft request' (duration: 177.622228ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:49:49.132978Z","caller":"traceutil/trace.go:171","msg":"trace[1411814830] linearizableReadLoop","detail":"{readStateIndex:509; appliedIndex:508; }","duration":"449.127521ms","start":"2026-02-18T19:49:48.683812Z","end":"2026-02-18T19:49:49.13294Z","steps":["trace[1411814830] 'read index received' (duration: 448.855264ms)","trace[1411814830] 'applied index is now lower than readState.Index' (duration: 271.127µs)"],"step_count":2} {"level":"info","ts":"2026-02-18T19:49:49.133123Z","caller":"traceutil/trace.go:171","msg":"trace[1245235723] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"451.536955ms","start":"2026-02-18T19:49:48.681572Z","end":"2026-02-18T19:49:49.133109Z","steps":["trace[1245235723] 'process raft request' (duration: 451.153635ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:49.133381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.358341ms","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-18T19:49:49.133557Z","caller":"traceutil/trace.go:171","msg":"trace[278252466] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:496; }","duration":"425.586148ms","start":"2026-02-18T19:49:48.707952Z","end":"2026-02-18T19:49:49.133538Z","steps":["trace[278252466] 'agreement among raft nodes before linearized reading' (duration: 425.26845ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:49.133601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:48.707943Z","time spent":"425.645239ms","remote":"127.0.0.1:60002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-18T19:49:49.133678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:48.681559Z","time spent":"451.598376ms","remote":"127.0.0.1:60002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-18T19:49:49.133822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.005494ms","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-18T19:49:49.133852Z","caller":"traceutil/trace.go:171","msg":"trace[1652005272] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:496; }","duration":"450.054025ms","start":"2026-02-18T19:49:48.68379Z","end":"2026-02-18T19:49:49.133844Z","steps":["trace[1652005272] 'agreement among raft nodes before linearized reading' (duration: 449.969203ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:49.1339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:48.683782Z","time spent":"450.111986ms","remote":"127.0.0.1:60002","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-18T19:49:49.133987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.286412ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T19:49:49.134024Z","caller":"traceutil/trace.go:171","msg":"trace[1993974584] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:496; }","duration":"227.349144ms","start":"2026-02-18T19:49:48.906664Z","end":"2026-02-18T19:49:49.134013Z","steps":["trace[1993974584] 'agreement among raft nodes before linearized reading' (duration: 227.293502ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:49.134059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.621649ms","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-18T19:49:49.134086Z","caller":"traceutil/trace.go:171","msg":"trace[1963392317] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:496; }","duration":"408.67281ms","start":"2026-02-18T19:49:48.725405Z","end":"2026-02-18T19:49:49.134078Z","steps":["trace[1963392317] 'agreement among raft nodes before linearized reading' (duration: 408.599108ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:49.134112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:48.725395Z","time spent":"408.710731ms","remote":"127.0.0.1:60002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-18T19:49:49.263523Z","caller":"traceutil/trace.go:171","msg":"trace[1609710377] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"112.502076ms","start":"2026-02-18T19:49:49.150995Z","end":"2026-02-18T19:49:49.263497Z","steps":["trace[1609710377] 'process raft request' (duration: 112.466345ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:49:49.263768Z","caller":"traceutil/trace.go:171","msg":"trace[1358864196] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"120.656282ms","start":"2026-02-18T19:49:49.143105Z","end":"2026-02-18T19:49:49.263762Z","steps":["trace[1358864196] 'process raft request' (duration: 120.269772ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:49:49.263831Z","caller":"traceutil/trace.go:171","msg":"trace[499802026] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"117.890109ms","start":"2026-02-18T19:49:49.145937Z","end":"2026-02-18T19:49:49.263827Z","steps":["trace[499802026] 'process raft request' (duration: 117.502768ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:06.048928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.627507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.209\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-18T19:50:06.049025Z","caller":"traceutil/trace.go:171","msg":"trace[748472041] range","detail":"{range_begin:/registry/masterleases/162.253.55.209; range_end:; response_count:1; response_revision:681; }","duration":"183.767031ms","start":"2026-02-18T19:50:05.865238Z","end":"2026-02-18T19:50:06.049005Z","steps":["trace[748472041] 'range keys from in-memory index tree' (duration: 183.475933ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:06.049335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.760929ms","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-18T19:50:06.049366Z","caller":"traceutil/trace.go:171","msg":"trace[60933218] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:681; }","duration":"423.817561ms","start":"2026-02-18T19:50:05.625539Z","end":"2026-02-18T19:50:06.049357Z","steps":["trace[60933218] 'range keys from in-memory index tree' (duration: 423.606045ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:06.049395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:50:05.625525Z","time spent":"423.860421ms","remote":"127.0.0.1:60002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-18T19:50:06.574017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.612908ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-18T19:50:06.574104Z","caller":"traceutil/trace.go:171","msg":"trace[1976029426] transaction","detail":"{read_only:false; response_revision:682; number_of_response:1; }","duration":"520.555309ms","start":"2026-02-18T19:50:06.053532Z","end":"2026-02-18T19:50:06.574087Z","steps":["trace[1976029426] 'process raft request' (duration: 300.667343ms)","trace[1976029426] 'compare' (duration: 219.424123ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T19:50:06.574159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:50:06.053517Z","time spent":"520.61716ms","remote":"127.0.0.1:60002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T19:50:06.657239Z","caller":"traceutil/trace.go:171","msg":"trace[664532363] transaction","detail":"{read_only:false; response_revision:684; number_of_response:1; }","duration":"389.810571ms","start":"2026-02-18T19:50:06.267412Z","end":"2026-02-18T19:50:06.657222Z","steps":["trace[664532363] 'process raft request' (duration: 389.78292ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:06.657336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:50:06.267399Z","time spent":"389.890353ms","remote":"127.0.0.1:59822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":817,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-18T19:50:06.657368Z","caller":"traceutil/trace.go:171","msg":"trace[1185260492] transaction","detail":"{read_only:false; response_revision:683; number_of_response:1; }","duration":"416.436085ms","start":"2026-02-18T19:50:06.240907Z","end":"2026-02-18T19:50:06.657343Z","steps":["trace[1185260492] 'process raft request' (duration: 416.198119ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:06.657493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:50:06.240894Z","time spent":"416.528477ms","remote":"127.0.0.1:59770","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T19:50:20.744036Z","caller":"traceutil/trace.go:171","msg":"trace[1899499001] transaction","detail":"{read_only:false; response_revision:729; number_of_response:1; }","duration":"105.052048ms","start":"2026-02-18T19:50:20.638953Z","end":"2026-02-18T19:50:20.744005Z","steps":["trace[1899499001] 'process raft request' (duration: 104.930625ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:50:22.911365Z","caller":"traceutil/trace.go:171","msg":"trace[1129217170] transaction","detail":"{read_only:false; response_revision:734; number_of_response:1; }","duration":"162.063006ms","start":"2026-02-18T19:50:22.749285Z","end":"2026-02-18T19:50:22.911348Z","steps":["trace[1129217170] 'process raft request' (duration: 161.719197ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:50:25.044637Z","caller":"traceutil/trace.go:171","msg":"trace[769606921] transaction","detail":"{read_only:false; response_revision:739; number_of_response:1; }","duration":"128.324254ms","start":"2026-02-18T19:50:24.916298Z","end":"2026-02-18T19:50:25.044622Z","steps":["trace[769606921] 'process raft request' (duration: 128.238262ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:25.318556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.318271ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-02-18T19:50:25.318609Z","caller":"traceutil/trace.go:171","msg":"trace[2087819908] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:739; }","duration":"126.405624ms","start":"2026-02-18T19:50:25.192191Z","end":"2026-02-18T19:50:25.318596Z","steps":["trace[2087819908] 'range keys from in-memory index tree' (duration: 126.154998ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:50:25.518747Z","caller":"traceutil/trace.go:171","msg":"trace[1691884752] transaction","detail":"{read_only:false; response_revision:740; number_of_response:1; }","duration":"197.33818ms","start":"2026-02-18T19:50:25.32139Z","end":"2026-02-18T19:50:25.518728Z","steps":["trace[1691884752] 'process raft request' (duration: 197.171485ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:50:25.519006Z","caller":"traceutil/trace.go:171","msg":"trace[1539136667] linearizableReadLoop","detail":"{readStateIndex:763; appliedIndex:763; }","duration":"118.049403ms","start":"2026-02-18T19:50:25.40095Z","end":"2026-02-18T19:50:25.518999Z","steps":["trace[1539136667] 'read index received' (duration: 118.046583ms)","trace[1539136667] 'applied index is now lower than readState.Index' (duration: 2.32µs)"],"step_count":2} {"level":"warn","ts":"2026-02-18T19:50:25.519526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.561886ms","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-18T19:50:25.519592Z","caller":"traceutil/trace.go:171","msg":"trace[1484199797] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:740; }","duration":"118.664279ms","start":"2026-02-18T19:50:25.400918Z","end":"2026-02-18T19:50:25.519583Z","steps":["trace[1484199797] 'agreement among raft nodes before linearized reading' (duration: 118.105344ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:50:25.629797Z","caller":"traceutil/trace.go:171","msg":"trace[192513354] transaction","detail":"{read_only:false; response_revision:741; number_of_response:1; }","duration":"106.744554ms","start":"2026-02-18T19:50:25.52303Z","end":"2026-02-18T19:50:25.629775Z","steps":["trace[192513354] 'process raft request' (duration: 59.987297ms)","trace[192513354] 'compare' (duration: 46.418168ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T19:50:29.838447Z","caller":"traceutil/trace.go:171","msg":"trace[306209862] transaction","detail":"{read_only:false; response_revision:752; number_of_response:1; }","duration":"306.65083ms","start":"2026-02-18T19:50:29.531776Z","end":"2026-02-18T19:50:29.838427Z","steps":["trace[306209862] 'process raft request' (duration: 306.523957ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:29.838566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:50:29.531741Z","time spent":"306.761833ms","remote":"127.0.0.1:60002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T19:50:29.838915Z","caller":"traceutil/trace.go:171","msg":"trace[1756600581] linearizableReadLoop","detail":"{readStateIndex:776; appliedIndex:776; }","duration":"193.864888ms","start":"2026-02-18T19:50:29.645042Z","end":"2026-02-18T19:50:29.838907Z","steps":["trace[1756600581] 'read index received' (duration: 193.860588ms)","trace[1756600581] 'applied index is now lower than readState.Index' (duration: 2.43µs)"],"step_count":2} {"level":"warn","ts":"2026-02-18T19:50:29.839014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.969171ms","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-18T19:50:29.839032Z","caller":"traceutil/trace.go:171","msg":"trace[126981633] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:752; }","duration":"194.020052ms","start":"2026-02-18T19:50:29.645006Z","end":"2026-02-18T19:50:29.839027Z","steps":["trace[126981633] 'agreement among raft nodes before linearized reading' (duration: 193.94416ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:29.847314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.218364ms","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-18T19:50:29.847371Z","caller":"traceutil/trace.go:171","msg":"trace[264288074] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:753; }","duration":"192.294047ms","start":"2026-02-18T19:50:29.655067Z","end":"2026-02-18T19:50:29.847361Z","steps":["trace[264288074] 'agreement among raft nodes before linearized reading' (duration: 192.157083ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:29.847501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.397679ms","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-18T19:50:29.847606Z","caller":"traceutil/trace.go:171","msg":"trace[340327663] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:753; }","duration":"192.508562ms","start":"2026-02-18T19:50:29.655088Z","end":"2026-02-18T19:50:29.847597Z","steps":["trace[340327663] 'agreement among raft nodes before linearized reading' (duration: 192.263505ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:30.009328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.134031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T19:50:30.009404Z","caller":"traceutil/trace.go:171","msg":"trace[680990517] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:756; }","duration":"105.229233ms","start":"2026-02-18T19:50:29.904157Z","end":"2026-02-18T19:50:30.009386Z","steps":["trace[680990517] 'range keys from in-memory index tree' (duration: 105.072039ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:50:46.133938Z","caller":"traceutil/trace.go:171","msg":"trace[1778114104] linearizableReadLoop","detail":"{readStateIndex:886; appliedIndex:885; }","duration":"166.835754ms","start":"2026-02-18T19:50:45.967087Z","end":"2026-02-18T19:50:46.133923Z","steps":["trace[1778114104] 'read index received' (duration: 152.58743ms)","trace[1778114104] 'applied index is now lower than readState.Index' (duration: 14.247814ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T19:50:46.134049Z","caller":"traceutil/trace.go:171","msg":"trace[2007691404] transaction","detail":"{read_only:false; response_revision:856; number_of_response:1; }","duration":"167.477341ms","start":"2026-02-18T19:50:45.966549Z","end":"2026-02-18T19:50:46.134026Z","steps":["trace[2007691404] 'process raft request' (duration: 153.157775ms)","trace[2007691404] 'compare' (duration: 14.142031ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T19:50:46.134096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.976868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T19:50:46.134123Z","caller":"traceutil/trace.go:171","msg":"trace[2038993535] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:856; }","duration":"167.037359ms","start":"2026-02-18T19:50:45.967077Z","end":"2026-02-18T19:50:46.134115Z","steps":["trace[2038993535] 'agreement among raft nodes before linearized reading' (duration: 166.941627ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:50:46.252924Z","caller":"traceutil/trace.go:171","msg":"trace[1085088903] transaction","detail":"{read_only:false; response_revision:857; number_of_response:1; }","duration":"282.072235ms","start":"2026-02-18T19:50:45.970837Z","end":"2026-02-18T19:50:46.252909Z","steps":["trace[1085088903] 'process raft request' (duration: 279.836166ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:50:46.253136Z","caller":"traceutil/trace.go:171","msg":"trace[517454073] linearizableReadLoop","detail":"{readStateIndex:889; appliedIndex:886; }","duration":"119.125263ms","start":"2026-02-18T19:50:46.134004Z","end":"2026-02-18T19:50:46.25313Z","steps":["trace[517454073] 'read index received' (duration: 116.620868ms)","trace[517454073] 'applied index is now lower than readState.Index' (duration: 2.504005ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T19:50:46.253226Z","caller":"traceutil/trace.go:171","msg":"trace[1529112020] transaction","detail":"{read_only:false; response_revision:858; number_of_response:1; }","duration":"281.267714ms","start":"2026-02-18T19:50:45.971953Z","end":"2026-02-18T19:50:46.253221Z","steps":["trace[1529112020] 'process raft request' (duration: 280.694789ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:50:46.253337Z","caller":"traceutil/trace.go:171","msg":"trace[1802194880] transaction","detail":"{read_only:false; response_revision:859; number_of_response:1; }","duration":"280.156495ms","start":"2026-02-18T19:50:45.973176Z","end":"2026-02-18T19:50:46.253332Z","steps":["trace[1802194880] 'process raft request' (duration: 279.496127ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:46.253491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.548261ms","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-18T19:50:46.253509Z","caller":"traceutil/trace.go:171","msg":"trace[2063015715] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:859; }","duration":"281.582902ms","start":"2026-02-18T19:50:45.97192Z","end":"2026-02-18T19:50:46.253503Z","steps":["trace[2063015715] 'agreement among raft nodes before linearized reading' (duration: 281.5099ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:46.255231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.615946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"info","ts":"2026-02-18T19:50:46.255269Z","caller":"traceutil/trace.go:171","msg":"trace[1178829904] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:859; }","duration":"119.841702ms","start":"2026-02-18T19:50:46.135403Z","end":"2026-02-18T19:50:46.255244Z","steps":["trace[1178829904] 'agreement among raft nodes before linearized reading' (duration: 119.801881ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:50:56.087311Z","caller":"traceutil/trace.go:171","msg":"trace[725297758] linearizableReadLoop","detail":"{readStateIndex:917; appliedIndex:916; }","duration":"183.89156ms","start":"2026-02-18T19:50:55.903403Z","end":"2026-02-18T19:50:56.087294Z","steps":["trace[725297758] 'read index received' (duration: 183.12443ms)","trace[725297758] 'applied index is now lower than readState.Index' (duration: 766.43µs)"],"step_count":2} {"level":"info","ts":"2026-02-18T19:50:56.087322Z","caller":"traceutil/trace.go:171","msg":"trace[467624569] transaction","detail":"{read_only:false; response_revision:885; number_of_response:1; }","duration":"184.907917ms","start":"2026-02-18T19:50:55.902396Z","end":"2026-02-18T19:50:56.087304Z","steps":["trace[467624569] 'process raft request' (duration: 184.133817ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:56.087399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.982612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T19:50:56.087418Z","caller":"traceutil/trace.go:171","msg":"trace[802409420] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:885; }","duration":"184.025444ms","start":"2026-02-18T19:50:55.903386Z","end":"2026-02-18T19:50:56.087411Z","steps":["trace[802409420] 'agreement among raft nodes before linearized reading' (duration: 183.967103ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:50:58.45316Z","caller":"traceutil/trace.go:171","msg":"trace[809030554] linearizableReadLoop","detail":"{readStateIndex:924; appliedIndex:923; }","duration":"158.532346ms","start":"2026-02-18T19:50:58.294613Z","end":"2026-02-18T19:50:58.453145Z","steps":["trace[809030554] 'read index received' (duration: 158.412203ms)","trace[809030554] 'applied index is now lower than readState.Index' (duration: 119.683µs)"],"step_count":2} {"level":"info","ts":"2026-02-18T19:50:58.453333Z","caller":"traceutil/trace.go:171","msg":"trace[1555255714] transaction","detail":"{read_only:false; response_revision:892; number_of_response:1; }","duration":"162.418268ms","start":"2026-02-18T19:50:58.290908Z","end":"2026-02-18T19:50:58.453327Z","steps":["trace[1555255714] 'process raft request' (duration: 162.158311ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:58.453484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.862824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-18T19:50:58.4535Z","caller":"traceutil/trace.go:171","msg":"trace[1185992456] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:892; }","duration":"158.899666ms","start":"2026-02-18T19:50:58.294595Z","end":"2026-02-18T19:50:58.453495Z","steps":["trace[1185992456] 'agreement among raft nodes before linearized reading' (duration: 158.827214ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:58.453579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.886527ms","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-18T19:50:58.453592Z","caller":"traceutil/trace.go:171","msg":"trace[2085367231] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:892; }","duration":"139.910117ms","start":"2026-02-18T19:50:58.313677Z","end":"2026-02-18T19:50:58.453588Z","steps":["trace[2085367231] 'agreement among raft nodes before linearized reading' (duration: 139.875177ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:58.453698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.386222ms","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-18T19:50:58.45371Z","caller":"traceutil/trace.go:171","msg":"trace[2096246091] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:892; }","duration":"129.412793ms","start":"2026-02-18T19:50:58.324293Z","end":"2026-02-18T19:50:58.453706Z","steps":["trace[2096246091] 'agreement among raft nodes before linearized reading' (duration: 129.371201ms)"],"step_count":1}