{"level":"warn","ts":"2026-02-20T18:21:09.950483Z","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-20T18:21:09.950694Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.74: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.74:2380","--initial-cluster=instance=https://162.253.55.74:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.74:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.74: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-20T18:21:09.950812Z","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-20T18:21:09.950855Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.74:2380"]} {"level":"info","ts":"2026-02-20T18:21:09.950949Z","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-20T18:21:09.951956Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.74:2379"]} {"level":"info","ts":"2026-02-20T18:21:09.952209Z","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://162.253.55.74:2380"],"listen-peer-urls":["https://162.253.55.74:2380"],"advertise-client-urls":["https://162.253.55.74:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.74:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.74: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-20T18:21:09.957176Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.348954ms"} {"level":"info","ts":"2026-02-20T18:21:09.966818Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"30aa8136fb61a722","cluster-id":"e7ea3889c4872560"} {"level":"info","ts":"2026-02-20T18:21:09.966937Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 switched to configuration voters=()"} {"level":"info","ts":"2026-02-20T18:21:09.966979Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 became follower at term 0"} {"level":"info","ts":"2026-02-20T18:21:09.967008Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 30aa8136fb61a722 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-20T18:21:09.967031Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 became follower at term 1"} {"level":"info","ts":"2026-02-20T18:21:09.967101Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 switched to configuration voters=(3506757333007050530)"} {"level":"warn","ts":"2026-02-20T18:21:09.972706Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-20T18:21:09.973989Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-20T18:21:09.975162Z","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-20T18:21:09.977206Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"30aa8136fb61a722","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-20T18:21:09.978326Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"30aa8136fb61a722","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-20T18:21:09.9809Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 switched to configuration voters=(3506757333007050530)"} {"level":"info","ts":"2026-02-20T18:21:09.98144Z","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-20T18:21:09.981726Z","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-20T18:21:09.982066Z","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-20T18:21:09.983745Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e7ea3889c4872560","local-member-id":"30aa8136fb61a722","added-peer-id":"30aa8136fb61a722","added-peer-peer-urls":["https://162.253.55.74:2380"]} {"level":"info","ts":"2026-02-20T18:21:09.984903Z","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-20T18:21:09.985127Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.74:2380"} {"level":"info","ts":"2026-02-20T18:21:09.985194Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.74:2380"} {"level":"info","ts":"2026-02-20T18:21:09.985428Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"30aa8136fb61a722","initial-advertise-peer-urls":["https://162.253.55.74:2380"],"listen-peer-urls":["https://162.253.55.74:2380"],"advertise-client-urls":["https://162.253.55.74:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.74:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-20T18:21:09.985583Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-20T18:21:10.967444Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 is starting a new election at term 1"} {"level":"info","ts":"2026-02-20T18:21:10.967508Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-20T18:21:10.967558Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 received MsgPreVoteResp from 30aa8136fb61a722 at term 1"} {"level":"info","ts":"2026-02-20T18:21:10.967582Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 became candidate at term 2"} {"level":"info","ts":"2026-02-20T18:21:10.967594Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 received MsgVoteResp from 30aa8136fb61a722 at term 2"} {"level":"info","ts":"2026-02-20T18:21:10.967618Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 became leader at term 2"} {"level":"info","ts":"2026-02-20T18:21:10.967636Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 30aa8136fb61a722 elected leader 30aa8136fb61a722 at term 2"} {"level":"info","ts":"2026-02-20T18:21:10.970858Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-20T18:21:10.971981Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"30aa8136fb61a722","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.74:2379]}","request-path":"/0/members/30aa8136fb61a722/attributes","cluster-id":"e7ea3889c4872560","publish-timeout":"7s"} {"level":"info","ts":"2026-02-20T18:21:10.972023Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-20T18:21:10.9721Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-20T18:21:10.972269Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e7ea3889c4872560","local-member-id":"30aa8136fb61a722","cluster-version":"3.5"} {"level":"info","ts":"2026-02-20T18:21:10.972337Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-20T18:21:10.972366Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-20T18:21:10.972396Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-20T18:21:10.972445Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-20T18:21:10.975997Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-20T18:21:10.976412Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.74:2379"} {"level":"info","ts":"2026-02-20T18:21:36.729812Z","caller":"traceutil/trace.go:171","msg":"trace[1084340419] transaction","detail":"{read_only:false; response_revision:424; number_of_response:1; }","duration":"141.228464ms","start":"2026-02-20T18:21:36.588549Z","end":"2026-02-20T18:21:36.729777Z","steps":["trace[1084340419] 'process raft request' (duration: 141.012191ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:21:36.729789Z","caller":"traceutil/trace.go:171","msg":"trace[283654895] linearizableReadLoop","detail":"{readStateIndex:440; appliedIndex:439; }","duration":"120.791585ms","start":"2026-02-20T18:21:36.608945Z","end":"2026-02-20T18:21:36.729737Z","steps":["trace[283654895] 'read index received' (duration: 120.539112ms)","trace[283654895] 'applied index is now lower than readState.Index' (duration: 250.883µs)"],"step_count":2} {"level":"warn","ts":"2026-02-20T18:21:36.72999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.007998ms","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-20T18:21:36.730132Z","caller":"traceutil/trace.go:171","msg":"trace[1420222444] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:424; }","duration":"121.220151ms","start":"2026-02-20T18:21:36.60889Z","end":"2026-02-20T18:21:36.73011Z","steps":["trace[1420222444] 'agreement among raft nodes before linearized reading' (duration: 120.980338ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:21:36.928838Z","caller":"traceutil/trace.go:171","msg":"trace[444253710] transaction","detail":"{read_only:false; response_revision:426; number_of_response:1; }","duration":"193.833819ms","start":"2026-02-20T18:21:36.734977Z","end":"2026-02-20T18:21:36.928811Z","steps":["trace[444253710] 'process raft request' (duration: 193.731188ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:21:36.928899Z","caller":"traceutil/trace.go:171","msg":"trace[1998758380] transaction","detail":"{read_only:false; response_revision:425; number_of_response:1; }","duration":"194.269626ms","start":"2026-02-20T18:21:36.734597Z","end":"2026-02-20T18:21:36.928866Z","steps":["trace[1998758380] 'process raft request' (duration: 134.495662ms)","trace[1998758380] 'compare' (duration: 59.48442ms)"],"step_count":2} {"level":"info","ts":"2026-02-20T18:21:54.894085Z","caller":"traceutil/trace.go:171","msg":"trace[991972280] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"171.595465ms","start":"2026-02-20T18:21:54.722447Z","end":"2026-02-20T18:21:54.894043Z","steps":["trace[991972280] 'process raft request' (duration: 171.336344ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:21:54.894229Z","caller":"traceutil/trace.go:171","msg":"trace[1326099226] linearizableReadLoop","detail":"{readStateIndex:542; appliedIndex:541; }","duration":"146.025959ms","start":"2026-02-20T18:21:54.747916Z","end":"2026-02-20T18:21:54.893942Z","steps":["trace[1326099226] 'read index received' (duration: 145.754947ms)","trace[1326099226] 'applied index is now lower than readState.Index' (duration: 270.132µs)"],"step_count":2} {"level":"warn","ts":"2026-02-20T18:21:54.894965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.00348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-7fcd8d6ffd-gs4ww\" ","response":"range_response_count:1 size:4635"} {"level":"info","ts":"2026-02-20T18:21:54.895048Z","caller":"traceutil/trace.go:171","msg":"trace[1332615341] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-7fcd8d6ffd-gs4ww; range_end:; response_count:1; response_revision:522; }","duration":"147.168237ms","start":"2026-02-20T18:21:54.747861Z","end":"2026-02-20T18:21:54.895029Z","steps":["trace[1332615341] 'agreement among raft nodes before linearized reading' (duration: 146.275269ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:21:55.234502Z","caller":"traceutil/trace.go:171","msg":"trace[1821640223] linearizableReadLoop","detail":"{readStateIndex:550; appliedIndex:549; }","duration":"150.491988ms","start":"2026-02-20T18:21:55.083991Z","end":"2026-02-20T18:21:55.234483Z","steps":["trace[1821640223] 'read index received' (duration: 150.30922ms)","trace[1821640223] 'applied index is now lower than readState.Index' (duration: 181.848µs)"],"step_count":2} {"level":"info","ts":"2026-02-20T18:21:55.234601Z","caller":"traceutil/trace.go:171","msg":"trace[934153018] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"151.838604ms","start":"2026-02-20T18:21:55.082752Z","end":"2026-02-20T18:21:55.234591Z","steps":["trace[934153018] 'process raft request' (duration: 151.602044ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:21:55.234748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.778584ms","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-20T18:21:55.234797Z","caller":"traceutil/trace.go:171","msg":"trace[562735454] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:530; }","duration":"113.884698ms","start":"2026-02-20T18:21:55.120896Z","end":"2026-02-20T18:21:55.234781Z","steps":["trace[562735454] 'agreement among raft nodes before linearized reading' (duration: 113.804095ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:21:55.235133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.133225ms","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-20T18:21:55.23517Z","caller":"traceutil/trace.go:171","msg":"trace[1510756561] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:530; }","duration":"151.179996ms","start":"2026-02-20T18:21:55.083979Z","end":"2026-02-20T18:21:55.235159Z","steps":["trace[1510756561] 'agreement among raft nodes before linearized reading' (duration: 151.096293ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:21:58.487386Z","caller":"traceutil/trace.go:171","msg":"trace[1303233218] linearizableReadLoop","detail":"{readStateIndex:596; appliedIndex:595; }","duration":"367.042493ms","start":"2026-02-20T18:21:58.12032Z","end":"2026-02-20T18:21:58.487362Z","steps":["trace[1303233218] 'read index received' (duration: 366.914818ms)","trace[1303233218] 'applied index is now lower than readState.Index' (duration: 126.735µs)"],"step_count":2} {"level":"info","ts":"2026-02-20T18:21:58.487525Z","caller":"traceutil/trace.go:171","msg":"trace[134275332] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"530.298947ms","start":"2026-02-20T18:21:57.957216Z","end":"2026-02-20T18:21:58.487515Z","steps":["trace[134275332] 'process raft request' (duration: 530.004275ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:21:58.487773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.569365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-20T18:21:58.487866Z","caller":"traceutil/trace.go:171","msg":"trace[1253829119] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:576; }","duration":"309.715231ms","start":"2026-02-20T18:21:58.178128Z","end":"2026-02-20T18:21:58.487843Z","steps":["trace[1253829119] 'agreement among raft nodes before linearized reading' (duration: 309.563674ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:21:58.487923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T18:21:58.178082Z","time spent":"309.833035ms","remote":"127.0.0.1:45530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-20T18:21:58.488017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T18:21:57.957196Z","time spent":"530.35254ms","remote":"127.0.0.1:45788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-20T18:21:58.488188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.913461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:1 size:188252"} {"level":"info","ts":"2026-02-20T18:21:58.488282Z","caller":"traceutil/trace.go:171","msg":"trace[787979723] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:1; response_revision:576; }","duration":"167.079948ms","start":"2026-02-20T18:21:58.32118Z","end":"2026-02-20T18:21:58.48826Z","steps":["trace[787979723] 'agreement among raft nodes before linearized reading' (duration: 166.683221ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:21:58.488723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.360217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:1 size:24244"} {"level":"info","ts":"2026-02-20T18:21:58.489686Z","caller":"traceutil/trace.go:171","msg":"trace[1739907342] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:1; response_revision:576; }","duration":"368.559765ms","start":"2026-02-20T18:21:58.120247Z","end":"2026-02-20T18:21:58.488807Z","steps":["trace[1739907342] 'agreement among raft nodes before linearized reading' (duration: 367.594866ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:21:58.489783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T18:21:58.120219Z","time spent":"369.541304ms","remote":"127.0.0.1:45574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":24267,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" "} {"level":"info","ts":"2026-02-20T18:22:01.646764Z","caller":"traceutil/trace.go:171","msg":"trace[919172835] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"360.79435ms","start":"2026-02-20T18:22:01.285935Z","end":"2026-02-20T18:22:01.646729Z","steps":["trace[919172835] 'process raft request' (duration: 360.565221ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:22:01.646928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T18:22:01.285902Z","time spent":"360.944356ms","remote":"127.0.0.1:45788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-20T18:22:01.64696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.773103ms","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-20T18:22:01.647026Z","caller":"traceutil/trace.go:171","msg":"trace[602802375] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:587; }","duration":"306.897438ms","start":"2026-02-20T18:22:01.340114Z","end":"2026-02-20T18:22:01.647012Z","steps":["trace[602802375] 'agreement among raft nodes before linearized reading' (duration: 306.68667ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:22:01.647083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T18:22:01.340091Z","time spent":"306.974441ms","remote":"127.0.0.1:45788","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-20T18:22:01.646694Z","caller":"traceutil/trace.go:171","msg":"trace[230667551] linearizableReadLoop","detail":"{readStateIndex:608; appliedIndex:607; }","duration":"306.508333ms","start":"2026-02-20T18:22:01.340162Z","end":"2026-02-20T18:22:01.64667Z","steps":["trace[230667551] 'read index received' (duration: 306.242432ms)","trace[230667551] 'applied index is now lower than readState.Index' (duration: 264.571µs)"],"step_count":2} {"level":"warn","ts":"2026-02-20T18:22:01.647438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.275704ms","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-20T18:22:01.647478Z","caller":"traceutil/trace.go:171","msg":"trace[378563625] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:587; }","duration":"306.354366ms","start":"2026-02-20T18:22:01.341114Z","end":"2026-02-20T18:22:01.647469Z","steps":["trace[378563625] 'agreement among raft nodes before linearized reading' (duration: 306.230401ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:22:01.647506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T18:22:01.341088Z","time spent":"306.411379ms","remote":"127.0.0.1:45788","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-20T18:22:01.885855Z","caller":"traceutil/trace.go:171","msg":"trace[1036200808] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"234.995726ms","start":"2026-02-20T18:22:01.650833Z","end":"2026-02-20T18:22:01.885829Z","steps":["trace[1036200808] 'process raft request' (duration: 234.790868ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:22:01.89632Z","caller":"traceutil/trace.go:171","msg":"trace[801147737] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"238.515435ms","start":"2026-02-20T18:22:01.657784Z","end":"2026-02-20T18:22:01.8963Z","steps":["trace[801147737] 'process raft request' (duration: 238.301936ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:22:01.896379Z","caller":"traceutil/trace.go:171","msg":"trace[1185839586] linearizableReadLoop","detail":"{readStateIndex:610; appliedIndex:608; }","duration":"118.131013ms","start":"2026-02-20T18:22:01.778089Z","end":"2026-02-20T18:22:01.89622Z","steps":["trace[1185839586] 'read index received' (duration: 107.544617ms)","trace[1185839586] 'applied index is now lower than readState.Index' (duration: 10.584906ms)"],"step_count":2} {"level":"warn","ts":"2026-02-20T18:22:01.896545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.443455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-bgrnx\" ","response":"range_response_count:1 size:16652"} {"level":"info","ts":"2026-02-20T18:22:01.896609Z","caller":"traceutil/trace.go:171","msg":"trace[1523642675] range","detail":"{range_begin:/registry/pods/kube-system/cilium-bgrnx; range_end:; response_count:1; response_revision:589; }","duration":"118.583301ms","start":"2026-02-20T18:22:01.778012Z","end":"2026-02-20T18:22:01.896595Z","steps":["trace[1523642675] 'agreement among raft nodes before linearized reading' (duration: 118.361103ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:22:02.029029Z","caller":"traceutil/trace.go:171","msg":"trace[942613755] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"120.018288ms","start":"2026-02-20T18:22:01.908985Z","end":"2026-02-20T18:22:02.029003Z","steps":["trace[942613755] 'process raft request' (duration: 114.94201ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:22:02.41009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.73067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-20T18:22:02.410202Z","caller":"traceutil/trace.go:171","msg":"trace[681676631] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:590; }","duration":"232.974109ms","start":"2026-02-20T18:22:02.177202Z","end":"2026-02-20T18:22:02.410176Z","steps":["trace[681676631] 'range keys from in-memory index tree' (duration: 232.621095ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:22:03.365871Z","caller":"traceutil/trace.go:171","msg":"trace[739722975] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"415.127629ms","start":"2026-02-20T18:22:02.950716Z","end":"2026-02-20T18:22:03.365844Z","steps":["trace[739722975] 'process raft request' (duration: 414.959262ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:22:03.366067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T18:22:02.95068Z","time spent":"415.273044ms","remote":"127.0.0.1:45788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-20T18:22:04.08543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.87057ms","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-20T18:22:04.085514Z","caller":"traceutil/trace.go:171","msg":"trace[1513647676] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:592; }","duration":"196.002485ms","start":"2026-02-20T18:22:03.889489Z","end":"2026-02-20T18:22:04.085491Z","steps":["trace[1513647676] 'range keys from in-memory index tree' (duration: 195.658961ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:22:04.085797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.248389ms","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-20T18:22:04.085827Z","caller":"traceutil/trace.go:171","msg":"trace[74188897] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:592; }","duration":"186.322381ms","start":"2026-02-20T18:22:03.899495Z","end":"2026-02-20T18:22:04.085817Z","steps":["trace[74188897] 'range keys from in-memory index tree' (duration: 186.112063ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:22:04.086008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.526951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-02-20T18:22:04.086047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.902555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.74\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-02-20T18:22:04.08613Z","caller":"traceutil/trace.go:171","msg":"trace[1349153138] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:592; }","duration":"434.712059ms","start":"2026-02-20T18:22:03.651381Z","end":"2026-02-20T18:22:04.086093Z","steps":["trace[1349153138] 'range keys from in-memory index tree' (duration: 434.296223ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:22:04.086156Z","caller":"traceutil/trace.go:171","msg":"trace[2058998708] range","detail":"{range_begin:/registry/masterleases/162.253.55.74; range_end:; response_count:1; response_revision:592; }","duration":"117.080462ms","start":"2026-02-20T18:22:03.969047Z","end":"2026-02-20T18:22:04.086127Z","steps":["trace[2058998708] 'range keys from in-memory index tree' (duration: 116.649995ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:22:04.086194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T18:22:03.651359Z","time spent":"434.824053ms","remote":"127.0.0.1:45788","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-20T18:22:04.086631Z","caller":"traceutil/trace.go:171","msg":"trace[489409876] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"102.092253ms","start":"2026-02-20T18:22:03.984515Z","end":"2026-02-20T18:22:04.086607Z","steps":["trace[489409876] 'process raft request' (duration: 39.156813ms)","trace[489409876] 'compare' (duration: 62.275965ms)"],"step_count":2} {"level":"warn","ts":"2026-02-20T18:22:24.171308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.332715ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-20T18:22:24.171439Z","caller":"traceutil/trace.go:171","msg":"trace[1095262275] transaction","detail":"{read_only:false; response_revision:754; number_of_response:1; }","duration":"131.115916ms","start":"2026-02-20T18:22:24.040301Z","end":"2026-02-20T18:22:24.171417Z","steps":["trace[1095262275] 'process raft request' (duration: 29.344787ms)","trace[1095262275] 'compare' (duration: 101.1702ms)"],"step_count":2} {"level":"info","ts":"2026-02-20T18:23:30.843389Z","caller":"traceutil/trace.go:171","msg":"trace[2126527065] transaction","detail":"{read_only:false; response_revision:983; number_of_response:1; }","duration":"204.364276ms","start":"2026-02-20T18:23:30.638997Z","end":"2026-02-20T18:23:30.843361Z","steps":["trace[2126527065] 'process raft request' (duration: 204.157182ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:23:30.845685Z","caller":"traceutil/trace.go:171","msg":"trace[954503412] transaction","detail":"{read_only:false; response_revision:984; number_of_response:1; }","duration":"205.821744ms","start":"2026-02-20T18:23:30.639837Z","end":"2026-02-20T18:23:30.845659Z","steps":["trace[954503412] 'process raft request' (duration: 205.61466ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:23:39.438202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.919253ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-20T18:23:40.121666Z","caller":"traceutil/trace.go:171","msg":"trace[542968039] transaction","detail":"{read_only:false; response_revision:1015; number_of_response:1; }","duration":"191.840438ms","start":"2026-02-20T18:23:39.929754Z","end":"2026-02-20T18:23:40.121594Z","steps":["trace[542968039] 'process raft request' (duration: 191.630575ms)"],"step_count":1}